Diff of the two buildlogs: -- --- b1/build.log 2024-04-27 11:31:02.578140823 +0000 +++ b2/build.log 2024-04-27 11:34:59.752027119 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Fri Apr 26 23:28:46 -12 2024 -I: pbuilder-time-stamp: 1714217326 +I: Current time: Sun Apr 28 01:31:05 +14 2024 +I: pbuilder-time-stamp: 1714217465 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -30,52 +30,84 @@ dpkg-source: info: applying py3 I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/3236606/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/1671518/tmp/hooks/D01_modify_environment starting +debug: Running on codethink02-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 +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Apr 27 11:31 /bin/sh -> /bin/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/1671518/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/1671518/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + 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=12 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='9a573c52cb5f4e45b93bde02dcade0fb' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='3236606' - PS1='# ' - PS2='> ' + INVOCATION_ID=2aa95ef5d6c54e9eac47bfa167432398 + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=1671518 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.EM2y9HuU/pbuilderrc_QP5T --distribution trixie --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.EM2y9HuU/b1 --logfile b1/build.log racon_1.5.0-3.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.4: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/r-b-build.EM2y9HuU/pbuilderrc_ar2i --distribution trixie --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.EM2y9HuU/b2 --logfile b2/build.log racon_1.5.0-3.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://192.168.101.4:3128 I: uname -a - Linux codethink04-arm64 6.1.0-20-cloud-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-20-cloud-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Apr 23 11:23 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/3236606/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Apr 21 07:15 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/1671518/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -227,7 +259,7 @@ Get: 60 http://deb.debian.org/debian trixie/main arm64 libspoa-dev arm64 4.1.4-1 [9380 B] Get: 61 http://deb.debian.org/debian trixie/main arm64 libthread-pool-dev arm64 4.0.0-2 [7304 B] Get: 62 http://deb.debian.org/debian trixie/main arm64 rampler arm64 2.1.1-1 [19.9 kB] -Fetched 37.4 MB in 0s (130 MB/s) +Fetched 37.4 MB in 0s (86.7 MB/s) debconf: delaying package configuration, since apt-utils is not installed dpkg: libssl3:arm64: dependency problems, but removing anyway as you requested: libkrb5-3:arm64 depends on libssl3 (>= 3.0.0). @@ -497,7 +529,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/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/1671518/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/1671518/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/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 @@ -523,7 +559,7 @@ -- Check for working CXX compiler: /usr/bin/c++ - skipped -- Detecting CXX compile features -- Detecting CXX compile features - done --- Configuring done (0.9s) +-- Configuring done (1.3s) -- Generating done (0.0s) CMake Warning: Manually-specified variables were not used by the project: @@ -551,14 +587,14 @@ make -f CMakeFiles/racon.dir/build.make CMakeFiles/racon.dir/build make[3]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu' [ 10%] Building CXX object CMakeFiles/racon.dir/src/logger.cpp.o -[ 20%] Building CXX object CMakeFiles/racon.dir/src/overlap.cpp.o -[ 30%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o -[ 40%] Building CXX object CMakeFiles/racon.dir/src/sequence.cpp.o /usr/bin/c++ -I/build/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -pthread -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/reproducible-path/racon-1.5.0/src/logger.cpp -[ 50%] Building CXX object CMakeFiles/racon.dir/src/window.cpp.o +[ 20%] Building CXX object CMakeFiles/racon.dir/src/polisher.cpp.o +[ 30%] Building CXX object CMakeFiles/racon.dir/src/overlap.cpp.o /usr/bin/c++ -I/build/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -pthread -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/reproducible-path/racon-1.5.0/src/polisher.cpp /usr/bin/c++ -I/build/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -pthread -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/reproducible-path/racon-1.5.0/src/overlap.cpp +[ 40%] Building CXX object CMakeFiles/racon.dir/src/sequence.cpp.o /usr/bin/c++ -I/build/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -pthread -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/reproducible-path/racon-1.5.0/src/sequence.cpp +[ 50%] Building CXX object CMakeFiles/racon.dir/src/window.cpp.o /usr/bin/c++ -I/build/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++11 -pthread -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/reproducible-path/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 @@ -574,15 +610,15 @@ make[3]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu' cd /build/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu && /usr/bin/cmake -E cmake_depends "Unix Makefiles" /build/reproducible-path/racon-1.5.0 /build/reproducible-path/racon-1.5.0 /build/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu /build/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu /build/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu/CMakeFiles/racon_test.dir/DependInfo.cmake "--color=" make[3]: Leaving directory '/build/reproducible-path/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/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu' -make[3]: Leaving directory '/build/reproducible-path/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/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu' make[3]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-aarch64-linux-gnu' -[ 70%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o -/usr/bin/c++ -DTEST_DATA=\"/build/reproducible-path/racon-1.5.0/test/data/\" -I/build/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++14 -DGTEST_HAS_PTHREAD=1 -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/reproducible-path/racon-1.5.0/test/racon_test.cpp -[ 80%] Building CXX object CMakeFiles/racon_exe.dir/src/main.cpp.o +make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/build +make[3]: Entering directory '/build/reproducible-path/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/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -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/reproducible-path/racon-1.5.0/src/main.cpp +[ 80%] Building CXX object CMakeFiles/racon_test.dir/test/racon_test.cpp.o +/usr/bin/c++ -DTEST_DATA=\"/build/reproducible-path/racon-1.5.0/test/data/\" -I/build/reproducible-path/racon-1.5.0/src -g -O2 -ffile-prefix-map=/build/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -Wdate-time -D_FORTIFY_SOURCE=2 -Wall -Wextra -pedantic -std=c++14 -DGTEST_HAS_PTHREAD=1 -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/reproducible-path/racon-1.5.0/test/racon_test.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/reproducible-path/racon-1.5.0=. -fstack-protector-strong -fstack-clash-protection -Wformat -Werror=format-security -mbranch-protection=standard -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 @@ -604,112 +640,112 @@ [----------] Global test environment set-up. [----------] 5 tests from RaconInitializeTest [ RUN ] RaconInitializeTest.PolisherTypeError -[ OK ] RaconInitializeTest.PolisherTypeError (8 ms) +[ OK ] RaconInitializeTest.PolisherTypeError (14 ms) [ RUN ] RaconInitializeTest.WindowLengthError -[ OK ] RaconInitializeTest.WindowLengthError (7 ms) +[ OK ] RaconInitializeTest.WindowLengthError (10 ms) [ RUN ] RaconInitializeTest.SequencesPathExtensionError -[ OK ] RaconInitializeTest.SequencesPathExtensionError (5 ms) +[ OK ] RaconInitializeTest.SequencesPathExtensionError (12 ms) [ RUN ] RaconInitializeTest.OverlapsPathExtensionError -[ OK ] RaconInitializeTest.OverlapsPathExtensionError (10 ms) +[ OK ] RaconInitializeTest.OverlapsPathExtensionError (11 ms) [ RUN ] RaconInitializeTest.TargetPathExtensionError -[ OK ] RaconInitializeTest.TargetPathExtensionError (5 ms) -[----------] 5 tests from RaconInitializeTest (40 ms total) +[ OK ] RaconInitializeTest.TargetPathExtensionError (12 ms) +[----------] 5 tests from RaconInitializeTest (61 ms total) [----------] 10 tests from RaconPolishingTest [ RUN ] RaconPolishingTest.ConsensusWithQualities -[racon::Polisher::initialize] loaded target sequences 0.000629 s -[racon::Polisher::initialize] loaded sequences 0.036538 s -[racon::Polisher::initialize] loaded overlaps 0.000471 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.088393 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.132139 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.148138 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.164133 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.176138 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.188135 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.196130 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.220142 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.232128 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.248145 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.264239 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.292229 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.310438 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.324204 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.352223 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.388436 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.400405 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.416402 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.428435 s [racon::Polisher::initialize] aligning overlaps [====================] 0.429570 s -[racon::Polisher::initialize] transformed data into windows 0.001580 s -[racon::Polisher::polish] generating consensus [=> ] 0.052772 s [racon::Polisher::polish] generating consensus [==> ] 0.104724 s [racon::Polisher::polish] generating consensus [===> ] 0.192735 s [racon::Polisher::polish] generating consensus [====> ] 0.220741 s [racon::Polisher::polish] generating consensus [=====> ] 0.248729 s [racon::Polisher::polish] generating consensus [======> ] 0.276730 s [racon::Polisher::polish] generating consensus [=======> ] 0.292733 s [racon::Polisher::polish] generating consensus [========> ] 0.312755 s [racon::Polisher::polish] generating consensus [=========> ] 0.328740 s [racon::Polisher::polish] generating consensus [==========> ] 0.344725 s [racon::Polisher::polish] generating consensus [===========> ] 0.376731 s [racon::Polisher::polish] generating consensus [============> ] 0.420745 s [racon::Polisher::polish] generating consensus [=============> ] 0.480725 s [racon::Polisher::polish] generating consensus [==============> ] 0.532912 s [racon::Polisher::polish] generating consensus [===============> ] 0.564891 s [racon::Polisher::polish] generating consensus [================> ] 0.596902 s [racon::Polisher::polish] generating consensus [=================> ] 0.624926 s [racon::Polisher::polish] generating consensus [==================> ] 0.636976 s [racon::Polisher::polish] generating consensus [===================>] 0.644926 s [racon::Polisher::polish] generating consensus [====================] 0.671745 s -[racon::Polisher::] total = 1.151632 s -[ OK ] RaconPolishingTest.ConsensusWithQualities (1161 ms) +[racon::Polisher::initialize] loaded target sequences 0.000419 s +[racon::Polisher::initialize] loaded sequences 0.066390 s +[racon::Polisher::initialize] loaded overlaps 0.000426 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.095569 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.119167 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.151154 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.175190 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.207136 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.235134 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.303134 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.327286 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.355193 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.371436 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.399430 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.419435 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.439440 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.454666 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.479436 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.519177 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.531141 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.571167 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.595146 s [racon::Polisher::initialize] aligning overlaps [====================] 0.623894 s +[racon::Polisher::initialize] transformed data into windows 0.001409 s +[racon::Polisher::polish] generating consensus [=> ] 0.117801 s [racon::Polisher::polish] generating consensus [==> ] 0.201834 s [racon::Polisher::polish] generating consensus [===> ] 0.273800 s [racon::Polisher::polish] generating consensus [====> ] 0.329827 s [racon::Polisher::polish] generating consensus [=====> ] 0.358085 s [racon::Polisher::polish] generating consensus [======> ] 0.398077 s [racon::Polisher::polish] generating consensus [=======> ] 0.430078 s [racon::Polisher::polish] generating consensus [========> ] 0.485822 s [racon::Polisher::polish] generating consensus [=========> ] 0.542062 s [racon::Polisher::polish] generating consensus [==========> ] 0.626068 s [racon::Polisher::polish] generating consensus [===========> ] 0.737793 s [racon::Polisher::polish] generating consensus [============> ] 0.821792 s [racon::Polisher::polish] generating consensus [=============> ] 0.997789 s [racon::Polisher::polish] generating consensus [==============> ] 1.125786 s [racon::Polisher::polish] generating consensus [===============> ] 1.125808 s [racon::Polisher::polish] generating consensus [================> ] 1.125844 s [racon::Polisher::polish] generating consensus [=================> ] 1.125853 s [racon::Polisher::polish] generating consensus [==================> ] 1.238089 s [racon::Polisher::polish] generating consensus [===================>] 1.270078 s [racon::Polisher::polish] generating consensus [====================] 1.349435 s +[racon::Polisher::] total = 2.060750 s +[ OK ] RaconPolishingTest.ConsensusWithQualities (2080 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualities -[racon::Polisher::initialize] loaded target sequences 0.000555 s -[racon::Polisher::initialize] loaded sequences 0.013969 s -[racon::Polisher::initialize] loaded overlaps 0.000277 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.040570 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.052579 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.072548 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.088557 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.096551 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.104556 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.128553 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.160562 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.168565 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.184562 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.200560 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.208548 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.236571 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.244558 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.252507 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.252520 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.252524 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.253810 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.253903 s [racon::Polisher::initialize] aligning overlaps [====================] 0.263259 s -[racon::Polisher::initialize] transformed data into windows 0.000483 s -[racon::Polisher::polish] generating consensus [=> ] 0.032493 s [racon::Polisher::polish] generating consensus [==> ] 0.068923 s [racon::Polisher::polish] generating consensus [===> ] 0.100469 s [racon::Polisher::polish] generating consensus [====> ] 0.128489 s [racon::Polisher::polish] generating consensus [=====> ] 0.156468 s [racon::Polisher::polish] generating consensus [======> ] 0.160649 s [racon::Polisher::polish] generating consensus [=======> ] 0.180426 s [racon::Polisher::polish] generating consensus [========> ] 0.196479 s [racon::Polisher::polish] generating consensus [=========> ] 0.220460 s [racon::Polisher::polish] generating consensus [==========> ] 0.256388 s [racon::Polisher::polish] generating consensus [===========> ] 0.292470 s [racon::Polisher::polish] generating consensus [============> ] 0.340475 s [racon::Polisher::polish] generating consensus [=============> ] 0.392498 s [racon::Polisher::polish] generating consensus [==============> ] 0.452467 s [racon::Polisher::polish] generating consensus [===============> ] 0.496480 s [racon::Polisher::polish] generating consensus [================> ] 0.548660 s [racon::Polisher::polish] generating consensus [=================> ] 0.592693 s [racon::Polisher::polish] generating consensus [==================> ] 0.624688 s [racon::Polisher::polish] generating consensus [===================>] 0.652474 s [racon::Polisher::polish] generating consensus [====================] 0.833198 s -[racon::Polisher::] total = 1.121331 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualities (1133 ms) +[racon::Polisher::initialize] loaded target sequences 0.006207 s +[racon::Polisher::initialize] loaded sequences 0.019895 s +[racon::Polisher::initialize] loaded overlaps 0.000211 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.067729 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.099880 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.131575 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.163716 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.191579 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.239853 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.299570 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.319577 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.335852 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.359877 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.375859 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.431861 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.443842 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.471871 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.511852 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.531855 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.535584 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.535598 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.545294 s [racon::Polisher::initialize] aligning overlaps [====================] 0.546677 s +[racon::Polisher::initialize] transformed data into windows 0.000464 s +[racon::Polisher::polish] generating consensus [=> ] 0.084116 s [racon::Polisher::polish] generating consensus [==> ] 0.188126 s [racon::Polisher::polish] generating consensus [===> ] 0.300417 s [racon::Polisher::polish] generating consensus [====> ] 0.344109 s [racon::Polisher::polish] generating consensus [=====> ] 0.368099 s [racon::Polisher::polish] generating consensus [======> ] 0.408099 s [racon::Polisher::polish] generating consensus [=======> ] 0.444105 s [racon::Polisher::polish] generating consensus [========> ] 0.468121 s [racon::Polisher::polish] generating consensus [=========> ] 0.508095 s [racon::Polisher::polish] generating consensus [==========> ] 0.584410 s [racon::Polisher::polish] generating consensus [===========> ] 0.700382 s [racon::Polisher::polish] generating consensus [============> ] 0.804379 s [racon::Polisher::polish] generating consensus [=============> ] 1.036096 s [racon::Polisher::polish] generating consensus [==============> ] 1.171271 s [racon::Polisher::polish] generating consensus [===============> ] 1.288379 s [racon::Polisher::polish] generating consensus [================> ] 1.388424 s [racon::Polisher::polish] generating consensus [=================> ] 1.484373 s [racon::Polisher::polish] generating consensus [==================> ] 1.508249 s [racon::Polisher::polish] generating consensus [===================>] 1.539746 s [racon::Polisher::polish] generating consensus [====================] 1.737609 s +[racon::Polisher::] total = 2.329328 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualities (2340 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments -[racon::Polisher::initialize] loaded target sequences 0.000443 s -[racon::Polisher::initialize] loaded sequences 0.030217 s -[racon::Polisher::initialize] loaded overlaps 0.015714 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.012727 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.012808 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.012889 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.012958 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.013026 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.013095 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.013182 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.013251 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.013322 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.013400 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.013467 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.013534 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.013616 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.013702 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.013782 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.013871 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.013955 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.014039 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.014122 s [racon::Polisher::initialize] aligning overlaps [====================] 0.014203 s -[racon::Polisher::initialize] transformed data into windows 0.002583 s -[racon::Polisher::polish] generating consensus [=> ] 0.030641 s [racon::Polisher::polish] generating consensus [==> ] 0.058628 s [racon::Polisher::polish] generating consensus [===> ] 0.098612 s [racon::Polisher::polish] generating consensus [====> ] 0.114624 s [racon::Polisher::polish] generating consensus [=====> ] 0.130693 s [racon::Polisher::polish] generating consensus [======> ] 0.142604 s [racon::Polisher::polish] generating consensus [=======> ] 0.150805 s [racon::Polisher::polish] generating consensus [========> ] 0.170641 s [racon::Polisher::polish] generating consensus [=========> ] 0.186618 s [racon::Polisher::polish] generating consensus [==========> ] 0.202605 s [racon::Polisher::polish] generating consensus [===========> ] 0.230613 s [racon::Polisher::polish] generating consensus [============> ] 0.266537 s [racon::Polisher::polish] generating consensus [=============> ] 0.314613 s [racon::Polisher::polish] generating consensus [==============> ] 0.366613 s [racon::Polisher::polish] generating consensus [===============> ] 0.418618 s [racon::Polisher::polish] generating consensus [================> ] 0.450656 s [racon::Polisher::polish] generating consensus [=================> ] 0.494616 s [racon::Polisher::polish] generating consensus [==================> ] 0.514615 s [racon::Polisher::polish] generating consensus [===================>] 0.534619 s [racon::Polisher::polish] generating consensus [====================] 0.610307 s -[racon::Polisher::] total = 0.683178 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (689 ms) +[racon::Polisher::initialize] loaded target sequences 0.005894 s +[racon::Polisher::initialize] loaded sequences 0.059843 s +[racon::Polisher::initialize] loaded overlaps 0.039981 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.015595 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.015935 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.016264 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.016582 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.016818 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.017047 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.017276 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.017502 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.017731 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.017964 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.018194 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.018423 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.018651 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.018878 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.019106 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.019333 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.019584 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.019812 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.020037 s [racon::Polisher::initialize] aligning overlaps [====================] 0.020269 s +[racon::Polisher::initialize] transformed data into windows 0.001553 s +[racon::Polisher::polish] generating consensus [=> ] 0.057704 s [racon::Polisher::polish] generating consensus [==> ] 0.121396 s [racon::Polisher::polish] generating consensus [===> ] 0.169395 s [racon::Polisher::polish] generating consensus [====> ] 0.205405 s [racon::Polisher::polish] generating consensus [=====> ] 0.229380 s [racon::Polisher::polish] generating consensus [======> ] 0.261384 s [racon::Polisher::polish] generating consensus [=======> ] 0.281398 s [racon::Polisher::polish] generating consensus [========> ] 0.313433 s [racon::Polisher::polish] generating consensus [=========> ] 0.337672 s [racon::Polisher::polish] generating consensus [==========> ] 0.393670 s [racon::Polisher::polish] generating consensus [===========> ] 0.461679 s [racon::Polisher::polish] generating consensus [============> ] 0.541675 s [racon::Polisher::polish] generating consensus [=============> ] 0.657384 s [racon::Polisher::polish] generating consensus [==============> ] 0.773383 s [racon::Polisher::polish] generating consensus [===============> ] 0.881693 s [racon::Polisher::polish] generating consensus [================> ] 0.957789 s [racon::Polisher::polish] generating consensus [=================> ] 1.037672 s [racon::Polisher::polish] generating consensus [==================> ] 1.089664 s [racon::Polisher::polish] generating consensus [===================>] 1.133679 s [racon::Polisher::polish] generating consensus [====================] 1.289069 s +[racon::Polisher::] total = 1.441883 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (1450 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments -[racon::Polisher::initialize] loaded target sequences 0.000980 s -[racon::Polisher::initialize] loaded sequences 0.013647 s -[racon::Polisher::initialize] loaded overlaps 0.015820 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.008122 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.008444 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.008765 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.009076 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.009401 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.009717 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.010026 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.010331 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.010636 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.010945 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.011254 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.011555 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.011870 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.012182 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.012461 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.012712 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.012939 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.013173 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.013401 s [racon::Polisher::initialize] aligning overlaps [====================] 0.013624 s -[racon::Polisher::initialize] transformed data into windows 0.000471 s -[racon::Polisher::polish] generating consensus [=> ] 0.063066 s [racon::Polisher::polish] generating consensus [==> ] 0.127081 s [racon::Polisher::polish] generating consensus [===> ] 0.183074 s [racon::Polisher::polish] generating consensus [====> ] 0.227089 s [racon::Polisher::polish] generating consensus [=====> ] 0.251089 s [racon::Polisher::polish] generating consensus [======> ] 0.268050 s [racon::Polisher::polish] generating consensus [=======> ] 0.282886 s [racon::Polisher::polish] generating consensus [========> ] 0.298896 s [racon::Polisher::polish] generating consensus [=========> ] 0.318879 s [racon::Polisher::polish] generating consensus [==========> ] 0.346884 s [racon::Polisher::polish] generating consensus [===========> ] 0.383063 s [racon::Polisher::polish] generating consensus [============> ] 0.422882 s [racon::Polisher::polish] generating consensus [=============> ] 0.479115 s [racon::Polisher::polish] generating consensus [==============> ] 0.535062 s [racon::Polisher::polish] generating consensus [===============> ] 0.583079 s [racon::Polisher::polish] generating consensus [================> ] 0.631104 s [racon::Polisher::polish] generating consensus [=================> ] 0.679060 s [racon::Polisher::polish] generating consensus [==================> ] 0.703077 s [racon::Polisher::polish] generating consensus [===================>] 0.726806 s [racon::Polisher::polish] generating consensus [====================] 0.818356 s -[racon::Polisher::] total = 0.870661 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (872 ms) +[racon::Polisher::initialize] loaded target sequences 0.000535 s +[racon::Polisher::initialize] loaded sequences 0.019760 s +[racon::Polisher::initialize] loaded overlaps 0.031795 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.015486 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.015806 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.016119 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.016459 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.016777 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.017087 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.017395 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.017698 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.018012 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.018253 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.018520 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.018759 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.018995 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.019227 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.019472 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.019703 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.019938 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.020173 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.020405 s [racon::Polisher::initialize] aligning overlaps [====================] 0.020631 s +[racon::Polisher::initialize] transformed data into windows 0.000512 s +[racon::Polisher::polish] generating consensus [=> ] 0.057020 s [racon::Polisher::polish] generating consensus [==> ] 0.149010 s [racon::Polisher::polish] generating consensus [===> ] 0.245013 s [racon::Polisher::polish] generating consensus [====> ] 0.324993 s [racon::Polisher::polish] generating consensus [=====> ] 0.357050 s [racon::Polisher::polish] generating consensus [======> ] 0.413007 s [racon::Polisher::polish] generating consensus [=======> ] 0.448996 s [racon::Polisher::polish] generating consensus [========> ] 0.513295 s [racon::Polisher::polish] generating consensus [=========> ] 0.543897 s [racon::Polisher::polish] generating consensus [==========> ] 0.609257 s [racon::Polisher::polish] generating consensus [===========> ] 0.693260 s [racon::Polisher::polish] generating consensus [============> ] 0.793272 s [racon::Polisher::polish] generating consensus [=============> ] 0.921332 s [racon::Polisher::polish] generating consensus [==============> ] 1.101502 s [racon::Polisher::polish] generating consensus [===============> ] 1.286030 s [racon::Polisher::polish] generating consensus [================> ] 1.456995 s [racon::Polisher::polish] generating consensus [=================> ] 1.590198 s [racon::Polisher::polish] generating consensus [==================> ] 1.590545 s [racon::Polisher::polish] generating consensus [===================>] 1.590889 s [racon::Polisher::polish] generating consensus [====================] 1.620909 s +[racon::Polisher::] total = 1.702143 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (1704 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow -[racon::Polisher::initialize] loaded target sequences 0.000550 s -[racon::Polisher::initialize] loaded sequences 0.027550 s -[racon::Polisher::initialize] loaded overlaps 0.000346 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.026848 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.039051 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.043024 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.055126 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.063028 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.072091 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.095043 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.103022 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.115024 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.119041 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.131045 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.139032 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.151044 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.155018 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.163020 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.175030 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.178858 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.186836 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.198841 s [racon::Polisher::initialize] aligning overlaps [====================] 0.207344 s -[racon::Polisher::initialize] transformed data into windows 0.001384 s -[racon::Polisher::polish] generating consensus [=> ] 0.114209 s [racon::Polisher::polish] generating consensus [==> ] 0.114538 s [racon::Polisher::polish] generating consensus [===> ] 0.210195 s [racon::Polisher::polish] generating consensus [====> ] 0.217933 s [racon::Polisher::polish] generating consensus [=====> ] 0.266239 s [racon::Polisher::polish] generating consensus [======> ] 0.266696 s [racon::Polisher::polish] generating consensus [=======> ] 0.305931 s [racon::Polisher::polish] generating consensus [========> ] 0.305970 s [racon::Polisher::polish] generating consensus [=========> ] 0.373927 s [racon::Polisher::polish] generating consensus [==========> ] 0.373946 s [racon::Polisher::polish] generating consensus [===========> ] 0.497928 s [racon::Polisher::polish] generating consensus [============> ] 0.509927 s [racon::Polisher::polish] generating consensus [=============> ] 0.713927 s [racon::Polisher::polish] generating consensus [==============> ] 0.713947 s [racon::Polisher::polish] generating consensus [===============> ] 0.838210 s [racon::Polisher::polish] generating consensus [================> ] 0.838578 s [racon::Polisher::polish] generating consensus [=================> ] 0.941297 s [racon::Polisher::polish] generating consensus [==================> ] 0.941642 s [racon::Polisher::polish] generating consensus [===================>] 1.029933 s [racon::Polisher::polish] generating consensus [====================] 1.241922 s -[racon::Polisher::] total = 1.487900 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (1504 ms) +[racon::Polisher::initialize] loaded target sequences 0.001366 s +[racon::Polisher::initialize] loaded sequences 0.026839 s +[racon::Polisher::initialize] loaded overlaps 0.000363 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.049935 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.065974 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.089651 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.105643 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.113651 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.125655 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.161647 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.193937 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.205981 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.225929 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.233939 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.277954 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.289943 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.325958 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.361947 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.397677 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.401916 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.413963 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.417912 s [racon::Polisher::initialize] aligning overlaps [====================] 0.432985 s +[racon::Polisher::initialize] transformed data into windows 0.008627 s +[racon::Polisher::polish] generating consensus [=> ] 0.199971 s [racon::Polisher::polish] generating consensus [==> ] 0.263670 s [racon::Polisher::polish] generating consensus [===> ] 0.379676 s [racon::Polisher::polish] generating consensus [====> ] 0.407981 s [racon::Polisher::polish] generating consensus [=====> ] 0.471671 s [racon::Polisher::polish] generating consensus [======> ] 0.483675 s [racon::Polisher::polish] generating consensus [=======> ] 0.547671 s [racon::Polisher::polish] generating consensus [========> ] 0.599694 s [racon::Polisher::polish] generating consensus [=========> ] 0.671670 s [racon::Polisher::polish] generating consensus [==========> ] 0.803941 s [racon::Polisher::polish] generating consensus [===========> ] 0.911958 s [racon::Polisher::polish] generating consensus [============> ] 1.083681 s [racon::Polisher::polish] generating consensus [=============> ] 1.319688 s [racon::Polisher::polish] generating consensus [==============> ] 1.495940 s [racon::Polisher::polish] generating consensus [===============> ] 1.579948 s [racon::Polisher::polish] generating consensus [================> ] 1.735982 s [racon::Polisher::polish] generating consensus [=================> ] 1.931944 s [racon::Polisher::polish] generating consensus [==================> ] 1.932282 s [racon::Polisher::polish] generating consensus [===================>] 2.099940 s [racon::Polisher::polish] generating consensus [====================] 2.380010 s +[racon::Polisher::] total = 2.868974 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (2884 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesEditDistance -[racon::Polisher::initialize] loaded target sequences 0.000363 s -[racon::Polisher::initialize] loaded sequences 0.035622 s -[racon::Polisher::initialize] loaded overlaps 0.000226 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.051928 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.066537 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.078633 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.102547 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.118537 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.118855 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.134543 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.158491 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.162534 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.170626 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.186552 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.198545 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.222563 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.222878 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.246537 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.259993 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.286525 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.289333 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.289669 s [racon::Polisher::initialize] aligning overlaps [====================] 0.302529 s -[racon::Polisher::initialize] transformed data into windows 0.001606 s -[racon::Polisher::polish] generating consensus [=> ] 0.042107 s [racon::Polisher::polish] generating consensus [==> ] 0.074098 s [racon::Polisher::polish] generating consensus [===> ] 0.101796 s [racon::Polisher::polish] generating consensus [====> ] 0.117840 s [racon::Polisher::polish] generating consensus [=====> ] 0.125828 s [racon::Polisher::polish] generating consensus [======> ] 0.133790 s [racon::Polisher::polish] generating consensus [=======> ] 0.153873 s [racon::Polisher::polish] generating consensus [========> ] 0.166068 s [racon::Polisher::polish] generating consensus [=========> ] 0.182051 s [racon::Polisher::polish] generating consensus [==========> ] 0.214058 s [racon::Polisher::polish] generating consensus [===========> ] 0.250052 s [racon::Polisher::polish] generating consensus [============> ] 0.298055 s [racon::Polisher::polish] generating consensus [=============> ] 0.366055 s [racon::Polisher::polish] generating consensus [==============> ] 0.421806 s [racon::Polisher::polish] generating consensus [===============> ] 0.461806 s [racon::Polisher::polish] generating consensus [================> ] 0.493815 s [racon::Polisher::polish] generating consensus [=================> ] 0.529802 s [racon::Polisher::polish] generating consensus [==================> ] 0.549795 s [racon::Polisher::polish] generating consensus [===================>] 0.569895 s [racon::Polisher::polish] generating consensus [====================] 0.642134 s -[racon::Polisher::] total = 0.991822 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (999 ms) +[racon::Polisher::initialize] loaded target sequences 0.000525 s +[racon::Polisher::initialize] loaded sequences 0.057533 s +[racon::Polisher::initialize] loaded overlaps 0.000403 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.047438 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.063410 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.083376 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.099398 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.115376 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.127402 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.183115 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.199413 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.214216 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.235383 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.259423 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.283394 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.299394 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.319418 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.327391 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.343406 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.355410 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.355687 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.363240 s [racon::Polisher::initialize] aligning overlaps [====================] 0.370441 s +[racon::Polisher::initialize] transformed data into windows 0.006327 s +[racon::Polisher::polish] generating consensus [=> ] 0.082261 s [racon::Polisher::polish] generating consensus [==> ] 0.154016 s [racon::Polisher::polish] generating consensus [===> ] 0.218259 s [racon::Polisher::polish] generating consensus [====> ] 0.266256 s [racon::Polisher::polish] generating consensus [=====> ] 0.294256 s [racon::Polisher::polish] generating consensus [======> ] 0.330241 s [racon::Polisher::polish] generating consensus [=======> ] 0.354231 s [racon::Polisher::polish] generating consensus [========> ] 0.390285 s [racon::Polisher::polish] generating consensus [=========> ] 0.442266 s [racon::Polisher::polish] generating consensus [==========> ] 0.498268 s [racon::Polisher::polish] generating consensus [===========> ] 0.586272 s [racon::Polisher::polish] generating consensus [============> ] 0.682274 s [racon::Polisher::polish] generating consensus [=============> ] 0.790269 s [racon::Polisher::polish] generating consensus [==============> ] 0.902278 s [racon::Polisher::polish] generating consensus [===============> ] 0.981987 s [racon::Polisher::polish] generating consensus [================> ] 1.033242 s [racon::Polisher::polish] generating consensus [=================> ] 1.113994 s [racon::Polisher::polish] generating consensus [==================> ] 1.153995 s [racon::Polisher::polish] generating consensus [===================>] 1.214279 s [racon::Polisher::polish] generating consensus [====================] 1.350795 s +[racon::Polisher::] total = 1.796262 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (1802 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualities -[racon::Polisher::initialize] loaded target sequences 0.026396 s -[racon::Polisher::initialize] loaded sequences 0.030409 s -[racon::Polisher::initialize] loaded overlaps 0.014133 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.031704 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.047967 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.067964 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.079941 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.095928 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.111943 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.131948 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.139979 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.151938 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.163933 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.175948 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.191943 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.203924 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.223949 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.227909 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.235969 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.241506 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.247683 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.247693 s [racon::Polisher::initialize] aligning overlaps [====================] 0.256608 s -[racon::Polisher::initialize] transformed data into windows 0.003021 s -[racon::Polisher::polish] generating consensus [=> ] 0.035853 s [racon::Polisher::polish] generating consensus [==> ] 0.055840 s [racon::Polisher::polish] generating consensus [===> ] 0.079884 s [racon::Polisher::polish] generating consensus [====> ] 0.080089 s [racon::Polisher::polish] generating consensus [=====> ] 0.096052 s [racon::Polisher::polish] generating consensus [======> ] 0.104133 s [racon::Polisher::polish] generating consensus [=======> ] 0.119897 s [racon::Polisher::polish] generating consensus [========> ] 0.127821 s [racon::Polisher::polish] generating consensus [=========> ] 0.151911 s [racon::Polisher::polish] generating consensus [==========> ] 0.163912 s [racon::Polisher::polish] generating consensus [===========> ] 0.176209 s [racon::Polisher::polish] generating consensus [============> ] 0.180102 s [racon::Polisher::polish] generating consensus [=============> ] 0.196078 s [racon::Polisher::polish] generating consensus [==============> ] 0.196509 s [racon::Polisher::polish] generating consensus [===============> ] 0.220073 s [racon::Polisher::polish] generating consensus [================> ] 0.220503 s [racon::Polisher::polish] generating consensus [=================> ] 0.284030 s [racon::Polisher::polish] generating consensus [==================> ] 0.300062 s [racon::Polisher::polish] generating consensus [===================>] 0.318410 s [racon::Polisher::polish] generating consensus [====================] 0.319089 s -[racon::Polisher::] total = 0.651054 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (652 ms) +[racon::Polisher::initialize] loaded target sequences 0.063371 s +[racon::Polisher::initialize] loaded sequences 0.042403 s +[racon::Polisher::initialize] loaded overlaps 0.008068 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.041655 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.081549 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.097545 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.121562 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.137547 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.157550 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.197559 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.225267 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.277521 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.285504 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.297545 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.317517 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.329515 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.345515 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.369340 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.397349 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.425328 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.448880 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.457611 s [racon::Polisher::initialize] aligning overlaps [====================] 0.465829 s +[racon::Polisher::initialize] transformed data into windows 0.003087 s +[racon::Polisher::polish] generating consensus [=> ] 0.047963 s [racon::Polisher::polish] generating consensus [==> ] 0.104335 s [racon::Polisher::polish] generating consensus [===> ] 0.160882 s [racon::Polisher::polish] generating consensus [====> ] 0.161336 s [racon::Polisher::polish] generating consensus [=====> ] 0.204281 s [racon::Polisher::polish] generating consensus [======> ] 0.212284 s [racon::Polisher::polish] generating consensus [=======> ] 0.240284 s [racon::Polisher::polish] generating consensus [========> ] 0.260111 s [racon::Polisher::polish] generating consensus [=========> ] 0.312122 s [racon::Polisher::polish] generating consensus [==========> ] 0.344007 s [racon::Polisher::polish] generating consensus [===========> ] 0.356081 s [racon::Polisher::polish] generating consensus [============> ] 0.360015 s [racon::Polisher::polish] generating consensus [=============> ] 0.384084 s [racon::Polisher::polish] generating consensus [==============> ] 0.384257 s [racon::Polisher::polish] generating consensus [===============> ] 0.448068 s [racon::Polisher::polish] generating consensus [================> ] 0.448226 s [racon::Polisher::polish] generating consensus [=================> ] 0.572005 s [racon::Polisher::polish] generating consensus [==================> ] 0.580067 s [racon::Polisher::polish] generating consensus [===================>] 0.596069 s [racon::Polisher::polish] generating consensus [====================] 0.604390 s +[racon::Polisher::] total = 1.188269 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (1192 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.027093 s -[racon::Polisher::initialize] loaded sequences 0.030463 s -[racon::Polisher::initialize] loaded overlaps 0.007083 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.317545 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.497561 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.653560 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.869462 s [racon::Polisher::initialize] aligning overlaps [=====> ] 1.053467 s [racon::Polisher::initialize] aligning overlaps [======> ] 1.185457 s [racon::Polisher::initialize] aligning overlaps [=======> ] 1.361729 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.589732 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.805723 s [racon::Polisher::initialize] aligning overlaps [==========> ] 2.013738 s [racon::Polisher::initialize] aligning overlaps [===========> ] 2.177737 s [racon::Polisher::initialize] aligning overlaps [============> ] 2.416056 s [racon::Polisher::initialize] aligning overlaps [=============> ] 2.677456 s [racon::Polisher::initialize] aligning overlaps [==============> ] 2.893464 s [racon::Polisher::initialize] aligning overlaps [===============> ] 3.161498 s [racon::Polisher::initialize] aligning overlaps [================> ] 3.413451 s [racon::Polisher::initialize] aligning overlaps [=================> ] 3.629462 s [racon::Polisher::initialize] aligning overlaps [==================> ] 3.889545 s [racon::Polisher::initialize] aligning overlaps [===================>] 4.157533 s [racon::Polisher::initialize] aligning overlaps [====================] 4.347241 s -[racon::Polisher::initialize] transformed data into windows 0.046545 s -[racon::Polisher::polish] generating consensus [=> ] 1.334063 s [racon::Polisher::polish] generating consensus [==> ] 2.242466 s [racon::Polisher::polish] generating consensus [===> ] 3.007603 s [racon::Polisher::polish] generating consensus [====> ] 3.830057 s [racon::Polisher::polish] generating consensus [=====> ] 4.813970 s [racon::Polisher::polish] generating consensus [======> ] 5.634147 s [racon::Polisher::polish] generating consensus [=======> ] 6.704504 s [racon::Polisher::polish] generating consensus [========> ] 7.322267 s [racon::Polisher::polish] generating consensus [=========> ] 8.042245 s [racon::Polisher::polish] generating consensus [==========> ] 9.082248 s [racon::Polisher::polish] generating consensus [===========> ] 9.878036 s [racon::Polisher::polish] generating consensus [============> ] 10.721975 s [racon::Polisher::polish] generating consensus [=============> ] 11.493979 s [racon::Polisher::polish] generating consensus [==============> ] 12.370251 s [racon::Polisher::polish] generating consensus [===============> ] 13.250259 s [racon::Polisher::polish] generating consensus [================> ] 13.830028 s [racon::Polisher::polish] generating consensus [=================> ] 14.765988 s [racon::Polisher::polish] generating consensus [==================> ] 15.638105 s [racon::Polisher::polish] generating consensus [===================>] 16.629973 s [racon::Polisher::polish] generating consensus [====================] 17.350121 s -[racon::Polisher::] total = 21.812714 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (21823 ms) +[racon::Polisher::initialize] loaded target sequences 0.062827 s +[racon::Polisher::initialize] loaded sequences 0.059839 s +[racon::Polisher::initialize] loaded overlaps 0.015844 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.887968 s [racon::Polisher::initialize] aligning overlaps [==> ] 1.331774 s [racon::Polisher::initialize] aligning overlaps [===> ] 1.839953 s [racon::Polisher::initialize] aligning overlaps [====> ] 2.399683 s [racon::Polisher::initialize] aligning overlaps [=====> ] 2.771697 s [racon::Polisher::initialize] aligning overlaps [======> ] 3.083755 s [racon::Polisher::initialize] aligning overlaps [=======> ] 3.487757 s [racon::Polisher::initialize] aligning overlaps [========> ] 3.983743 s [racon::Polisher::initialize] aligning overlaps [=========> ] 4.559776 s [racon::Polisher::initialize] aligning overlaps [==========> ] 4.987763 s [racon::Polisher::initialize] aligning overlaps [===========> ] 5.363761 s [racon::Polisher::initialize] aligning overlaps [============> ] 5.867751 s [racon::Polisher::initialize] aligning overlaps [=============> ] 6.427752 s [racon::Polisher::initialize] aligning overlaps [==============> ] 6.924129 s [racon::Polisher::initialize] aligning overlaps [===============> ] 7.443953 s [racon::Polisher::initialize] aligning overlaps [================> ] 7.819762 s [racon::Polisher::initialize] aligning overlaps [=================> ] 8.091758 s [racon::Polisher::initialize] aligning overlaps [==================> ] 8.347757 s [racon::Polisher::initialize] aligning overlaps [===================>] 8.611671 s [racon::Polisher::initialize] aligning overlaps [====================] 8.819756 s +[racon::Polisher::initialize] transformed data into windows 0.044985 s +[racon::Polisher::polish] generating consensus [=> ] 2.465227 s [racon::Polisher::polish] generating consensus [==> ] 4.233498 s [racon::Polisher::polish] generating consensus [===> ] 5.841226 s [racon::Polisher::polish] generating consensus [====> ] 7.357209 s [racon::Polisher::polish] generating consensus [=====> ] 8.461427 s [racon::Polisher::polish] generating consensus [======> ] 10.453428 s [racon::Polisher::polish] generating consensus [=======> ] 11.909405 s [racon::Polisher::polish] generating consensus [========> ] 13.377418 s [racon::Polisher::polish] generating consensus [=========> ] 15.181414 s [racon::Polisher::polish] generating consensus [==========> ] 16.985823 s [racon::Polisher::polish] generating consensus [===========> ] 18.153462 s [racon::Polisher::polish] generating consensus [============> ] 20.057493 s [racon::Polisher::polish] generating consensus [=============> ] 21.613426 s [racon::Polisher::polish] generating consensus [==============> ] 22.973149 s [racon::Polisher::polish] generating consensus [===============> ] 24.524964 s [racon::Polisher::polish] generating consensus [================> ] 25.607035 s [racon::Polisher::polish] generating consensus [=================> ] 27.401131 s [racon::Polisher::polish] generating consensus [==================> ] 29.409473 s [racon::Polisher::polish] generating consensus [===================>] 30.945156 s [racon::Polisher::polish] generating consensus [====================] 31.573842 s +[racon::Polisher::] total = 40.580945 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (40587 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.011459 s -[racon::Polisher::initialize] loaded sequences 0.015683 s -[racon::Polisher::initialize] loaded overlaps 0.015963 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.295971 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.475968 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.655987 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.871976 s [racon::Polisher::initialize] aligning overlaps [=====> ] 1.060179 s [racon::Polisher::initialize] aligning overlaps [======> ] 1.192193 s [racon::Polisher::initialize] aligning overlaps [=======> ] 1.368192 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.596156 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.851987 s [racon::Polisher::initialize] aligning overlaps [==========> ] 2.075971 s [racon::Polisher::initialize] aligning overlaps [===========> ] 2.260183 s [racon::Polisher::initialize] aligning overlaps [============> ] 2.500164 s [racon::Polisher::initialize] aligning overlaps [=============> ] 2.772160 s [racon::Polisher::initialize] aligning overlaps [==============> ] 3.048180 s [racon::Polisher::initialize] aligning overlaps [===============> ] 3.328014 s [racon::Polisher::initialize] aligning overlaps [================> ] 3.731971 s [racon::Polisher::initialize] aligning overlaps [=================> ] 3.935987 s [racon::Polisher::initialize] aligning overlaps [==================> ] 4.199988 s [racon::Polisher::initialize] aligning overlaps [===================>] 4.487886 s [racon::Polisher::initialize] aligning overlaps [====================] 4.590851 s -[racon::Polisher::initialize] transformed data into windows 0.015472 s -[racon::Polisher::polish] generating consensus [=> ] 1.611268 s [racon::Polisher::polish] generating consensus [==> ] 2.907259 s [racon::Polisher::polish] generating consensus [===> ] 4.011302 s [racon::Polisher::polish] generating consensus [====> ] 4.927297 s [racon::Polisher::polish] generating consensus [=====> ] 6.011267 s [racon::Polisher::polish] generating consensus [======> ] 7.079547 s [racon::Polisher::polish] generating consensus [=======> ] 8.219415 s [racon::Polisher::polish] generating consensus [========> ] 9.031411 s [racon::Polisher::polish] generating consensus [=========> ] 10.163247 s [racon::Polisher::polish] generating consensus [==========> ] 11.431258 s [racon::Polisher::polish] generating consensus [===========> ] 12.484185 s [racon::Polisher::polish] generating consensus [============> ] 13.935381 s [racon::Polisher::polish] generating consensus [=============> ] 15.079264 s [racon::Polisher::polish] generating consensus [==============> ] 17.011328 s [racon::Polisher::polish] generating consensus [===============> ] 18.663534 s [racon::Polisher::polish] generating consensus [================> ] 19.407314 s [racon::Polisher::polish] generating consensus [=================> ] 21.375256 s [racon::Polisher::polish] generating consensus [==================> ] 22.867595 s [racon::Polisher::polish] generating consensus [===================>] 24.139282 s [racon::Polisher::polish] generating consensus [====================] 24.912189 s -[racon::Polisher::] total = 29.564710 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (29568 ms) +[racon::Polisher::initialize] loaded target sequences 0.023509 s +[racon::Polisher::initialize] loaded sequences 0.027591 s +[racon::Polisher::initialize] loaded overlaps 0.015837 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.535790 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.915690 s [racon::Polisher::initialize] aligning overlaps [===> ] 1.279693 s [racon::Polisher::initialize] aligning overlaps [====> ] 1.779671 s [racon::Polisher::initialize] aligning overlaps [=====> ] 2.071960 s [racon::Polisher::initialize] aligning overlaps [======> ] 2.387969 s [racon::Polisher::initialize] aligning overlaps [=======> ] 2.795680 s [racon::Polisher::initialize] aligning overlaps [========> ] 3.291191 s [racon::Polisher::initialize] aligning overlaps [=========> ] 3.915681 s [racon::Polisher::initialize] aligning overlaps [==========> ] 4.339680 s [racon::Polisher::initialize] aligning overlaps [===========> ] 4.711708 s [racon::Polisher::initialize] aligning overlaps [============> ] 5.215959 s [racon::Polisher::initialize] aligning overlaps [=============> ] 5.723679 s [racon::Polisher::initialize] aligning overlaps [==============> ] 6.211686 s [racon::Polisher::initialize] aligning overlaps [===============> ] 6.783681 s [racon::Polisher::initialize] aligning overlaps [================> ] 7.287689 s [racon::Polisher::initialize] aligning overlaps [=================> ] 7.815686 s [racon::Polisher::initialize] aligning overlaps [==================> ] 8.355676 s [racon::Polisher::initialize] aligning overlaps [===================>] 8.559697 s [racon::Polisher::initialize] aligning overlaps [====================] 8.735996 s +[racon::Polisher::initialize] transformed data into windows 0.026147 s +[racon::Polisher::polish] generating consensus [=> ] 3.543645 s [racon::Polisher::polish] generating consensus [==> ] 5.875648 s [racon::Polisher::polish] generating consensus [===> ] 8.935683 s [racon::Polisher::polish] generating consensus [====> ] 11.123683 s [racon::Polisher::polish] generating consensus [=====> ] 14.043913 s [racon::Polisher::polish] generating consensus [======> ] 16.339664 s [racon::Polisher::polish] generating consensus [=======> ] 17.935642 s [racon::Polisher::polish] generating consensus [========> ] 19.927912 s [racon::Polisher::polish] generating consensus [=========> ] 21.591650 s [racon::Polisher::polish] generating consensus [==========> ] 24.663897 s [racon::Polisher::polish] generating consensus [===========> ] 26.851690 s [racon::Polisher::polish] generating consensus [============> ] 29.551638 s [racon::Polisher::polish] generating consensus [=============> ] 31.935945 s [racon::Polisher::polish] generating consensus [==============> ] 33.848157 s [racon::Polisher::polish] generating consensus [===============> ] 35.200100 s [racon::Polisher::polish] generating consensus [================> ] 35.824628 s [racon::Polisher::polish] generating consensus [=================> ] 38.595967 s [racon::Polisher::polish] generating consensus [==================> ] 41.351714 s [racon::Polisher::polish] generating consensus [===================>] 42.415659 s [racon::Polisher::polish] generating consensus [====================] 42.907983 s +[racon::Polisher::] total = 51.740481 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (51744 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap -[racon::Polisher::initialize] loaded target sequences 0.039006 s -[racon::Polisher::initialize] loaded sequences 0.048298 s -[racon::Polisher::initialize] loaded overlaps 0.008558 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.434003 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.670125 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.869999 s [racon::Polisher::initialize] aligning overlaps [====> ] 1.113854 s [racon::Polisher::initialize] aligning overlaps [=====> ] 1.262048 s [racon::Polisher::initialize] aligning overlaps [======> ] 1.406191 s [racon::Polisher::initialize] aligning overlaps [=======> ] 1.593951 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.885949 s [racon::Polisher::initialize] aligning overlaps [=========> ] 2.296313 s [racon::Polisher::initialize] aligning overlaps [==========> ] 2.573937 s [racon::Polisher::initialize] aligning overlaps [===========> ] 2.761959 s [racon::Polisher::initialize] aligning overlaps [============> ] 3.033969 s [racon::Polisher::initialize] aligning overlaps [=============> ] 3.376253 s [racon::Polisher::initialize] aligning overlaps [==============> ] 3.666002 s [racon::Polisher::initialize] aligning overlaps [===============> ] 3.946037 s [racon::Polisher::initialize] aligning overlaps [================> ] 4.237847 s [racon::Polisher::initialize] aligning overlaps [=================> ] 4.525860 s [racon::Polisher::initialize] aligning overlaps [==================> ] 5.341864 s [racon::Polisher::initialize] aligning overlaps [===================>] 5.548842 s [racon::Polisher::initialize] aligning overlaps [====================] 5.709435 s -[racon::Polisher::initialize] transformed data into windows 0.083697 s -[racon::Polisher::polish] generating consensus [=> ] 2.764076 s [racon::Polisher::polish] generating consensus [==> ] 3.690431 s [racon::Polisher::polish] generating consensus [===> ] 4.699855 s [racon::Polisher::polish] generating consensus [====> ] 5.799845 s [racon::Polisher::polish] generating consensus [=====> ] 6.635900 s [racon::Polisher::polish] generating consensus [======> ] 7.727845 s [racon::Polisher::polish] generating consensus [=======> ] 9.012082 s [racon::Polisher::polish] generating consensus [========> ] 9.961585 s [racon::Polisher::polish] generating consensus [=========> ] 10.824089 s [racon::Polisher::polish] generating consensus [==========> ] 12.044276 s [racon::Polisher::polish] generating consensus [===========> ] 13.255859 s [racon::Polisher::polish] generating consensus [============> ] 14.356118 s [racon::Polisher::polish] generating consensus [=============> ] 15.296144 s [racon::Polisher::polish] generating consensus [==============> ] 16.386254 s [racon::Polisher::polish] generating consensus [===============> ] 17.799812 s [racon::Polisher::polish] generating consensus [================> ] 18.512119 s [racon::Polisher::polish] generating consensus [=================> ] 19.868126 s [racon::Polisher::polish] generating consensus [==================> ] 20.975974 s [racon::Polisher::polish] generating consensus [===================>] 21.847911 s [racon::Polisher::polish] generating consensus [====================] 22.143826 s -[racon::Polisher::] total = 28.039190 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (28042 ms) -[----------] 10 tests from RaconPolishingTest (86452 ms total) +[racon::Polisher::initialize] loaded target sequences 0.030185 s +[racon::Polisher::initialize] loaded sequences 0.028100 s +[racon::Polisher::initialize] loaded overlaps 0.008288 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.527620 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.915620 s [racon::Polisher::initialize] aligning overlaps [===> ] 1.351930 s [racon::Polisher::initialize] aligning overlaps [====> ] 1.851707 s [racon::Polisher::initialize] aligning overlaps [=====> ] 2.275702 s [racon::Polisher::initialize] aligning overlaps [======> ] 2.575614 s [racon::Polisher::initialize] aligning overlaps [=======> ] 2.983619 s [racon::Polisher::initialize] aligning overlaps [========> ] 3.503616 s [racon::Polisher::initialize] aligning overlaps [=========> ] 3.983614 s [racon::Polisher::initialize] aligning overlaps [==========> ] 4.387910 s [racon::Polisher::initialize] aligning overlaps [===========> ] 4.703887 s [racon::Polisher::initialize] aligning overlaps [============> ] 4.967693 s [racon::Polisher::initialize] aligning overlaps [=============> ] 5.227884 s [racon::Polisher::initialize] aligning overlaps [==============> ] 5.711885 s [racon::Polisher::initialize] aligning overlaps [===============> ] 6.299323 s [racon::Polisher::initialize] aligning overlaps [================> ] 6.863877 s [racon::Polisher::initialize] aligning overlaps [=================> ] 7.307617 s [racon::Polisher::initialize] aligning overlaps [==================> ] 7.831611 s [racon::Polisher::initialize] aligning overlaps [===================>] 7.999610 s [racon::Polisher::initialize] aligning overlaps [====================] 8.074301 s +[racon::Polisher::initialize] transformed data into windows 0.044828 s +[racon::Polisher::polish] generating consensus [=> ] 2.382710 s [racon::Polisher::polish] generating consensus [==> ] 3.951070 s [racon::Polisher::polish] generating consensus [===> ] 5.522708 s [racon::Polisher::polish] generating consensus [====> ] 6.986754 s [racon::Polisher::polish] generating consensus [=====> ] 8.734705 s [racon::Polisher::polish] generating consensus [======> ] 10.603149 s [racon::Polisher::polish] generating consensus [=======> ] 11.411155 s [racon::Polisher::polish] generating consensus [========> ] 12.026885 s [racon::Polisher::polish] generating consensus [=========> ] 12.755027 s [racon::Polisher::polish] generating consensus [==========> ] 13.631025 s [racon::Polisher::polish] generating consensus [===========> ] 14.394754 s [racon::Polisher::polish] generating consensus [============> ] 15.334701 s [racon::Polisher::polish] generating consensus [=============> ] 16.286709 s [racon::Polisher::polish] generating consensus [==============> ] 18.126976 s [racon::Polisher::polish] generating consensus [===============> ] 19.158976 s [racon::Polisher::polish] generating consensus [================> ] 19.583047 s [racon::Polisher::polish] generating consensus [=================> ] 21.250326 s [racon::Polisher::polish] generating consensus [==================> ] 23.282758 s [racon::Polisher::polish] generating consensus [===================>] 24.082701 s [racon::Polisher::polish] generating consensus [====================] 24.602874 s +[racon::Polisher::] total = 32.798805 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (32807 ms) +[----------] 10 tests from RaconPolishingTest (138595 ms total) [----------] Global test environment tear-down -[==========] 15 tests from 2 test suites ran. (86492 ms total) +[==========] 15 tests from 2 test suites ran. (138657 ms total) [ PASSED ] 15 tests. make[1]: Leaving directory '/build/reproducible-path/racon-1.5.0' create-stamp debian/debhelper-build-stamp @@ -758,12 +794,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/1671518/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/1671518/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/3236606 and its subdirectories -I: Current time: Fri Apr 26 23:31:01 -12 2024 -I: pbuilder-time-stamp: 1714217461 +I: removing directory /srv/workspace/pbuilder/1671518 and its subdirectories +I: Current time: Sun Apr 28 01:34:58 +14 2024 +I: pbuilder-time-stamp: 1714217698