Diff of the two buildlogs: -- --- b1/build.log 2023-04-12 17:48:32.682472242 +0000 +++ b2/build.log 2023-04-12 17:59:10.566504615 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue May 14 11:56:07 -12 2024 -I: pbuilder-time-stamp: 1715730967 +I: Current time: Thu Apr 13 07:48:37 +14 2023 +I: pbuilder-time-stamp: 1681321717 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bookworm-reproducible-base.tgz] I: copying local configuration @@ -16,7 +16,7 @@ I: copying [./racon_1.5.0.orig.tar.gz] I: copying [./racon_1.5.0-3.debian.tar.xz] I: Extracting source -gpgv: Signature made Thu Sep 29 00:45:21 2022 -12 +gpgv: Signature made Fri Sep 30 02:45:21 2022 +14 gpgv: using RSA key F1F007320A035541F0A663CA578A0494D1C646D1 gpgv: issuer "tille@debian.org" gpgv: Can't check signature: No public key @@ -30,11 +30,20 @@ dpkg-source: info: applying py3 I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/6193/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/24270/tmp/hooks/D01_modify_environment starting +debug: Running on codethink14-arm64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +lrwxrwxrwx 1 root root 4 Jan 6 03:20 /bin/sh -> dash +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/24270/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/24270/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' + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME='pbuilder2' BUILD_ARCH='arm64' DEBIAN_FRONTEND='noninteractive' DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=8' @@ -44,38 +53,38 @@ IFS=' ' LANG='C' - LANGUAGE='en_US:en' + LANGUAGE='nl_BE:nl' LC_ALL='C' MAIL='/var/mail/root' OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' + 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' - PPID='6193' + PPID='24270' PS1='# ' PS2='> ' 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/r-b-build.Qe9GO1di/pbuilderrc_PU9M --distribution bookworm --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.Qe9GO1di/b1 --logfile b1/build.log racon_1.5.0-3.dsc' + 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/r-b-build.Qe9GO1di/pbuilderrc_PwS5 --distribution bookworm --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.Qe9GO1di/b2 --logfile b2/build.log --extrapackages usrmerge racon_1.5.0-3.dsc' SUDO_GID='117' SUDO_UID='110' SUDO_USER='jenkins' TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' + TZ='/usr/share/zoneinfo/Etc/GMT-14' USER='root' USERNAME='root' _='/usr/bin/systemd-run' http_proxy='http://192.168.101.16:3128' I: uname -a - Linux codethink13-arm64 4.15.0-208-generic #220-Ubuntu SMP Mon Mar 20 14:28:12 UTC 2023 aarch64 GNU/Linux + Linux i-capture-the-hostname 4.15.0-208-generic #220-Ubuntu SMP Mon Mar 20 14:28:12 UTC 2023 aarch64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 May 13 04:48 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/6193/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Apr 11 00:24 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/24270/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -188,7 +197,7 @@ Get: 59 http://deb.debian.org/debian bookworm/main arm64 libspoa-dev arm64 4.0.8-1 [9344 B] Get: 60 http://deb.debian.org/debian bookworm/main arm64 libthread-pool-dev arm64 4.0.0-1 [7236 B] Get: 61 http://deb.debian.org/debian bookworm/main arm64 rampler arm64 2.1.1-1 [19.9 kB] -Fetched 32.0 MB in 1s (22.1 MB/s) +Fetched 32.0 MB in 1s (45.0 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libproc2-0:arm64. (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 ... 19616 files and directories currently installed.) @@ -446,8 +455,17 @@ Writing extended state information... Building tag database... -> Finished parsing the build-deps +Reading package lists... +Building dependency tree... +Reading state information... +usrmerge is already the newest version (35). +0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/racon-1.5.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../racon_1.5.0-3_source.changes +I: user script /srv/workspace/pbuilder/24270/tmp/hooks/A99_set_merged_usr starting +Re-configuring usrmerge... +I: user script /srv/workspace/pbuilder/24270/tmp/hooks/A99_set_merged_usr finished +hostname: Temporary failure in name resolution +I: Running cd /build/racon-1.5.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../racon_1.5.0-3_source.changes dpkg-buildpackage: info: source package racon dpkg-buildpackage: info: source version 1.5.0-3 dpkg-buildpackage: info: source distribution unstable @@ -500,16 +518,16 @@ make[3]: Leaving directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' make -f CMakeFiles/racon.dir/build.make CMakeFiles/racon.dir/build make[3]: Entering directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' -[ 10%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o -[ 20%] Building CXX object CMakeFiles/racon.dir/src/logger.cpp.o +[ 10%] Building CXX object CMakeFiles/racon.dir/src/logger.cpp.o +/usr/bin/c++ -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -MD -MT CMakeFiles/racon.dir/src/logger.cpp.o -MF CMakeFiles/racon.dir/src/logger.cpp.o.d -o CMakeFiles/racon.dir/src/logger.cpp.o -c /build/racon-1.5.0/src/logger.cpp +[ 20%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o /usr/bin/c++ -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -MD -MT CMakeFiles/racon.dir/src/polisher.cpp.o -MF CMakeFiles/racon.dir/src/polisher.cpp.o.d -o CMakeFiles/racon.dir/src/polisher.cpp.o -c /build/racon-1.5.0/src/polisher.cpp [ 30%] Building CXX object CMakeFiles/racon.dir/src/overlap.cpp.o -/usr/bin/c++ -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -MD -MT CMakeFiles/racon.dir/src/logger.cpp.o -MF CMakeFiles/racon.dir/src/logger.cpp.o.d -o CMakeFiles/racon.dir/src/logger.cpp.o -c /build/racon-1.5.0/src/logger.cpp -[ 40%] Building CXX object CMakeFiles/racon.dir/src/window.cpp.o +[ 40%] Building CXX object CMakeFiles/racon.dir/src/sequence.cpp.o /usr/bin/c++ -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -MD -MT CMakeFiles/racon.dir/src/overlap.cpp.o -MF CMakeFiles/racon.dir/src/overlap.cpp.o.d -o CMakeFiles/racon.dir/src/overlap.cpp.o -c /build/racon-1.5.0/src/overlap.cpp -/usr/bin/c++ -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -MD -MT CMakeFiles/racon.dir/src/window.cpp.o -MF CMakeFiles/racon.dir/src/window.cpp.o.d -o CMakeFiles/racon.dir/src/window.cpp.o -c /build/racon-1.5.0/src/window.cpp -[ 50%] Building CXX object CMakeFiles/racon.dir/src/sequence.cpp.o /usr/bin/c++ -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -MD -MT CMakeFiles/racon.dir/src/sequence.cpp.o -MF CMakeFiles/racon.dir/src/sequence.cpp.o.d -o CMakeFiles/racon.dir/src/sequence.cpp.o -c /build/racon-1.5.0/src/sequence.cpp +[ 50%] Building CXX object CMakeFiles/racon.dir/src/window.cpp.o +/usr/bin/c++ -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -pthread -std=c++11 -MD -MT CMakeFiles/racon.dir/src/window.cpp.o -MF CMakeFiles/racon.dir/src/window.cpp.o.d -o CMakeFiles/racon.dir/src/window.cpp.o -c /build/racon-1.5.0/src/window.cpp [ 60%] Linking CXX static library lib/libracon.a /usr/bin/cmake -P CMakeFiles/racon.dir/cmake_clean_target.cmake /usr/bin/cmake -E cmake_link_script CMakeFiles/racon.dir/link.txt --verbose=1 @@ -524,15 +542,15 @@ make[3]: Entering directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' cd /build/racon-1.5.0/obj-aarch64-linux-gnu && /usr/bin/cmake -E cmake_depends "Unix Makefiles" /build/racon-1.5.0 /build/racon-1.5.0 /build/racon-1.5.0/obj-aarch64-linux-gnu /build/racon-1.5.0/obj-aarch64-linux-gnu /build/racon-1.5.0/obj-aarch64-linux-gnu/CMakeFiles/racon_test.dir/DependInfo.cmake --color= make[3]: Leaving directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' -make -f CMakeFiles/racon_exe.dir/build.make CMakeFiles/racon_exe.dir/build -make[3]: Leaving directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/build make[3]: Entering directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' +make[3]: Leaving directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' +make -f CMakeFiles/racon_exe.dir/build.make CMakeFiles/racon_exe.dir/build make[3]: Entering directory '/build/racon-1.5.0/obj-aarch64-linux-gnu' -[ 70%] Building CXX object CMakeFiles/racon_exe.dir/src/main.cpp.o -/usr/bin/c++ -DVERSION=\"1.5.0\" -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -MD -MT CMakeFiles/racon_exe.dir/src/main.cpp.o -MF CMakeFiles/racon_exe.dir/src/main.cpp.o.d -o CMakeFiles/racon_exe.dir/src/main.cpp.o -c /build/racon-1.5.0/src/main.cpp -[ 80%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o +[ 70%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o +[ 80%] Building CXX object CMakeFiles/racon_exe.dir/src/main.cpp.o /usr/bin/c++ -DTEST_DATA=\"/build/racon-1.5.0/test/data/\" -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -DGTEST_HAS_PTHREAD=1 -std=c++11 -MD -MT CMakeFiles/racon_test.dir/test/racon_test.cpp.o -MF CMakeFiles/racon_test.dir/test/racon_test.cpp.o.d -o CMakeFiles/racon_test.dir/test/racon_test.cpp.o -c /build/racon-1.5.0/test/racon_test.cpp +/usr/bin/c++ -DVERSION=\"1.5.0\" -I/build/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -MD -MT CMakeFiles/racon_exe.dir/src/main.cpp.o -MF CMakeFiles/racon_exe.dir/src/main.cpp.o.d -o CMakeFiles/racon_exe.dir/src/main.cpp.o -c /build/racon-1.5.0/src/main.cpp [ 90%] Linking CXX executable bin/racon /usr/bin/cmake -E cmake_link_script CMakeFiles/racon_exe.dir/link.txt --verbose=1 /usr/bin/c++ -g -O2 -ffile-prefix-map=/build/racon-1.5.0=. -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -Wl,-z,relro -Wl,-z,now CMakeFiles/racon_exe.dir/src/main.cpp.o -o bin/racon lib/libracon.a -ledlib -lspoa -lpthread -lz @@ -554,112 +572,112 @@ [----------] Global test environment set-up. [----------] 5 tests from RaconInitializeTest [ RUN ] RaconInitializeTest.PolisherTypeError -[ OK ] RaconInitializeTest.PolisherTypeError (8 ms) +[ OK ] RaconInitializeTest.PolisherTypeError (5 ms) [ RUN ] RaconInitializeTest.WindowLengthError [ OK ] RaconInitializeTest.WindowLengthError (7 ms) [ RUN ] RaconInitializeTest.SequencesPathExtensionError -[ OK ] RaconInitializeTest.SequencesPathExtensionError (9 ms) +[ OK ] RaconInitializeTest.SequencesPathExtensionError (8 ms) [ RUN ] RaconInitializeTest.OverlapsPathExtensionError -[ OK ] RaconInitializeTest.OverlapsPathExtensionError (39 ms) +[ OK ] RaconInitializeTest.OverlapsPathExtensionError (14 ms) [ RUN ] RaconInitializeTest.TargetPathExtensionError -[ OK ] RaconInitializeTest.TargetPathExtensionError (30 ms) -[----------] 5 tests from RaconInitializeTest (94 ms total) +[ OK ] RaconInitializeTest.TargetPathExtensionError (5 ms) +[----------] 5 tests from RaconInitializeTest (42 ms total) [----------] 10 tests from RaconPolishingTest [ RUN ] RaconPolishingTest.ConsensusWithQualities -[racon::Polisher::initialize] loaded target sequences 0.001051 s -[racon::Polisher::initialize] loaded sequences 0.316594 s -[racon::Polisher::initialize] loaded overlaps 0.009060 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.239632 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.351615 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.443612 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.547594 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.663598 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.771626 s [racon::Polisher::initialize] aligning overlaps [=======> ] 1.015624 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.147615 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.243486 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.359644 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.491607 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.603611 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.710822 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.763178 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.871605 s [racon::Polisher::initialize] aligning overlaps [================> ] 2.091619 s [racon::Polisher::initialize] aligning overlaps [=================> ] 2.159608 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.271632 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.391475 s [racon::Polisher::initialize] aligning overlaps [====================] 2.470853 s -[racon::Polisher::initialize] transformed data into windows 0.004916 s -[racon::Polisher::polish] generating consensus [=> ] 0.435650 s [racon::Polisher::polish] generating consensus [==> ] 0.735656 s [racon::Polisher::polish] generating consensus [===> ] 1.071635 s [racon::Polisher::polish] generating consensus [====> ] 1.423687 s [racon::Polisher::polish] generating consensus [=====> ] 1.607653 s [racon::Polisher::polish] generating consensus [======> ] 1.833717 s [racon::Polisher::polish] generating consensus [=======> ] 2.013594 s [racon::Polisher::polish] generating consensus [========> ] 2.139674 s [racon::Polisher::polish] generating consensus [=========> ] 2.362402 s [racon::Polisher::polish] generating consensus [==========> ] 2.779610 s [racon::Polisher::polish] generating consensus [===========> ] 3.359623 s [racon::Polisher::polish] generating consensus [============> ] 3.751641 s [racon::Polisher::polish] generating consensus [=============> ] 4.555639 s [racon::Polisher::polish] generating consensus [==============> ] 5.359633 s [racon::Polisher::polish] generating consensus [===============> ] 6.051613 s [racon::Polisher::polish] generating consensus [================> ] 6.519703 s [racon::Polisher::polish] generating consensus [=================> ] 7.195627 s [racon::Polisher::polish] generating consensus [==================> ] 7.583645 s [racon::Polisher::polish] generating consensus [===================>] 7.955649 s [racon::Polisher::polish] generating consensus [====================] 9.968969 s -[racon::Polisher::] total = 12.842266 s -[ OK ] RaconPolishingTest.ConsensusWithQualities (12876 ms) +[racon::Polisher::initialize] loaded target sequences 0.001085 s +[racon::Polisher::initialize] loaded sequences 0.115137 s +[racon::Polisher::initialize] loaded overlaps 0.000672 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.214776 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.286753 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.354747 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.410742 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.474753 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.534737 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.682743 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.754754 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.814766 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.862750 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.938738 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.002763 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.058753 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.098754 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.146747 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.166766 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.194753 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.230742 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.248085 s [racon::Polisher::initialize] aligning overlaps [====================] 1.289264 s +[racon::Polisher::initialize] transformed data into windows 0.004620 s +[racon::Polisher::polish] generating consensus [=> ] 0.308668 s [racon::Polisher::polish] generating consensus [==> ] 0.436653 s [racon::Polisher::polish] generating consensus [===> ] 0.740672 s [racon::Polisher::polish] generating consensus [====> ] 0.884713 s [racon::Polisher::polish] generating consensus [=====> ] 0.968660 s [racon::Polisher::polish] generating consensus [======> ] 1.100664 s [racon::Polisher::polish] generating consensus [=======> ] 1.204658 s [racon::Polisher::polish] generating consensus [========> ] 1.348714 s [racon::Polisher::polish] generating consensus [=========> ] 1.487102 s [racon::Polisher::polish] generating consensus [==========> ] 1.644696 s [racon::Polisher::polish] generating consensus [===========> ] 1.876725 s [racon::Polisher::polish] generating consensus [============> ] 2.124686 s [racon::Polisher::polish] generating consensus [=============> ] 2.544674 s [racon::Polisher::polish] generating consensus [==============> ] 2.940682 s [racon::Polisher::polish] generating consensus [===============> ] 3.160681 s [racon::Polisher::polish] generating consensus [================> ] 3.340765 s [racon::Polisher::polish] generating consensus [=================> ] 3.668705 s [racon::Polisher::polish] generating consensus [==================> ] 3.804689 s [racon::Polisher::polish] generating consensus [===================>] 3.956676 s [racon::Polisher::polish] generating consensus [====================] 4.636764 s +[racon::Polisher::] total = 6.097742 s +[ OK ] RaconPolishingTest.ConsensusWithQualities (6119 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualities -[racon::Polisher::initialize] loaded target sequences 0.000954 s -[racon::Polisher::initialize] loaded sequences 0.154709 s -[racon::Polisher::initialize] loaded overlaps 0.000610 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.298782 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.398764 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.522765 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.598774 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.702778 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.764482 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.950775 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.086757 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.189568 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.257008 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.350820 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.466768 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.558761 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.602764 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.726769 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.850765 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.946815 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.091555 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.133306 s [racon::Polisher::initialize] aligning overlaps [====================] 2.239054 s -[racon::Polisher::initialize] transformed data into windows 0.001059 s -[racon::Polisher::polish] generating consensus [=> ] 0.618492 s [racon::Polisher::polish] generating consensus [==> ] 1.150524 s [racon::Polisher::polish] generating consensus [===> ] 1.629922 s [racon::Polisher::polish] generating consensus [====> ] 2.062488 s [racon::Polisher::polish] generating consensus [=====> ] 2.298468 s [racon::Polisher::polish] generating consensus [======> ] 2.514471 s [racon::Polisher::polish] generating consensus [=======> ] 2.782441 s [racon::Polisher::polish] generating consensus [========> ] 2.947068 s [racon::Polisher::polish] generating consensus [=========> ] 3.378465 s [racon::Polisher::polish] generating consensus [==========> ] 3.950440 s [racon::Polisher::polish] generating consensus [===========> ] 4.786441 s [racon::Polisher::polish] generating consensus [============> ] 5.602441 s [racon::Polisher::polish] generating consensus [=============> ] 6.518453 s [racon::Polisher::polish] generating consensus [==============> ] 7.598441 s [racon::Polisher::polish] generating consensus [===============> ] 8.514429 s [racon::Polisher::polish] generating consensus [================> ] 9.354534 s [racon::Polisher::polish] generating consensus [=================> ] 10.258452 s [racon::Polisher::polish] generating consensus [==================> ] 10.722448 s [racon::Polisher::polish] generating consensus [===================>] 11.230447 s [racon::Polisher::polish] generating consensus [====================] 13.970467 s -[racon::Polisher::] total = 16.447784 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualities (16459 ms) +[racon::Polisher::initialize] loaded target sequences 0.000979 s +[racon::Polisher::initialize] loaded sequences 0.090849 s +[racon::Polisher::initialize] loaded overlaps 0.000605 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.084755 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.136749 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.205753 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.254711 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.320746 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.376254 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.504747 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.556748 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.600746 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.636749 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.688762 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.748756 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.808722 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.876746 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.944690 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.032758 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.064763 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.119353 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.156742 s [racon::Polisher::initialize] aligning overlaps [====================] 1.195444 s +[racon::Polisher::initialize] transformed data into windows 0.001032 s +[racon::Polisher::polish] generating consensus [=> ] 0.320084 s [racon::Polisher::polish] generating consensus [==> ] 0.548072 s [racon::Polisher::polish] generating consensus [===> ] 0.824022 s [racon::Polisher::polish] generating consensus [====> ] 0.956033 s [racon::Polisher::polish] generating consensus [=====> ] 1.072068 s [racon::Polisher::polish] generating consensus [======> ] 1.196064 s [racon::Polisher::polish] generating consensus [=======> ] 1.336055 s [racon::Polisher::polish] generating consensus [========> ] 1.456090 s [racon::Polisher::polish] generating consensus [=========> ] 1.596040 s [racon::Polisher::polish] generating consensus [==========> ] 1.872056 s [racon::Polisher::polish] generating consensus [===========> ] 2.192029 s [racon::Polisher::polish] generating consensus [============> ] 2.588030 s [racon::Polisher::polish] generating consensus [=============> ] 3.172044 s [racon::Polisher::polish] generating consensus [==============> ] 3.568062 s [racon::Polisher::polish] generating consensus [===============> ] 4.044039 s [racon::Polisher::polish] generating consensus [================> ] 4.356044 s [racon::Polisher::polish] generating consensus [=================> ] 4.688056 s [racon::Polisher::polish] generating consensus [==================> ] 4.900047 s [racon::Polisher::polish] generating consensus [===================>] 5.100054 s [racon::Polisher::polish] generating consensus [====================] 6.662181 s +[racon::Polisher::] total = 7.972895 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualities (7990 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments -[racon::Polisher::initialize] loaded target sequences 0.000955 s -[racon::Polisher::initialize] loaded sequences 0.245079 s -[racon::Polisher::initialize] loaded overlaps 0.087330 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.046811 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.046857 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.046876 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.046894 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.046912 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.046929 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.046947 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.046963 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.046980 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.046997 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.047014 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.047030 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.047047 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.047064 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.047081 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.047097 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.047115 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.047131 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.047538 s [racon::Polisher::initialize] aligning overlaps [====================] 0.050013 s -[racon::Polisher::initialize] transformed data into windows 0.004798 s -[racon::Polisher::polish] generating consensus [=> ] 0.674900 s [racon::Polisher::polish] generating consensus [==> ] 1.047064 s [racon::Polisher::polish] generating consensus [===> ] 1.386865 s [racon::Polisher::polish] generating consensus [====> ] 1.694864 s [racon::Polisher::polish] generating consensus [=====> ] 1.885028 s [racon::Polisher::polish] generating consensus [======> ] 2.082869 s [racon::Polisher::polish] generating consensus [=======> ] 2.246826 s [racon::Polisher::polish] generating consensus [========> ] 2.434353 s [racon::Polisher::polish] generating consensus [=========> ] 2.662770 s [racon::Polisher::polish] generating consensus [==========> ] 2.886168 s [racon::Polisher::polish] generating consensus [===========> ] 3.398823 s [racon::Polisher::polish] generating consensus [============> ] 4.050809 s [racon::Polisher::polish] generating consensus [=============> ] 4.774809 s [racon::Polisher::polish] generating consensus [==============> ] 5.632517 s [racon::Polisher::polish] generating consensus [===============> ] 6.334821 s [racon::Polisher::polish] generating consensus [================> ] 6.814917 s [racon::Polisher::polish] generating consensus [=================> ] 7.538897 s [racon::Polisher::polish] generating consensus [==================> ] 7.986821 s [racon::Polisher::polish] generating consensus [===================>] 8.302827 s [racon::Polisher::polish] generating consensus [====================] 9.971565 s -[racon::Polisher::] total = 10.463840 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (10471 ms) +[racon::Polisher::initialize] loaded target sequences 0.000970 s +[racon::Polisher::initialize] loaded sequences 0.180199 s +[racon::Polisher::initialize] loaded overlaps 0.070640 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.027123 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.027174 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.027194 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.027213 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.027232 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.027248 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.027265 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.027281 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.027297 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.027314 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.027329 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.027345 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.027361 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.027378 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.027395 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.027413 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.027432 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.027449 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.027466 s [racon::Polisher::initialize] aligning overlaps [====================] 0.027483 s +[racon::Polisher::initialize] transformed data into windows 0.004785 s +[racon::Polisher::polish] generating consensus [=> ] 0.349008 s [racon::Polisher::polish] generating consensus [==> ] 0.542684 s [racon::Polisher::polish] generating consensus [===> ] 0.726660 s [racon::Polisher::polish] generating consensus [====> ] 0.866711 s [racon::Polisher::polish] generating consensus [=====> ] 0.938667 s [racon::Polisher::polish] generating consensus [======> ] 1.022640 s [racon::Polisher::polish] generating consensus [=======> ] 1.122666 s [racon::Polisher::polish] generating consensus [========> ] 1.250713 s [racon::Polisher::polish] generating consensus [=========> ] 1.358661 s [racon::Polisher::polish] generating consensus [==========> ] 1.550660 s [racon::Polisher::polish] generating consensus [===========> ] 1.810651 s [racon::Polisher::polish] generating consensus [============> ] 2.054667 s [racon::Polisher::polish] generating consensus [=============> ] 2.474668 s [racon::Polisher::polish] generating consensus [==============> ] 2.842668 s [racon::Polisher::polish] generating consensus [===============> ] 3.150674 s [racon::Polisher::polish] generating consensus [================> ] 3.382766 s [racon::Polisher::polish] generating consensus [=================> ] 3.706680 s [racon::Polisher::polish] generating consensus [==================> ] 3.878671 s [racon::Polisher::polish] generating consensus [===================>] 4.026667 s [racon::Polisher::polish] generating consensus [====================] 4.759650 s +[racon::Polisher::] total = 5.094695 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (5100 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments -[racon::Polisher::initialize] loaded target sequences 0.000913 s -[racon::Polisher::initialize] loaded sequences 0.108681 s -[racon::Polisher::initialize] loaded overlaps 0.171209 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.020546 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.020600 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.020621 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.020638 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.026074 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.026119 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.026137 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.026155 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.026173 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.026192 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.026210 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.026229 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.026247 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.026265 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.026282 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.026300 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.026318 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.026335 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.026354 s [racon::Polisher::initialize] aligning overlaps [====================] 0.026373 s -[racon::Polisher::initialize] transformed data into windows 0.001060 s -[racon::Polisher::polish] generating consensus [=> ] 0.526274 s [racon::Polisher::polish] generating consensus [==> ] 1.002280 s [racon::Polisher::polish] generating consensus [===> ] 1.506294 s [racon::Polisher::polish] generating consensus [====> ] 1.974296 s [racon::Polisher::polish] generating consensus [=====> ] 2.182276 s [racon::Polisher::polish] generating consensus [======> ] 2.354282 s [racon::Polisher::polish] generating consensus [=======> ] 2.566283 s [racon::Polisher::polish] generating consensus [========> ] 2.874340 s [racon::Polisher::polish] generating consensus [=========> ] 3.198264 s [racon::Polisher::polish] generating consensus [==========> ] 3.866261 s [racon::Polisher::polish] generating consensus [===========> ] 4.458912 s [racon::Polisher::polish] generating consensus [============> ] 5.341895 s [racon::Polisher::polish] generating consensus [=============> ] 6.682841 s [racon::Polisher::polish] generating consensus [==============> ] 7.582271 s [racon::Polisher::polish] generating consensus [===============> ] 8.270267 s [racon::Polisher::polish] generating consensus [================> ] 8.828917 s [racon::Polisher::polish] generating consensus [=================> ] 9.782276 s [racon::Polisher::polish] generating consensus [==================> ] 10.266942 s [racon::Polisher::polish] generating consensus [===================>] 10.690283 s [racon::Polisher::polish] generating consensus [====================] 13.055961 s -[racon::Polisher::] total = 13.389607 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (13395 ms) +[racon::Polisher::initialize] loaded target sequences 0.000945 s +[racon::Polisher::initialize] loaded sequences 0.090723 s +[racon::Polisher::initialize] loaded overlaps 0.085428 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.020536 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.020671 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.020914 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.022726 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.022759 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.022776 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.022791 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.022808 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.022824 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.022841 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.022858 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.022874 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.022890 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.022906 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.022923 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.022941 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.022958 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.022975 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.022993 s [racon::Polisher::initialize] aligning overlaps [====================] 0.023010 s +[racon::Polisher::initialize] transformed data into windows 0.000966 s +[racon::Polisher::polish] generating consensus [=> ] 0.248176 s [racon::Polisher::polish] generating consensus [==> ] 0.708172 s [racon::Polisher::polish] generating consensus [===> ] 0.936130 s [racon::Polisher::polish] generating consensus [====> ] 1.112180 s [racon::Polisher::polish] generating consensus [=====> ] 1.232135 s [racon::Polisher::polish] generating consensus [======> ] 1.376138 s [racon::Polisher::polish] generating consensus [=======> ] 1.496141 s [racon::Polisher::polish] generating consensus [========> ] 1.636202 s [racon::Polisher::polish] generating consensus [=========> ] 1.776142 s [racon::Polisher::polish] generating consensus [==========> ] 1.987337 s [racon::Polisher::polish] generating consensus [===========> ] 2.268132 s [racon::Polisher::polish] generating consensus [============> ] 2.620135 s [racon::Polisher::polish] generating consensus [=============> ] 3.056132 s [racon::Polisher::polish] generating consensus [==============> ] 3.524131 s [racon::Polisher::polish] generating consensus [===============> ] 3.964136 s [racon::Polisher::polish] generating consensus [================> ] 4.340208 s [racon::Polisher::polish] generating consensus [=================> ] 4.716145 s [racon::Polisher::polish] generating consensus [==================> ] 4.936165 s [racon::Polisher::polish] generating consensus [===================>] 5.152128 s [racon::Polisher::polish] generating consensus [====================] 6.164231 s +[racon::Polisher::] total = 6.384080 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (6390 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow -[racon::Polisher::initialize] loaded target sequences 0.000957 s -[racon::Polisher::initialize] loaded sequences 0.261311 s -[racon::Polisher::initialize] loaded overlaps 0.000600 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.189260 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.292642 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.400636 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.500632 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.588638 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.676637 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.896636 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.005133 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.072625 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.140620 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.244627 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.326578 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.464636 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.500636 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.572656 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.836701 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.876629 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.956627 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.020416 s [racon::Polisher::initialize] aligning overlaps [====================] 2.074250 s -[racon::Polisher::initialize] transformed data into windows 0.004188 s -[racon::Polisher::polish] generating consensus [=> ] 1.660026 s [racon::Polisher::polish] generating consensus [==> ] 1.660090 s [racon::Polisher::polish] generating consensus [===> ] 2.945743 s [racon::Polisher::polish] generating consensus [====> ] 2.945863 s [racon::Polisher::polish] generating consensus [=====> ] 3.318349 s [racon::Polisher::polish] generating consensus [======> ] 3.318403 s [racon::Polisher::polish] generating consensus [=======> ] 3.993945 s [racon::Polisher::polish] generating consensus [========> ] 3.994042 s [racon::Polisher::polish] generating consensus [=========> ] 4.558001 s [racon::Polisher::polish] generating consensus [==========> ] 4.558056 s [racon::Polisher::polish] generating consensus [===========> ] 6.341938 s [racon::Polisher::polish] generating consensus [============> ] 6.509932 s [racon::Polisher::polish] generating consensus [=============> ] 9.469350 s [racon::Polisher::polish] generating consensus [==============> ] 9.469417 s [racon::Polisher::polish] generating consensus [===============> ] 11.601939 s [racon::Polisher::polish] generating consensus [================> ] 11.602068 s [racon::Polisher::polish] generating consensus [=================> ] 13.473934 s [racon::Polisher::polish] generating consensus [==================> ] 13.473995 s [racon::Polisher::polish] generating consensus [===================>] 14.849929 s [racon::Polisher::polish] generating consensus [====================] 16.828243 s -[racon::Polisher::] total = 19.229027 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (19256 ms) +[racon::Polisher::initialize] loaded target sequences 0.000946 s +[racon::Polisher::initialize] loaded sequences 0.113293 s +[racon::Polisher::initialize] loaded overlaps 0.005046 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.075329 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.131325 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.203333 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.275327 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.327333 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.327380 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.379312 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.447335 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.467331 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.523341 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.554208 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.655328 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.679338 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.727331 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.791336 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.883330 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.959333 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.031331 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.067352 s [racon::Polisher::initialize] aligning overlaps [====================] 1.070170 s +[racon::Polisher::initialize] transformed data into windows 0.008330 s +[racon::Polisher::polish] generating consensus [=> ] 0.840628 s [racon::Polisher::polish] generating consensus [==> ] 0.840701 s [racon::Polisher::polish] generating consensus [===> ] 1.476584 s [racon::Polisher::polish] generating consensus [====> ] 1.476668 s [racon::Polisher::polish] generating consensus [=====> ] 1.720584 s [racon::Polisher::polish] generating consensus [======> ] 1.720648 s [racon::Polisher::polish] generating consensus [=======> ] 2.092585 s [racon::Polisher::polish] generating consensus [========> ] 2.092668 s [racon::Polisher::polish] generating consensus [=========> ] 2.432582 s [racon::Polisher::polish] generating consensus [==========> ] 2.432644 s [racon::Polisher::polish] generating consensus [===========> ] 3.264588 s [racon::Polisher::polish] generating consensus [============> ] 3.390506 s [racon::Polisher::polish] generating consensus [=============> ] 4.636567 s [racon::Polisher::polish] generating consensus [==============> ] 4.776582 s [racon::Polisher::polish] generating consensus [===============> ] 5.732610 s [racon::Polisher::polish] generating consensus [================> ] 5.732696 s [racon::Polisher::polish] generating consensus [=================> ] 6.600597 s [racon::Polisher::polish] generating consensus [==================> ] 6.600651 s [racon::Polisher::polish] generating consensus [===================>] 7.200591 s [racon::Polisher::polish] generating consensus [====================] 8.449739 s +[racon::Polisher::] total = 9.675631 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (9687 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesEditDistance -[racon::Polisher::initialize] loaded target sequences 0.000963 s -[racon::Polisher::initialize] loaded sequences 0.239475 s -[racon::Polisher::initialize] loaded overlaps 0.000589 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.209478 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.273980 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.405990 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.478005 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.577345 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.633995 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.802000 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.893994 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.973988 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.107320 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.141638 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.297990 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.476585 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.522307 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.677984 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.818487 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.886826 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.997994 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.137375 s [racon::Polisher::initialize] aligning overlaps [====================] 2.246680 s -[racon::Polisher::initialize] transformed data into windows 0.022572 s -[racon::Polisher::polish] generating consensus [=> ] 0.501257 s [racon::Polisher::polish] generating consensus [==> ] 0.820495 s [racon::Polisher::polish] generating consensus [===> ] 1.122406 s [racon::Polisher::polish] generating consensus [====> ] 1.368515 s [racon::Polisher::polish] generating consensus [=====> ] 1.556647 s [racon::Polisher::polish] generating consensus [======> ] 1.701768 s [racon::Polisher::polish] generating consensus [=======> ] 1.878578 s [racon::Polisher::polish] generating consensus [========> ] 2.132601 s [racon::Polisher::polish] generating consensus [=========> ] 2.396467 s [racon::Polisher::polish] generating consensus [==========> ] 2.724464 s [racon::Polisher::polish] generating consensus [===========> ] 3.112476 s [racon::Polisher::polish] generating consensus [============> ] 3.544548 s [racon::Polisher::polish] generating consensus [=============> ] 4.300559 s [racon::Polisher::polish] generating consensus [==============> ] 5.048470 s [racon::Polisher::polish] generating consensus [===============> ] 5.688492 s [racon::Polisher::polish] generating consensus [================> ] 6.108570 s [racon::Polisher::polish] generating consensus [=================> ] 6.744499 s [racon::Polisher::polish] generating consensus [==================> ] 7.080485 s [racon::Polisher::polish] generating consensus [===================>] 7.444457 s [racon::Polisher::polish] generating consensus [====================] 8.711623 s -[racon::Polisher::] total = 11.310288 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (11328 ms) +[racon::Polisher::initialize] loaded target sequences 0.000954 s +[racon::Polisher::initialize] loaded sequences 0.104380 s +[racon::Polisher::initialize] loaded overlaps 0.000603 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.081037 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.137022 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.185031 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.247944 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.305032 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.325033 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.401037 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.529055 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.553032 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.613042 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.665036 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.765026 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.785041 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.833019 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.876792 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.937043 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.001033 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.061034 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.061078 s [racon::Polisher::initialize] aligning overlaps [====================] 1.109026 s +[racon::Polisher::initialize] transformed data into windows 0.005059 s +[racon::Polisher::polish] generating consensus [=> ] 0.230757 s [racon::Polisher::polish] generating consensus [==> ] 0.410737 s [racon::Polisher::polish] generating consensus [===> ] 0.566709 s [racon::Polisher::polish] generating consensus [====> ] 0.686756 s [racon::Polisher::polish] generating consensus [=====> ] 0.802741 s [racon::Polisher::polish] generating consensus [======> ] 0.906721 s [racon::Polisher::polish] generating consensus [=======> ] 1.002723 s [racon::Polisher::polish] generating consensus [========> ] 1.098761 s [racon::Polisher::polish] generating consensus [=========> ] 1.230742 s [racon::Polisher::polish] generating consensus [==========> ] 1.418704 s [racon::Polisher::polish] generating consensus [===========> ] 1.674718 s [racon::Polisher::polish] generating consensus [============> ] 1.910720 s [racon::Polisher::polish] generating consensus [=============> ] 2.318721 s [racon::Polisher::polish] generating consensus [==============> ] 2.726706 s [racon::Polisher::polish] generating consensus [===============> ] 2.998717 s [racon::Polisher::polish] generating consensus [================> ] 3.198712 s [racon::Polisher::polish] generating consensus [=================> ] 3.506719 s [racon::Polisher::polish] generating consensus [==================> ] 3.714710 s [racon::Polisher::polish] generating consensus [===================>] 3.878721 s [racon::Polisher::polish] generating consensus [====================] 4.598686 s +[racon::Polisher::] total = 5.847972 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (5858 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualities -[racon::Polisher::initialize] loaded target sequences 0.188421 s -[racon::Polisher::initialize] loaded sequences 0.088122 s -[racon::Polisher::initialize] loaded overlaps 0.030611 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.183194 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.359218 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.419201 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.499198 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.595193 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.711205 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.838600 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.946140 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.095188 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.223205 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.339011 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.559197 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.723184 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.903206 s [racon::Polisher::initialize] aligning overlaps [===============> ] 2.027195 s [racon::Polisher::initialize] aligning overlaps [================> ] 2.187190 s [racon::Polisher::initialize] aligning overlaps [=================> ] 2.307198 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.359199 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.475189 s [racon::Polisher::initialize] aligning overlaps [====================] 2.596952 s -[racon::Polisher::initialize] transformed data into windows 0.012288 s -[racon::Polisher::polish] generating consensus [=> ] 0.365093 s [racon::Polisher::polish] generating consensus [==> ] 0.721046 s [racon::Polisher::polish] generating consensus [===> ] 1.113046 s [racon::Polisher::polish] generating consensus [====> ] 1.113467 s [racon::Polisher::polish] generating consensus [=====> ] 1.325194 s [racon::Polisher::polish] generating consensus [======> ] 1.485275 s [racon::Polisher::polish] generating consensus [=======> ] 1.689242 s [racon::Polisher::polish] generating consensus [========> ] 1.737343 s [racon::Polisher::polish] generating consensus [=========> ] 2.220077 s [racon::Polisher::polish] generating consensus [==========> ] 2.408968 s [racon::Polisher::polish] generating consensus [===========> ] 2.569136 s [racon::Polisher::polish] generating consensus [============> ] 2.641215 s [racon::Polisher::polish] generating consensus [=============> ] 2.824975 s [racon::Polisher::polish] generating consensus [==============> ] 2.825445 s [racon::Polisher::polish] generating consensus [===============> ] 3.273089 s [racon::Polisher::polish] generating consensus [================> ] 3.273484 s [racon::Polisher::polish] generating consensus [=================> ] 4.113205 s [racon::Polisher::polish] generating consensus [==================> ] 4.325144 s [racon::Polisher::polish] generating consensus [===================>] 4.593771 s [racon::Polisher::polish] generating consensus [====================] 4.703659 s -[racon::Polisher::] total = 7.622783 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (7628 ms) +[racon::Polisher::initialize] loaded target sequences 0.088562 s +[racon::Polisher::initialize] loaded sequences 0.085173 s +[racon::Polisher::initialize] loaded overlaps 0.026361 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.148134 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.208118 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.248116 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.284104 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.328104 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.392118 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.426978 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.466909 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.524123 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.616113 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.700108 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.748120 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.816105 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.912106 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.980103 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.052123 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.104096 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.208115 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.244104 s [racon::Polisher::initialize] aligning overlaps [====================] 1.276115 s +[racon::Polisher::initialize] transformed data into windows 0.017805 s +[racon::Polisher::polish] generating consensus [=> ] 0.210059 s [racon::Polisher::polish] generating consensus [==> ] 0.390279 s [racon::Polisher::polish] generating consensus [===> ] 0.589991 s [racon::Polisher::polish] generating consensus [====> ] 0.602316 s [racon::Polisher::polish] generating consensus [=====> ] 0.710173 s [racon::Polisher::polish] generating consensus [======> ] 0.806309 s [racon::Polisher::polish] generating consensus [=======> ] 0.938307 s [racon::Polisher::polish] generating consensus [========> ] 0.938780 s [racon::Polisher::polish] generating consensus [=========> ] 1.186427 s [racon::Polisher::polish] generating consensus [==========> ] 1.281930 s [racon::Polisher::polish] generating consensus [===========> ] 1.366101 s [racon::Polisher::polish] generating consensus [============> ] 1.402161 s [racon::Polisher::polish] generating consensus [=============> ] 1.530277 s [racon::Polisher::polish] generating consensus [==============> ] 1.531036 s [racon::Polisher::polish] generating consensus [===============> ] 1.774166 s [racon::Polisher::polish] generating consensus [================> ] 1.774537 s [racon::Polisher::polish] generating consensus [=================> ] 2.154016 s [racon::Polisher::polish] generating consensus [==================> ] 2.266148 s [racon::Polisher::polish] generating consensus [===================>] 2.330264 s [racon::Polisher::polish] generating consensus [====================] 2.345065 s +[racon::Polisher::] total = 3.840458 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (3845 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.111806 s -[racon::Polisher::initialize] loaded sequences 0.198588 s -[racon::Polisher::initialize] loaded overlaps 0.021724 s -[racon::Polisher::initialize] aligning overlaps [=> ] 2.544929 s [racon::Polisher::initialize] aligning overlaps [==> ] 4.101603 s [racon::Polisher::initialize] aligning overlaps [===> ] 5.623307 s [racon::Polisher::initialize] aligning overlaps [====> ] 7.561609 s [racon::Polisher::initialize] aligning overlaps [=====> ] 9.281655 s [racon::Polisher::initialize] aligning overlaps [======> ] 10.773612 s [racon::Polisher::initialize] aligning overlaps [=======> ] 12.539301 s [racon::Polisher::initialize] aligning overlaps [========> ] 14.789598 s [racon::Polisher::initialize] aligning overlaps [=========> ] 17.121605 s [racon::Polisher::initialize] aligning overlaps [==========> ] 19.305608 s [racon::Polisher::initialize] aligning overlaps [===========> ] 21.153602 s [racon::Polisher::initialize] aligning overlaps [============> ] 23.453616 s [racon::Polisher::initialize] aligning overlaps [=============> ] 26.033147 s [racon::Polisher::initialize] aligning overlaps [==============> ] 28.273609 s [racon::Polisher::initialize] aligning overlaps [===============> ] 30.749605 s [racon::Polisher::initialize] aligning overlaps [================> ] 32.965611 s [racon::Polisher::initialize] aligning overlaps [=================> ] 35.381604 s [racon::Polisher::initialize] aligning overlaps [==================> ] 37.682714 s [racon::Polisher::initialize] aligning overlaps [===================>] 40.410023 s [racon::Polisher::initialize] aligning overlaps [====================] 42.260562 s -[racon::Polisher::initialize] transformed data into windows 0.338362 s -[racon::Polisher::polish] generating consensus [=> ] 15.138852 s [racon::Polisher::polish] generating consensus [==> ] 25.606855 s [racon::Polisher::polish] generating consensus [===> ] 36.904869 s [racon::Polisher::polish] generating consensus [====> ] 47.030974 s [racon::Polisher::polish] generating consensus [=====> ] 57.790873 s [racon::Polisher::polish] generating consensus [======> ] 69.870865 s [racon::Polisher::polish] generating consensus [=======> ] 82.910865 s [racon::Polisher::polish] generating consensus [========> ] 92.154865 s [racon::Polisher::polish] generating consensus [=========> ] 104.130853 s [racon::Polisher::polish] generating consensus [==========> ] 119.178842 s [racon::Polisher::polish] generating consensus [===========> ] 132.909556 s [racon::Polisher::polish] generating consensus [============> ] 146.982855 s [racon::Polisher::polish] generating consensus [=============> ] 159.222864 s [racon::Polisher::polish] generating consensus [==============> ] 170.806864 s [racon::Polisher::polish] generating consensus [===============> ] 185.058841 s [racon::Polisher::polish] generating consensus [================> ] 194.251934 s [racon::Polisher::polish] generating consensus [=================> ] 210.122867 s [racon::Polisher::polish] generating consensus [==================> ] 223.486970 s [racon::Polisher::polish] generating consensus [===================>] 235.330846 s [racon::Polisher::polish] generating consensus [====================] 249.690158 s -[racon::Polisher::] total = 292.670400 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (292675 ms) +[racon::Polisher::initialize] loaded target sequences 0.104605 s +[racon::Polisher::initialize] loaded sequences 0.064341 s +[racon::Polisher::initialize] loaded overlaps 0.022105 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.599220 s [racon::Polisher::initialize] aligning overlaps [==> ] 2.591225 s [racon::Polisher::initialize] aligning overlaps [===> ] 3.607248 s [racon::Polisher::initialize] aligning overlaps [====> ] 4.935229 s [racon::Polisher::initialize] aligning overlaps [=====> ] 5.803253 s [racon::Polisher::initialize] aligning overlaps [======> ] 6.619221 s [racon::Polisher::initialize] aligning overlaps [=======> ] 7.619214 s [racon::Polisher::initialize] aligning overlaps [========> ] 8.947213 s [racon::Polisher::initialize] aligning overlaps [=========> ] 10.419218 s [racon::Polisher::initialize] aligning overlaps [==========> ] 11.635225 s [racon::Polisher::initialize] aligning overlaps [===========> ] 12.719231 s [racon::Polisher::initialize] aligning overlaps [============> ] 14.187221 s [racon::Polisher::initialize] aligning overlaps [=============> ] 15.667229 s [racon::Polisher::initialize] aligning overlaps [==============> ] 16.847214 s [racon::Polisher::initialize] aligning overlaps [===============> ] 18.131229 s [racon::Polisher::initialize] aligning overlaps [================> ] 19.407232 s [racon::Polisher::initialize] aligning overlaps [=================> ] 20.451235 s [racon::Polisher::initialize] aligning overlaps [==================> ] 22.011227 s [racon::Polisher::initialize] aligning overlaps [===================>] 23.127227 s [racon::Polisher::initialize] aligning overlaps [====================] 24.299236 s +[racon::Polisher::initialize] transformed data into windows 0.363710 s +[racon::Polisher::polish] generating consensus [=> ] 8.788453 s [racon::Polisher::polish] generating consensus [==> ] 14.736453 s [racon::Polisher::polish] generating consensus [===> ] 20.880523 s [racon::Polisher::polish] generating consensus [====> ] 26.272535 s [racon::Polisher::polish] generating consensus [=====> ] 32.576445 s [racon::Polisher::polish] generating consensus [======> ] 39.188445 s [racon::Polisher::polish] generating consensus [=======> ] 46.328439 s [racon::Polisher::polish] generating consensus [========> ] 51.316455 s [racon::Polisher::polish] generating consensus [=========> ] 57.764424 s [racon::Polisher::polish] generating consensus [==========> ] 65.044451 s [racon::Polisher::polish] generating consensus [===========> ] 71.740561 s [racon::Polisher::polish] generating consensus [============> ] 78.648431 s [racon::Polisher::polish] generating consensus [=============> ] 85.096452 s [racon::Polisher::polish] generating consensus [==============> ] 91.628472 s [racon::Polisher::polish] generating consensus [===============> ] 98.540435 s [racon::Polisher::polish] generating consensus [================> ] 102.456529 s [racon::Polisher::polish] generating consensus [=================> ] 110.172453 s [racon::Polisher::polish] generating consensus [==================> ] 117.388524 s [racon::Polisher::polish] generating consensus [===================>] 124.148458 s [racon::Polisher::polish] generating consensus [====================] 130.587708 s +[racon::Polisher::] total = 155.453157 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (155459 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.166659 s -[racon::Polisher::initialize] loaded sequences 0.110723 s -[racon::Polisher::initialize] loaded overlaps 0.053873 s -[racon::Polisher::initialize] aligning overlaps [=> ] 2.547047 s [racon::Polisher::initialize] aligning overlaps [==> ] 4.303049 s [racon::Polisher::initialize] aligning overlaps [===> ] 5.811050 s [racon::Polisher::initialize] aligning overlaps [====> ] 7.575052 s [racon::Polisher::initialize] aligning overlaps [=====> ] 9.195292 s [racon::Polisher::initialize] aligning overlaps [======> ] 10.295041 s [racon::Polisher::initialize] aligning overlaps [=======> ] 11.843034 s [racon::Polisher::initialize] aligning overlaps [========> ] 13.563046 s [racon::Polisher::initialize] aligning overlaps [=========> ] 15.179079 s [racon::Polisher::initialize] aligning overlaps [==========> ] 16.423049 s [racon::Polisher::initialize] aligning overlaps [===========> ] 17.815045 s [racon::Polisher::initialize] aligning overlaps [============> ] 19.567057 s [racon::Polisher::initialize] aligning overlaps [=============> ] 21.403050 s [racon::Polisher::initialize] aligning overlaps [==============> ] 22.991058 s [racon::Polisher::initialize] aligning overlaps [===============> ] 24.583052 s [racon::Polisher::initialize] aligning overlaps [================> ] 26.111085 s [racon::Polisher::initialize] aligning overlaps [=================> ] 27.743049 s [racon::Polisher::initialize] aligning overlaps [==================> ] 29.347052 s [racon::Polisher::initialize] aligning overlaps [===================>] 30.807041 s [racon::Polisher::initialize] aligning overlaps [====================] 32.379056 s -[racon::Polisher::initialize] transformed data into windows 0.164994 s -[racon::Polisher::polish] generating consensus [=> ] 13.878719 s [racon::Polisher::polish] generating consensus [==> ] 22.599830 s [racon::Polisher::polish] generating consensus [===> ] 32.007895 s [racon::Polisher::polish] generating consensus [====> ] 39.695909 s [racon::Polisher::polish] generating consensus [=====> ] 49.219938 s [racon::Polisher::polish] generating consensus [======> ] 59.203802 s [racon::Polisher::polish] generating consensus [=======> ] 70.299805 s [racon::Polisher::polish] generating consensus [========> ] 77.871805 s [racon::Polisher::polish] generating consensus [=========> ] 87.923799 s [racon::Polisher::polish] generating consensus [==========> ] 98.599796 s [racon::Polisher::polish] generating consensus [===========> ] 106.587912 s [racon::Polisher::polish] generating consensus [============> ] 116.107901 s [racon::Polisher::polish] generating consensus [=============> ] 123.143801 s [racon::Polisher::polish] generating consensus [==============> ] 132.043808 s [racon::Polisher::polish] generating consensus [===============> ] 140.179783 s [racon::Polisher::polish] generating consensus [================> ] 144.463906 s [racon::Polisher::polish] generating consensus [=================> ] 155.891786 s [racon::Polisher::polish] generating consensus [==================> ] 165.359898 s [racon::Polisher::polish] generating consensus [===================>] 173.955815 s [racon::Polisher::polish] generating consensus [====================] 181.791899 s -[racon::Polisher::] total = 214.684499 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (214687 ms) +[racon::Polisher::initialize] loaded target sequences 0.090430 s +[racon::Polisher::initialize] loaded sequences 0.110736 s +[racon::Polisher::initialize] loaded overlaps 0.062199 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.595398 s [racon::Polisher::initialize] aligning overlaps [==> ] 2.535396 s [racon::Polisher::initialize] aligning overlaps [===> ] 3.443380 s [racon::Polisher::initialize] aligning overlaps [====> ] 4.795409 s [racon::Polisher::initialize] aligning overlaps [=====> ] 6.035394 s [racon::Polisher::initialize] aligning overlaps [======> ] 6.823381 s [racon::Polisher::initialize] aligning overlaps [=======> ] 7.835385 s [racon::Polisher::initialize] aligning overlaps [========> ] 9.099397 s [racon::Polisher::initialize] aligning overlaps [=========> ] 10.695258 s [racon::Polisher::initialize] aligning overlaps [==========> ] 11.827407 s [racon::Polisher::initialize] aligning overlaps [===========> ] 12.819390 s [racon::Polisher::initialize] aligning overlaps [============> ] 14.107393 s [racon::Polisher::initialize] aligning overlaps [=============> ] 15.667401 s [racon::Polisher::initialize] aligning overlaps [==============> ] 16.971399 s [racon::Polisher::initialize] aligning overlaps [===============> ] 18.223387 s [racon::Polisher::initialize] aligning overlaps [================> ] 19.535411 s [racon::Polisher::initialize] aligning overlaps [=================> ] 20.643381 s [racon::Polisher::initialize] aligning overlaps [==================> ] 21.903418 s [racon::Polisher::initialize] aligning overlaps [===================>] 23.243384 s [racon::Polisher::initialize] aligning overlaps [====================] 24.319399 s +[racon::Polisher::initialize] transformed data into windows 0.073003 s +[racon::Polisher::polish] generating consensus [=> ] 10.687405 s [racon::Polisher::polish] generating consensus [==> ] 18.383412 s [racon::Polisher::polish] generating consensus [===> ] 26.959484 s [racon::Polisher::polish] generating consensus [====> ] 33.531517 s [racon::Polisher::polish] generating consensus [=====> ] 41.451424 s [racon::Polisher::polish] generating consensus [======> ] 50.247427 s [racon::Polisher::polish] generating consensus [=======> ] 58.567425 s [racon::Polisher::polish] generating consensus [========> ] 64.379394 s [racon::Polisher::polish] generating consensus [=========> ] 71.303403 s [racon::Polisher::polish] generating consensus [==========> ] 80.391374 s [racon::Polisher::polish] generating consensus [===========> ] 88.035532 s [racon::Polisher::polish] generating consensus [============> ] 95.403511 s [racon::Polisher::polish] generating consensus [=============> ] 102.547394 s [racon::Polisher::polish] generating consensus [==============> ] 109.855413 s [racon::Polisher::polish] generating consensus [===============> ] 117.315417 s [racon::Polisher::polish] generating consensus [================> ] 121.231521 s [racon::Polisher::polish] generating consensus [=================> ] 130.779401 s [racon::Polisher::polish] generating consensus [==================> ] 139.619505 s [racon::Polisher::polish] generating consensus [===================>] 147.535443 s [racon::Polisher::polish] generating consensus [====================] 153.515565 s +[racon::Polisher::] total = 178.179830 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (178185 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap -[racon::Polisher::initialize] loaded target sequences 0.119422 s -[racon::Polisher::initialize] loaded sequences 0.116337 s -[racon::Polisher::initialize] loaded overlaps 0.035438 s -[racon::Polisher::initialize] aligning overlaps [=> ] 1.435836 s [racon::Polisher::initialize] aligning overlaps [==> ] 2.431853 s [racon::Polisher::initialize] aligning overlaps [===> ] 3.367844 s [racon::Polisher::initialize] aligning overlaps [====> ] 4.707833 s [racon::Polisher::initialize] aligning overlaps [=====> ] 5.855842 s [racon::Polisher::initialize] aligning overlaps [======> ] 6.723847 s [racon::Polisher::initialize] aligning overlaps [=======> ] 7.459822 s [racon::Polisher::initialize] aligning overlaps [========> ] 8.779321 s [racon::Polisher::initialize] aligning overlaps [=========> ] 10.322993 s [racon::Polisher::initialize] aligning overlaps [==========> ] 11.435827 s [racon::Polisher::initialize] aligning overlaps [===========> ] 12.271844 s [racon::Polisher::initialize] aligning overlaps [============> ] 13.727833 s [racon::Polisher::initialize] aligning overlaps [=============> ] 15.255836 s [racon::Polisher::initialize] aligning overlaps [==============> ] 16.199845 s [racon::Polisher::initialize] aligning overlaps [===============> ] 17.247862 s [racon::Polisher::initialize] aligning overlaps [================> ] 18.495837 s [racon::Polisher::initialize] aligning overlaps [=================> ] 20.035838 s [racon::Polisher::initialize] aligning overlaps [==================> ] 21.703854 s [racon::Polisher::initialize] aligning overlaps [===================>] 22.579815 s [racon::Polisher::initialize] aligning overlaps [====================] 23.062690 s -[racon::Polisher::initialize] transformed data into windows 0.245290 s -[racon::Polisher::polish] generating consensus [=> ] 7.920362 s [racon::Polisher::polish] generating consensus [==> ] 13.320364 s [racon::Polisher::polish] generating consensus [===> ] 20.180355 s [racon::Polisher::polish] generating consensus [====> ] 25.996467 s [racon::Polisher::polish] generating consensus [=====> ] 31.768382 s [racon::Polisher::polish] generating consensus [======> ] 38.556377 s [racon::Polisher::polish] generating consensus [=======> ] 44.084375 s [racon::Polisher::polish] generating consensus [========> ] 48.372391 s [racon::Polisher::polish] generating consensus [=========> ] 53.488406 s [racon::Polisher::polish] generating consensus [==========> ] 61.156328 s [racon::Polisher::polish] generating consensus [===========> ] 67.776385 s [racon::Polisher::polish] generating consensus [============> ] 73.984488 s [racon::Polisher::polish] generating consensus [=============> ] 79.712369 s [racon::Polisher::polish] generating consensus [==============> ] 86.444358 s [racon::Polisher::polish] generating consensus [===============> ] 92.420349 s [racon::Polisher::polish] generating consensus [================> ] 96.332460 s [racon::Polisher::polish] generating consensus [=================> ] 103.768427 s [racon::Polisher::polish] generating consensus [==================> ] 110.820485 s [racon::Polisher::polish] generating consensus [===================>] 116.500363 s [racon::Polisher::polish] generating consensus [====================] 121.272498 s -[racon::Polisher::] total = 144.877838 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (144880 ms) -[----------] 10 tests from RaconPolishingTest (743661 ms total) +[racon::Polisher::initialize] loaded target sequences 0.108649 s +[racon::Polisher::initialize] loaded sequences 0.092961 s +[racon::Polisher::initialize] loaded overlaps 0.023573 s +[racon::Polisher::initialize] aligning overlaps [=> ] 1.276213 s [racon::Polisher::initialize] aligning overlaps [==> ] 2.130429 s [racon::Polisher::initialize] aligning overlaps [===> ] 2.956172 s [racon::Polisher::initialize] aligning overlaps [====> ] 4.020191 s [racon::Polisher::initialize] aligning overlaps [=====> ] 4.784185 s [racon::Polisher::initialize] aligning overlaps [======> ] 5.500188 s [racon::Polisher::initialize] aligning overlaps [=======> ] 6.220180 s [racon::Polisher::initialize] aligning overlaps [========> ] 7.268184 s [racon::Polisher::initialize] aligning overlaps [=========> ] 8.504194 s [racon::Polisher::initialize] aligning overlaps [==========> ] 9.400172 s [racon::Polisher::initialize] aligning overlaps [===========> ] 10.184182 s [racon::Polisher::initialize] aligning overlaps [============> ] 11.316174 s [racon::Polisher::initialize] aligning overlaps [=============> ] 12.488165 s [racon::Polisher::initialize] aligning overlaps [==============> ] 13.556186 s [racon::Polisher::initialize] aligning overlaps [===============> ] 14.756179 s [racon::Polisher::initialize] aligning overlaps [================> ] 15.880192 s [racon::Polisher::initialize] aligning overlaps [=================> ] 17.088180 s [racon::Polisher::initialize] aligning overlaps [==================> ] 18.328193 s [racon::Polisher::initialize] aligning overlaps [===================>] 19.076176 s [racon::Polisher::initialize] aligning overlaps [====================] 19.805803 s +[racon::Polisher::initialize] transformed data into windows 0.203347 s +[racon::Polisher::polish] generating consensus [=> ] 6.824573 s [racon::Polisher::polish] generating consensus [==> ] 11.812577 s [racon::Polisher::polish] generating consensus [===> ] 17.040677 s [racon::Polisher::polish] generating consensus [====> ] 21.064693 s [racon::Polisher::polish] generating consensus [=====> ] 25.600591 s [racon::Polisher::polish] generating consensus [======> ] 31.048568 s [racon::Polisher::polish] generating consensus [=======> ] 35.984596 s [racon::Polisher::polish] generating consensus [========> ] 39.892594 s [racon::Polisher::polish] generating consensus [=========> ] 44.976570 s [racon::Polisher::polish] generating consensus [==========> ] 51.028570 s [racon::Polisher::polish] generating consensus [===========> ] 56.052714 s [racon::Polisher::polish] generating consensus [============> ] 61.812586 s [racon::Polisher::polish] generating consensus [=============> ] 66.876585 s [racon::Polisher::polish] generating consensus [==============> ] 72.088586 s [racon::Polisher::polish] generating consensus [===============> ] 77.444588 s [racon::Polisher::polish] generating consensus [================> ] 81.240689 s [racon::Polisher::polish] generating consensus [=================> ] 88.164555 s [racon::Polisher::polish] generating consensus [==================> ] 94.868689 s [racon::Polisher::polish] generating consensus [===================>] 101.564600 s [racon::Polisher::polish] generating consensus [====================] 106.489440 s +[racon::Polisher::] total = 126.731996 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (126739 ms) +[----------] 10 tests from RaconPolishingTest (505378 ms total) [----------] Global test environment tear-down -[==========] 15 tests from 2 test suites ran. (743762 ms total) +[==========] 15 tests from 2 test suites ran. (505420 ms total) [ PASSED ] 15 tests. make[1]: Leaving directory '/build/racon-1.5.0' create-stamp debian/debhelper-build-stamp @@ -708,12 +726,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: not including original source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/24270/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/24270/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/6193 and its subdirectories -I: Current time: Tue May 14 12:11:31 -12 2024 -I: pbuilder-time-stamp: 1715731891 +I: removing directory /srv/workspace/pbuilder/24270 and its subdirectories +I: Current time: Thu Apr 13 07:59:09 +14 2023 +I: pbuilder-time-stamp: 1681322349