Diff of the two buildlogs: -- --- b1/build.log 2021-08-21 16:56:32.265824908 +0000 +++ b2/build.log 2021-08-21 17:05:47.373002644 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Fri Sep 23 11:11:41 -12 2022 -I: pbuilder-time-stamp: 1663974701 +I: Current time: Sun Aug 22 06:56:37 +14 2021 +I: pbuilder-time-stamp: 1629564997 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bullseye-reproducible-base.tgz] I: copying local configuration @@ -16,8 +16,8 @@ I: copying [./racon_1.4.20-1.debian.tar.xz] I: Extracting source gpgv: unknown type of key resource 'trustedkeys.kbx' -gpgv: keyblock resource '/tmp/dpkg-verify-sig.FyUM74M1/trustedkeys.kbx': General error -gpgv: Signature made Mon Jan 18 22:04:56 2021 -12 +gpgv: keyblock resource '/tmp/dpkg-verify-sig.sY2UsQPG/trustedkeys.kbx': General error +gpgv: Signature made Wed Jan 20 00:04:56 2021 +14 gpgv: using RSA key 724D609337113C710550D7473C26763F6C67E6E2 gpgv: Can't check signature: No public key dpkg-source: warning: failed to verify signature on ./racon_1.4.20-1.dsc @@ -30,135 +30,169 @@ dpkg-source: info: applying py3 I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/26276/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/31276/tmp/hooks/D01_modify_environment starting +debug: Running on codethink10-arm64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +Removing 'diversion of /bin/sh to /bin/sh.distrib by dash' +Adding 'diversion of /bin/sh to /bin/sh.distrib by bash' +Removing 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by dash' +Adding 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by bash' +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/31276/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/31276/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="1" [2]="4" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.1.4(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=8' - DISTRIBUTION='' - HOME='/var/lib/jenkins' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION= + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/var/lib/jenkins + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='26276' - PS1='# ' - PS2='> ' + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=31276 PS4='+ ' - PWD='/' - SHELL='/bin/bash' - SHLVL='2' - SUDO_COMMAND='/usr/bin/timeout -k 18.1h 18h /usr/bin/ionice -c 3 /usr/bin/nice /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/tmp.KqRd9dJF08/pbuilderrc_4Vgo --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.KqRd9dJF08/b1 --logfile b1/build.log racon_1.4.20-1.dsc' - SUDO_GID='117' - SUDO_UID='110' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - USERNAME='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.16:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/tmp.KqRd9dJF08/pbuilderrc_E5Ig --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.KqRd9dJF08/b2 --logfile b2/build.log racon_1.4.20-1.dsc' + SUDO_GID=117 + SUDO_UID=110 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + USERNAME=root + _='I: set' + http_proxy=http://192.168.101.16:3128 I: uname -a - Linux codethink9-arm64 4.15.0-154-generic #161-Ubuntu SMP Fri Jul 30 13:01:15 UTC 2021 aarch64 GNU/Linux + Linux i-capture-the-hostname 4.15.0-154-generic #161-Ubuntu SMP Fri Jul 30 13:01:15 UTC 2021 aarch64 GNU/Linux I: ls -l /bin total 5252 - -rwxr-xr-x 1 root root 1282512 Aug 4 2021 bash - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bunzip2 - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bzcat - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2225 Jul 20 2020 bzdiff - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4877 Sep 4 2019 bzexe - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3775 Jul 20 2020 bzgrep - -rwxr-xr-x 3 root root 34808 Jul 20 2020 bzip2 - -rwxr-xr-x 1 root root 14264 Jul 20 2020 bzip2recover - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Jul 20 2020 bzmore - -rwxr-xr-x 1 root root 39832 Sep 22 2020 cat - -rwxr-xr-x 1 root root 64512 Sep 22 2020 chgrp - -rwxr-xr-x 1 root root 60368 Sep 22 2020 chmod - -rwxr-xr-x 1 root root 64528 Sep 22 2020 chown - -rwxr-xr-x 1 root root 138896 Sep 22 2020 cp - -rwxr-xr-x 1 root root 129544 Dec 10 2020 dash - -rwxr-xr-x 1 root root 101384 Sep 22 2020 date - -rwxr-xr-x 1 root root 80984 Sep 22 2020 dd - -rwxr-xr-x 1 root root 89824 Sep 22 2020 df - -rwxr-xr-x 1 root root 143088 Sep 22 2020 dir - -rwxr-xr-x 1 root root 76152 Jul 28 2021 dmesg - lrwxrwxrwx 1 root root 8 Nov 6 2019 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Nov 6 2019 domainname -> hostname - -rwxr-xr-x 1 root root 35632 Sep 22 2020 echo - -rwxr-xr-x 1 root root 28 Nov 9 2020 egrep - -rwxr-xr-x 1 root root 31512 Sep 22 2020 false - -rwxr-xr-x 1 root root 28 Nov 9 2020 fgrep - -rwxr-xr-x 1 root root 64856 Jul 28 2021 findmnt - -rwsr-xr-x 1 root root 34824 Feb 26 2021 fusermount - -rwxr-xr-x 1 root root 178400 Nov 9 2020 grep - -rwxr-xr-x 2 root root 2346 Mar 2 2021 gunzip - -rwxr-xr-x 1 root root 6376 Mar 2 2021 gzexe - -rwxr-xr-x 1 root root 93744 Mar 2 2021 gzip - -rwxr-xr-x 1 root root 18440 Nov 6 2019 hostname - -rwxr-xr-x 1 root root 68720 Sep 22 2020 ln - -rwxr-xr-x 1 root root 52720 Feb 7 2020 login - -rwxr-xr-x 1 root root 143088 Sep 22 2020 ls - -rwxr-xr-x 1 root root 161960 Jul 28 2021 lsblk - -rwxr-xr-x 1 root root 85200 Sep 22 2020 mkdir - -rwxr-xr-x 1 root root 68744 Sep 22 2020 mknod - -rwxr-xr-x 1 root root 43976 Sep 22 2020 mktemp - -rwxr-xr-x 1 root root 51368 Jul 28 2021 more - -rwsr-xr-x 1 root root 51360 Jul 28 2021 mount - -rwxr-xr-x 1 root root 14496 Jul 28 2021 mountpoint - -rwxr-xr-x 1 root root 134808 Sep 22 2020 mv - lrwxrwxrwx 1 root root 8 Nov 6 2019 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Apr 18 2021 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 35720 Sep 22 2020 pwd - lrwxrwxrwx 1 root root 4 Aug 4 2021 rbash -> bash - -rwxr-xr-x 1 root root 43872 Sep 22 2020 readlink - -rwxr-xr-x 1 root root 68592 Sep 22 2020 rm - -rwxr-xr-x 1 root root 43880 Sep 22 2020 rmdir - -rwxr-xr-x 1 root root 19208 Sep 27 2020 run-parts - -rwxr-xr-x 1 root root 114016 Dec 22 2018 sed - lrwxrwxrwx 1 root root 4 Sep 23 03:48 sh -> dash - -rwxr-xr-x 1 root root 35656 Sep 22 2020 sleep - -rwxr-xr-x 1 root root 72640 Sep 22 2020 stty - -rwsr-xr-x 1 root root 67776 Jul 28 2021 su - -rwxr-xr-x 1 root root 35672 Sep 22 2020 sync - -rwxr-xr-x 1 root root 535768 Feb 16 2021 tar - -rwxr-xr-x 1 root root 10568 Sep 27 2020 tempfile - -rwxr-xr-x 1 root root 89120 Sep 22 2020 touch - -rwxr-xr-x 1 root root 31512 Sep 22 2020 true - -rwxr-xr-x 1 root root 14264 Feb 26 2021 ulockmgr_server - -rwsr-xr-x 1 root root 30880 Jul 28 2021 umount - -rwxr-xr-x 1 root root 35640 Sep 22 2020 uname - -rwxr-xr-x 2 root root 2346 Mar 2 2021 uncompress - -rwxr-xr-x 1 root root 143088 Sep 22 2020 vdir - -rwxr-xr-x 1 root root 59584 Jul 28 2021 wdctl - lrwxrwxrwx 1 root root 8 Nov 6 2019 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Mar 2 2021 zcat - -rwxr-xr-x 1 root root 1678 Mar 2 2021 zcmp - -rwxr-xr-x 1 root root 5880 Mar 2 2021 zdiff - -rwxr-xr-x 1 root root 29 Mar 2 2021 zegrep - -rwxr-xr-x 1 root root 29 Mar 2 2021 zfgrep - -rwxr-xr-x 1 root root 2081 Mar 2 2021 zforce - -rwxr-xr-x 1 root root 7585 Mar 2 2021 zgrep - -rwxr-xr-x 1 root root 2206 Mar 2 2021 zless - -rwxr-xr-x 1 root root 1842 Mar 2 2021 zmore - -rwxr-xr-x 1 root root 4553 Mar 2 2021 znew -I: user script /srv/workspace/pbuilder/26276/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1282512 Aug 5 10:25 bash + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bunzip2 + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bzcat + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2225 Jul 21 2020 bzdiff + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4877 Sep 5 2019 bzexe + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3775 Jul 21 2020 bzgrep + -rwxr-xr-x 3 root root 34808 Jul 21 2020 bzip2 + -rwxr-xr-x 1 root root 14264 Jul 21 2020 bzip2recover + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Jul 21 2020 bzmore + -rwxr-xr-x 1 root root 39832 Sep 23 2020 cat + -rwxr-xr-x 1 root root 64512 Sep 23 2020 chgrp + -rwxr-xr-x 1 root root 60368 Sep 23 2020 chmod + -rwxr-xr-x 1 root root 64528 Sep 23 2020 chown + -rwxr-xr-x 1 root root 138896 Sep 23 2020 cp + -rwxr-xr-x 1 root root 129544 Dec 11 2020 dash + -rwxr-xr-x 1 root root 101384 Sep 23 2020 date + -rwxr-xr-x 1 root root 80984 Sep 23 2020 dd + -rwxr-xr-x 1 root root 89824 Sep 23 2020 df + -rwxr-xr-x 1 root root 143088 Sep 23 2020 dir + -rwxr-xr-x 1 root root 76152 Jul 29 09:09 dmesg + lrwxrwxrwx 1 root root 8 Nov 8 2019 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Nov 8 2019 domainname -> hostname + -rwxr-xr-x 1 root root 35632 Sep 23 2020 echo + -rwxr-xr-x 1 root root 28 Nov 10 2020 egrep + -rwxr-xr-x 1 root root 31512 Sep 23 2020 false + -rwxr-xr-x 1 root root 28 Nov 10 2020 fgrep + -rwxr-xr-x 1 root root 64856 Jul 29 09:09 findmnt + -rwsr-xr-x 1 root root 34824 Feb 27 06:12 fusermount + -rwxr-xr-x 1 root root 178400 Nov 10 2020 grep + -rwxr-xr-x 2 root root 2346 Mar 3 13:30 gunzip + -rwxr-xr-x 1 root root 6376 Mar 3 13:30 gzexe + -rwxr-xr-x 1 root root 93744 Mar 3 13:30 gzip + -rwxr-xr-x 1 root root 18440 Nov 8 2019 hostname + -rwxr-xr-x 1 root root 68720 Sep 23 2020 ln + -rwxr-xr-x 1 root root 52720 Feb 8 2020 login + -rwxr-xr-x 1 root root 143088 Sep 23 2020 ls + -rwxr-xr-x 1 root root 161960 Jul 29 09:09 lsblk + -rwxr-xr-x 1 root root 85200 Sep 23 2020 mkdir + -rwxr-xr-x 1 root root 68744 Sep 23 2020 mknod + -rwxr-xr-x 1 root root 43976 Sep 23 2020 mktemp + -rwxr-xr-x 1 root root 51368 Jul 29 09:09 more + -rwsr-xr-x 1 root root 51360 Jul 29 09:09 mount + -rwxr-xr-x 1 root root 14496 Jul 29 09:09 mountpoint + -rwxr-xr-x 1 root root 134808 Sep 23 2020 mv + lrwxrwxrwx 1 root root 8 Nov 8 2019 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Apr 19 05:38 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 35720 Sep 23 2020 pwd + lrwxrwxrwx 1 root root 4 Aug 5 10:25 rbash -> bash + -rwxr-xr-x 1 root root 43872 Sep 23 2020 readlink + -rwxr-xr-x 1 root root 68592 Sep 23 2020 rm + -rwxr-xr-x 1 root root 43880 Sep 23 2020 rmdir + -rwxr-xr-x 1 root root 19208 Sep 28 2020 run-parts + -rwxr-xr-x 1 root root 114016 Dec 23 2018 sed + lrwxrwxrwx 1 root root 4 Aug 22 06:56 sh -> bash + lrwxrwxrwx 1 root root 4 Aug 21 23:24 sh.distrib -> dash + -rwxr-xr-x 1 root root 35656 Sep 23 2020 sleep + -rwxr-xr-x 1 root root 72640 Sep 23 2020 stty + -rwsr-xr-x 1 root root 67776 Jul 29 09:09 su + -rwxr-xr-x 1 root root 35672 Sep 23 2020 sync + -rwxr-xr-x 1 root root 535768 Feb 17 2021 tar + -rwxr-xr-x 1 root root 10568 Sep 28 2020 tempfile + -rwxr-xr-x 1 root root 89120 Sep 23 2020 touch + -rwxr-xr-x 1 root root 31512 Sep 23 2020 true + -rwxr-xr-x 1 root root 14264 Feb 27 06:12 ulockmgr_server + -rwsr-xr-x 1 root root 30880 Jul 29 09:09 umount + -rwxr-xr-x 1 root root 35640 Sep 23 2020 uname + -rwxr-xr-x 2 root root 2346 Mar 3 13:30 uncompress + -rwxr-xr-x 1 root root 143088 Sep 23 2020 vdir + -rwxr-xr-x 1 root root 59584 Jul 29 09:09 wdctl + lrwxrwxrwx 1 root root 8 Nov 8 2019 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Mar 3 13:30 zcat + -rwxr-xr-x 1 root root 1678 Mar 3 13:30 zcmp + -rwxr-xr-x 1 root root 5880 Mar 3 13:30 zdiff + -rwxr-xr-x 1 root root 29 Mar 3 13:30 zegrep + -rwxr-xr-x 1 root root 29 Mar 3 13:30 zfgrep + -rwxr-xr-x 1 root root 2081 Mar 3 13:30 zforce + -rwxr-xr-x 1 root root 7585 Mar 3 13:30 zgrep + -rwxr-xr-x 1 root root 2206 Mar 3 13:30 zless + -rwxr-xr-x 1 root root 1842 Mar 3 13:30 zmore + -rwxr-xr-x 1 root root 4553 Mar 3 13:30 znew +I: user script /srv/workspace/pbuilder/31276/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -272,7 +306,7 @@ Get: 60 http://deb.debian.org/debian bullseye/main arm64 libspoa-dev arm64 4.0.7+ds-1+b1 [6992 B] Get: 61 http://deb.debian.org/debian bullseye/main arm64 libthread-pool-dev all 3.0.2-1 [4376 B] Get: 62 http://deb.debian.org/debian bullseye/main arm64 rampler arm64 2.0.0-1 [20.5 kB] -Fetched 27.5 MB in 4s (6791 kB/s) +Fetched 27.5 MB in 4s (6537 kB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package bsdextrautils. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19646 files and directories currently installed.) @@ -536,7 +570,8 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/racon-1.4.20/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../racon_1.4.20-1_source.changes +hostname: Temporary failure in name resolution +I: Running cd /build/racon-1.4.20/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../racon_1.4.20-1_source.changes dpkg-buildpackage: info: source package racon dpkg-buildpackage: info: source version 1.4.20-1 dpkg-buildpackage: info: source distribution unstable @@ -594,56 +629,56 @@ make -f CMakeFiles/Makefile2 all make[2]: Entering directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/depend +make -f CMakeFiles/racon.dir/build.make CMakeFiles/racon.dir/depend make[3]: Entering directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' cd /build/racon-1.4.20/obj-aarch64-linux-gnu && /usr/bin/cmake -E cmake_depends "Unix Makefiles" /build/racon-1.4.20 /build/racon-1.4.20 /build/racon-1.4.20/obj-aarch64-linux-gnu /build/racon-1.4.20/obj-aarch64-linux-gnu /build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon_test.dir/DependInfo.cmake --color= -make -f CMakeFiles/racon.dir/build.make CMakeFiles/racon.dir/depend make[3]: Entering directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' cd /build/racon-1.4.20/obj-aarch64-linux-gnu && /usr/bin/cmake -E cmake_depends "Unix Makefiles" /build/racon-1.4.20 /build/racon-1.4.20 /build/racon-1.4.20/obj-aarch64-linux-gnu /build/racon-1.4.20/obj-aarch64-linux-gnu /build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon.dir/DependInfo.cmake --color= +Dependee "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon.dir/DependInfo.cmake" is newer than depender "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon.dir/depend.internal". +Dependee "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/CMakeDirectoryInformation.cmake" is newer than depender "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon.dir/depend.internal". Dependee "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon_test.dir/DependInfo.cmake" is newer than depender "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon_test.dir/depend.internal". Dependee "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/CMakeDirectoryInformation.cmake" is newer than depender "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon_test.dir/depend.internal". Scanning dependencies of target racon_test -make[3]: Leaving directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' -make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/build -make[3]: Entering directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' -Dependee "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon.dir/DependInfo.cmake" is newer than depender "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon.dir/depend.internal". -Dependee "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/CMakeDirectoryInformation.cmake" is newer than depender "/build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles/racon.dir/depend.internal". Scanning dependencies of target racon make[3]: Leaving directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' make -f CMakeFiles/racon.dir/build.make CMakeFiles/racon.dir/build +make[3]: Leaving directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' +make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/build make[3]: Entering directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' -[ 7%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o +make[3]: Entering directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' +[ 7%] Building CXX object CMakeFiles/racon.dir/src/overlap.cpp.o +[ 21%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o +[ 14%] Building CXX object CMakeFiles/racon.dir/src/logger.cpp.o /usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/test/racon_test.cpp.o -c /build/racon-1.4.20/test/racon_test.cpp -[ 14%] Building CXX object CMakeFiles/racon_test.dir/src/polisher.cpp.o -/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/polisher.cpp.o -c /build/racon-1.4.20/src/polisher.cpp -[ 21%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o -/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/polisher.cpp.o -c /build/racon-1.4.20/src/polisher.cpp -[ 35%] Building CXX object CMakeFiles/racon.dir/src/main.cpp.o -/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/main.cpp.o -c /build/racon-1.4.20/src/main.cpp -[ 28%] Building CXX object CMakeFiles/racon_test.dir/src/logger.cpp.o -[ 42%] Building CXX object CMakeFiles/racon_test.dir/src/overlap.cpp.o -/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/logger.cpp.o -c /build/racon-1.4.20/src/logger.cpp -[ 50%] Building CXX object CMakeFiles/racon_test.dir/src/sequence.cpp.o -[ 57%] Building CXX object CMakeFiles/racon.dir/src/logger.cpp.o +[ 28%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o /usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/logger.cpp.o -c /build/racon-1.4.20/src/logger.cpp +/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/overlap.cpp.o -c /build/racon-1.4.20/src/overlap.cpp +[ 35%] Building CXX object CMakeFiles/racon_test.dir/src/logger.cpp.o +/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/logger.cpp.o -c /build/racon-1.4.20/src/logger.cpp +/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/polisher.cpp.o -c /build/racon-1.4.20/src/polisher.cpp +[ 57%] Building CXX object CMakeFiles/racon_test.dir/src/overlap.cpp.o /usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/overlap.cpp.o -c /build/racon-1.4.20/src/overlap.cpp +[ 42%] Building CXX object CMakeFiles/racon.dir/src/main.cpp.o +[ 57%] Building CXX object CMakeFiles/racon_test.dir/src/polisher.cpp.o +/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/main.cpp.o -c /build/racon-1.4.20/src/main.cpp +/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/polisher.cpp.o -c /build/racon-1.4.20/src/polisher.cpp +[ 64%] Building CXX object CMakeFiles/racon_test.dir/src/sequence.cpp.o /usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/sequence.cpp.o -c /build/racon-1.4.20/src/sequence.cpp -[ 64%] Building CXX object CMakeFiles/racon_test.dir/src/window.cpp.o -/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/window.cpp.o -c /build/racon-1.4.20/src/window.cpp -[ 71%] Building CXX object CMakeFiles/racon.dir/src/overlap.cpp.o -/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/overlap.cpp.o -c /build/racon-1.4.20/src/overlap.cpp -[ 78%] Building CXX object CMakeFiles/racon.dir/src/sequence.cpp.o +[ 71%] Building CXX object CMakeFiles/racon.dir/src/sequence.cpp.o /usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/sequence.cpp.o -c /build/racon-1.4.20/src/sequence.cpp -[ 85%] Building CXX object CMakeFiles/racon.dir/src/window.cpp.o +[ 78%] Building CXX object CMakeFiles/racon.dir/src/window.cpp.o /usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -o CMakeFiles/racon.dir/src/window.cpp.o -c /build/racon-1.4.20/src/window.cpp +[ 85%] Building CXX object CMakeFiles/racon_test.dir/src/window.cpp.o +/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-aarch64-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -o CMakeFiles/racon_test.dir/src/window.cpp.o -c /build/racon-1.4.20/src/window.cpp [ 92%] Linking CXX executable bin/racon /usr/bin/cmake -E cmake_link_script CMakeFiles/racon.dir/link.txt --verbose=1 /usr/bin/c++ -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -Wl,-z,relro -Wl,-z,now -rdynamic -pthread CMakeFiles/racon.dir/src/main.cpp.o CMakeFiles/racon.dir/src/logger.cpp.o CMakeFiles/racon.dir/src/polisher.cpp.o CMakeFiles/racon.dir/src/overlap.cpp.o CMakeFiles/racon.dir/src/sequence.cpp.o CMakeFiles/racon.dir/src/window.cpp.o -o bin/racon -lspoa -ledlib -lz +make[3]: Leaving directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' +[ 92%] Built target racon [100%] Linking CXX executable bin/racon_test /usr/bin/cmake -E cmake_link_script CMakeFiles/racon_test.dir/link.txt --verbose=1 /usr/bin/c++ -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -Wl,-z,relro -Wl,-z,now -rdynamic CMakeFiles/racon_test.dir/test/racon_test.cpp.o CMakeFiles/racon_test.dir/src/logger.cpp.o CMakeFiles/racon_test.dir/src/polisher.cpp.o CMakeFiles/racon_test.dir/src/overlap.cpp.o CMakeFiles/racon_test.dir/src/sequence.cpp.o CMakeFiles/racon_test.dir/src/window.cpp.o -o bin/racon_test -lspoa -ledlib /usr/lib/aarch64-linux-gnu/libgtest_main.a -lz /usr/lib/aarch64-linux-gnu/libgtest.a -pthread make[3]: Leaving directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' -[100%] Built target racon -make[3]: Leaving directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' [100%] Built target racon_test make[2]: Leaving directory '/build/racon-1.4.20/obj-aarch64-linux-gnu' /usr/bin/cmake -E cmake_progress_start /build/racon-1.4.20/obj-aarch64-linux-gnu/CMakeFiles 0 @@ -656,112 +691,112 @@ [----------] Global test environment set-up. [----------] 5 tests from RaconInitializeTest [ RUN ] RaconInitializeTest.PolisherTypeError -[ OK ] RaconInitializeTest.PolisherTypeError (5 ms) +[ OK ] RaconInitializeTest.PolisherTypeError (6 ms) [ RUN ] RaconInitializeTest.WindowLengthError -[ OK ] RaconInitializeTest.WindowLengthError (7 ms) +[ OK ] RaconInitializeTest.WindowLengthError (8 ms) [ RUN ] RaconInitializeTest.SequencesPathExtensionError -[ OK ] RaconInitializeTest.SequencesPathExtensionError (8 ms) +[ OK ] RaconInitializeTest.SequencesPathExtensionError (2 ms) [ RUN ] RaconInitializeTest.OverlapsPathExtensionError [ OK ] RaconInitializeTest.OverlapsPathExtensionError (6 ms) [ RUN ] RaconInitializeTest.TargetPathExtensionError [ OK ] RaconInitializeTest.TargetPathExtensionError (6 ms) -[----------] 5 tests from RaconInitializeTest (32 ms total) +[----------] 5 tests from RaconInitializeTest (28 ms total) [----------] 10 tests from RaconPolishingTest [ RUN ] RaconPolishingTest.ConsensusWithQualities -[racon::Polisher::initialize] loaded target sequences 0.001082 s -[racon::Polisher::initialize] loaded sequences 0.193621 s -[racon::Polisher::initialize] loaded overlaps 0.008955 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.150353 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.187345 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.227327 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.287359 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.323332 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.347321 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.423315 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.451326 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.487324 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.555332 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.579335 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.623329 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.655322 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.695335 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.723336 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.763324 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.787322 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.827337 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.867328 s [racon::Polisher::initialize] aligning overlaps [====================] 0.915338 s -[racon::Polisher::initialize] transformed data into windows 0.004851 s -[racon::Polisher::polish] generating consensus [=> ] 0.170866 s [racon::Polisher::polish] generating consensus [==> ] 0.318903 s [racon::Polisher::polish] generating consensus [===> ] 0.462889 s [racon::Polisher::polish] generating consensus [====> ] 0.550910 s [racon::Polisher::polish] generating consensus [=====> ] 0.635002 s [racon::Polisher::polish] generating consensus [======> ] 0.714891 s [racon::Polisher::polish] generating consensus [=======> ] 0.758882 s [racon::Polisher::polish] generating consensus [========> ] 0.866921 s [racon::Polisher::polish] generating consensus [=========> ] 0.946877 s [racon::Polisher::polish] generating consensus [==========> ] 1.078875 s [racon::Polisher::polish] generating consensus [===========> ] 1.306878 s [racon::Polisher::polish] generating consensus [============> ] 1.466887 s [racon::Polisher::polish] generating consensus [=============> ] 1.802874 s [racon::Polisher::polish] generating consensus [==============> ] 2.058882 s [racon::Polisher::polish] generating consensus [===============> ] 2.258889 s [racon::Polisher::polish] generating consensus [================> ] 2.398873 s [racon::Polisher::polish] generating consensus [=================> ] 2.630873 s [racon::Polisher::polish] generating consensus [==================> ] 2.786882 s [racon::Polisher::polish] generating consensus [===================>] 2.958874 s [racon::Polisher::polish] generating consensus [====================] 3.546343 s -[racon::Polisher::] total = 4.714170 s -[ OK ] RaconPolishingTest.ConsensusWithQualities (4723 ms) +[racon::Polisher::initialize] loaded target sequences 0.001073 s +[racon::Polisher::initialize] loaded sequences 0.125902 s +[racon::Polisher::initialize] loaded overlaps 0.000649 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.180879 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.254729 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.277810 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.313811 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.349809 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.366082 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.433845 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.453819 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.481812 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.565008 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.565061 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.577835 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.617811 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.657817 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.677819 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.721846 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.761801 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.797812 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.829802 s [racon::Polisher::initialize] aligning overlaps [====================] 0.877821 s +[racon::Polisher::initialize] transformed data into windows 0.004481 s +[racon::Polisher::polish] generating consensus [=> ] 0.151297 s [racon::Polisher::polish] generating consensus [==> ] 0.271284 s [racon::Polisher::polish] generating consensus [===> ] 0.398953 s [racon::Polisher::polish] generating consensus [====> ] 0.491259 s [racon::Polisher::polish] generating consensus [=====> ] 0.503267 s [racon::Polisher::polish] generating consensus [======> ] 0.567256 s [racon::Polisher::polish] generating consensus [=======> ] 0.639270 s [racon::Polisher::polish] generating consensus [========> ] 0.671308 s [racon::Polisher::polish] generating consensus [=========> ] 0.767269 s [racon::Polisher::polish] generating consensus [==========> ] 0.903240 s [racon::Polisher::polish] generating consensus [===========> ] 1.047263 s [racon::Polisher::polish] generating consensus [============> ] 1.127249 s [racon::Polisher::polish] generating consensus [=============> ] 1.451307 s [racon::Polisher::polish] generating consensus [==============> ] 1.691270 s [racon::Polisher::polish] generating consensus [===============> ] 1.811257 s [racon::Polisher::polish] generating consensus [================> ] 1.891247 s [racon::Polisher::polish] generating consensus [=================> ] 2.031261 s [racon::Polisher::polish] generating consensus [==================> ] 2.175246 s [racon::Polisher::polish] generating consensus [===================>] 2.243882 s [racon::Polisher::polish] generating consensus [====================] 2.830918 s +[racon::Polisher::] total = 3.871991 s +[ OK ] RaconPolishingTest.ConsensusWithQualities (3885 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualities -[racon::Polisher::initialize] loaded target sequences 0.001007 s -[racon::Polisher::initialize] loaded sequences 0.051205 s -[racon::Polisher::initialize] loaded overlaps 0.000592 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.083087 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.131068 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.167081 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.211084 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.247080 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.271072 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.323084 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.371073 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.391073 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.439075 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.467076 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.503099 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.559087 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.575055 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.627072 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.687087 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.707091 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.747070 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.795079 s [racon::Polisher::initialize] aligning overlaps [====================] 0.855095 s -[racon::Polisher::initialize] transformed data into windows 0.001041 s -[racon::Polisher::polish] generating consensus [=> ] 0.206706 s [racon::Polisher::polish] generating consensus [==> ] 0.406655 s [racon::Polisher::polish] generating consensus [===> ] 0.558670 s [racon::Polisher::polish] generating consensus [====> ] 0.642699 s [racon::Polisher::polish] generating consensus [=====> ] 0.706656 s [racon::Polisher::polish] generating consensus [======> ] 0.778660 s [racon::Polisher::polish] generating consensus [=======> ] 0.866678 s [racon::Polisher::polish] generating consensus [========> ] 1.006657 s [racon::Polisher::polish] generating consensus [=========> ] 1.078657 s [racon::Polisher::polish] generating consensus [==========> ] 1.242659 s [racon::Polisher::polish] generating consensus [===========> ] 1.482673 s [racon::Polisher::polish] generating consensus [============> ] 1.718659 s [racon::Polisher::polish] generating consensus [=============> ] 2.110663 s [racon::Polisher::polish] generating consensus [==============> ] 2.274673 s [racon::Polisher::polish] generating consensus [===============> ] 2.602662 s [racon::Polisher::polish] generating consensus [================> ] 2.838647 s [racon::Polisher::polish] generating consensus [=================> ] 3.070668 s [racon::Polisher::polish] generating consensus [==================> ] 3.154648 s [racon::Polisher::polish] generating consensus [===================>] 3.378669 s [racon::Polisher::polish] generating consensus [====================] 4.350808 s -[racon::Polisher::] total = 5.300224 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualities (5314 ms) +[racon::Polisher::initialize] loaded target sequences 0.000966 s +[racon::Polisher::initialize] loaded sequences 0.080751 s +[racon::Polisher::initialize] loaded overlaps 0.000570 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.097522 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.145539 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.185525 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.249536 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.305525 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.349539 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.409536 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.461527 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.506252 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.550417 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.589956 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.645851 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.713782 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.749543 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.806706 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.864208 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.913532 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.965983 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.029526 s [racon::Polisher::initialize] aligning overlaps [====================] 1.109597 s +[racon::Polisher::initialize] transformed data into windows 0.000915 s +[racon::Polisher::polish] generating consensus [=> ] 0.250822 s [racon::Polisher::polish] generating consensus [==> ] 0.498301 s [racon::Polisher::polish] generating consensus [===> ] 0.710777 s [racon::Polisher::polish] generating consensus [====> ] 0.886794 s [racon::Polisher::polish] generating consensus [=====> ] 0.932344 s [racon::Polisher::polish] generating consensus [======> ] 1.038788 s [racon::Polisher::polish] generating consensus [=======> ] 1.130754 s [racon::Polisher::polish] generating consensus [========> ] 1.326821 s [racon::Polisher::polish] generating consensus [=========> ] 1.439437 s [racon::Polisher::polish] generating consensus [==========> ] 1.738766 s [racon::Polisher::polish] generating consensus [===========> ] 1.982857 s [racon::Polisher::polish] generating consensus [============> ] 2.410795 s [racon::Polisher::polish] generating consensus [=============> ] 2.638791 s [racon::Polisher::polish] generating consensus [==============> ] 3.038776 s [racon::Polisher::polish] generating consensus [===============> ] 3.406784 s [racon::Polisher::polish] generating consensus [================> ] 3.706808 s [racon::Polisher::polish] generating consensus [=================> ] 4.054784 s [racon::Polisher::polish] generating consensus [==================> ] 4.242782 s [racon::Polisher::polish] generating consensus [===================>] 4.514797 s [racon::Polisher::polish] generating consensus [====================] 5.634899 s +[racon::Polisher::] total = 6.861089 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualities (6874 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments -[racon::Polisher::initialize] loaded target sequences 0.001004 s -[racon::Polisher::initialize] loaded sequences 0.127355 s -[racon::Polisher::initialize] loaded overlaps 0.060035 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.022580 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.023384 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.024204 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.024973 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.025231 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.025565 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.026058 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.026391 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.026812 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.027182 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.027641 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.028129 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.028706 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.031868 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.031908 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.031927 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.031945 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.031963 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.031979 s [racon::Polisher::initialize] aligning overlaps [====================] 0.031996 s -[racon::Polisher::initialize] transformed data into windows 0.004465 s -[racon::Polisher::polish] generating consensus [=> ] 0.271753 s [racon::Polisher::polish] generating consensus [==> ] 0.361770 s [racon::Polisher::polish] generating consensus [===> ] 0.543712 s [racon::Polisher::polish] generating consensus [====> ] 0.615762 s [racon::Polisher::polish] generating consensus [=====> ] 0.679710 s [racon::Polisher::polish] generating consensus [======> ] 0.751702 s [racon::Polisher::polish] generating consensus [=======> ] 0.815699 s [racon::Polisher::polish] generating consensus [========> ] 0.919766 s [racon::Polisher::polish] generating consensus [=========> ] 0.951715 s [racon::Polisher::polish] generating consensus [==========> ] 1.051739 s [racon::Polisher::polish] generating consensus [===========> ] 1.203730 s [racon::Polisher::polish] generating consensus [============> ] 1.355718 s [racon::Polisher::polish] generating consensus [=============> ] 1.599722 s [racon::Polisher::polish] generating consensus [==============> ] 1.827724 s [racon::Polisher::polish] generating consensus [===============> ] 1.983716 s [racon::Polisher::polish] generating consensus [================> ] 2.115702 s [racon::Polisher::polish] generating consensus [=================> ] 2.291729 s [racon::Polisher::polish] generating consensus [==================> ] 2.395713 s [racon::Polisher::polish] generating consensus [===================>] 2.503712 s [racon::Polisher::polish] generating consensus [====================] 3.047853 s -[racon::Polisher::] total = 3.303248 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (3313 ms) +[racon::Polisher::initialize] loaded target sequences 0.000980 s +[racon::Polisher::initialize] loaded sequences 0.146538 s +[racon::Polisher::initialize] loaded overlaps 0.039697 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.008053 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.008440 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.008830 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.009270 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.009579 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.009894 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.010388 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.010722 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.011140 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.011507 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.012810 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.012979 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.013484 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.013779 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.014267 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.014791 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.015058 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.015510 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.016689 s [racon::Polisher::initialize] aligning overlaps [====================] 0.016718 s +[racon::Polisher::initialize] transformed data into windows 0.004647 s +[racon::Polisher::polish] generating consensus [=> ] 0.274318 s [racon::Polisher::polish] generating consensus [==> ] 0.382285 s [racon::Polisher::polish] generating consensus [===> ] 0.518271 s [racon::Polisher::polish] generating consensus [====> ] 0.602315 s [racon::Polisher::polish] generating consensus [=====> ] 0.646264 s [racon::Polisher::polish] generating consensus [======> ] 0.686466 s [racon::Polisher::polish] generating consensus [=======> ] 0.738272 s [racon::Polisher::polish] generating consensus [========> ] 0.818365 s [racon::Polisher::polish] generating consensus [=========> ] 0.919704 s [racon::Polisher::polish] generating consensus [==========> ] 1.066274 s [racon::Polisher::polish] generating consensus [===========> ] 1.338282 s [racon::Polisher::polish] generating consensus [============> ] 1.470315 s [racon::Polisher::polish] generating consensus [=============> ] 1.858280 s [racon::Polisher::polish] generating consensus [==============> ] 2.086287 s [racon::Polisher::polish] generating consensus [===============> ] 2.290284 s [racon::Polisher::polish] generating consensus [================> ] 2.490287 s [racon::Polisher::polish] generating consensus [=================> ] 2.605319 s [racon::Polisher::polish] generating consensus [==================> ] 2.746268 s [racon::Polisher::polish] generating consensus [===================>] 2.938279 s [racon::Polisher::polish] generating consensus [====================] 3.602416 s +[racon::Polisher::] total = 3.845415 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (3859 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments -[racon::Polisher::initialize] loaded target sequences 0.000969 s -[racon::Polisher::initialize] loaded sequences 0.051086 s -[racon::Polisher::initialize] loaded overlaps 0.063151 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.011810 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.012117 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.012311 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.012625 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.012810 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.013054 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.013352 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.013620 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.013848 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.014085 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.014423 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.014759 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.015079 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.017205 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.017240 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.017257 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.017275 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.017290 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.017306 s [racon::Polisher::initialize] aligning overlaps [====================] 0.017322 s -[racon::Polisher::initialize] transformed data into windows 0.000959 s -[racon::Polisher::polish] generating consensus [=> ] 0.212904 s [racon::Polisher::polish] generating consensus [==> ] 0.351976 s [racon::Polisher::polish] generating consensus [===> ] 0.464839 s [racon::Polisher::polish] generating consensus [====> ] 0.592903 s [racon::Polisher::polish] generating consensus [=====> ] 0.616853 s [racon::Polisher::polish] generating consensus [======> ] 0.676845 s [racon::Polisher::polish] generating consensus [=======> ] 0.736835 s [racon::Polisher::polish] generating consensus [========> ] 0.848916 s [racon::Polisher::polish] generating consensus [=========> ] 0.940852 s [racon::Polisher::polish] generating consensus [==========> ] 1.100847 s [racon::Polisher::polish] generating consensus [===========> ] 1.264845 s [racon::Polisher::polish] generating consensus [============> ] 1.488859 s [racon::Polisher::polish] generating consensus [=============> ] 1.820847 s [racon::Polisher::polish] generating consensus [==============> ] 2.040848 s [racon::Polisher::polish] generating consensus [===============> ] 2.308842 s [racon::Polisher::polish] generating consensus [================> ] 2.424847 s [racon::Polisher::polish] generating consensus [=================> ] 2.632858 s [racon::Polisher::polish] generating consensus [==================> ] 2.732850 s [racon::Polisher::polish] generating consensus [===================>] 2.860846 s [racon::Polisher::polish] generating consensus [====================] 3.704966 s -[racon::Polisher::] total = 3.864685 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (3868 ms) +[racon::Polisher::initialize] loaded target sequences 0.000980 s +[racon::Polisher::initialize] loaded sequences 0.071614 s +[racon::Polisher::initialize] loaded overlaps 0.087310 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.024817 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.025636 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.026492 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.027375 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.028028 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.028740 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.029613 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.046347 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.046397 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.046417 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.046434 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.046452 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.046468 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.046485 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.046501 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.046519 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.046537 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.046553 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.046571 s [racon::Polisher::initialize] aligning overlaps [====================] 0.046588 s +[racon::Polisher::initialize] transformed data into windows 0.001013 s +[racon::Polisher::polish] generating consensus [=> ] 0.314603 s [racon::Polisher::polish] generating consensus [==> ] 0.502574 s [racon::Polisher::polish] generating consensus [===> ] 0.646541 s [racon::Polisher::polish] generating consensus [====> ] 0.790685 s [racon::Polisher::polish] generating consensus [=====> ] 0.842858 s [racon::Polisher::polish] generating consensus [======> ] 0.938545 s [racon::Polisher::polish] generating consensus [=======> ] 1.001847 s [racon::Polisher::polish] generating consensus [========> ] 1.110607 s [racon::Polisher::polish] generating consensus [=========> ] 1.210531 s [racon::Polisher::polish] generating consensus [==========> ] 1.394549 s [racon::Polisher::polish] generating consensus [===========> ] 1.618572 s [racon::Polisher::polish] generating consensus [============> ] 1.890536 s [racon::Polisher::polish] generating consensus [=============> ] 2.346538 s [racon::Polisher::polish] generating consensus [==============> ] 2.726542 s [racon::Polisher::polish] generating consensus [===============> ] 3.030536 s [racon::Polisher::polish] generating consensus [================> ] 3.310552 s [racon::Polisher::polish] generating consensus [=================> ] 3.558544 s [racon::Polisher::polish] generating consensus [==================> ] 3.586529 s [racon::Polisher::polish] generating consensus [===================>] 3.758542 s [racon::Polisher::polish] generating consensus [====================] 4.820211 s +[racon::Polisher::] total = 5.057470 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (5062 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow -[racon::Polisher::initialize] loaded target sequences 0.000997 s -[racon::Polisher::initialize] loaded sequences 0.122516 s -[racon::Polisher::initialize] loaded overlaps 0.000591 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.060238 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.098269 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.130272 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.172702 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.205435 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.230266 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.294267 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.338273 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.372044 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.414280 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.462268 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.494275 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.558264 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.593394 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.618275 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.666262 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.690262 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.728075 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.762254 s [racon::Polisher::initialize] aligning overlaps [====================] 0.814275 s -[racon::Polisher::initialize] transformed data into windows 0.004438 s -[racon::Polisher::polish] generating consensus [=> ] 0.455343 s [racon::Polisher::polish] generating consensus [==> ] 0.455408 s [racon::Polisher::polish] generating consensus [===> ] 0.763310 s [racon::Polisher::polish] generating consensus [====> ] 0.763394 s [racon::Polisher::polish] generating consensus [=====> ] 0.891313 s [racon::Polisher::polish] generating consensus [======> ] 0.935303 s [racon::Polisher::polish] generating consensus [=======> ] 1.059298 s [racon::Polisher::polish] generating consensus [========> ] 1.159342 s [racon::Polisher::polish] generating consensus [=========> ] 1.315326 s [racon::Polisher::polish] generating consensus [==========> ] 1.547318 s [racon::Polisher::polish] generating consensus [===========> ] 1.783311 s [racon::Polisher::polish] generating consensus [============> ] 2.199311 s [racon::Polisher::polish] generating consensus [=============> ] 2.611315 s [racon::Polisher::polish] generating consensus [==============> ] 2.907308 s [racon::Polisher::polish] generating consensus [===============> ] 3.175312 s [racon::Polisher::polish] generating consensus [================> ] 3.355378 s [racon::Polisher::polish] generating consensus [=================> ] 3.735321 s [racon::Polisher::polish] generating consensus [==================> ] 3.735378 s [racon::Polisher::polish] generating consensus [===================>] 4.143308 s [racon::Polisher::polish] generating consensus [====================] 4.983411 s -[racon::Polisher::] total = 5.958938 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (5969 ms) +[racon::Polisher::initialize] loaded target sequences 0.001024 s +[racon::Polisher::initialize] loaded sequences 0.099061 s +[racon::Polisher::initialize] loaded overlaps 0.000888 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.063562 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.112557 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.143543 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.195556 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.239547 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.259546 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.303555 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.351552 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.401495 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.455569 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.483395 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.524004 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.599553 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.619563 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.663577 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.731565 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.775554 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.835570 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.875555 s [racon::Polisher::initialize] aligning overlaps [====================] 0.943568 s +[racon::Polisher::initialize] transformed data into windows 0.004292 s +[racon::Polisher::polish] generating consensus [=> ] 0.971439 s [racon::Polisher::polish] generating consensus [==> ] 0.971513 s [racon::Polisher::polish] generating consensus [===> ] 1.183425 s [racon::Polisher::polish] generating consensus [====> ] 1.183510 s [racon::Polisher::polish] generating consensus [=====> ] 1.331411 s [racon::Polisher::polish] generating consensus [======> ] 1.423402 s [racon::Polisher::polish] generating consensus [=======> ] 1.576448 s [racon::Polisher::polish] generating consensus [========> ] 1.643775 s [racon::Polisher::polish] generating consensus [=========> ] 1.927409 s [racon::Polisher::polish] generating consensus [==========> ] 2.195414 s [racon::Polisher::polish] generating consensus [===========> ] 2.583439 s [racon::Polisher::polish] generating consensus [============> ] 2.987424 s [racon::Polisher::polish] generating consensus [=============> ] 3.707404 s [racon::Polisher::polish] generating consensus [==============> ] 3.867415 s [racon::Polisher::polish] generating consensus [===============> ] 4.423403 s [racon::Polisher::polish] generating consensus [================> ] 4.423510 s [racon::Polisher::polish] generating consensus [=================> ] 5.033571 s [racon::Polisher::polish] generating consensus [==================> ] 5.033627 s [racon::Polisher::polish] generating consensus [===================>] 5.447397 s [racon::Polisher::polish] generating consensus [====================] 6.508103 s +[racon::Polisher::] total = 7.586523 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (7604 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesEditDistance -[racon::Polisher::initialize] loaded target sequences 0.005345 s -[racon::Polisher::initialize] loaded sequences 0.106273 s -[racon::Polisher::initialize] loaded overlaps 0.000597 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.068445 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.108428 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.136427 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.180428 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.212419 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.232439 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.276427 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.332428 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.368436 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.404426 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.448429 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.480437 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.532433 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.560423 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.612421 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.644437 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.676466 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.724437 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.764438 s [racon::Polisher::initialize] aligning overlaps [====================] 0.796434 s -[racon::Polisher::initialize] transformed data into windows 0.004688 s -[racon::Polisher::polish] generating consensus [=> ] 0.223106 s [racon::Polisher::polish] generating consensus [==> ] 0.315064 s [racon::Polisher::polish] generating consensus [===> ] 0.411073 s [racon::Polisher::polish] generating consensus [====> ] 0.483092 s [racon::Polisher::polish] generating consensus [=====> ] 0.515076 s [racon::Polisher::polish] generating consensus [======> ] 0.543075 s [racon::Polisher::polish] generating consensus [=======> ] 0.599068 s [racon::Polisher::polish] generating consensus [========> ] 0.655121 s [racon::Polisher::polish] generating consensus [=========> ] 0.735052 s [racon::Polisher::polish] generating consensus [==========> ] 0.827058 s [racon::Polisher::polish] generating consensus [===========> ] 1.043056 s [racon::Polisher::polish] generating consensus [============> ] 1.199061 s [racon::Polisher::polish] generating consensus [=============> ] 1.491075 s [racon::Polisher::polish] generating consensus [==============> ] 1.639063 s [racon::Polisher::polish] generating consensus [===============> ] 1.779072 s [racon::Polisher::polish] generating consensus [================> ] 1.923068 s [racon::Polisher::polish] generating consensus [=================> ] 2.059077 s [racon::Polisher::polish] generating consensus [==================> ] 2.155052 s [racon::Polisher::polish] generating consensus [===================>] 2.283063 s [racon::Polisher::polish] generating consensus [====================] 2.831594 s -[racon::Polisher::] total = 3.773190 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (3779 ms) +[racon::Polisher::initialize] loaded target sequences 0.001407 s +[racon::Polisher::initialize] loaded sequences 0.156130 s +[racon::Polisher::initialize] loaded overlaps 0.000603 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.082505 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.146523 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.186498 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.234569 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.262578 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.302517 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.354517 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.394516 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.450004 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.486504 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.522493 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.571253 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.626508 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.662510 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.698495 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.766516 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.803816 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.862162 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.967477 s [racon::Polisher::initialize] aligning overlaps [====================] 0.986512 s +[racon::Polisher::initialize] transformed data into windows 0.004934 s +[racon::Polisher::polish] generating consensus [=> ] 0.186787 s [racon::Polisher::polish] generating consensus [==> ] 0.350801 s [racon::Polisher::polish] generating consensus [===> ] 0.494778 s [racon::Polisher::polish] generating consensus [====> ] 0.598813 s [racon::Polisher::polish] generating consensus [=====> ] 0.626761 s [racon::Polisher::polish] generating consensus [======> ] 0.702764 s [racon::Polisher::polish] generating consensus [=======> ] 0.758775 s [racon::Polisher::polish] generating consensus [========> ] 0.954838 s [racon::Polisher::polish] generating consensus [=========> ] 0.954911 s [racon::Polisher::polish] generating consensus [==========> ] 1.082784 s [racon::Polisher::polish] generating consensus [===========> ] 1.270766 s [racon::Polisher::polish] generating consensus [============> ] 1.482789 s [racon::Polisher::polish] generating consensus [=============> ] 1.751858 s [racon::Polisher::polish] generating consensus [==============> ] 2.094796 s [racon::Polisher::polish] generating consensus [===============> ] 2.266785 s [racon::Polisher::polish] generating consensus [================> ] 2.466770 s [racon::Polisher::polish] generating consensus [=================> ] 2.614786 s [racon::Polisher::polish] generating consensus [==================> ] 2.733467 s [racon::Polisher::polish] generating consensus [===================>] 2.926785 s [racon::Polisher::polish] generating consensus [====================] 3.562856 s +[racon::Polisher::] total = 4.738506 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (4741 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualities -[racon::Polisher::initialize] loaded target sequences 0.098171 s -[racon::Polisher::initialize] loaded sequences 0.098284 s -[racon::Polisher::initialize] loaded overlaps 0.022306 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.071738 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.111734 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.155719 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.195719 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.231726 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.255741 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.299728 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.311730 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.355737 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.395715 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.427727 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.467729 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.511732 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.555720 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.599709 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.643721 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.671726 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.731733 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.767724 s [racon::Polisher::initialize] aligning overlaps [====================] 0.875726 s -[racon::Polisher::initialize] transformed data into windows 0.009665 s -[racon::Polisher::polish] generating consensus [=> ] 0.110161 s [racon::Polisher::polish] generating consensus [==> ] 0.226309 s [racon::Polisher::polish] generating consensus [===> ] 0.334270 s [racon::Polisher::polish] generating consensus [====> ] 0.334652 s [racon::Polisher::polish] generating consensus [=====> ] 0.414264 s [racon::Polisher::polish] generating consensus [======> ] 0.462336 s [racon::Polisher::polish] generating consensus [=======> ] 0.542475 s [racon::Polisher::polish] generating consensus [========> ] 0.546123 s [racon::Polisher::polish] generating consensus [=========> ] 0.690076 s [racon::Polisher::polish] generating consensus [==========> ] 0.750063 s [racon::Polisher::polish] generating consensus [===========> ] 0.798294 s [racon::Polisher::polish] generating consensus [============> ] 0.834237 s [racon::Polisher::polish] generating consensus [=============> ] 0.894325 s [racon::Polisher::polish] generating consensus [==============> ] 0.894744 s [racon::Polisher::polish] generating consensus [===============> ] 1.042323 s [racon::Polisher::polish] generating consensus [================> ] 1.054141 s [racon::Polisher::polish] generating consensus [=================> ] 1.326269 s [racon::Polisher::polish] generating consensus [==================> ] 1.442280 s [racon::Polisher::polish] generating consensus [===================>] 1.566366 s [racon::Polisher::polish] generating consensus [====================] 1.622322 s -[racon::Polisher::] total = 2.727980 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (2735 ms) +[racon::Polisher::initialize] loaded target sequences 0.118427 s +[racon::Polisher::initialize] loaded sequences 0.082388 s +[racon::Polisher::initialize] loaded overlaps 0.024949 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.089816 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.137819 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.157824 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.185817 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.229845 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.249823 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.277833 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.301838 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.349822 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.389815 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.421817 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.449811 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.513831 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.557823 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.609836 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.661839 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.705823 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.765832 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.817848 s [racon::Polisher::initialize] aligning overlaps [====================] 0.933861 s +[racon::Polisher::initialize] transformed data into windows 0.009446 s +[racon::Polisher::polish] generating consensus [=> ] 0.142353 s [racon::Polisher::polish] generating consensus [==> ] 0.247499 s [racon::Polisher::polish] generating consensus [===> ] 0.370452 s [racon::Polisher::polish] generating consensus [====> ] 0.370856 s [racon::Polisher::polish] generating consensus [=====> ] 0.458457 s [racon::Polisher::polish] generating consensus [======> ] 0.522586 s [racon::Polisher::polish] generating consensus [=======> ] 0.614367 s [racon::Polisher::polish] generating consensus [========> ] 0.614877 s [racon::Polisher::polish] generating consensus [=========> ] 0.786252 s [racon::Polisher::polish] generating consensus [==========> ] 0.862238 s [racon::Polisher::polish] generating consensus [===========> ] 0.930260 s [racon::Polisher::polish] generating consensus [============> ] 0.946436 s [racon::Polisher::polish] generating consensus [=============> ] 1.054513 s [racon::Polisher::polish] generating consensus [==============> ] 1.054947 s [racon::Polisher::polish] generating consensus [===============> ] 1.218514 s [racon::Polisher::polish] generating consensus [================> ] 1.218872 s [racon::Polisher::polish] generating consensus [=================> ] 1.494449 s [racon::Polisher::polish] generating consensus [==================> ] 1.610400 s [racon::Polisher::polish] generating consensus [===================>] 1.746419 s [racon::Polisher::polish] generating consensus [====================] 1.798522 s +[racon::Polisher::] total = 2.969340 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (2973 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.137245 s -[racon::Polisher::initialize] loaded sequences 0.097031 s -[racon::Polisher::initialize] loaded overlaps 0.033821 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.926729 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.482730 s [racon::Polisher::initialize] aligning overlaps [===> ] 1.994725 s [racon::Polisher::initialize] aligning overlaps [====> ] 2.702731 s [racon::Polisher::initialize] aligning overlaps [=====> ] 3.270738 s [racon::Polisher::initialize] aligning overlaps [======> ] 3.794734 s [racon::Polisher::initialize] aligning overlaps [=======> ] 4.538728 s [racon::Polisher::initialize] aligning overlaps [========> ] 5.318739 s [racon::Polisher::initialize] aligning overlaps [=========> ] 6.110724 s [racon::Polisher::initialize] aligning overlaps [==========> ] 6.878727 s [racon::Polisher::initialize] aligning overlaps [===========> ] 7.494727 s [racon::Polisher::initialize] aligning overlaps [============> ] 8.314725 s [racon::Polisher::initialize] aligning overlaps [=============> ] 9.230727 s [racon::Polisher::initialize] aligning overlaps [==============> ] 10.070726 s [racon::Polisher::initialize] aligning overlaps [===============> ] 10.998715 s [racon::Polisher::initialize] aligning overlaps [================> ] 11.846720 s [racon::Polisher::initialize] aligning overlaps [=================> ] 12.718742 s [racon::Polisher::initialize] aligning overlaps [==================> ] 13.622737 s [racon::Polisher::initialize] aligning overlaps [===================>] 14.510737 s [racon::Polisher::initialize] aligning overlaps [====================] 15.458741 s -[racon::Polisher::initialize] transformed data into windows 0.207640 s -[racon::Polisher::polish] generating consensus [=> ] 4.644677 s [racon::Polisher::polish] generating consensus [==> ] 8.128674 s [racon::Polisher::polish] generating consensus [===> ] 11.992698 s [racon::Polisher::polish] generating consensus [====> ] 15.012788 s [racon::Polisher::polish] generating consensus [=====> ] 18.556761 s [racon::Polisher::polish] generating consensus [======> ] 22.520670 s [racon::Polisher::polish] generating consensus [=======> ] 26.380673 s [racon::Polisher::polish] generating consensus [========> ] 29.304674 s [racon::Polisher::polish] generating consensus [=========> ] 33.012696 s [racon::Polisher::polish] generating consensus [==========> ] 37.632716 s [racon::Polisher::polish] generating consensus [===========> ] 41.460808 s [racon::Polisher::polish] generating consensus [============> ] 45.756661 s [racon::Polisher::polish] generating consensus [=============> ] 49.320687 s [racon::Polisher::polish] generating consensus [==============> ] 53.420665 s [racon::Polisher::polish] generating consensus [===============> ] 57.336671 s [racon::Polisher::polish] generating consensus [================> ] 59.616776 s [racon::Polisher::polish] generating consensus [=================> ] 64.036673 s [racon::Polisher::polish] generating consensus [==================> ] 68.136751 s [racon::Polisher::polish] generating consensus [===================>] 72.128656 s [racon::Polisher::polish] generating consensus [====================] 76.008803 s -[racon::Polisher::] total = 91.954614 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (91957 ms) +[racon::Polisher::initialize] loaded target sequences 0.117164 s +[racon::Polisher::initialize] loaded sequences 0.094240 s +[racon::Polisher::initialize] loaded overlaps 0.026368 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.048510 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.724519 s [racon::Polisher::initialize] aligning overlaps [===> ] 2.368565 s [racon::Polisher::initialize] aligning overlaps [====> ] 3.292541 s [racon::Polisher::initialize] aligning overlaps [=====> ] 3.976521 s [racon::Polisher::initialize] aligning overlaps [======> ] 4.575270 s [racon::Polisher::initialize] aligning overlaps [=======> ] 5.392532 s [racon::Polisher::initialize] aligning overlaps [========> ] 6.360512 s [racon::Polisher::initialize] aligning overlaps [=========> ] 7.312874 s [racon::Polisher::initialize] aligning overlaps [==========> ] 8.156519 s [racon::Polisher::initialize] aligning overlaps [===========> ] 8.960550 s [racon::Polisher::initialize] aligning overlaps [============> ] 9.996614 s [racon::Polisher::initialize] aligning overlaps [=============> ] 11.044511 s [racon::Polisher::initialize] aligning overlaps [==============> ] 11.972514 s [racon::Polisher::initialize] aligning overlaps [===============> ] 13.006035 s [racon::Polisher::initialize] aligning overlaps [================> ] 13.901746 s [racon::Polisher::initialize] aligning overlaps [=================> ] 14.908520 s [racon::Polisher::initialize] aligning overlaps [==================> ] 15.908513 s [racon::Polisher::initialize] aligning overlaps [===================>] 16.892739 s [racon::Polisher::initialize] aligning overlaps [====================] 17.780543 s +[racon::Polisher::initialize] transformed data into windows 0.157165 s +[racon::Polisher::polish] generating consensus [=> ] 5.250026 s [racon::Polisher::polish] generating consensus [==> ] 9.298022 s [racon::Polisher::polish] generating consensus [===> ] 13.530146 s [racon::Polisher::polish] generating consensus [====> ] 16.618146 s [racon::Polisher::polish] generating consensus [=====> ] 20.382202 s [racon::Polisher::polish] generating consensus [======> ] 24.362031 s [racon::Polisher::polish] generating consensus [=======> ] 28.166044 s [racon::Polisher::polish] generating consensus [========> ] 31.790038 s [racon::Polisher::polish] generating consensus [=========> ] 36.302023 s [racon::Polisher::polish] generating consensus [==========> ] 41.958031 s [racon::Polisher::polish] generating consensus [===========> ] 46.826141 s [racon::Polisher::polish] generating consensus [============> ] 51.811783 s [racon::Polisher::polish] generating consensus [=============> ] 56.171844 s [racon::Polisher::polish] generating consensus [==============> ] 61.134028 s [racon::Polisher::polish] generating consensus [===============> ] 65.993372 s [racon::Polisher::polish] generating consensus [================> ] 68.734127 s [racon::Polisher::polish] generating consensus [=================> ] 74.950035 s [racon::Polisher::polish] generating consensus [==================> ] 80.574154 s [racon::Polisher::polish] generating consensus [===================>] 86.226024 s [racon::Polisher::polish] generating consensus [====================] 91.510130 s +[racon::Polisher::] total = 109.698724 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (109701 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.047544 s -[racon::Polisher::initialize] loaded sequences 0.051906 s -[racon::Polisher::initialize] loaded overlaps 0.034673 s -[racon::Polisher::initialize] aligning overlaps [=> ] 1.003622 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.715617 s [racon::Polisher::initialize] aligning overlaps [===> ] 2.331607 s [racon::Polisher::initialize] aligning overlaps [====> ] 3.091605 s [racon::Polisher::initialize] aligning overlaps [=====> ] 3.691612 s [racon::Polisher::initialize] aligning overlaps [======> ] 4.179602 s [racon::Polisher::initialize] aligning overlaps [=======> ] 4.787592 s [racon::Polisher::initialize] aligning overlaps [========> ] 5.571593 s [racon::Polisher::initialize] aligning overlaps [=========> ] 6.383605 s [racon::Polisher::initialize] aligning overlaps [==========> ] 7.167607 s [racon::Polisher::initialize] aligning overlaps [===========> ] 7.771629 s [racon::Polisher::initialize] aligning overlaps [============> ] 8.761959 s [racon::Polisher::initialize] aligning overlaps [=============> ] 9.719618 s [racon::Polisher::initialize] aligning overlaps [==============> ] 10.523606 s [racon::Polisher::initialize] aligning overlaps [===============> ] 11.415601 s [racon::Polisher::initialize] aligning overlaps [================> ] 12.227597 s [racon::Polisher::initialize] aligning overlaps [=================> ] 13.075606 s [racon::Polisher::initialize] aligning overlaps [==================> ] 14.035617 s [racon::Polisher::initialize] aligning overlaps [===================>] 15.055620 s [racon::Polisher::initialize] aligning overlaps [====================] 15.923618 s -[racon::Polisher::initialize] transformed data into windows 0.069935 s -[racon::Polisher::polish] generating consensus [=> ] 6.670038 s [racon::Polisher::polish] generating consensus [==> ] 11.290051 s [racon::Polisher::polish] generating consensus [===> ] 16.414135 s [racon::Polisher::polish] generating consensus [====> ] 20.250154 s [racon::Polisher::polish] generating consensus [=====> ] 25.278073 s [racon::Polisher::polish] generating consensus [======> ] 30.602052 s [racon::Polisher::polish] generating consensus [=======> ] 35.946052 s [racon::Polisher::polish] generating consensus [========> ] 40.306048 s [racon::Polisher::polish] generating consensus [=========> ] 45.526057 s [racon::Polisher::polish] generating consensus [==========> ] 51.774106 s [racon::Polisher::polish] generating consensus [===========> ] 56.986168 s [racon::Polisher::polish] generating consensus [============> ] 62.702047 s [racon::Polisher::polish] generating consensus [=============> ] 67.846069 s [racon::Polisher::polish] generating consensus [==============> ] 73.382030 s [racon::Polisher::polish] generating consensus [===============> ] 78.670039 s [racon::Polisher::polish] generating consensus [================> ] 81.550162 s [racon::Polisher::polish] generating consensus [=================> ] 88.018056 s [racon::Polisher::polish] generating consensus [==================> ] 94.058156 s [racon::Polisher::polish] generating consensus [===================>] 99.694052 s [racon::Polisher::polish] generating consensus [====================] 105.112379 s -[racon::Polisher::] total = 121.250471 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (121255 ms) +[racon::Polisher::initialize] loaded target sequences 0.073046 s +[racon::Polisher::initialize] loaded sequences 0.075609 s +[racon::Polisher::initialize] loaded overlaps 0.045384 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.165266 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.955937 s [racon::Polisher::initialize] aligning overlaps [===> ] 2.671393 s [racon::Polisher::initialize] aligning overlaps [====> ] 3.739387 s [racon::Polisher::initialize] aligning overlaps [=====> ] 4.591539 s [racon::Polisher::initialize] aligning overlaps [======> ] 5.307430 s [racon::Polisher::initialize] aligning overlaps [=======> ] 6.291378 s [racon::Polisher::initialize] aligning overlaps [========> ] 7.483400 s [racon::Polisher::initialize] aligning overlaps [=========> ] 8.711377 s [racon::Polisher::initialize] aligning overlaps [==========> ] 9.816571 s [racon::Polisher::initialize] aligning overlaps [===========> ] 10.675387 s [racon::Polisher::initialize] aligning overlaps [============> ] 11.891388 s [racon::Polisher::initialize] aligning overlaps [=============> ] 13.119926 s [racon::Polisher::initialize] aligning overlaps [==============> ] 14.171397 s [racon::Polisher::initialize] aligning overlaps [===============> ] 15.535363 s [racon::Polisher::initialize] aligning overlaps [================> ] 16.789498 s [racon::Polisher::initialize] aligning overlaps [=================> ] 17.955394 s [racon::Polisher::initialize] aligning overlaps [==================> ] 19.231913 s [racon::Polisher::initialize] aligning overlaps [===================>] 20.621802 s [racon::Polisher::initialize] aligning overlaps [====================] 21.811428 s +[racon::Polisher::initialize] transformed data into windows 0.066907 s +[racon::Polisher::polish] generating consensus [=> ] 8.773462 s [racon::Polisher::polish] generating consensus [==> ] 14.837479 s [racon::Polisher::polish] generating consensus [===> ] 21.793442 s [racon::Polisher::polish] generating consensus [====> ] 26.985544 s [racon::Polisher::polish] generating consensus [=====> ] 33.401455 s [racon::Polisher::polish] generating consensus [======> ] 41.761449 s [racon::Polisher::polish] generating consensus [=======> ] 50.169439 s [racon::Polisher::polish] generating consensus [========> ] 56.677436 s [racon::Polisher::polish] generating consensus [=========> ] 64.377902 s [racon::Polisher::polish] generating consensus [==========> ] 74.093472 s [racon::Polisher::polish] generating consensus [===========> ] 83.169547 s [racon::Polisher::polish] generating consensus [============> ] 92.177454 s [racon::Polisher::polish] generating consensus [=============> ] 101.901437 s [racon::Polisher::polish] generating consensus [==============> ] 111.501442 s [racon::Polisher::polish] generating consensus [===============> ] 119.853453 s [racon::Polisher::polish] generating consensus [================> ] 124.529553 s [racon::Polisher::polish] generating consensus [=================> ] 134.661448 s [racon::Polisher::polish] generating consensus [==================> ] 144.153552 s [racon::Polisher::polish] generating consensus [===================>] 152.601439 s [racon::Polisher::polish] generating consensus [====================] 159.716026 s +[racon::Polisher::] total = 181.797784 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (181802 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap -[racon::Polisher::initialize] loaded target sequences 0.108434 s -[racon::Polisher::initialize] loaded sequences 0.065841 s -[racon::Polisher::initialize] loaded overlaps 0.019307 s -[racon::Polisher::initialize] aligning overlaps [=> ] 1.052975 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.740974 s [racon::Polisher::initialize] aligning overlaps [===> ] 2.356993 s [racon::Polisher::initialize] aligning overlaps [====> ] 3.136649 s [racon::Polisher::initialize] aligning overlaps [=====> ] 3.776984 s [racon::Polisher::initialize] aligning overlaps [======> ] 4.412981 s [racon::Polisher::initialize] aligning overlaps [=======> ] 5.232981 s [racon::Polisher::initialize] aligning overlaps [========> ] 6.220985 s [racon::Polisher::initialize] aligning overlaps [=========> ] 7.168980 s [racon::Polisher::initialize] aligning overlaps [==========> ] 7.920971 s [racon::Polisher::initialize] aligning overlaps [===========> ] 8.580990 s [racon::Polisher::initialize] aligning overlaps [============> ] 9.478257 s [racon::Polisher::initialize] aligning overlaps [=============> ] 10.368984 s [racon::Polisher::initialize] aligning overlaps [==============> ] 11.161195 s [racon::Polisher::initialize] aligning overlaps [===============> ] 12.132982 s [racon::Polisher::initialize] aligning overlaps [================> ] 13.176992 s [racon::Polisher::initialize] aligning overlaps [=================> ] 14.161007 s [racon::Polisher::initialize] aligning overlaps [==================> ] 15.156995 s [racon::Polisher::initialize] aligning overlaps [===================>] 16.172993 s [racon::Polisher::initialize] aligning overlaps [====================] 17.201022 s -[racon::Polisher::initialize] transformed data into windows 0.197982 s -[racon::Polisher::polish] generating consensus [=> ] 5.502089 s [racon::Polisher::polish] generating consensus [==> ] 8.862088 s [racon::Polisher::polish] generating consensus [===> ] 13.322162 s [racon::Polisher::polish] generating consensus [====> ] 16.678144 s [racon::Polisher::polish] generating consensus [=====> ] 21.266152 s [racon::Polisher::polish] generating consensus [======> ] 26.126053 s [racon::Polisher::polish] generating consensus [=======> ] 30.946082 s [racon::Polisher::polish] generating consensus [========> ] 34.542174 s [racon::Polisher::polish] generating consensus [=========> ] 39.202078 s [racon::Polisher::polish] generating consensus [==========> ] 45.210139 s [racon::Polisher::polish] generating consensus [===========> ] 50.194202 s [racon::Polisher::polish] generating consensus [============> ] 55.994124 s [racon::Polisher::polish] generating consensus [=============> ] 60.718086 s [racon::Polisher::polish] generating consensus [==============> ] 66.130081 s [racon::Polisher::polish] generating consensus [===============> ] 71.702099 s [racon::Polisher::polish] generating consensus [================> ] 74.858188 s [racon::Polisher::polish] generating consensus [=================> ] 80.990073 s [racon::Polisher::polish] generating consensus [==================> ] 86.450202 s [racon::Polisher::polish] generating consensus [===================>] 90.918072 s [racon::Polisher::polish] generating consensus [====================] 95.502199 s -[racon::Polisher::] total = 113.106170 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (113112 ms) -[----------] 10 tests from RaconPolishingTest (356027 ms total) +[racon::Polisher::initialize] loaded target sequences 0.116919 s +[racon::Polisher::initialize] loaded sequences 0.092222 s +[racon::Polisher::initialize] loaded overlaps 0.024710 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.313424 s [racon::Polisher::initialize] aligning overlaps [==> ] 2.077400 s [racon::Polisher::initialize] aligning overlaps [===> ] 2.793403 s [racon::Polisher::initialize] aligning overlaps [====> ] 3.809396 s [racon::Polisher::initialize] aligning overlaps [=====> ] 4.641402 s [racon::Polisher::initialize] aligning overlaps [======> ] 5.377417 s [racon::Polisher::initialize] aligning overlaps [=======> ] 6.299775 s [racon::Polisher::initialize] aligning overlaps [========> ] 7.525407 s [racon::Polisher::initialize] aligning overlaps [=========> ] 8.649410 s [racon::Polisher::initialize] aligning overlaps [==========> ] 9.553409 s [racon::Polisher::initialize] aligning overlaps [===========> ] 10.277400 s [racon::Polisher::initialize] aligning overlaps [============> ] 11.365392 s [racon::Polisher::initialize] aligning overlaps [=============> ] 12.633406 s [racon::Polisher::initialize] aligning overlaps [==============> ] 13.689143 s [racon::Polisher::initialize] aligning overlaps [===============> ] 15.070663 s [racon::Polisher::initialize] aligning overlaps [================> ] 16.121479 s [racon::Polisher::initialize] aligning overlaps [=================> ] 17.137401 s [racon::Polisher::initialize] aligning overlaps [==================> ] 18.237410 s [racon::Polisher::initialize] aligning overlaps [===================>] 19.437400 s [racon::Polisher::initialize] aligning overlaps [====================] 20.537401 s +[racon::Polisher::initialize] transformed data into windows 0.142332 s +[racon::Polisher::polish] generating consensus [=> ] 4.521734 s [racon::Polisher::polish] generating consensus [==> ] 8.790275 s [racon::Polisher::polish] generating consensus [===> ] 13.862366 s [racon::Polisher::polish] generating consensus [====> ] 17.626787 s [racon::Polisher::polish] generating consensus [=====> ] 22.078289 s [racon::Polisher::polish] generating consensus [======> ] 26.738287 s [racon::Polisher::polish] generating consensus [=======> ] 31.202292 s [racon::Polisher::polish] generating consensus [========> ] 34.558272 s [racon::Polisher::polish] generating consensus [=========> ] 38.822307 s [racon::Polisher::polish] generating consensus [==========> ] 43.726298 s [racon::Polisher::polish] generating consensus [===========> ] 47.894307 s [racon::Polisher::polish] generating consensus [============> ] 52.658273 s [racon::Polisher::polish] generating consensus [=============> ] 56.894300 s [racon::Polisher::polish] generating consensus [==============> ] 61.673034 s [racon::Polisher::polish] generating consensus [===============> ] 66.346304 s [racon::Polisher::polish] generating consensus [================> ] 69.170402 s [racon::Polisher::polish] generating consensus [=================> ] 74.974280 s [racon::Polisher::polish] generating consensus [==================> ] 81.062601 s [racon::Polisher::polish] generating consensus [===================>] 86.822406 s [racon::Polisher::polish] generating consensus [====================] 92.180819 s +[racon::Polisher::] total = 113.105342 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (113114 ms) +[----------] 10 tests from RaconPolishingTest (439615 ms total) [----------] Global test environment tear-down -[==========] 15 tests from 2 test suites ran. (356059 ms total) +[==========] 15 tests from 2 test suites ran. (439643 ms total) [ PASSED ] 15 tests. make[1]: Leaving directory '/build/racon-1.4.20' create-stamp debian/debhelper-build-stamp @@ -801,8 +836,8 @@ dh_gencontrol -O--buildsystem=cmake dh_md5sums -O--buildsystem=cmake dh_builddeb -O--buildsystem=cmake -dpkg-deb: building package 'racon' in '../racon_1.4.20-1_arm64.deb'. dpkg-deb: building package 'racon-dbgsym' in '../racon-dbgsym_1.4.20-1_arm64.deb'. +dpkg-deb: building package 'racon' in '../racon_1.4.20-1_arm64.deb'. dpkg-genbuildinfo --build=binary dpkg-genchanges --build=binary >../racon_1.4.20-1_arm64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -810,12 +845,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/31276/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/31276/tmp/hooks/B01_cleanup finished I: unmounting dev/ptmx filesystem I: unmounting dev/pts filesystem I: unmounting dev/shm filesystem I: unmounting proc filesystem I: unmounting sys filesystem I: cleaning the build env -I: removing directory /srv/workspace/pbuilder/26276 and its subdirectories -I: Current time: Fri Sep 23 11:19:31 -12 2022 -I: pbuilder-time-stamp: 1663975171 +I: removing directory /srv/workspace/pbuilder/31276 and its subdirectories +I: Current time: Sun Aug 22 07:05:46 +14 2021 +I: pbuilder-time-stamp: 1629565546