Diff of the two buildlogs: -- --- b1/build.log 2021-08-12 16:59:33.219020987 +0000 +++ b2/build.log 2021-08-12 17:55:45.633094973 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Sep 14 11:04:54 -12 2022 -I: pbuilder-time-stamp: 1663196694 +I: Current time: Fri Aug 13 06:59:37 +14 2021 +I: pbuilder-time-stamp: 1628787577 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bullseye-reproducible-base.tgz] I: copying local configuration @@ -17,8 +17,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.I__tbr9q/trustedkeys.kbx': General error -gpgv: Signature made Mon Jan 18 22:04:56 2021 -12 +gpgv: keyblock resource '/tmp/dpkg-verify-sig.QGOQHgQC/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 @@ -31,137 +31,171 @@ dpkg-source: info: applying py3 I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/42669/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/7375/tmp/hooks/D01_modify_environment starting +debug: Running on ionos12-i386. +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/7375/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/7375/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='i386' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=16' - DISTRIBUTION='' - HOME='/root' - HOST_ARCH='i386' + 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]="i686-pc-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=i386 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=7' + DIRSTACK=() + DISTRIBUTION= + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=i686 + HOST_ARCH=i386 IFS=' ' - INVOCATION_ID='8fa9992e09b94c0cab58c28caa06a16d' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - LD_LIBRARY_PATH='/usr/lib/libeatmydata' - LD_PRELOAD='libeatmydata.so' - 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='42669' - PS1='# ' - PS2='> ' + INVOCATION_ID=15b53389ad31464f98ee4e87b4322bf4 + LANG=C + LANGUAGE=de_CH:de + LC_ALL=C + LD_LIBRARY_PATH=/usr/lib/libeatmydata + LD_PRELOAD=libeatmydata.so + MACHTYPE=i686-pc-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=7375 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.YPuiR7cCGX/pbuilderrc_kjiP --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.YPuiR7cCGX/b1 --logfile b1/build.log racon_1.4.20-1.dsc' - SUDO_GID='112' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://85.184.249.68: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.YPuiR7cCGX/pbuilderrc_Kze0 --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.YPuiR7cCGX/b2 --logfile b2/build.log --extrapackages usrmerge racon_1.4.20-1.dsc' + SUDO_GID=112 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://78.137.99.97:3128 I: uname -a - Linux ionos6-i386 4.19.0-17-amd64 #1 SMP Debian 4.19.194-3 (2021-07-18) x86_64 GNU/Linux + Linux i-capture-the-hostname 4.19.0-17-686-pae #1 SMP Debian 4.19.194-3 (2021-07-18) i686 GNU/Linux I: ls -l /bin - total 5776 - -rwxr-xr-x 1 root root 1367848 Aug 4 2021 bash - -rwxr-xr-x 3 root root 38280 Jul 20 2020 bunzip2 - -rwxr-xr-x 3 root root 38280 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 38280 Jul 20 2020 bzip2 - -rwxr-xr-x 1 root root 17768 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 38824 Sep 22 2020 cat - -rwxr-xr-x 1 root root 71624 Sep 22 2020 chgrp - -rwxr-xr-x 1 root root 67528 Sep 22 2020 chmod - -rwxr-xr-x 1 root root 75752 Sep 22 2020 chown - -rwxr-xr-x 1 root root 157960 Sep 22 2020 cp - -rwxr-xr-x 1 root root 128724 Dec 10 2020 dash - -rwxr-xr-x 1 root root 124904 Sep 22 2020 date - -rwxr-xr-x 1 root root 92172 Sep 22 2020 dd - -rwxr-xr-x 1 root root 100752 Sep 22 2020 df - -rwxr-xr-x 1 root root 153964 Sep 22 2020 dir - -rwxr-xr-x 1 root root 83644 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 34664 Sep 22 2020 echo - -rwxr-xr-x 1 root root 28 Nov 9 2020 egrep - -rwxr-xr-x 1 root root 34664 Sep 22 2020 false - -rwxr-xr-x 1 root root 28 Nov 9 2020 fgrep - -rwxr-xr-x 1 root root 71928 Jul 28 2021 findmnt - -rwsr-xr-x 1 root root 30112 Feb 26 2021 fusermount - -rwxr-xr-x 1 root root 210488 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 100952 Mar 2 2021 gzip - -rwxr-xr-x 1 root root 21916 Nov 6 2019 hostname - -rwxr-xr-x 1 root root 83980 Sep 22 2020 ln - -rwxr-xr-x 1 root root 55572 Feb 7 2020 login - -rwxr-xr-x 1 root root 153964 Sep 22 2020 ls - -rwxr-xr-x 1 root root 153124 Jul 28 2021 lsblk - -rwxr-xr-x 1 root root 96328 Sep 22 2020 mkdir - -rwxr-xr-x 1 root root 79912 Sep 22 2020 mknod - -rwxr-xr-x 1 root root 47048 Sep 22 2020 mktemp - -rwxr-xr-x 1 root root 58920 Jul 28 2021 more - -rwsr-xr-x 1 root root 50720 Jul 28 2021 mount - -rwxr-xr-x 1 root root 13856 Jul 28 2021 mountpoint - -rwxr-xr-x 1 root root 157996 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 38824 Sep 22 2020 pwd - lrwxrwxrwx 1 root root 4 Aug 4 2021 rbash -> bash - -rwxr-xr-x 1 root root 46984 Sep 22 2020 readlink - -rwxr-xr-x 1 root root 75720 Sep 22 2020 rm - -rwxr-xr-x 1 root root 46984 Sep 22 2020 rmdir - -rwxr-xr-x 1 root root 22292 Sep 27 2020 run-parts - -rwxr-xr-x 1 root root 125036 Dec 22 2018 sed - lrwxrwxrwx 1 root root 4 Sep 13 03:48 sh -> dash - -rwxr-xr-x 1 root root 34696 Sep 22 2020 sleep - -rwxr-xr-x 1 root root 83880 Sep 22 2020 stty - -rwsr-xr-x 1 root root 79396 Jul 28 2021 su - -rwxr-xr-x 1 root root 34696 Sep 22 2020 sync - -rwxr-xr-x 1 root root 602584 Feb 16 2021 tar - -rwxr-xr-x 1 root root 13860 Sep 27 2020 tempfile - -rwxr-xr-x 1 root root 108520 Sep 22 2020 touch - -rwxr-xr-x 1 root root 34664 Sep 22 2020 true - -rwxr-xr-x 1 root root 17768 Feb 26 2021 ulockmgr_server - -rwsr-xr-x 1 root root 30236 Jul 28 2021 umount - -rwxr-xr-x 1 root root 34664 Sep 22 2020 uname - -rwxr-xr-x 2 root root 2346 Mar 2 2021 uncompress - -rwxr-xr-x 1 root root 153964 Sep 22 2020 vdir - -rwxr-xr-x 1 root root 63024 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/42669/tmp/hooks/D02_print_environment finished + total 5792 + -rwxr-xr-x 1 root root 1367848 Aug 5 10:25 bash + -rwxr-xr-x 3 root root 38280 Jul 21 2020 bunzip2 + -rwxr-xr-x 3 root root 38280 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 38280 Jul 21 2020 bzip2 + -rwxr-xr-x 1 root root 17768 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 38824 Sep 23 2020 cat + -rwxr-xr-x 1 root root 71624 Sep 23 2020 chgrp + -rwxr-xr-x 1 root root 67528 Sep 23 2020 chmod + -rwxr-xr-x 1 root root 75752 Sep 23 2020 chown + -rwxr-xr-x 1 root root 157960 Sep 23 2020 cp + -rwxr-xr-x 1 root root 128724 Dec 11 2020 dash + -rwxr-xr-x 1 root root 124904 Sep 23 2020 date + -rwxr-xr-x 1 root root 92172 Sep 23 2020 dd + -rwxr-xr-x 1 root root 100752 Sep 23 2020 df + -rwxr-xr-x 1 root root 153964 Sep 23 2020 dir + -rwxr-xr-x 1 root root 83644 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 34664 Sep 23 2020 echo + -rwxr-xr-x 1 root root 28 Nov 10 2020 egrep + -rwxr-xr-x 1 root root 34664 Sep 23 2020 false + -rwxr-xr-x 1 root root 28 Nov 10 2020 fgrep + -rwxr-xr-x 1 root root 71928 Jul 29 09:09 findmnt + -rwsr-xr-x 1 root root 30112 Feb 27 06:12 fusermount + -rwxr-xr-x 1 root root 210488 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 100952 Mar 3 13:30 gzip + -rwxr-xr-x 1 root root 21916 Nov 8 2019 hostname + -rwxr-xr-x 1 root root 83980 Sep 23 2020 ln + -rwxr-xr-x 1 root root 55572 Feb 8 2020 login + -rwxr-xr-x 1 root root 153964 Sep 23 2020 ls + -rwxr-xr-x 1 root root 153124 Jul 29 09:09 lsblk + -rwxr-xr-x 1 root root 96328 Sep 23 2020 mkdir + -rwxr-xr-x 1 root root 79912 Sep 23 2020 mknod + -rwxr-xr-x 1 root root 47048 Sep 23 2020 mktemp + -rwxr-xr-x 1 root root 58920 Jul 29 09:09 more + -rwsr-xr-x 1 root root 50720 Jul 29 09:09 mount + -rwxr-xr-x 1 root root 13856 Jul 29 09:09 mountpoint + -rwxr-xr-x 1 root root 157996 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 38824 Sep 23 2020 pwd + lrwxrwxrwx 1 root root 4 Aug 5 10:25 rbash -> bash + -rwxr-xr-x 1 root root 46984 Sep 23 2020 readlink + -rwxr-xr-x 1 root root 75720 Sep 23 2020 rm + -rwxr-xr-x 1 root root 46984 Sep 23 2020 rmdir + -rwxr-xr-x 1 root root 22292 Sep 28 2020 run-parts + -rwxr-xr-x 1 root root 125036 Dec 23 2018 sed + lrwxrwxrwx 1 root root 4 Aug 13 07:02 sh -> bash + lrwxrwxrwx 1 root root 4 Aug 11 21:48 sh.distrib -> dash + -rwxr-xr-x 1 root root 34696 Sep 23 2020 sleep + -rwxr-xr-x 1 root root 83880 Sep 23 2020 stty + -rwsr-xr-x 1 root root 79396 Jul 29 09:09 su + -rwxr-xr-x 1 root root 34696 Sep 23 2020 sync + -rwxr-xr-x 1 root root 602584 Feb 17 23:55 tar + -rwxr-xr-x 1 root root 13860 Sep 28 2020 tempfile + -rwxr-xr-x 1 root root 108520 Sep 23 2020 touch + -rwxr-xr-x 1 root root 34664 Sep 23 2020 true + -rwxr-xr-x 1 root root 17768 Feb 27 06:12 ulockmgr_server + -rwsr-xr-x 1 root root 30236 Jul 29 09:09 umount + -rwxr-xr-x 1 root root 34664 Sep 23 2020 uname + -rwxr-xr-x 2 root root 2346 Mar 3 13:30 uncompress + -rwxr-xr-x 1 root root 153964 Sep 23 2020 vdir + -rwxr-xr-x 1 root root 63024 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/7375/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -275,7 +309,7 @@ Get: 60 http://deb.debian.org/debian bullseye/main i386 libspoa-dev i386 4.0.7+ds-1+b1 [6988 B] Get: 61 http://deb.debian.org/debian bullseye/main i386 libthread-pool-dev all 3.0.2-1 [4376 B] Get: 62 http://deb.debian.org/debian bullseye/main i386 rampler i386 2.0.0-1 [23.4 kB] -Fetched 33.0 MB in 1s (58.4 MB/s) +Fetched 33.0 MB in 11s (2881 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 ... 19675 files and directories currently installed.) @@ -538,8 +572,44 @@ Writing extended state information... Building tag database... -> Finished parsing the build-deps +Reading package lists... +Building dependency tree... +Reading state information... +The following additional packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl +The following NEW packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl usrmerge +0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. +Need to get 59.5 kB of archives. +After this operation, 157 kB of additional disk space will be used. +Get:1 http://deb.debian.org/debian bullseye/main i386 libnumber-compare-perl all 0.03-1.1 [6956 B] +Get:2 http://deb.debian.org/debian bullseye/main i386 libtext-glob-perl all 0.11-1 [8888 B] +Get:3 http://deb.debian.org/debian bullseye/main i386 libfile-find-rule-perl all 0.34-1 [30.6 kB] +Get:4 http://deb.debian.org/debian bullseye/main i386 usrmerge all 25 [13.0 kB] +debconf: delaying package configuration, since apt-utils is not installed +Fetched 59.5 kB in 0s (896 kB/s) +Selecting previously unselected package libnumber-compare-perl. +(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 ... 25282 files and directories currently installed.) +Preparing to unpack .../libnumber-compare-perl_0.03-1.1_all.deb ... +Unpacking libnumber-compare-perl (0.03-1.1) ... +Selecting previously unselected package libtext-glob-perl. +Preparing to unpack .../libtext-glob-perl_0.11-1_all.deb ... +Unpacking libtext-glob-perl (0.11-1) ... +Selecting previously unselected package libfile-find-rule-perl. +Preparing to unpack .../libfile-find-rule-perl_0.34-1_all.deb ... +Unpacking libfile-find-rule-perl (0.34-1) ... +Selecting previously unselected package usrmerge. +Preparing to unpack .../archives/usrmerge_25_all.deb ... +Unpacking usrmerge (25) ... +Setting up libtext-glob-perl (0.11-1) ... +Setting up libnumber-compare-perl (0.03-1.1) ... +Setting up libfile-find-rule-perl (0.34-1) ... +Setting up usrmerge (25) ... +The system has been successfully converted. +Processing triggers for man-db (2.9.4-2) ... +Not building database; man-db/auto-update is not 'true'. 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 +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 dpkg-buildpackage: info: source package racon dpkg-buildpackage: info: source version 1.4.20-1 dpkg-buildpackage: info: source distribution unstable @@ -590,7 +660,7 @@ sed -i 's/-lpthread/-pthread/' obj-*/CMakeFiles/racon_test.dir/link.txt make[1]: Leaving directory '/build/racon-1.4.20' dh_auto_build -O--buildsystem=cmake - cd obj-i686-linux-gnu && make -j16 "INSTALL=install --strip-program=true" VERBOSE=1 + cd obj-i686-linux-gnu && make -j7 "INSTALL=install --strip-program=true" VERBOSE=1 make[1]: Entering directory '/build/racon-1.4.20/obj-i686-linux-gnu' /usr/bin/cmake -S/build/racon-1.4.20 -B/build/racon-1.4.20/obj-i686-linux-gnu --check-build-system CMakeFiles/Makefile.cmake 0 /usr/bin/cmake -E cmake_progress_start /build/racon-1.4.20/obj-i686-linux-gnu/CMakeFiles /build/racon-1.4.20/obj-i686-linux-gnu//CMakeFiles/progress.marks @@ -606,38 +676,28 @@ Dependee "/build/racon-1.4.20/obj-i686-linux-gnu/CMakeFiles/CMakeDirectoryInformation.cmake" is newer than depender "/build/racon-1.4.20/obj-i686-linux-gnu/CMakeFiles/racon_test.dir/depend.internal". Dependee "/build/racon-1.4.20/obj-i686-linux-gnu/CMakeFiles/racon.dir/DependInfo.cmake" is newer than depender "/build/racon-1.4.20/obj-i686-linux-gnu/CMakeFiles/racon.dir/depend.internal". Dependee "/build/racon-1.4.20/obj-i686-linux-gnu/CMakeFiles/CMakeDirectoryInformation.cmake" is newer than depender "/build/racon-1.4.20/obj-i686-linux-gnu/CMakeFiles/racon.dir/depend.internal". -Scanning dependencies of target racon_test Scanning dependencies of target racon -make[3]: Leaving directory '/build/racon-1.4.20/obj-i686-linux-gnu' -make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/build +Scanning dependencies of target racon_test make[3]: Leaving directory '/build/racon-1.4.20/obj-i686-linux-gnu' make -f CMakeFiles/racon.dir/build.make CMakeFiles/racon.dir/build +make[3]: Leaving directory '/build/racon-1.4.20/obj-i686-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-i686-linux-gnu' make[3]: Entering directory '/build/racon-1.4.20/obj-i686-linux-gnu' -[ 7%] Building CXX object CMakeFiles/racon_test.dir/src/polisher.cpp.o -[ 14%] Building CXX object CMakeFiles/racon_test.dir/src/logger.cpp.o -[ 21%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -[ 28%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -[ 35%] Building CXX object CMakeFiles/racon.dir/src/overlap.cpp.o -[ 42%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -[ 50%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o -[ 57%] Building CXX object CMakeFiles/racon.dir/src/main.cpp.o -/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -[ 64%] Building CXX object CMakeFiles/racon.dir/src/logger.cpp.o -/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -[ 71%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o -[ 78%] Building CXX object CMakeFiles/racon_test.dir/src/window.cpp.o +[ 7%] Building CXX object CMakeFiles/racon.dir/src/logger.cpp.o /usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +[ 21%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +[ 21%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o +/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +[ 35%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o +[ 42%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 -[ 85%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +[ 50%] Building CXX object CMakeFiles/racon_test.dir/src/logger.cpp.o +/usr/bin/c++ -DRACON_VERSION=\"v1.4.20\" -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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.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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 /build/racon-1.4.20/src/overlap.cpp: In member function 'virtual void racon::Overlap::align_overlaps(const char*, uint32_t, const char*, uint32_t)': /build/racon-1.4.20/src/overlap.cpp:219:48: warning: format '%zu' expects argument of type 'size_t', but argument 3 has type 'uint64_t' {aka 'long long unsigned int'} [-Wformat=] 219 | "edlib unable to align pair (%zu x %zu)!\n", q_id_, t_id_); @@ -651,6 +711,12 @@ | | | | unsigned int uint64_t {aka long long unsigned int} | %llu +[ 64%] Building CXX object CMakeFiles/racon_test.dir/src/overlap.cpp.o +[ 71%] Building CXX object CMakeFiles/racon_test.dir/src/polisher.cpp.o +[ 71%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +/usr/bin/c++ -I/build/racon-1.4.20/src -I/build/racon-1.4.20/obj-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 /build/racon-1.4.20/src/overlap.cpp: In member function 'virtual void racon::Overlap::align_overlaps(const char*, uint32_t, const char*, uint32_t)': /build/racon-1.4.20/src/overlap.cpp:219:48: warning: format '%zu' expects argument of type 'size_t', but argument 3 has type 'uint64_t' {aka 'long long unsigned int'} [-Wformat=] 219 | "edlib unable to align pair (%zu x %zu)!\n", q_id_, t_id_); @@ -664,6 +730,10 @@ | | | | unsigned int uint64_t {aka long long unsigned int} | %llu +[ 78%] 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 +[ 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-i686-linux-gnu/config -g -O2 -fdebug-prefix-map=/build/racon-1.4.20=. -fstack-protector-strong -Wformat -Werror=format-security -ffloat-store -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 /build/racon-1.4.20/src/window.cpp: In member function 'bool racon::Window::generate_consensus(std::shared_ptr, bool)': /build/racon-1.4.20/src/window.cpp:142:27: warning: format '%lu' expects argument of type 'long unsigned int', but argument 3 has type 'uint64_t' {aka 'long long unsigned int'} [-Wformat=] 142 | "contig %lu might be chimeric in window %u!\n", id_, rank_); @@ -678,11 +748,11 @@ | | | | long unsigned int uint64_t {aka long long unsigned int} | %llu -[ 92%] Linking CXX executable bin/racon +[ 92%] Linking CXX executable bin/racon_test +[100%] Linking CXX executable bin/racon +/usr/bin/cmake -E cmake_link_script CMakeFiles/racon_test.dir/link.txt --verbose=1 /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 -ffloat-store -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 -[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 -ffloat-store -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/i386-linux-gnu/libgtest_main.a -lz /usr/lib/i386-linux-gnu/libgtest.a -pthread make[3]: Leaving directory '/build/racon-1.4.20/obj-i686-linux-gnu' [100%] Built target racon @@ -699,119 +769,119 @@ [----------] Global test environment set-up. [----------] 5 tests from RaconInitializeTest [ RUN ] RaconInitializeTest.PolisherTypeError -[ OK ] RaconInitializeTest.PolisherTypeError (1 ms) +[ OK ] RaconInitializeTest.PolisherTypeError (3 ms) [ RUN ] RaconInitializeTest.WindowLengthError -[ OK ] RaconInitializeTest.WindowLengthError (1 ms) +[ OK ] RaconInitializeTest.WindowLengthError (2 ms) [ RUN ] RaconInitializeTest.SequencesPathExtensionError -[ OK ] RaconInitializeTest.SequencesPathExtensionError (1 ms) +[ OK ] RaconInitializeTest.SequencesPathExtensionError (2 ms) [ RUN ] RaconInitializeTest.OverlapsPathExtensionError -[ OK ] RaconInitializeTest.OverlapsPathExtensionError (3 ms) +[ OK ] RaconInitializeTest.OverlapsPathExtensionError (11 ms) [ RUN ] RaconInitializeTest.TargetPathExtensionError -[ OK ] RaconInitializeTest.TargetPathExtensionError (2 ms) -[----------] 5 tests from RaconInitializeTest (8 ms total) +[ OK ] RaconInitializeTest.TargetPathExtensionError (11 ms) +[----------] 5 tests from RaconInitializeTest (29 ms total) [----------] 10 tests from RaconPolishingTest [ RUN ] RaconPolishingTest.ConsensusWithQualities -[racon::Polisher::initialize] loaded target sequences 0.000569 s -[racon::Polisher::initialize] loaded sequences 0.038355 s -[racon::Polisher::initialize] loaded overlaps 0.000396 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.039229 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.067637 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.085069 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.116495 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.136996 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.155729 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.191897 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.222099 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.243775 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.278382 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.301869 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.330164 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.370508 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.393702 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.427828 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.461549 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.486626 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.516700 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.546679 s [racon::Polisher::initialize] aligning overlaps [====================] 0.593816 s -[racon::Polisher::initialize] transformed data into windows 0.013054 s -[racon::Polisher::polish] generating consensus [=> ] 0.490227 s [racon::Polisher::polish] generating consensus [==> ] 0.938912 s [racon::Polisher::polish] generating consensus [===> ] 1.284619 s [racon::Polisher::polish] generating consensus [====> ] 1.550286 s [racon::Polisher::polish] generating consensus [=====> ] 1.752394 s [racon::Polisher::polish] generating consensus [======> ] 1.866516 s [racon::Polisher::polish] generating consensus [=======> ] 2.024669 s [racon::Polisher::polish] generating consensus [========> ] 2.286113 s [racon::Polisher::polish] generating consensus [=========> ] 2.593142 s [racon::Polisher::polish] generating consensus [==========> ] 2.962494 s [racon::Polisher::polish] generating consensus [===========> ] 3.515637 s [racon::Polisher::polish] generating consensus [============> ] 4.118024 s [racon::Polisher::polish] generating consensus [=============> ] 4.892605 s [racon::Polisher::polish] generating consensus [==============> ] 5.852785 s [racon::Polisher::polish] generating consensus [===============> ] 6.265553 s [racon::Polisher::polish] generating consensus [================> ] 6.776097 s [racon::Polisher::polish] generating consensus [=================> ] 7.305498 s [racon::Polisher::polish] generating consensus [==================> ] 7.728824 s [racon::Polisher::polish] generating consensus [===================>] 8.156312 s [racon::Polisher::polish] generating consensus [====================] 10.268018 s -[racon::Polisher::] total = 10.942644 s -[ OK ] RaconPolishingTest.ConsensusWithQualities (10947 ms) +[racon::Polisher::initialize] loaded target sequences 0.001860 s +[racon::Polisher::initialize] loaded sequences 0.065739 s +[racon::Polisher::initialize] loaded overlaps 0.001065 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.112483 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.182223 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.220827 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.293999 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.341084 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.379249 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.454306 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.525438 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.570148 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.640793 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.697392 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.759275 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.844424 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.889932 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.964278 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.038269 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.084493 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.143108 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.210651 s [racon::Polisher::initialize] aligning overlaps [====================] 1.303742 s +[racon::Polisher::initialize] transformed data into windows 0.055759 s +[racon::Polisher::polish] generating consensus [=> ] 1.172776 s [racon::Polisher::polish] generating consensus [==> ] 2.219683 s [racon::Polisher::polish] generating consensus [===> ] 2.972668 s [racon::Polisher::polish] generating consensus [====> ] 3.555605 s [racon::Polisher::polish] generating consensus [=====> ] 3.986778 s [racon::Polisher::polish] generating consensus [======> ] 4.290163 s [racon::Polisher::polish] generating consensus [=======> ] 4.639162 s [racon::Polisher::polish] generating consensus [========> ] 5.244572 s [racon::Polisher::polish] generating consensus [=========> ] 5.832553 s [racon::Polisher::polish] generating consensus [==========> ] 6.611290 s [racon::Polisher::polish] generating consensus [===========> ] 7.789411 s [racon::Polisher::polish] generating consensus [============> ] 9.172658 s [racon::Polisher::polish] generating consensus [=============> ] 10.985235 s [racon::Polisher::polish] generating consensus [==============> ] 13.036544 s [racon::Polisher::polish] generating consensus [===============> ] 13.924551 s [racon::Polisher::polish] generating consensus [================> ] 15.075385 s [racon::Polisher::polish] generating consensus [=================> ] 16.239306 s [racon::Polisher::polish] generating consensus [==================> ] 17.175508 s [racon::Polisher::polish] generating consensus [===================>] 18.126645 s [racon::Polisher::polish] generating consensus [====================] 22.693799 s +[racon::Polisher::] total = 24.214416 s +[ OK ] RaconPolishingTest.ConsensusWithQualities (24240 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualities -[racon::Polisher::initialize] loaded target sequences 0.000554 s -[racon::Polisher::initialize] loaded sequences 0.018138 s -[racon::Polisher::initialize] loaded overlaps 0.000308 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.037581 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.072518 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.089308 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.120325 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.141010 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.159736 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.195380 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.226688 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.247530 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.280605 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.305529 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.335072 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.376180 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.399380 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.438770 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.475805 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.499051 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.526470 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.556001 s [racon::Polisher::initialize] aligning overlaps [====================] 0.602124 s -[racon::Polisher::initialize] transformed data into windows 0.000444 s -[racon::Polisher::polish] generating consensus [=> ] 0.521616 s [racon::Polisher::polish] generating consensus [==> ] 1.127021 s [racon::Polisher::polish] generating consensus [===> ] 1.560544 s [racon::Polisher::polish] generating consensus [====> ] 1.901572 s [racon::Polisher::polish] generating consensus [=====> ] 2.104859 s [racon::Polisher::polish] generating consensus [======> ] 2.338821 s [racon::Polisher::polish] generating consensus [=======> ] 2.607361 s [racon::Polisher::polish] generating consensus [========> ] 2.971714 s [racon::Polisher::polish] generating consensus [=========> ] 3.373017 s [racon::Polisher::polish] generating consensus [==========> ] 3.987619 s [racon::Polisher::polish] generating consensus [===========> ] 4.643683 s [racon::Polisher::polish] generating consensus [============> ] 5.420280 s [racon::Polisher::polish] generating consensus [=============> ] 6.574964 s [racon::Polisher::polish] generating consensus [==============> ] 7.427134 s [racon::Polisher::polish] generating consensus [===============> ] 8.268443 s [racon::Polisher::polish] generating consensus [================> ] 8.956908 s [racon::Polisher::polish] generating consensus [=================> ] 9.760326 s [racon::Polisher::polish] generating consensus [==================> ] 10.161753 s [racon::Polisher::polish] generating consensus [===================>] 10.672886 s [racon::Polisher::polish] generating consensus [====================] 13.923524 s -[racon::Polisher::] total = 14.572424 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualities (14577 ms) +[racon::Polisher::initialize] loaded target sequences 0.001205 s +[racon::Polisher::initialize] loaded sequences 0.028820 s +[racon::Polisher::initialize] loaded overlaps 0.000483 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.094692 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.153131 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.186122 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.253408 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.297445 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.335529 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.404723 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.471404 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.515648 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.585368 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.632481 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.692226 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.781699 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.824914 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.898934 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.970087 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.026901 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.086896 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.151527 s [racon::Polisher::initialize] aligning overlaps [====================] 1.243989 s +[racon::Polisher::initialize] transformed data into windows 0.001258 s +[racon::Polisher::polish] generating consensus [=> ] 1.151551 s [racon::Polisher::polish] generating consensus [==> ] 2.502137 s [racon::Polisher::polish] generating consensus [===> ] 3.412207 s [racon::Polisher::polish] generating consensus [====> ] 4.207920 s [racon::Polisher::polish] generating consensus [=====> ] 4.661470 s [racon::Polisher::polish] generating consensus [======> ] 5.179344 s [racon::Polisher::polish] generating consensus [=======> ] 5.697358 s [racon::Polisher::polish] generating consensus [========> ] 6.495108 s [racon::Polisher::polish] generating consensus [=========> ] 7.370474 s [racon::Polisher::polish] generating consensus [==========> ] 8.712974 s [racon::Polisher::polish] generating consensus [===========> ] 10.156889 s [racon::Polisher::polish] generating consensus [============> ] 11.931611 s [racon::Polisher::polish] generating consensus [=============> ] 14.486818 s [racon::Polisher::polish] generating consensus [==============> ] 16.313558 s [racon::Polisher::polish] generating consensus [===============> ] 18.123120 s [racon::Polisher::polish] generating consensus [================> ] 19.812754 s [racon::Polisher::polish] generating consensus [=================> ] 21.195007 s [racon::Polisher::polish] generating consensus [==================> ] 22.082211 s [racon::Polisher::polish] generating consensus [===================>] 23.380443 s [racon::Polisher::polish] generating consensus [====================] 30.343006 s +[racon::Polisher::] total = 31.683865 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualities (31700 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments -[racon::Polisher::initialize] loaded target sequences 0.000493 s -[racon::Polisher::initialize] loaded sequences 0.037224 s -[racon::Polisher::initialize] loaded overlaps 0.020521 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.002398 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.002537 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.002623 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.002746 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.002813 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.002930 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.003047 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.003162 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.003255 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.003341 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.003481 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.003621 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.003791 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.003881 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.003974 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.004133 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.004206 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.004331 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.004448 s [racon::Polisher::initialize] aligning overlaps [====================] 0.004616 s -[racon::Polisher::initialize] transformed data into windows 0.012881 s -[racon::Polisher::polish] generating consensus [=> ] 0.487031 s [racon::Polisher::polish] generating consensus [==> ] 0.943566 s [racon::Polisher::polish] generating consensus [===> ] 1.296380 s [racon::Polisher::polish] generating consensus [====> ] 1.566579 s [racon::Polisher::polish] generating consensus [=====> ] 1.740631 s [racon::Polisher::polish] generating consensus [======> ] 1.864066 s [racon::Polisher::polish] generating consensus [=======> ] 2.017727 s [racon::Polisher::polish] generating consensus [========> ] 2.286728 s [racon::Polisher::polish] generating consensus [=========> ] 2.508795 s [racon::Polisher::polish] generating consensus [==========> ] 2.884966 s [racon::Polisher::polish] generating consensus [===========> ] 3.402576 s [racon::Polisher::polish] generating consensus [============> ] 3.971058 s [racon::Polisher::polish] generating consensus [=============> ] 4.797242 s [racon::Polisher::polish] generating consensus [==============> ] 5.690216 s [racon::Polisher::polish] generating consensus [===============> ] 6.181172 s [racon::Polisher::polish] generating consensus [================> ] 6.686472 s [racon::Polisher::polish] generating consensus [=================> ] 7.204844 s [racon::Polisher::polish] generating consensus [==================> ] 7.584498 s [racon::Polisher::polish] generating consensus [===================>] 7.921174 s [racon::Polisher::polish] generating consensus [====================] 9.901088 s -[racon::Polisher::] total = 10.008312 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (10013 ms) +[racon::Polisher::initialize] loaded target sequences 0.000882 s +[racon::Polisher::initialize] loaded sequences 0.061407 s +[racon::Polisher::initialize] loaded overlaps 0.041522 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.009305 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.009668 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.009966 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.010526 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.010694 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.011161 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.011573 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.011913 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.012531 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.012548 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.012659 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.013085 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.013257 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.013443 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.013863 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.014275 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.014653 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.015201 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.015602 s [racon::Polisher::initialize] aligning overlaps [====================] 0.016243 s +[racon::Polisher::initialize] transformed data into windows 0.049398 s +[racon::Polisher::polish] generating consensus [=> ] 1.118849 s [racon::Polisher::polish] generating consensus [==> ] 2.108022 s [racon::Polisher::polish] generating consensus [===> ] 2.924117 s [racon::Polisher::polish] generating consensus [====> ] 3.509874 s [racon::Polisher::polish] generating consensus [=====> ] 3.900693 s [racon::Polisher::polish] generating consensus [======> ] 4.172701 s [racon::Polisher::polish] generating consensus [=======> ] 4.520336 s [racon::Polisher::polish] generating consensus [========> ] 5.123089 s [racon::Polisher::polish] generating consensus [=========> ] 5.621154 s [racon::Polisher::polish] generating consensus [==========> ] 6.453752 s [racon::Polisher::polish] generating consensus [===========> ] 7.614424 s [racon::Polisher::polish] generating consensus [============> ] 8.802504 s [racon::Polisher::polish] generating consensus [=============> ] 10.690743 s [racon::Polisher::polish] generating consensus [==============> ] 12.799887 s [racon::Polisher::polish] generating consensus [===============> ] 13.864795 s [racon::Polisher::polish] generating consensus [================> ] 15.021679 s [racon::Polisher::polish] generating consensus [=================> ] 16.247894 s [racon::Polisher::polish] generating consensus [==================> ] 17.044042 s [racon::Polisher::polish] generating consensus [===================>] 17.835363 s [racon::Polisher::polish] generating consensus [====================] 22.225176 s +[racon::Polisher::] total = 22.470691 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (22484 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments -[racon::Polisher::initialize] loaded target sequences 0.000535 s -[racon::Polisher::initialize] loaded sequences 0.016461 s -[racon::Polisher::initialize] loaded overlaps 0.020341 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.002084 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.002200 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.002323 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.002455 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.002528 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.002650 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.002770 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.002898 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.003002 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.003201 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.003337 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.003434 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.003600 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.003706 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.003873 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.003984 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.004083 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.004211 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.004394 s [racon::Polisher::initialize] aligning overlaps [====================] 0.004559 s -[racon::Polisher::initialize] transformed data into windows 0.000477 s -[racon::Polisher::polish] generating consensus [=> ] 0.486260 s [racon::Polisher::polish] generating consensus [==> ] 1.028295 s [racon::Polisher::polish] generating consensus [===> ] 1.440979 s [racon::Polisher::polish] generating consensus [====> ] 1.746195 s [racon::Polisher::polish] generating consensus [=====> ] 1.950531 s [racon::Polisher::polish] generating consensus [======> ] 2.187034 s [racon::Polisher::polish] generating consensus [=======> ] 2.408770 s [racon::Polisher::polish] generating consensus [========> ] 2.786594 s [racon::Polisher::polish] generating consensus [=========> ] 3.069481 s [racon::Polisher::polish] generating consensus [==========> ] 3.660398 s [racon::Polisher::polish] generating consensus [===========> ] 4.242364 s [racon::Polisher::polish] generating consensus [============> ] 4.948742 s [racon::Polisher::polish] generating consensus [=============> ] 6.089547 s [racon::Polisher::polish] generating consensus [==============> ] 6.952261 s [racon::Polisher::polish] generating consensus [===============> ] 7.732088 s [racon::Polisher::polish] generating consensus [================> ] 8.526278 s [racon::Polisher::polish] generating consensus [=================> ] 9.227608 s [racon::Polisher::polish] generating consensus [==================> ] 9.538969 s [racon::Polisher::polish] generating consensus [===================>] 9.931757 s [racon::Polisher::polish] generating consensus [====================] 12.827624 s -[racon::Polisher::] total = 12.889773 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (12895 ms) +[racon::Polisher::initialize] loaded target sequences 0.000773 s +[racon::Polisher::initialize] loaded sequences 0.026697 s +[racon::Polisher::initialize] loaded overlaps 0.030731 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.004286 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.004558 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.004720 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.005055 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.005202 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.005472 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.005677 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.006033 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.006248 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.006552 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.006837 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.007077 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.007524 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.007601 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.007941 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.008284 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.008445 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.008734 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.009075 s [racon::Polisher::initialize] aligning overlaps [====================] 0.009481 s +[racon::Polisher::initialize] transformed data into windows 0.000746 s +[racon::Polisher::polish] generating consensus [=> ] 1.107528 s [racon::Polisher::polish] generating consensus [==> ] 2.286590 s [racon::Polisher::polish] generating consensus [===> ] 3.208931 s [racon::Polisher::polish] generating consensus [====> ] 3.848524 s [racon::Polisher::polish] generating consensus [=====> ] 4.321754 s [racon::Polisher::polish] generating consensus [======> ] 4.835953 s [racon::Polisher::polish] generating consensus [=======> ] 5.322717 s [racon::Polisher::polish] generating consensus [========> ] 6.130278 s [racon::Polisher::polish] generating consensus [=========> ] 6.731489 s [racon::Polisher::polish] generating consensus [==========> ] 8.012769 s [racon::Polisher::polish] generating consensus [===========> ] 9.303281 s [racon::Polisher::polish] generating consensus [============> ] 10.863794 s [racon::Polisher::polish] generating consensus [=============> ] 13.366982 s [racon::Polisher::polish] generating consensus [==============> ] 15.076678 s [racon::Polisher::polish] generating consensus [===============> ] 16.755286 s [racon::Polisher::polish] generating consensus [================> ] 18.328477 s [racon::Polisher::polish] generating consensus [=================> ] 19.823344 s [racon::Polisher::polish] generating consensus [==================> ] 20.675722 s [racon::Polisher::polish] generating consensus [===================>] 21.692656 s [racon::Polisher::polish] generating consensus [====================] 27.702338 s +[racon::Polisher::] total = 27.851279 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (27866 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow -[racon::Polisher::initialize] loaded target sequences 0.000510 s -[racon::Polisher::initialize] loaded sequences 0.036008 s -[racon::Polisher::initialize] loaded overlaps 0.000324 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.037780 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.066131 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.085109 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.115673 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.136726 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.154912 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.191190 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.221829 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.244275 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.278090 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.301871 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.331517 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.370936 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.393099 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.427720 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.461135 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.485156 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.514423 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.546142 s [racon::Polisher::initialize] aligning overlaps [====================] 0.591856 s -[racon::Polisher::initialize] transformed data into windows 0.012990 s -[racon::Polisher::polish] generating consensus [=> ] 1.803113 s [racon::Polisher::polish] generating consensus [==> ] 1.803149 s [racon::Polisher::polish] generating consensus [===> ] 3.177642 s [racon::Polisher::polish] generating consensus [====> ] 3.177906 s [racon::Polisher::polish] generating consensus [=====> ] 3.660614 s [racon::Polisher::polish] generating consensus [======> ] 3.874103 s [racon::Polisher::polish] generating consensus [=======> ] 4.129245 s [racon::Polisher::polish] generating consensus [========> ] 4.759249 s [racon::Polisher::polish] generating consensus [=========> ] 5.241740 s [racon::Polisher::polish] generating consensus [==========> ] 6.229369 s [racon::Polisher::polish] generating consensus [===========> ] 7.334783 s [racon::Polisher::polish] generating consensus [============> ] 8.484480 s [racon::Polisher::polish] generating consensus [=============> ] 10.560070 s [racon::Polisher::polish] generating consensus [==============> ] 11.634201 s [racon::Polisher::polish] generating consensus [===============> ] 12.681557 s [racon::Polisher::polish] generating consensus [================> ] 13.515790 s [racon::Polisher::polish] generating consensus [=================> ] 14.659440 s [racon::Polisher::polish] generating consensus [==================> ] 15.126378 s [racon::Polisher::polish] generating consensus [===================>] 16.159523 s [racon::Polisher::polish] generating consensus [====================] 20.113951 s -[racon::Polisher::] total = 20.785496 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (20790 ms) +[racon::Polisher::initialize] loaded target sequences 0.000869 s +[racon::Polisher::initialize] loaded sequences 0.057997 s +[racon::Polisher::initialize] loaded overlaps 0.000834 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.093496 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.146803 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.186737 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.253176 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.298518 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.329573 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.403611 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.467292 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.515373 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.586336 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.634999 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.690539 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.772822 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.814541 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.883567 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.952250 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.002642 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.056395 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.120752 s [racon::Polisher::initialize] aligning overlaps [====================] 1.211487 s +[racon::Polisher::initialize] transformed data into windows 0.051178 s +[racon::Polisher::polish] generating consensus [=> ] 4.119123 s [racon::Polisher::polish] generating consensus [==> ] 4.119173 s [racon::Polisher::polish] generating consensus [===> ] 6.909231 s [racon::Polisher::polish] generating consensus [====> ] 6.909297 s [racon::Polisher::polish] generating consensus [=====> ] 8.104672 s [racon::Polisher::polish] generating consensus [======> ] 8.399775 s [racon::Polisher::polish] generating consensus [=======> ] 9.320477 s [racon::Polisher::polish] generating consensus [========> ] 10.304003 s [racon::Polisher::polish] generating consensus [=========> ] 11.733184 s [racon::Polisher::polish] generating consensus [==========> ] 13.384955 s [racon::Polisher::polish] generating consensus [===========> ] 16.212545 s [racon::Polisher::polish] generating consensus [============> ] 18.123666 s [racon::Polisher::polish] generating consensus [=============> ] 23.111971 s [racon::Polisher::polish] generating consensus [==============> ] 24.807102 s [racon::Polisher::polish] generating consensus [===============> ] 27.713531 s [racon::Polisher::polish] generating consensus [================> ] 28.848293 s [racon::Polisher::polish] generating consensus [=================> ] 31.989221 s [racon::Polisher::polish] generating consensus [==================> ] 32.192225 s [racon::Polisher::polish] generating consensus [===================>] 35.223918 s [racon::Polisher::polish] generating consensus [====================] 43.479802 s +[racon::Polisher::] total = 44.879560 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (44892 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesEditDistance -[racon::Polisher::initialize] loaded target sequences 0.000542 s -[racon::Polisher::initialize] loaded sequences 0.036550 s -[racon::Polisher::initialize] loaded overlaps 0.000318 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.037497 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.065671 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.083795 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.114661 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.135555 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.153801 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.190237 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.221149 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.242360 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.275446 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.299082 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.329918 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.372402 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.393411 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.427993 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.461913 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.486090 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.516109 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.545184 s [racon::Polisher::initialize] aligning overlaps [====================] 0.590209 s -[racon::Polisher::initialize] transformed data into windows 0.013214 s -[racon::Polisher::polish] generating consensus [=> ] 0.476431 s [racon::Polisher::polish] generating consensus [==> ] 0.917112 s [racon::Polisher::polish] generating consensus [===> ] 1.253884 s [racon::Polisher::polish] generating consensus [====> ] 1.514771 s [racon::Polisher::polish] generating consensus [=====> ] 1.701672 s [racon::Polisher::polish] generating consensus [======> ] 1.823094 s [racon::Polisher::polish] generating consensus [=======> ] 1.973859 s [racon::Polisher::polish] generating consensus [========> ] 2.230608 s [racon::Polisher::polish] generating consensus [=========> ] 2.525302 s [racon::Polisher::polish] generating consensus [==========> ] 2.882700 s [racon::Polisher::polish] generating consensus [===========> ] 3.408495 s [racon::Polisher::polish] generating consensus [============> ] 4.006633 s [racon::Polisher::polish] generating consensus [=============> ] 4.764051 s [racon::Polisher::polish] generating consensus [==============> ] 5.634332 s [racon::Polisher::polish] generating consensus [===============> ] 6.079286 s [racon::Polisher::polish] generating consensus [================> ] 6.571171 s [racon::Polisher::polish] generating consensus [=================> ] 7.078496 s [racon::Polisher::polish] generating consensus [==================> ] 7.481397 s [racon::Polisher::polish] generating consensus [===================>] 7.875420 s [racon::Polisher::polish] generating consensus [====================] 9.868169 s -[racon::Polisher::] total = 10.537161 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (10542 ms) +[racon::Polisher::initialize] loaded target sequences 0.000791 s +[racon::Polisher::initialize] loaded sequences 0.056296 s +[racon::Polisher::initialize] loaded overlaps 0.000525 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.095496 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.163121 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.205467 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.276240 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.323567 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.363405 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.444085 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.510632 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.555801 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.629252 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.682352 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.745575 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.830560 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.880384 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.951473 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.027357 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.081148 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.138102 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.209873 s [racon::Polisher::initialize] aligning overlaps [====================] 1.310329 s +[racon::Polisher::initialize] transformed data into windows 0.046215 s +[racon::Polisher::polish] generating consensus [=> ] 1.033815 s [racon::Polisher::polish] generating consensus [==> ] 1.959002 s [racon::Polisher::polish] generating consensus [===> ] 2.710914 s [racon::Polisher::polish] generating consensus [====> ] 3.284715 s [racon::Polisher::polish] generating consensus [=====> ] 3.677117 s [racon::Polisher::polish] generating consensus [======> ] 3.971149 s [racon::Polisher::polish] generating consensus [=======> ] 4.299867 s [racon::Polisher::polish] generating consensus [========> ] 4.846456 s [racon::Polisher::polish] generating consensus [=========> ] 5.459434 s [racon::Polisher::polish] generating consensus [==========> ] 6.207441 s [racon::Polisher::polish] generating consensus [===========> ] 7.304597 s [racon::Polisher::polish] generating consensus [============> ] 8.539011 s [racon::Polisher::polish] generating consensus [=============> ] 10.127688 s [racon::Polisher::polish] generating consensus [==============> ] 12.045821 s [racon::Polisher::polish] generating consensus [===============> ] 13.066095 s [racon::Polisher::polish] generating consensus [================> ] 14.113942 s [racon::Polisher::polish] generating consensus [=================> ] 15.214385 s [racon::Polisher::polish] generating consensus [==================> ] 16.077333 s [racon::Polisher::polish] generating consensus [===================>] 16.884656 s [racon::Polisher::polish] generating consensus [====================] 21.078063 s +[racon::Polisher::] total = 22.556025 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (22570 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualities -[racon::Polisher::initialize] loaded target sequences 0.036545 s -[racon::Polisher::initialize] loaded sequences 0.037254 s -[racon::Polisher::initialize] loaded overlaps 0.008057 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.040371 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.070784 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.101142 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.123038 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.150005 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.164049 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.195526 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.207977 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.237062 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.277084 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.299977 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.335037 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.379977 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.412494 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.452554 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.488139 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.520624 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.570185 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.596736 s [racon::Polisher::initialize] aligning overlaps [====================] 0.686439 s -[racon::Polisher::initialize] transformed data into windows 0.015958 s -[racon::Polisher::polish] generating consensus [=> ] 0.295283 s [racon::Polisher::polish] generating consensus [==> ] 0.608048 s [racon::Polisher::polish] generating consensus [===> ] 0.917399 s [racon::Polisher::polish] generating consensus [====> ] 0.917538 s [racon::Polisher::polish] generating consensus [=====> ] 1.124841 s [racon::Polisher::polish] generating consensus [======> ] 1.266386 s [racon::Polisher::polish] generating consensus [=======> ] 1.460168 s [racon::Polisher::polish] generating consensus [========> ] 1.478047 s [racon::Polisher::polish] generating consensus [=========> ] 1.934137 s [racon::Polisher::polish] generating consensus [==========> ] 2.095056 s [racon::Polisher::polish] generating consensus [===========> ] 2.238567 s [racon::Polisher::polish] generating consensus [============> ] 2.320479 s [racon::Polisher::polish] generating consensus [=============> ] 2.484836 s [racon::Polisher::polish] generating consensus [==============> ] 2.484956 s [racon::Polisher::polish] generating consensus [===============> ] 2.905446 s [racon::Polisher::polish] generating consensus [================> ] 2.905574 s [racon::Polisher::polish] generating consensus [=================> ] 3.720073 s [racon::Polisher::polish] generating consensus [==================> ] 3.980404 s [racon::Polisher::polish] generating consensus [===================>] 4.323384 s [racon::Polisher::polish] generating consensus [====================] 4.469803 s -[racon::Polisher::] total = 5.254586 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (5259 ms) +[racon::Polisher::initialize] loaded target sequences 0.055014 s +[racon::Polisher::initialize] loaded sequences 0.057098 s +[racon::Polisher::initialize] loaded overlaps 0.014823 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.090464 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.151566 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.221448 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.263591 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.319225 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.346492 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.413398 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.442155 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.498667 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.591568 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.629374 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.702717 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.795523 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.878357 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.966683 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.051516 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.111521 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.223240 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.288147 s [racon::Polisher::initialize] aligning overlaps [====================] 1.471337 s +[racon::Polisher::initialize] transformed data into windows 0.067555 s +[racon::Polisher::polish] generating consensus [=> ] 0.669924 s [racon::Polisher::polish] generating consensus [==> ] 1.396838 s [racon::Polisher::polish] generating consensus [===> ] 2.116397 s [racon::Polisher::polish] generating consensus [====> ] 2.116641 s [racon::Polisher::polish] generating consensus [=====> ] 2.591127 s [racon::Polisher::polish] generating consensus [======> ] 2.911325 s [racon::Polisher::polish] generating consensus [=======> ] 3.364513 s [racon::Polisher::polish] generating consensus [========> ] 3.396455 s [racon::Polisher::polish] generating consensus [=========> ] 4.400324 s [racon::Polisher::polish] generating consensus [==========> ] 4.748308 s [racon::Polisher::polish] generating consensus [===========> ] 5.050842 s [racon::Polisher::polish] generating consensus [============> ] 5.235541 s [racon::Polisher::polish] generating consensus [=============> ] 5.607529 s [racon::Polisher::polish] generating consensus [==============> ] 5.608404 s [racon::Polisher::polish] generating consensus [===============> ] 6.525799 s [racon::Polisher::polish] generating consensus [================> ] 6.525994 s [racon::Polisher::polish] generating consensus [=================> ] 8.220962 s [racon::Polisher::polish] generating consensus [==================> ] 8.835743 s [racon::Polisher::polish] generating consensus [===================>] 9.580442 s [racon::Polisher::polish] generating consensus [====================] 9.907433 s +[racon::Polisher::] total = 11.574837 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (11589 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.039361 s -[racon::Polisher::initialize] loaded sequences 0.039925 s -[racon::Polisher::initialize] loaded overlaps 0.008299 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.706104 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.189669 s [racon::Polisher::initialize] aligning overlaps [===> ] 1.620038 s [racon::Polisher::initialize] aligning overlaps [====> ] 2.248322 s [racon::Polisher::initialize] aligning overlaps [=====> ] 2.724477 s [racon::Polisher::initialize] aligning overlaps [======> ] 3.131114 s [racon::Polisher::initialize] aligning overlaps [=======> ] 3.662362 s [racon::Polisher::initialize] aligning overlaps [========> ] 4.346020 s [racon::Polisher::initialize] aligning overlaps [=========> ] 5.032698 s [racon::Polisher::initialize] aligning overlaps [==========> ] 5.646282 s [racon::Polisher::initialize] aligning overlaps [===========> ] 6.131879 s [racon::Polisher::initialize] aligning overlaps [============> ] 6.840531 s [racon::Polisher::initialize] aligning overlaps [=============> ] 7.583859 s [racon::Polisher::initialize] aligning overlaps [==============> ] 8.218906 s [racon::Polisher::initialize] aligning overlaps [===============> ] 8.990905 s [racon::Polisher::initialize] aligning overlaps [================> ] 9.732341 s [racon::Polisher::initialize] aligning overlaps [=================> ] 10.415553 s [racon::Polisher::initialize] aligning overlaps [==================> ] 11.146825 s [racon::Polisher::initialize] aligning overlaps [===================>] 11.917205 s [racon::Polisher::initialize] aligning overlaps [====================] 12.634948 s -[racon::Polisher::initialize] transformed data into windows 0.360836 s -[racon::Polisher::polish] generating consensus [=> ] 16.087360 s [racon::Polisher::polish] generating consensus [==> ] 27.341793 s [racon::Polisher::polish] generating consensus [===> ] 40.156461 s [racon::Polisher::polish] generating consensus [====> ] 50.742077 s [racon::Polisher::polish] generating consensus [=====> ] 62.688782 s [racon::Polisher::polish] generating consensus [======> ] 76.424860 s [racon::Polisher::polish] generating consensus [=======> ] 90.073495 s [racon::Polisher::polish] generating consensus [========> ] 100.456794 s [racon::Polisher::polish] generating consensus [=========> ] 113.251246 s [racon::Polisher::polish] generating consensus [==========> ] 128.610428 s [racon::Polisher::polish] generating consensus [===========> ] 141.404945 s [racon::Polisher::polish] generating consensus [============> ] 155.935041 s [racon::Polisher::polish] generating consensus [=============> ] 168.757793 s [racon::Polisher::polish] generating consensus [==============> ] 182.608575 s [racon::Polisher::polish] generating consensus [===============> ] 196.882013 s [racon::Polisher::polish] generating consensus [================> ] 205.352976 s [racon::Polisher::polish] generating consensus [=================> ] 220.778543 s [racon::Polisher::polish] generating consensus [==================> ] 235.278928 s [racon::Polisher::polish] generating consensus [===================>] 249.476754 s [racon::Polisher::polish] generating consensus [====================] 262.934929 s -[racon::Polisher::] total = 276.020374 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (276026 ms) +[racon::Polisher::initialize] loaded target sequences 0.061001 s +[racon::Polisher::initialize] loaded sequences 0.061927 s +[racon::Polisher::initialize] loaded overlaps 0.016404 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.505503 s [racon::Polisher::initialize] aligning overlaps [==> ] 2.514983 s [racon::Polisher::initialize] aligning overlaps [===> ] 3.418324 s [racon::Polisher::initialize] aligning overlaps [====> ] 4.749262 s [racon::Polisher::initialize] aligning overlaps [=====> ] 5.775704 s [racon::Polisher::initialize] aligning overlaps [======> ] 6.675733 s [racon::Polisher::initialize] aligning overlaps [=======> ] 7.829653 s [racon::Polisher::initialize] aligning overlaps [========> ] 9.286240 s [racon::Polisher::initialize] aligning overlaps [=========> ] 10.745654 s [racon::Polisher::initialize] aligning overlaps [==========> ] 12.050596 s [racon::Polisher::initialize] aligning overlaps [===========> ] 13.048979 s [racon::Polisher::initialize] aligning overlaps [============> ] 14.545160 s [racon::Polisher::initialize] aligning overlaps [=============> ] 16.110696 s [racon::Polisher::initialize] aligning overlaps [==============> ] 17.502634 s [racon::Polisher::initialize] aligning overlaps [===============> ] 19.143618 s [racon::Polisher::initialize] aligning overlaps [================> ] 20.706717 s [racon::Polisher::initialize] aligning overlaps [=================> ] 22.122912 s [racon::Polisher::initialize] aligning overlaps [==================> ] 23.628982 s [racon::Polisher::initialize] aligning overlaps [===================>] 25.258942 s [racon::Polisher::initialize] aligning overlaps [====================] 26.772122 s +[racon::Polisher::initialize] transformed data into windows 1.247797 s +[racon::Polisher::polish] generating consensus [=> ] 40.239577 s [racon::Polisher::polish] generating consensus [==> ] 76.667550 s [racon::Polisher::polish] generating consensus [===> ] 113.155401 s [racon::Polisher::polish] generating consensus [====> ] 144.627592 s [racon::Polisher::polish] generating consensus [=====> ] 170.718025 s [racon::Polisher::polish] generating consensus [======> ] 226.737314 s [racon::Polisher::polish] generating consensus [=======> ] 264.323590 s [racon::Polisher::polish] generating consensus [========> ] 290.367576 s [racon::Polisher::polish] generating consensus [=========> ] 319.083572 s [racon::Polisher::polish] generating consensus [==========> ] 352.690710 s [racon::Polisher::polish] generating consensus [===========> ] 380.557793 s [racon::Polisher::polish] generating consensus [============> ] 411.163770 s [racon::Polisher::polish] generating consensus [=============> ] 438.941296 s [racon::Polisher::polish] generating consensus [==============> ] 469.247452 s [racon::Polisher::polish] generating consensus [===============> ] 504.803575 s [racon::Polisher::polish] generating consensus [================> ] 527.431601 s [racon::Polisher::polish] generating consensus [=================> ] 566.531596 s [racon::Polisher::polish] generating consensus [==================> ] 607.151617 s [racon::Polisher::polish] generating consensus [===================>] 646.383584 s [racon::Polisher::polish] generating consensus [====================] 682.208009 s +[racon::Polisher::] total = 710.372458 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (710387 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.015494 s -[racon::Polisher::initialize] loaded sequences 0.015897 s -[racon::Polisher::initialize] loaded overlaps 0.007772 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.702378 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.189430 s [racon::Polisher::initialize] aligning overlaps [===> ] 1.615359 s [racon::Polisher::initialize] aligning overlaps [====> ] 2.244061 s [racon::Polisher::initialize] aligning overlaps [=====> ] 2.717477 s [racon::Polisher::initialize] aligning overlaps [======> ] 3.123347 s [racon::Polisher::initialize] aligning overlaps [=======> ] 3.657415 s [racon::Polisher::initialize] aligning overlaps [========> ] 4.346644 s [racon::Polisher::initialize] aligning overlaps [=========> ] 5.038472 s [racon::Polisher::initialize] aligning overlaps [==========> ] 5.651401 s [racon::Polisher::initialize] aligning overlaps [===========> ] 6.138331 s [racon::Polisher::initialize] aligning overlaps [============> ] 6.847294 s [racon::Polisher::initialize] aligning overlaps [=============> ] 7.589755 s [racon::Polisher::initialize] aligning overlaps [==============> ] 8.227210 s [racon::Polisher::initialize] aligning overlaps [===============> ] 8.989546 s [racon::Polisher::initialize] aligning overlaps [================> ] 9.733400 s [racon::Polisher::initialize] aligning overlaps [=================> ] 10.418351 s [racon::Polisher::initialize] aligning overlaps [==================> ] 11.158433 s [racon::Polisher::initialize] aligning overlaps [===================>] 11.924143 s [racon::Polisher::initialize] aligning overlaps [====================] 12.640689 s -[racon::Polisher::initialize] transformed data into windows 0.011754 s -[racon::Polisher::polish] generating consensus [=> ] 22.638489 s [racon::Polisher::polish] generating consensus [==> ] 39.225457 s [racon::Polisher::polish] generating consensus [===> ] 56.908428 s [racon::Polisher::polish] generating consensus [====> ] 70.524733 s [racon::Polisher::polish] generating consensus [=====> ] 87.278050 s [racon::Polisher::polish] generating consensus [======> ] 105.407682 s [racon::Polisher::polish] generating consensus [=======> ] 124.638310 s [racon::Polisher::polish] generating consensus [========> ] 139.288380 s [racon::Polisher::polish] generating consensus [=========> ] 157.101503 s [racon::Polisher::polish] generating consensus [==========> ] 178.435374 s [racon::Polisher::polish] generating consensus [===========> ] 196.515483 s [racon::Polisher::polish] generating consensus [============> ] 216.084835 s [racon::Polisher::polish] generating consensus [=============> ] 234.746744 s [racon::Polisher::polish] generating consensus [==============> ] 253.490092 s [racon::Polisher::polish] generating consensus [===============> ] 272.310493 s [racon::Polisher::polish] generating consensus [================> ] 282.667090 s [racon::Polisher::polish] generating consensus [=================> ] 305.962288 s [racon::Polisher::polish] generating consensus [==================> ] 327.460585 s [racon::Polisher::polish] generating consensus [===================>] 348.006491 s [racon::Polisher::polish] generating consensus [====================] 366.655700 s -[racon::Polisher::] total = 379.348948 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (379354 ms) +[racon::Polisher::initialize] loaded target sequences 0.030028 s +[racon::Polisher::initialize] loaded sequences 0.029600 s +[racon::Polisher::initialize] loaded overlaps 0.016868 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.894181 s [racon::Polisher::initialize] aligning overlaps [==> ] 3.092001 s [racon::Polisher::initialize] aligning overlaps [===> ] 4.094252 s [racon::Polisher::initialize] aligning overlaps [====> ] 5.672780 s [racon::Polisher::initialize] aligning overlaps [=====> ] 6.774176 s [racon::Polisher::initialize] aligning overlaps [======> ] 8.215651 s [racon::Polisher::initialize] aligning overlaps [=======> ] 10.834245 s [racon::Polisher::initialize] aligning overlaps [========> ] 13.634174 s [racon::Polisher::initialize] aligning overlaps [=========> ] 16.354169 s [racon::Polisher::initialize] aligning overlaps [==========> ] 18.238157 s [racon::Polisher::initialize] aligning overlaps [===========> ] 19.862155 s [racon::Polisher::initialize] aligning overlaps [============> ] 22.794172 s [racon::Polisher::initialize] aligning overlaps [=============> ] 25.434708 s [racon::Polisher::initialize] aligning overlaps [==============> ] 28.242180 s [racon::Polisher::initialize] aligning overlaps [===============> ] 31.562564 s [racon::Polisher::initialize] aligning overlaps [================> ] 34.514172 s [racon::Polisher::initialize] aligning overlaps [=================> ] 37.542154 s [racon::Polisher::initialize] aligning overlaps [==================> ] 40.198169 s [racon::Polisher::initialize] aligning overlaps [===================>] 43.322176 s [racon::Polisher::initialize] aligning overlaps [====================] 46.192597 s +[racon::Polisher::initialize] transformed data into windows 0.027536 s +[racon::Polisher::polish] generating consensus [=> ] 89.636115 s [racon::Polisher::polish] generating consensus [==> ] 166.140183 s [racon::Polisher::polish] generating consensus [===> ] 242.000915 s [racon::Polisher::polish] generating consensus [====> ] 293.156227 s [racon::Polisher::polish] generating consensus [=====> ] 344.432109 s [racon::Polisher::polish] generating consensus [======> ] 399.676267 s [racon::Polisher::polish] generating consensus [=======> ] 455.440103 s [racon::Polisher::polish] generating consensus [========> ] 501.216199 s [racon::Polisher::polish] generating consensus [=========> ] 553.132135 s [racon::Polisher::polish] generating consensus [==========> ] 611.008152 s [racon::Polisher::polish] generating consensus [===========> ] 659.296268 s [racon::Polisher::polish] generating consensus [============> ] 714.848575 s [racon::Polisher::polish] generating consensus [=============> ] 767.404116 s [racon::Polisher::polish] generating consensus [==============> ] 816.204337 s [racon::Polisher::polish] generating consensus [===============> ] 907.384116 s [racon::Polisher::polish] generating consensus [================> ] 959.800176 s [racon::Polisher::polish] generating consensus [=================> ] 1069.588115 s [racon::Polisher::polish] generating consensus [==================> ] 1165.390617 s [racon::Polisher::polish] generating consensus [===================>] 1250.948120 s [racon::Polisher::polish] generating consensus [====================] 1336.540466 s +[racon::Polisher::] total = 1382.840627 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (1382861 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap -[racon::Polisher::initialize] loaded target sequences 0.035763 s -[racon::Polisher::initialize] loaded sequences 0.036924 s -[racon::Polisher::initialize] loaded overlaps 0.008344 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.710142 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.191750 s [racon::Polisher::initialize] aligning overlaps [===> ] 1.617416 s [racon::Polisher::initialize] aligning overlaps [====> ] 2.244468 s [racon::Polisher::initialize] aligning overlaps [=====> ] 2.720267 s [racon::Polisher::initialize] aligning overlaps [======> ] 3.127188 s [racon::Polisher::initialize] aligning overlaps [=======> ] 3.655918 s [racon::Polisher::initialize] aligning overlaps [========> ] 4.344205 s [racon::Polisher::initialize] aligning overlaps [=========> ] 5.036398 s [racon::Polisher::initialize] aligning overlaps [==========> ] 5.648965 s [racon::Polisher::initialize] aligning overlaps [===========> ] 6.134909 s [racon::Polisher::initialize] aligning overlaps [============> ] 6.848330 s [racon::Polisher::initialize] aligning overlaps [=============> ] 7.589968 s [racon::Polisher::initialize] aligning overlaps [==============> ] 8.225030 s [racon::Polisher::initialize] aligning overlaps [===============> ] 8.991374 s [racon::Polisher::initialize] aligning overlaps [================> ] 9.739515 s [racon::Polisher::initialize] aligning overlaps [=================> ] 10.425490 s [racon::Polisher::initialize] aligning overlaps [==================> ] 11.168844 s [racon::Polisher::initialize] aligning overlaps [===================>] 11.945028 s [racon::Polisher::initialize] aligning overlaps [====================] 12.665375 s -[racon::Polisher::initialize] transformed data into windows 0.372573 s -[racon::Polisher::polish] generating consensus [=> ] 16.086285 s [racon::Polisher::polish] generating consensus [==> ] 27.410340 s [racon::Polisher::polish] generating consensus [===> ] 40.280682 s [racon::Polisher::polish] generating consensus [====> ] 50.884333 s [racon::Polisher::polish] generating consensus [=====> ] 62.903465 s [racon::Polisher::polish] generating consensus [======> ] 76.518043 s [racon::Polisher::polish] generating consensus [=======> ] 90.122610 s [racon::Polisher::polish] generating consensus [========> ] 100.491548 s [racon::Polisher::polish] generating consensus [=========> ] 113.272842 s [racon::Polisher::polish] generating consensus [==========> ] 128.519251 s [racon::Polisher::polish] generating consensus [===========> ] 141.154592 s [racon::Polisher::polish] generating consensus [============> ] 155.488682 s [racon::Polisher::polish] generating consensus [=============> ] 168.120673 s [racon::Polisher::polish] generating consensus [==============> ] 181.918017 s [racon::Polisher::polish] generating consensus [===============> ] 196.278372 s [racon::Polisher::polish] generating consensus [================> ] 204.664826 s [racon::Polisher::polish] generating consensus [=================> ] 219.909194 s [racon::Polisher::polish] generating consensus [==================> ] 240.926590 s [racon::Polisher::polish] generating consensus [===================>] 255.801784 s [racon::Polisher::polish] generating consensus [====================] 269.059339 s -[racon::Polisher::] total = 282.179917 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (282185 ms) -[----------] 10 tests from RaconPolishingTest (1022588 ms total) +[racon::Polisher::initialize] loaded target sequences 0.070456 s +[racon::Polisher::initialize] loaded sequences 0.064704 s +[racon::Polisher::initialize] loaded overlaps 0.041796 s +[racon::Polisher::initialize] aligning overlaps [=> ] 3.016152 s [racon::Polisher::initialize] aligning overlaps [==> ] 4.353065 s [racon::Polisher::initialize] aligning overlaps [===> ] 5.532136 s [racon::Polisher::initialize] aligning overlaps [====> ] 7.220144 s [racon::Polisher::initialize] aligning overlaps [=====> ] 8.784137 s [racon::Polisher::initialize] aligning overlaps [======> ] 10.340140 s [racon::Polisher::initialize] aligning overlaps [=======> ] 12.032111 s [racon::Polisher::initialize] aligning overlaps [========> ] 14.128134 s [racon::Polisher::initialize] aligning overlaps [=========> ] 16.420116 s [racon::Polisher::initialize] aligning overlaps [==========> ] 18.224155 s [racon::Polisher::initialize] aligning overlaps [===========> ] 20.068135 s [racon::Polisher::initialize] aligning overlaps [============> ] 23.284127 s [racon::Polisher::initialize] aligning overlaps [=============> ] 25.996134 s [racon::Polisher::initialize] aligning overlaps [==============> ] 29.376124 s [racon::Polisher::initialize] aligning overlaps [===============> ] 33.428121 s [racon::Polisher::initialize] aligning overlaps [================> ] 36.904156 s [racon::Polisher::initialize] aligning overlaps [=================> ] 41.000151 s [racon::Polisher::initialize] aligning overlaps [==================> ] 45.120207 s [racon::Polisher::initialize] aligning overlaps [===================>] 47.864109 s [racon::Polisher::initialize] aligning overlaps [====================] 50.055532 s +[racon::Polisher::initialize] transformed data into windows 2.062995 s +[racon::Polisher::polish] generating consensus [=> ] 56.575759 s [racon::Polisher::polish] generating consensus [==> ] 100.951795 s [racon::Polisher::polish] generating consensus [===> ] 133.570509 s [racon::Polisher::polish] generating consensus [====> ] 156.584334 s [racon::Polisher::polish] generating consensus [=====> ] 182.345455 s [racon::Polisher::polish] generating consensus [======> ] 211.864014 s [racon::Polisher::polish] generating consensus [=======> ] 241.336680 s [racon::Polisher::polish] generating consensus [========> ] 263.741143 s [racon::Polisher::polish] generating consensus [=========> ] 291.272713 s [racon::Polisher::polish] generating consensus [==========> ] 324.290803 s [racon::Polisher::polish] generating consensus [===========> ] 351.830127 s [racon::Polisher::polish] generating consensus [============> ] 383.033195 s [racon::Polisher::polish] generating consensus [=============> ] 411.217424 s [racon::Polisher::polish] generating consensus [==============> ] 454.959763 s [racon::Polisher::polish] generating consensus [===============> ] 510.267760 s [racon::Polisher::polish] generating consensus [================> ] 543.911809 s [racon::Polisher::polish] generating consensus [=================> ] 599.617155 s [racon::Polisher::polish] generating consensus [==================> ] 637.235778 s [racon::Polisher::polish] generating consensus [===================>] 676.907742 s [racon::Polisher::polish] generating consensus [====================] 713.841982 s +[racon::Polisher::] total = 766.141623 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (766162 ms) +[----------] 10 tests from RaconPolishingTest (3044751 ms total) [----------] Global test environment tear-down -[==========] 15 tests from 2 test suites ran. (1022597 ms total) +[==========] 15 tests from 2 test suites ran. (3044780 ms total) [ PASSED ] 15 tests. make[1]: Leaving directory '/build/racon-1.4.20' create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=cmake dh_prep -O--buildsystem=cmake dh_auto_install -O--buildsystem=cmake - cd obj-i686-linux-gnu && make -j16 install DESTDIR=/build/racon-1.4.20/debian/racon AM_UPDATE_INFO_DIR=no "INSTALL=install --strip-program=true" + cd obj-i686-linux-gnu && make -j7 install DESTDIR=/build/racon-1.4.20/debian/racon AM_UPDATE_INFO_DIR=no "INSTALL=install --strip-program=true" make[1]: Entering directory '/build/racon-1.4.20/obj-i686-linux-gnu' /usr/bin/cmake -S/build/racon-1.4.20 -B/build/racon-1.4.20/obj-i686-linux-gnu --check-build-system CMakeFiles/Makefile.cmake 0 make -f CMakeFiles/Makefile2 preinstall @@ -852,12 +922,14 @@ dpkg-source --after-build . dpkg-buildpackage: info: binary-only upload (no source included) I: copying local configuration +I: user script /srv/workspace/pbuilder/7375/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/7375/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/42669 and its subdirectories -I: Current time: Wed Sep 14 11:22:31 -12 2022 -I: pbuilder-time-stamp: 1663197751 +I: removing directory /srv/workspace/pbuilder/7375 and its subdirectories +I: Current time: Fri Aug 13 07:55:45 +14 2021 +I: pbuilder-time-stamp: 1628790945