Diff of the two buildlogs: -- --- b1/build.log 2024-05-08 17:27:14.633218653 +0000 +++ b2/build.log 2024-05-08 18:23:49.400705084 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed May 8 04:22:35 -12 2024 -I: pbuilder-time-stamp: 1715185355 +I: Current time: Thu May 9 07:27:30 +14 2024 +I: pbuilder-time-stamp: 1715189250 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/2761/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/4205/tmp/hooks/D01_modify_environment starting +debug: Running on virt32a. +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 May 8 17:27 /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/4205/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/4205/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='armhf' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=5 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='armhf' + 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]="arm-unknown-linux-gnueabihf") + 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=armhf + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=4 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=arm + HOST_ARCH=armhf IFS=' ' - INVOCATION_ID='afb1a6029ab64b908bcaa2d316727e68' - 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='2761' - PS1='# ' - PS2='> ' + INVOCATION_ID=9be7111d0d404f0382390639c4866ba5 + LANG=C + LANGUAGE=it_CH:it + LC_ALL=C + MACHTYPE=arm-unknown-linux-gnueabihf + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnueabihf + 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=4205 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.4afJXjzD/pbuilderrc_eA25 --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.4afJXjzD/b1 --logfile b1/build.log racon_1.5.0-3.dsc' - SUDO_GID='114' - SUDO_UID='109' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://10.0.0.15:3142/' + 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.4afJXjzD/pbuilderrc_eeUL --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.4afJXjzD/b2 --logfile b2/build.log racon_1.5.0-3.dsc' + SUDO_GID=113 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://10.0.0.15:3142/ I: uname -a - Linux ff64a 6.1.0-21-arm64 #1 SMP Debian 6.1.90-1 (2024-05-03) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-21-armmp-lpae #1 SMP Debian 6.1.90-1 (2024-05-03) armv7l GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 May 6 11:27 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/2761/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 May 7 11:24 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/4205/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -191,7 +223,7 @@ Get: 62 http://deb.debian.org/debian trixie/main armhf libspoa-dev armhf 4.1.4-1 [9388 B] Get: 63 http://deb.debian.org/debian trixie/main armhf libthread-pool-dev armhf 4.0.0-2 [7304 B] Get: 64 http://deb.debian.org/debian trixie/main armhf rampler armhf 2.1.1-1 [19.3 kB] -Fetched 31.1 MB in 1s (34.4 MB/s) +Fetched 31.1 MB in 3s (11.0 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libproc2-0:armhf. (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 ... 19444 files and directories currently installed.) @@ -462,7 +494,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/4205/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/4205/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 @@ -488,8 +524,8 @@ -- Check for working CXX compiler: /usr/bin/c++ - skipped -- Detecting CXX compile features -- Detecting CXX compile features - done --- Configuring done (3.0s) --- Generating done (0.0s) +-- Configuring done (5.0s) +-- Generating done (0.1s) CMake Warning: Manually-specified variables were not used by the project: @@ -503,7 +539,7 @@ sed -i 's/-lpthread/-pthread/' obj-*/CMakeFiles/racon_test.dir/link.txt make[1]: Leaving directory '/build/reproducible-path/racon-1.5.0' dh_auto_build -O--buildsystem=cmake - cd obj-arm-linux-gnueabihf && make -j5 "INSTALL=install --strip-program=true" VERBOSE=1 + cd obj-arm-linux-gnueabihf && make -j4 "INSTALL=install --strip-program=true" VERBOSE=1 make[1]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf' /usr/bin/cmake -S/build/reproducible-path/racon-1.5.0 -B/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf --check-build-system CMakeFiles/Makefile.cmake 0 /usr/bin/cmake -E cmake_progress_start /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf/CMakeFiles /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf//CMakeFiles/progress.marks @@ -517,14 +553,12 @@ make[3]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf' [ 10%] Building CXX object CMakeFiles/racon.dir/src/logger.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 -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -D_TIME_BITS=64 -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 -[ 30%] Building CXX object CMakeFiles/racon.dir/src/window.cpp.o [ 20%] Building CXX object CMakeFiles/racon.dir/src/polisher.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 -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -D_TIME_BITS=64 -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 -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -D_TIME_BITS=64 -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 +[ 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 -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -D_TIME_BITS=64 -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 -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -D_TIME_BITS=64 -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/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 -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -D_TIME_BITS=64 -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 /build/reproducible-path/racon-1.5.0/src/overlap.cpp: In member function 'virtual void racon::Overlap::align_overlaps(const char*, uint32_t, const char*, uint32_t)': /build/reproducible-path/racon-1.5.0/src/overlap.cpp:219:48: warning: format '%zu' expects argument of type 'size_t', but argument 3 has type 'uint64_t' {aka 'long long unsigned int'} [-Wformat=] 219 | "edlib unable to align pair (%zu x %zu)!\n", q_id_, t_id_); @@ -538,6 +572,8 @@ | | | | unsigned int uint64_t {aka long long unsigned int} | %llu +[ 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 -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -D_TIME_BITS=64 -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 /build/reproducible-path/racon-1.5.0/src/window.cpp: In member function 'bool racon::Window::generate_consensus(std::shared_ptr, bool)': /build/reproducible-path/racon-1.5.0/src/window.cpp:142:27: warning: format '%lu' expects argument of type 'long unsigned int', but argument 3 has type 'uint64_t' {aka 'long long unsigned int'} [-Wformat=] 142 | "contig %lu might be chimeric in window %u!\n", id_, rank_); @@ -553,8 +589,8 @@ make[3]: Leaving directory '/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf' [ 60%] Built target racon make -f CMakeFiles/racon_exe.dir/build.make CMakeFiles/racon_exe.dir/depend -make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/depend make[3]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf' +make -f CMakeFiles/racon_test.dir/build.make CMakeFiles/racon_test.dir/depend cd /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf && /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-arm-linux-gnueabihf /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf/CMakeFiles/racon_exe.dir/DependInfo.cmake "--color=" make[3]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf' cd /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf && /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-arm-linux-gnueabihf /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf /build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf/CMakeFiles/racon_test.dir/DependInfo.cmake "--color=" @@ -589,119 +625,119 @@ [----------] Global test environment set-up. [----------] 5 tests from RaconInitializeTest [ RUN ] RaconInitializeTest.PolisherTypeError -[ OK ] RaconInitializeTest.PolisherTypeError (7 ms) +[ OK ] RaconInitializeTest.PolisherTypeError (22 ms) [ RUN ] RaconInitializeTest.WindowLengthError -[ OK ] RaconInitializeTest.WindowLengthError (5 ms) +[ OK ] RaconInitializeTest.WindowLengthError (12 ms) [ RUN ] RaconInitializeTest.SequencesPathExtensionError -[ OK ] RaconInitializeTest.SequencesPathExtensionError (8 ms) +[ OK ] RaconInitializeTest.SequencesPathExtensionError (12 ms) [ RUN ] RaconInitializeTest.OverlapsPathExtensionError -[ OK ] RaconInitializeTest.OverlapsPathExtensionError (17 ms) +[ OK ] RaconInitializeTest.OverlapsPathExtensionError (20 ms) [ RUN ] RaconInitializeTest.TargetPathExtensionError -[ OK ] RaconInitializeTest.TargetPathExtensionError (16 ms) -[----------] 5 tests from RaconInitializeTest (56 ms total) +[ OK ] RaconInitializeTest.TargetPathExtensionError (24 ms) +[----------] 5 tests from RaconInitializeTest (111 ms total) [----------] 10 tests from RaconPolishingTest [ RUN ] RaconPolishingTest.ConsensusWithQualities -[racon::Polisher::initialize] loaded target sequences 0.006097 s -[racon::Polisher::initialize] loaded sequences 0.217822 s -[racon::Polisher::initialize] loaded overlaps 0.002559 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.214512 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.298623 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.421718 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.556032 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.652005 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.683449 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.824318 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.942312 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.068065 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.165861 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.307785 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.433885 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.565211 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.639099 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.741079 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.840076 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.997651 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.113479 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.240011 s [racon::Polisher::initialize] aligning overlaps [====================] 2.294019 s -[racon::Polisher::initialize] transformed data into windows 0.022633 s -[racon::Polisher::polish] generating consensus [=> ] 1.899041 s [racon::Polisher::polish] generating consensus [==> ] 3.904017 s [racon::Polisher::polish] generating consensus [===> ] 5.867351 s [racon::Polisher::polish] generating consensus [====> ] 7.153550 s [racon::Polisher::polish] generating consensus [=====> ] 7.754187 s [racon::Polisher::polish] generating consensus [======> ] 8.610834 s [racon::Polisher::polish] generating consensus [=======> ] 9.417485 s [racon::Polisher::polish] generating consensus [========> ] 10.285193 s [racon::Polisher::polish] generating consensus [=========> ] 11.052082 s [racon::Polisher::polish] generating consensus [==========> ] 13.142400 s [racon::Polisher::polish] generating consensus [===========> ] 15.030315 s [racon::Polisher::polish] generating consensus [============> ] 18.086620 s [racon::Polisher::polish] generating consensus [=============> ] 21.538718 s [racon::Polisher::polish] generating consensus [==============> ] 25.465588 s [racon::Polisher::polish] generating consensus [===============> ] 27.137996 s [racon::Polisher::polish] generating consensus [================> ] 27.520607 s [racon::Polisher::polish] generating consensus [=================> ] 27.523771 s [racon::Polisher::polish] generating consensus [==================> ] 27.763162 s [racon::Polisher::polish] generating consensus [===================>] 28.659873 s [racon::Polisher::polish] generating consensus [====================] 31.943243 s -[racon::Polisher::] total = 34.601416 s -[ OK ] RaconPolishingTest.ConsensusWithQualities (34654 ms) +[racon::Polisher::initialize] loaded target sequences 0.010357 s +[racon::Polisher::initialize] loaded sequences 0.264443 s +[racon::Polisher::initialize] loaded overlaps 0.006663 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.238530 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.307027 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.406787 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.532185 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.620125 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.648143 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.732178 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.896152 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.940134 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.024161 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.108141 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.276079 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.392215 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.448119 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.588130 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.742206 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.796102 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.916143 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.968114 s [racon::Polisher::initialize] aligning overlaps [====================] 2.044166 s +[racon::Polisher::initialize] transformed data into windows 0.034515 s +[racon::Polisher::polish] generating consensus [=> ] 1.787847 s [racon::Polisher::polish] generating consensus [==> ] 3.451793 s [racon::Polisher::polish] generating consensus [===> ] 5.335803 s [racon::Polisher::polish] generating consensus [====> ] 6.487858 s [racon::Polisher::polish] generating consensus [=====> ] 6.955884 s [racon::Polisher::polish] generating consensus [======> ] 7.679813 s [racon::Polisher::polish] generating consensus [=======> ] 8.343833 s [racon::Polisher::polish] generating consensus [========> ] 9.059733 s [racon::Polisher::polish] generating consensus [=========> ] 9.687759 s [racon::Polisher::polish] generating consensus [==========> ] 11.421207 s [racon::Polisher::polish] generating consensus [===========> ] 12.950981 s [racon::Polisher::polish] generating consensus [============> ] 15.495800 s [racon::Polisher::polish] generating consensus [=============> ] 18.247885 s [racon::Polisher::polish] generating consensus [==============> ] 21.537714 s [racon::Polisher::polish] generating consensus [===============> ] 23.855617 s [racon::Polisher::polish] generating consensus [================> ] 25.567866 s [racon::Polisher::polish] generating consensus [=================> ] 27.635891 s [racon::Polisher::polish] generating consensus [==================> ] 28.866724 s [racon::Polisher::polish] generating consensus [===================>] 30.522715 s [racon::Polisher::polish] generating consensus [====================] 37.040564 s +[racon::Polisher::] total = 39.491903 s +[ OK ] RaconPolishingTest.ConsensusWithQualities (39593 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualities -[racon::Polisher::initialize] loaded target sequences 0.002888 s -[racon::Polisher::initialize] loaded sequences 0.102755 s -[racon::Polisher::initialize] loaded overlaps 0.001688 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.182626 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.284201 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.423216 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.535938 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.669083 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.783854 s [racon::Polisher::initialize] aligning overlaps [=======> ] 1.053401 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.188472 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.297083 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.390762 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.522423 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.636179 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.764502 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.829979 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.914906 s [racon::Polisher::initialize] aligning overlaps [================> ] 2.065067 s [racon::Polisher::initialize] aligning overlaps [=================> ] 2.129975 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.234487 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.288732 s [racon::Polisher::initialize] aligning overlaps [====================] 2.314118 s -[racon::Polisher::initialize] transformed data into windows 0.004156 s -[racon::Polisher::polish] generating consensus [=> ] 2.068885 s [racon::Polisher::polish] generating consensus [==> ] 4.564525 s [racon::Polisher::polish] generating consensus [===> ] 6.986185 s [racon::Polisher::polish] generating consensus [====> ] 8.532449 s [racon::Polisher::polish] generating consensus [=====> ] 9.515667 s [racon::Polisher::polish] generating consensus [======> ] 10.607598 s [racon::Polisher::polish] generating consensus [=======> ] 11.621651 s [racon::Polisher::polish] generating consensus [========> ] 12.732714 s [racon::Polisher::polish] generating consensus [=========> ] 14.312831 s [racon::Polisher::polish] generating consensus [==========> ] 16.789856 s [racon::Polisher::polish] generating consensus [===========> ] 19.716460 s [racon::Polisher::polish] generating consensus [============> ] 23.364187 s [racon::Polisher::polish] generating consensus [=============> ] 27.660469 s [racon::Polisher::polish] generating consensus [==============> ] 30.833732 s [racon::Polisher::polish] generating consensus [===============> ] 32.836180 s [racon::Polisher::polish] generating consensus [================> ] 34.951735 s [racon::Polisher::polish] generating consensus [=================> ] 36.717624 s [racon::Polisher::polish] generating consensus [==================> ] 38.111958 s [racon::Polisher::polish] generating consensus [===================>] 39.203978 s [racon::Polisher::polish] generating consensus [====================] 43.862835 s -[racon::Polisher::] total = 46.387195 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualities (46431 ms) +[racon::Polisher::initialize] loaded target sequences 0.010351 s +[racon::Polisher::initialize] loaded sequences 0.131728 s +[racon::Polisher::initialize] loaded overlaps 0.005309 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.148050 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.252132 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.352092 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.463972 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.552140 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.576103 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.787758 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.908165 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.004093 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.088126 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.204128 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.300132 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.416137 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.472073 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.552163 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.688152 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.740190 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.820197 s [racon::Polisher::initialize] aligning overlaps [===================>] 1.936106 s [racon::Polisher::initialize] aligning overlaps [====================] 2.020483 s +[racon::Polisher::initialize] transformed data into windows 0.001677 s +[racon::Polisher::polish] generating consensus [=> ] 1.912417 s [racon::Polisher::polish] generating consensus [==> ] 4.168446 s [racon::Polisher::polish] generating consensus [===> ] 5.856467 s [racon::Polisher::polish] generating consensus [====> ] 7.120412 s [racon::Polisher::polish] generating consensus [=====> ] 7.935638 s [racon::Polisher::polish] generating consensus [======> ] 8.860396 s [racon::Polisher::polish] generating consensus [=======> ] 9.712429 s [racon::Polisher::polish] generating consensus [========> ] 10.576406 s [racon::Polisher::polish] generating consensus [=========> ] 12.028405 s [racon::Polisher::polish] generating consensus [==========> ] 14.251206 s [racon::Polisher::polish] generating consensus [===========> ] 16.619220 s [racon::Polisher::polish] generating consensus [============> ] 19.492418 s [racon::Polisher::polish] generating consensus [=============> ] 23.724323 s [racon::Polisher::polish] generating consensus [==============> ] 27.003216 s [racon::Polisher::polish] generating consensus [===============> ] 30.156314 s [racon::Polisher::polish] generating consensus [================> ] 32.787214 s [racon::Polisher::polish] generating consensus [=================> ] 34.963228 s [racon::Polisher::polish] generating consensus [==================> ] 36.876258 s [racon::Polisher::polish] generating consensus [===================>] 39.384837 s [racon::Polisher::polish] generating consensus [====================] 51.172356 s +[racon::Polisher::] total = 53.405949 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualities (53467 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments -[racon::Polisher::initialize] loaded target sequences 0.002892 s -[racon::Polisher::initialize] loaded sequences 0.203816 s -[racon::Polisher::initialize] loaded overlaps 0.126091 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.015790 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.016834 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.018498 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.020215 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.020997 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.022855 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.024462 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.026211 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.027683 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.029160 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.030658 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.032129 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.032596 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.032639 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.033598 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.033905 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.033951 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.033992 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.034692 s [racon::Polisher::initialize] aligning overlaps [====================] 0.034741 s -[racon::Polisher::initialize] transformed data into windows 0.008242 s -[racon::Polisher::polish] generating consensus [=> ] 1.761655 s [racon::Polisher::polish] generating consensus [==> ] 3.630824 s [racon::Polisher::polish] generating consensus [===> ] 5.547131 s [racon::Polisher::polish] generating consensus [====> ] 6.752080 s [racon::Polisher::polish] generating consensus [=====> ] 7.649431 s [racon::Polisher::polish] generating consensus [======> ] 8.439474 s [racon::Polisher::polish] generating consensus [=======> ] 9.192394 s [racon::Polisher::polish] generating consensus [========> ] 10.163958 s [racon::Polisher::polish] generating consensus [=========> ] 11.267049 s [racon::Polisher::polish] generating consensus [==========> ] 12.608377 s [racon::Polisher::polish] generating consensus [===========> ] 14.960458 s [racon::Polisher::polish] generating consensus [============> ] 17.891471 s [racon::Polisher::polish] generating consensus [=============> ] 21.815615 s [racon::Polisher::polish] generating consensus [==============> ] 25.945810 s [racon::Polisher::polish] generating consensus [===============> ] 25.948395 s [racon::Polisher::polish] generating consensus [================> ] 26.343266 s [racon::Polisher::polish] generating consensus [=================> ] 28.646059 s [racon::Polisher::polish] generating consensus [==================> ] 28.648654 s [racon::Polisher::polish] generating consensus [===================>] 28.651205 s [racon::Polisher::polish] generating consensus [====================] 30.629710 s -[racon::Polisher::] total = 31.108008 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (31150 ms) +[racon::Polisher::initialize] loaded target sequences 0.001534 s +[racon::Polisher::initialize] loaded sequences 0.206386 s +[racon::Polisher::initialize] loaded overlaps 0.117541 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.045500 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.046635 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.047447 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.048218 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.048918 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.049459 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.050006 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.050563 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.051104 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.051662 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.052289 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.053006 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.053617 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.054247 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.055570 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.057210 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.057803 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.058560 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.059131 s [racon::Polisher::initialize] aligning overlaps [====================] 0.059724 s +[racon::Polisher::initialize] transformed data into windows 0.008868 s +[racon::Polisher::polish] generating consensus [=> ] 1.760493 s [racon::Polisher::polish] generating consensus [==> ] 3.480486 s [racon::Polisher::polish] generating consensus [===> ] 5.076563 s [racon::Polisher::polish] generating consensus [====> ] 6.012492 s [racon::Polisher::polish] generating consensus [=====> ] 6.520573 s [racon::Polisher::polish] generating consensus [======> ] 7.072547 s [racon::Polisher::polish] generating consensus [=======> ] 7.592524 s [racon::Polisher::polish] generating consensus [========> ] 8.600652 s [racon::Polisher::polish] generating consensus [=========> ] 9.452463 s [racon::Polisher::polish] generating consensus [==========> ] 10.936590 s [racon::Polisher::polish] generating consensus [===========> ] 12.703392 s [racon::Polisher::polish] generating consensus [============> ] 14.427417 s [racon::Polisher::polish] generating consensus [=============> ] 17.576682 s [racon::Polisher::polish] generating consensus [==============> ] 20.883397 s [racon::Polisher::polish] generating consensus [===============> ] 23.175395 s [racon::Polisher::polish] generating consensus [================> ] 24.883392 s [racon::Polisher::polish] generating consensus [=================> ] 27.124512 s [racon::Polisher::polish] generating consensus [==================> ] 28.312281 s [racon::Polisher::polish] generating consensus [===================>] 29.424296 s [racon::Polisher::polish] generating consensus [====================] 36.667363 s +[racon::Polisher::] total = 37.163479 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesAndAlignments (37251 ms) [ RUN ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments -[racon::Polisher::initialize] loaded target sequences 0.002856 s -[racon::Polisher::initialize] loaded sequences 0.096770 s -[racon::Polisher::initialize] loaded overlaps 0.121146 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.011349 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.014731 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.014787 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.014827 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.016868 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.019223 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.021372 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.023555 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.023937 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.023993 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.024045 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.025048 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.025867 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.026728 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.028056 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.028747 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.028807 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.029947 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.030009 s [racon::Polisher::initialize] aligning overlaps [====================] 0.030392 s -[racon::Polisher::initialize] transformed data into windows 0.002348 s -[racon::Polisher::polish] generating consensus [=> ] 2.167058 s [racon::Polisher::polish] generating consensus [==> ] 4.571039 s [racon::Polisher::polish] generating consensus [===> ] 6.074516 s [racon::Polisher::polish] generating consensus [====> ] 7.622515 s [racon::Polisher::polish] generating consensus [=====> ] 8.694868 s [racon::Polisher::polish] generating consensus [======> ] 9.422126 s [racon::Polisher::polish] generating consensus [=======> ] 10.594192 s [racon::Polisher::polish] generating consensus [========> ] 11.865284 s [racon::Polisher::polish] generating consensus [=========> ] 14.527596 s [racon::Polisher::polish] generating consensus [==========> ] 16.055592 s [racon::Polisher::polish] generating consensus [===========> ] 18.616845 s [racon::Polisher::polish] generating consensus [============> ] 21.183457 s [racon::Polisher::polish] generating consensus [=============> ] 25.284283 s [racon::Polisher::polish] generating consensus [==============> ] 29.225718 s [racon::Polisher::polish] generating consensus [===============> ] 31.264740 s [racon::Polisher::polish] generating consensus [================> ] 32.366115 s [racon::Polisher::polish] generating consensus [=================> ] 33.749014 s [racon::Polisher::polish] generating consensus [==================> ] 35.951712 s [racon::Polisher::polish] generating consensus [===================>] 36.632998 s [racon::Polisher::polish] generating consensus [====================] 40.880242 s -[racon::Polisher::] total = 41.212034 s -[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (41258 ms) +[racon::Polisher::initialize] loaded target sequences 0.016596 s +[racon::Polisher::initialize] loaded sequences 0.196036 s +[racon::Polisher::initialize] loaded overlaps 0.200465 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.064431 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.064474 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.064495 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.064517 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.064537 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.064556 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.064576 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.072425 s [racon::Polisher::initialize] aligning overlaps [=========> ] 0.072464 s [racon::Polisher::initialize] aligning overlaps [==========> ] 0.072485 s [racon::Polisher::initialize] aligning overlaps [===========> ] 0.072504 s [racon::Polisher::initialize] aligning overlaps [============> ] 0.072528 s [racon::Polisher::initialize] aligning overlaps [=============> ] 0.072549 s [racon::Polisher::initialize] aligning overlaps [==============> ] 0.072569 s [racon::Polisher::initialize] aligning overlaps [===============> ] 0.072592 s [racon::Polisher::initialize] aligning overlaps [================> ] 0.076406 s [racon::Polisher::initialize] aligning overlaps [=================> ] 0.076439 s [racon::Polisher::initialize] aligning overlaps [==================> ] 0.076459 s [racon::Polisher::initialize] aligning overlaps [===================>] 0.076481 s [racon::Polisher::initialize] aligning overlaps [====================] 0.079970 s +[racon::Polisher::initialize] transformed data into windows 0.001282 s +[racon::Polisher::polish] generating consensus [=> ] 2.606959 s [racon::Polisher::polish] generating consensus [==> ] 4.982970 s [racon::Polisher::polish] generating consensus [===> ] 7.171433 s [racon::Polisher::polish] generating consensus [====> ] 8.811012 s [racon::Polisher::polish] generating consensus [=====> ] 10.038956 s [racon::Polisher::polish] generating consensus [======> ] 10.987498 s [racon::Polisher::polish] generating consensus [=======> ] 12.035409 s [racon::Polisher::polish] generating consensus [========> ] 13.504073 s [racon::Polisher::polish] generating consensus [=========> ] 14.550142 s [racon::Polisher::polish] generating consensus [==========> ] 16.706968 s [racon::Polisher::polish] generating consensus [===========> ] 18.895906 s [racon::Polisher::polish] generating consensus [============> ] 21.532129 s [racon::Polisher::polish] generating consensus [=============> ] 25.798971 s [racon::Polisher::polish] generating consensus [==============> ] 29.090921 s [racon::Polisher::polish] generating consensus [===============> ] 32.020010 s [racon::Polisher::polish] generating consensus [================> ] 34.430273 s [racon::Polisher::polish] generating consensus [=================> ] 36.847947 s [racon::Polisher::polish] generating consensus [==================> ] 38.317822 s [racon::Polisher::polish] generating consensus [===================>] 40.039001 s [racon::Polisher::polish] generating consensus [====================] 49.266203 s +[racon::Polisher::] total = 49.821940 s +[ OK ] RaconPolishingTest.ConsensusWithoutQualitiesAndWithAlignments (49936 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow -[racon::Polisher::initialize] loaded target sequences 0.002872 s -[racon::Polisher::initialize] loaded sequences 0.202552 s -[racon::Polisher::initialize] loaded overlaps 0.001684 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.198764 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.302419 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.404465 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.535938 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.630710 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.659780 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.825779 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.041568 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.095154 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.228201 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.319941 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.503148 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.730512 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.775115 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.968137 s [racon::Polisher::initialize] aligning overlaps [================> ] 2.063149 s [racon::Polisher::initialize] aligning overlaps [=================> ] 2.235173 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.391169 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.403129 s [racon::Polisher::initialize] aligning overlaps [====================] 2.481996 s -[racon::Polisher::initialize] transformed data into windows 0.020736 s -[racon::Polisher::polish] generating consensus [=> ] 5.679738 s [racon::Polisher::polish] generating consensus [==> ] 6.333037 s [racon::Polisher::polish] generating consensus [===> ] 11.403633 s [racon::Polisher::polish] generating consensus [====> ] 11.623638 s [racon::Polisher::polish] generating consensus [=====> ] 12.967631 s [racon::Polisher::polish] generating consensus [======> ] 13.911636 s [racon::Polisher::polish] generating consensus [=======> ] 15.419719 s [racon::Polisher::polish] generating consensus [========> ] 17.167761 s [racon::Polisher::polish] generating consensus [=========> ] 18.959669 s [racon::Polisher::polish] generating consensus [==========> ] 24.299654 s [racon::Polisher::polish] generating consensus [===========> ] 25.284790 s [racon::Polisher::polish] generating consensus [============> ] 32.003654 s [racon::Polisher::polish] generating consensus [=============> ] 38.231599 s [racon::Polisher::polish] generating consensus [==============> ] 40.003667 s [racon::Polisher::polish] generating consensus [===============> ] 47.143676 s [racon::Polisher::polish] generating consensus [================> ] 47.631816 s [racon::Polisher::polish] generating consensus [=================> ] 55.182908 s [racon::Polisher::polish] generating consensus [==================> ] 55.182999 s [racon::Polisher::polish] generating consensus [===================>] 60.255623 s [racon::Polisher::polish] generating consensus [====================] 68.459580 s -[racon::Polisher::] total = 71.305059 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (71439 ms) +[racon::Polisher::initialize] loaded target sequences 0.007450 s +[racon::Polisher::initialize] loaded sequences 0.203761 s +[racon::Polisher::initialize] loaded overlaps 0.001237 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.178170 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.258184 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.353975 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.470039 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.558096 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.594080 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.818247 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.922175 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.014010 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.089589 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.197485 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.286062 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.389774 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.450075 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.625076 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.833064 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.905092 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.976842 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.040715 s [racon::Polisher::initialize] aligning overlaps [====================] 2.057090 s +[racon::Polisher::initialize] transformed data into windows 0.016411 s +[racon::Polisher::polish] generating consensus [=> ] 6.483315 s [racon::Polisher::polish] generating consensus [==> ] 6.483373 s [racon::Polisher::polish] generating consensus [===> ] 11.947306 s [racon::Polisher::polish] generating consensus [====> ] 11.947377 s [racon::Polisher::polish] generating consensus [=====> ] 14.631283 s [racon::Polisher::polish] generating consensus [======> ] 14.631339 s [racon::Polisher::polish] generating consensus [=======> ] 16.875297 s [racon::Polisher::polish] generating consensus [========> ] 16.875378 s [racon::Polisher::polish] generating consensus [=========> ] 21.156397 s [racon::Polisher::polish] generating consensus [==========> ] 21.157886 s [racon::Polisher::polish] generating consensus [===========> ] 28.568422 s [racon::Polisher::polish] generating consensus [============> ] 29.024495 s [racon::Polisher::polish] generating consensus [=============> ] 38.723297 s [racon::Polisher::polish] generating consensus [==============> ] 39.931306 s [racon::Polisher::polish] generating consensus [===============> ] 46.394888 s [racon::Polisher::polish] generating consensus [================> ] 47.404225 s [racon::Polisher::polish] generating consensus [=================> ] 53.579304 s [racon::Polisher::polish] generating consensus [==================> ] 53.579360 s [racon::Polisher::polish] generating consensus [===================>] 58.982418 s [racon::Polisher::polish] generating consensus [====================] 71.320489 s +[racon::Polisher::] total = 73.646749 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesLargerWindow (73829 ms) [ RUN ] RaconPolishingTest.ConsensusWithQualitiesEditDistance -[racon::Polisher::initialize] loaded target sequences 0.004328 s -[racon::Polisher::initialize] loaded sequences 0.287722 s -[racon::Polisher::initialize] loaded overlaps 0.002753 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.193258 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.301207 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.429338 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.540749 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.650535 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.762327 s [racon::Polisher::initialize] aligning overlaps [=======> ] 1.032758 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.164758 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.276766 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.372771 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.508730 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.624741 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.752749 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.822456 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.910437 s [racon::Polisher::initialize] aligning overlaps [================> ] 2.070541 s [racon::Polisher::initialize] aligning overlaps [=================> ] 2.135769 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.245875 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.405818 s [racon::Polisher::initialize] aligning overlaps [====================] 2.555881 s -[racon::Polisher::initialize] transformed data into windows 0.022484 s -[racon::Polisher::polish] generating consensus [=> ] 2.209797 s [racon::Polisher::polish] generating consensus [==> ] 4.141733 s [racon::Polisher::polish] generating consensus [===> ] 5.537690 s [racon::Polisher::polish] generating consensus [====> ] 7.793782 s [racon::Polisher::polish] generating consensus [=====> ] 8.705716 s [racon::Polisher::polish] generating consensus [======> ] 9.489745 s [racon::Polisher::polish] generating consensus [=======> ] 10.197722 s [racon::Polisher::polish] generating consensus [========> ] 11.066910 s [racon::Polisher::polish] generating consensus [=========> ] 12.350854 s [racon::Polisher::polish] generating consensus [==========> ] 13.610796 s [racon::Polisher::polish] generating consensus [===========> ] 16.038792 s [racon::Polisher::polish] generating consensus [============> ] 18.762941 s [racon::Polisher::polish] generating consensus [=============> ] 22.141739 s [racon::Polisher::polish] generating consensus [==============> ] 26.177573 s [racon::Polisher::polish] generating consensus [===============> ] 28.373404 s [racon::Polisher::polish] generating consensus [================> ] 29.420038 s [racon::Polisher::polish] generating consensus [=================> ] 30.691498 s [racon::Polisher::polish] generating consensus [==================> ] 31.217151 s [racon::Polisher::polish] generating consensus [===================>] 31.703182 s [racon::Polisher::polish] generating consensus [====================] 35.136339 s -[racon::Polisher::] total = 38.110294 s -[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (38166 ms) +[racon::Polisher::initialize] loaded target sequences 0.007448 s +[racon::Polisher::initialize] loaded sequences 0.178440 s +[racon::Polisher::initialize] loaded overlaps 0.001276 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.175437 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.271379 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.383465 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.491456 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.587488 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.683484 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.919440 s [racon::Polisher::initialize] aligning overlaps [========> ] 1.035481 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.131449 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.215426 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.331466 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.427389 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.547481 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.599462 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.675427 s [racon::Polisher::initialize] aligning overlaps [================> ] 1.731457 s [racon::Polisher::initialize] aligning overlaps [=================> ] 1.787491 s [racon::Polisher::initialize] aligning overlaps [==================> ] 1.890408 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.032171 s [racon::Polisher::initialize] aligning overlaps [====================] 2.123470 s +[racon::Polisher::initialize] transformed data into windows 0.030048 s +[racon::Polisher::polish] generating consensus [=> ] 1.708126 s [racon::Polisher::polish] generating consensus [==> ] 3.292139 s [racon::Polisher::polish] generating consensus [===> ] 4.828150 s [racon::Polisher::polish] generating consensus [====> ] 5.844287 s [racon::Polisher::polish] generating consensus [=====> ] 6.398739 s [racon::Polisher::polish] generating consensus [======> ] 7.060168 s [racon::Polisher::polish] generating consensus [=======> ] 7.631996 s [racon::Polisher::polish] generating consensus [========> ] 8.352158 s [racon::Polisher::polish] generating consensus [=========> ] 9.399017 s [racon::Polisher::polish] generating consensus [==========> ] 10.463039 s [racon::Polisher::polish] generating consensus [===========> ] 12.428140 s [racon::Polisher::polish] generating consensus [============> ] 14.859890 s [racon::Polisher::polish] generating consensus [=============> ] 18.000094 s [racon::Polisher::polish] generating consensus [==============> ] 21.292223 s [racon::Polisher::polish] generating consensus [===============> ] 23.448108 s [racon::Polisher::polish] generating consensus [================> ] 25.100081 s [racon::Polisher::polish] generating consensus [=================> ] 27.332037 s [racon::Polisher::polish] generating consensus [==================> ] 28.830236 s [racon::Polisher::polish] generating consensus [===================>] 30.752139 s [racon::Polisher::polish] generating consensus [====================] 35.963513 s +[racon::Polisher::] total = 38.391945 s +[ OK ] RaconPolishingTest.ConsensusWithQualitiesEditDistance (38446 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualities -[racon::Polisher::initialize] loaded target sequences 0.203076 s -[racon::Polisher::initialize] loaded sequences 0.208878 s -[racon::Polisher::initialize] loaded overlaps 0.058357 s -[racon::Polisher::initialize] aligning overlaps [=> ] 0.182573 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.382558 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.450491 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.574523 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.662306 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.757321 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.814027 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.904979 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.003087 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.150479 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.282940 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.522577 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.682577 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.820113 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.909106 s [racon::Polisher::initialize] aligning overlaps [================> ] 2.028715 s [racon::Polisher::initialize] aligning overlaps [=================> ] 2.160687 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.397998 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.536561 s [racon::Polisher::initialize] aligning overlaps [====================] 2.601697 s -[racon::Polisher::initialize] transformed data into windows 0.039338 s -[racon::Polisher::polish] generating consensus [=> ] 1.663393 s [racon::Polisher::polish] generating consensus [==> ] 3.086589 s [racon::Polisher::polish] generating consensus [===> ] 4.483909 s [racon::Polisher::polish] generating consensus [====> ] 4.486985 s [racon::Polisher::polish] generating consensus [=====> ] 5.398670 s [racon::Polisher::polish] generating consensus [======> ] 6.003294 s [racon::Polisher::polish] generating consensus [=======> ] 6.899271 s [racon::Polisher::polish] generating consensus [========> ] 6.900682 s [racon::Polisher::polish] generating consensus [=========> ] 8.979282 s [racon::Polisher::polish] generating consensus [==========> ] 9.694468 s [racon::Polisher::polish] generating consensus [===========> ] 10.311024 s [racon::Polisher::polish] generating consensus [============> ] 10.514418 s [racon::Polisher::polish] generating consensus [=============> ] 11.462976 s [racon::Polisher::polish] generating consensus [==============> ] 11.466068 s [racon::Polisher::polish] generating consensus [===============> ] 13.030875 s [racon::Polisher::polish] generating consensus [================> ] 13.034691 s [racon::Polisher::polish] generating consensus [=================> ] 14.720790 s [racon::Polisher::polish] generating consensus [==================> ] 14.869527 s [racon::Polisher::polish] generating consensus [===================>] 15.246745 s [racon::Polisher::polish] generating consensus [====================] 15.249071 s -[racon::Polisher::] total = 18.365941 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (18413 ms) +[racon::Polisher::initialize] loaded target sequences 0.206325 s +[racon::Polisher::initialize] loaded sequences 0.215721 s +[racon::Polisher::initialize] loaded overlaps 0.067385 s +[racon::Polisher::initialize] aligning overlaps [=> ] 0.220034 s [racon::Polisher::initialize] aligning overlaps [==> ] 0.344005 s [racon::Polisher::initialize] aligning overlaps [===> ] 0.416055 s [racon::Polisher::initialize] aligning overlaps [====> ] 0.516033 s [racon::Polisher::initialize] aligning overlaps [=====> ] 0.612034 s [racon::Polisher::initialize] aligning overlaps [======> ] 0.723977 s [racon::Polisher::initialize] aligning overlaps [=======> ] 0.891970 s [racon::Polisher::initialize] aligning overlaps [========> ] 0.992041 s [racon::Polisher::initialize] aligning overlaps [=========> ] 1.131947 s [racon::Polisher::initialize] aligning overlaps [==========> ] 1.211985 s [racon::Polisher::initialize] aligning overlaps [===========> ] 1.307942 s [racon::Polisher::initialize] aligning overlaps [============> ] 1.504231 s [racon::Polisher::initialize] aligning overlaps [=============> ] 1.632122 s [racon::Polisher::initialize] aligning overlaps [==============> ] 1.787989 s [racon::Polisher::initialize] aligning overlaps [===============> ] 1.891968 s [racon::Polisher::initialize] aligning overlaps [================> ] 2.047979 s [racon::Polisher::initialize] aligning overlaps [=================> ] 2.092020 s [racon::Polisher::initialize] aligning overlaps [==================> ] 2.124002 s [racon::Polisher::initialize] aligning overlaps [===================>] 2.216072 s [racon::Polisher::initialize] aligning overlaps [====================] 2.339888 s +[racon::Polisher::initialize] transformed data into windows 0.050679 s +[racon::Polisher::polish] generating consensus [=> ] 1.152499 s [racon::Polisher::polish] generating consensus [==> ] 2.608406 s [racon::Polisher::polish] generating consensus [===> ] 3.716567 s [racon::Polisher::polish] generating consensus [====> ] 3.723183 s [racon::Polisher::polish] generating consensus [=====> ] 4.572515 s [racon::Polisher::polish] generating consensus [======> ] 5.124633 s [racon::Polisher::polish] generating consensus [=======> ] 5.928586 s [racon::Polisher::polish] generating consensus [========> ] 6.100599 s [racon::Polisher::polish] generating consensus [=========> ] 7.684580 s [racon::Polisher::polish] generating consensus [==========> ] 8.328350 s [racon::Polisher::polish] generating consensus [===========> ] 8.848474 s [racon::Polisher::polish] generating consensus [============> ] 9.048548 s [racon::Polisher::polish] generating consensus [=============> ] 9.728274 s [racon::Polisher::polish] generating consensus [==============> ] 9.744407 s [racon::Polisher::polish] generating consensus [===============> ] 11.192445 s [racon::Polisher::polish] generating consensus [================> ] 11.199616 s [racon::Polisher::polish] generating consensus [=================> ] 13.968421 s [racon::Polisher::polish] generating consensus [==================> ] 14.940541 s [racon::Polisher::polish] generating consensus [===================>] 16.000680 s [racon::Polisher::polish] generating consensus [====================] 16.333783 s +[racon::Polisher::] total = 19.222336 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualities (19291 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.202252 s -[racon::Polisher::initialize] loaded sequences 0.207788 s -[racon::Polisher::initialize] loaded overlaps 0.056157 s -[racon::Polisher::initialize] aligning overlaps [=> ] 3.277768 s [racon::Polisher::initialize] aligning overlaps [==> ] 5.398162 s [racon::Polisher::initialize] aligning overlaps [===> ] 7.386527 s [racon::Polisher::initialize] aligning overlaps [====> ] 10.343040 s [racon::Polisher::initialize] aligning overlaps [=====> ] 12.595232 s [racon::Polisher::initialize] aligning overlaps [======> ] 14.613247 s [racon::Polisher::initialize] aligning overlaps [=======> ] 17.172341 s [racon::Polisher::initialize] aligning overlaps [========> ] 19.532256 s [racon::Polisher::initialize] aligning overlaps [=========> ] 22.456235 s [racon::Polisher::initialize] aligning overlaps [==========> ] 25.189850 s [racon::Polisher::initialize] aligning overlaps [===========> ] 27.228320 s [racon::Polisher::initialize] aligning overlaps [============> ] 30.188268 s [racon::Polisher::initialize] aligning overlaps [=============> ] 33.004333 s [racon::Polisher::initialize] aligning overlaps [==============> ] 35.260246 s [racon::Polisher::initialize] aligning overlaps [===============> ] 38.468308 s [racon::Polisher::initialize] aligning overlaps [================> ] 41.152244 s [racon::Polisher::initialize] aligning overlaps [=================> ] 43.589432 s [racon::Polisher::initialize] aligning overlaps [==================> ] 46.488703 s [racon::Polisher::initialize] aligning overlaps [===================>] 49.416240 s [racon::Polisher::initialize] aligning overlaps [====================] 51.232039 s -[racon::Polisher::initialize] transformed data into windows 0.366411 s -[racon::Polisher::polish] generating consensus [=> ] 62.923639 s [racon::Polisher::polish] generating consensus [==> ] 112.761709 s [racon::Polisher::polish] generating consensus [===> ] 171.692482 s [racon::Polisher::polish] generating consensus [====> ] 208.425285 s [racon::Polisher::polish] generating consensus [=====> ] 256.545563 s [racon::Polisher::polish] generating consensus [======> ] 305.492488 s [racon::Polisher::polish] generating consensus [=======> ] 364.996471 s [racon::Polisher::polish] generating consensus [========> ] 415.133282 s [racon::Polisher::polish] generating consensus [=========> ] 470.149696 s [racon::Polisher::polish] generating consensus [==========> ] 510.157546 s [racon::Polisher::polish] generating consensus [===========> ] 550.161015 s [racon::Polisher::polish] generating consensus [============> ] 613.159489 s [racon::Polisher::polish] generating consensus [=============> ] 662.845851 s [racon::Polisher::polish] generating consensus [==============> ] 694.703611 s [racon::Polisher::polish] generating consensus [===============> ] 757.288053 s [racon::Polisher::polish] generating consensus [================> ] 794.365043 s [racon::Polisher::polish] generating consensus [=================> ] 848.900464 s [racon::Polisher::polish] generating consensus [==================> ] 884.953923 s [racon::Polisher::polish] generating consensus [===================>] 896.210202 s [racon::Polisher::polish] generating consensus [====================] 905.855728 s -[racon::Polisher::] total = 957.939798 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (957997 ms) +[racon::Polisher::initialize] loaded target sequences 0.227262 s +[racon::Polisher::initialize] loaded sequences 0.214389 s +[racon::Polisher::initialize] loaded overlaps 0.062841 s +[racon::Polisher::initialize] aligning overlaps [=> ] 2.759343 s [racon::Polisher::initialize] aligning overlaps [==> ] 4.707478 s [racon::Polisher::initialize] aligning overlaps [===> ] 6.291460 s [racon::Polisher::initialize] aligning overlaps [====> ] 8.583413 s [racon::Polisher::initialize] aligning overlaps [=====> ] 10.635635 s [racon::Polisher::initialize] aligning overlaps [======> ] 12.010343 s [racon::Polisher::initialize] aligning overlaps [=======> ] 13.974361 s [racon::Polisher::initialize] aligning overlaps [========> ] 16.494347 s [racon::Polisher::initialize] aligning overlaps [=========> ] 18.499450 s [racon::Polisher::initialize] aligning overlaps [==========> ] 20.822335 s [racon::Polisher::initialize] aligning overlaps [===========> ] 22.487420 s [racon::Polisher::initialize] aligning overlaps [============> ] 25.110370 s [racon::Polisher::initialize] aligning overlaps [=============> ] 28.042357 s [racon::Polisher::initialize] aligning overlaps [==============> ] 30.339396 s [racon::Polisher::initialize] aligning overlaps [===============> ] 33.223449 s [racon::Polisher::initialize] aligning overlaps [================> ] 35.697764 s [racon::Polisher::initialize] aligning overlaps [=================> ] 37.815500 s [racon::Polisher::initialize] aligning overlaps [==================> ] 40.703497 s [racon::Polisher::initialize] aligning overlaps [===================>] 43.527428 s [racon::Polisher::initialize] aligning overlaps [====================] 45.394354 s +[racon::Polisher::initialize] transformed data into windows 0.606939 s +[racon::Polisher::polish] generating consensus [=> ] 62.551919 s [racon::Polisher::polish] generating consensus [==> ] 105.484099 s [racon::Polisher::polish] generating consensus [===> ] 146.747809 s [racon::Polisher::polish] generating consensus [====> ] 177.951813 s [racon::Polisher::polish] generating consensus [=====> ] 201.814978 s [racon::Polisher::polish] generating consensus [======> ] 240.238713 s [racon::Polisher::polish] generating consensus [=======> ] 274.071793 s [racon::Polisher::polish] generating consensus [========> ] 299.430688 s [racon::Polisher::polish] generating consensus [=========> ] 331.610682 s [racon::Polisher::polish] generating consensus [==========> ] 368.951763 s [racon::Polisher::polish] generating consensus [===========> ] 398.331825 s [racon::Polisher::polish] generating consensus [============> ] 433.314727 s [racon::Polisher::polish] generating consensus [=============> ] 466.587755 s [racon::Polisher::polish] generating consensus [==============> ] 499.030666 s [racon::Polisher::polish] generating consensus [===============> ] 535.959344 s [racon::Polisher::polish] generating consensus [================> ] 557.426715 s [racon::Polisher::polish] generating consensus [=================> ] 594.271492 s [racon::Polisher::polish] generating consensus [==================> ] 636.267685 s [racon::Polisher::polish] generating consensus [===================>] 697.282660 s [racon::Polisher::polish] generating consensus [====================] 741.122783 s +[racon::Polisher::] total = 787.689593 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFull (787772 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull -[racon::Polisher::initialize] loaded target sequences 0.095612 s -[racon::Polisher::initialize] loaded sequences 0.096183 s -[racon::Polisher::initialize] loaded overlaps 0.055688 s -[racon::Polisher::initialize] aligning overlaps [=> ] 3.182730 s [racon::Polisher::initialize] aligning overlaps [==> ] 5.457653 s [racon::Polisher::initialize] aligning overlaps [===> ] 7.678699 s [racon::Polisher::initialize] aligning overlaps [====> ] 10.585488 s [racon::Polisher::initialize] aligning overlaps [=====> ] 13.135026 s [racon::Polisher::initialize] aligning overlaps [======> ] 14.981106 s [racon::Polisher::initialize] aligning overlaps [=======> ] 17.440677 s [racon::Polisher::initialize] aligning overlaps [========> ] 20.552954 s [racon::Polisher::initialize] aligning overlaps [=========> ] 23.433108 s [racon::Polisher::initialize] aligning overlaps [==========> ] 26.317843 s [racon::Polisher::initialize] aligning overlaps [===========> ] 28.569632 s [racon::Polisher::initialize] aligning overlaps [============> ] 31.700642 s [racon::Polisher::initialize] aligning overlaps [=============> ] 34.885216 s [racon::Polisher::initialize] aligning overlaps [==============> ] 37.519307 s [racon::Polisher::initialize] aligning overlaps [===============> ] 41.159140 s [racon::Polisher::initialize] aligning overlaps [================> ] 43.878836 s [racon::Polisher::initialize] aligning overlaps [=================> ] 45.648334 s [racon::Polisher::initialize] aligning overlaps [==================> ] 46.301863 s [racon::Polisher::initialize] aligning overlaps [===================>] 46.988679 s [racon::Polisher::initialize] aligning overlaps [====================] 47.608614 s -[racon::Polisher::initialize] transformed data into windows 0.094298 s -[racon::Polisher::polish] generating consensus [=> ] 102.352950 s [racon::Polisher::polish] generating consensus [==> ] 156.389639 s [racon::Polisher::polish] generating consensus [===> ] 221.852364 s [racon::Polisher::polish] generating consensus [====> ] 284.425053 s [racon::Polisher::polish] generating consensus [=====> ] 356.857526 s [racon::Polisher::polish] generating consensus [======> ] 414.424430 s [racon::Polisher::polish] generating consensus [=======> ] 481.552499 s [racon::Polisher::polish] generating consensus [========> ] 551.742418 s [racon::Polisher::polish] generating consensus [=========> ] 628.584481 s [racon::Polisher::polish] generating consensus [==========> ] 725.198495 s [racon::Polisher::polish] generating consensus [===========> ] 793.751308 s [racon::Polisher::polish] generating consensus [============> ] 870.880587 s [racon::Polisher::polish] generating consensus [=============> ] 932.452968 s [racon::Polisher::polish] generating consensus [==============> ] 999.524426 s [racon::Polisher::polish] generating consensus [===============> ] 1048.944474 s [racon::Polisher::polish] generating consensus [================> ] 1068.741721 s [racon::Polisher::polish] generating consensus [=================> ] 1109.922395 s [racon::Polisher::polish] generating consensus [==================> ] 1211.096549 s [racon::Polisher::polish] generating consensus [===================>] 1240.280846 s [racon::Polisher::polish] generating consensus [====================] 1269.697281 s -[racon::Polisher::] total = 1317.677016 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (1317730 ms) +[racon::Polisher::initialize] loaded target sequences 0.187393 s +[racon::Polisher::initialize] loaded sequences 0.194799 s +[racon::Polisher::initialize] loaded overlaps 0.094211 s +[racon::Polisher::initialize] aligning overlaps [=> ] 4.426709 s [racon::Polisher::initialize] aligning overlaps [==> ] 7.230451 s [racon::Polisher::initialize] aligning overlaps [===> ] 9.510405 s [racon::Polisher::initialize] aligning overlaps [====> ] 12.642457 s [racon::Polisher::initialize] aligning overlaps [=====> ] 15.634448 s [racon::Polisher::initialize] aligning overlaps [======> ] 17.745425 s [racon::Polisher::initialize] aligning overlaps [=======> ] 20.742487 s [racon::Polisher::initialize] aligning overlaps [========> ] 24.414447 s [racon::Polisher::initialize] aligning overlaps [=========> ] 27.269917 s [racon::Polisher::initialize] aligning overlaps [==========> ] 29.258522 s [racon::Polisher::initialize] aligning overlaps [===========> ] 30.998462 s [racon::Polisher::initialize] aligning overlaps [============> ] 33.187667 s [racon::Polisher::initialize] aligning overlaps [=============> ] 35.396472 s [racon::Polisher::initialize] aligning overlaps [==============> ] 37.034886 s [racon::Polisher::initialize] aligning overlaps [===============> ] 39.851459 s [racon::Polisher::initialize] aligning overlaps [================> ] 41.762878 s [racon::Polisher::initialize] aligning overlaps [=================> ] 43.970440 s [racon::Polisher::initialize] aligning overlaps [==================> ] 46.378839 s [racon::Polisher::initialize] aligning overlaps [===================>] 48.431501 s [racon::Polisher::initialize] aligning overlaps [====================] 49.065690 s +[racon::Polisher::initialize] transformed data into windows 0.046202 s +[racon::Polisher::polish] generating consensus [=> ] 47.112102 s [racon::Polisher::polish] generating consensus [==> ] 120.308100 s [racon::Polisher::polish] generating consensus [===> ] 164.648187 s [racon::Polisher::polish] generating consensus [====> ] 187.472905 s [racon::Polisher::polish] generating consensus [=====> ] 266.712392 s [racon::Polisher::polish] generating consensus [======> ] 300.847546 s [racon::Polisher::polish] generating consensus [=======> ] 374.144514 s [racon::Polisher::polish] generating consensus [========> ] 430.352123 s [racon::Polisher::polish] generating consensus [=========> ] 476.613167 s [racon::Polisher::polish] generating consensus [==========> ] 541.069446 s [racon::Polisher::polish] generating consensus [===========> ] 597.660220 s [racon::Polisher::polish] generating consensus [============> ] 649.820188 s [racon::Polisher::polish] generating consensus [=============> ] 710.897099 s [racon::Polisher::polish] generating consensus [==============> ] 776.068102 s [racon::Polisher::polish] generating consensus [===============> ] 841.906314 s [racon::Polisher::polish] generating consensus [================> ] 869.316190 s [racon::Polisher::polish] generating consensus [=================> ] 929.732146 s [racon::Polisher::polish] generating consensus [==================> ] 1006.295199 s [racon::Polisher::polish] generating consensus [===================>] 1078.424096 s [racon::Polisher::polish] generating consensus [====================] 1131.884199 s +[racon::Polisher::] total = 1181.482735 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithoutQualitiesFull (1181630 ms) [ RUN ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap -[racon::Polisher::initialize] loaded target sequences 0.365836 s -[racon::Polisher::initialize] loaded sequences 0.355687 s -[racon::Polisher::initialize] loaded overlaps 0.067509 s -[racon::Polisher::initialize] aligning overlaps [=> ] 6.801924 s [racon::Polisher::initialize] aligning overlaps [==> ] 10.430053 s [racon::Polisher::initialize] aligning overlaps [===> ] 13.914052 s [racon::Polisher::initialize] aligning overlaps [====> ] 18.350070 s [racon::Polisher::initialize] aligning overlaps [=====> ] 21.650019 s [racon::Polisher::initialize] aligning overlaps [======> ] 24.917995 s [racon::Polisher::initialize] aligning overlaps [=======> ] 28.801994 s [racon::Polisher::initialize] aligning overlaps [========> ] 34.589928 s [racon::Polisher::initialize] aligning overlaps [=========> ] 38.078685 s [racon::Polisher::initialize] aligning overlaps [==========> ] 40.914667 s [racon::Polisher::initialize] aligning overlaps [===========> ] 43.142002 s [racon::Polisher::initialize] aligning overlaps [============> ] 46.390434 s [racon::Polisher::initialize] aligning overlaps [=============> ] 49.605928 s [racon::Polisher::initialize] aligning overlaps [==============> ] 52.238009 s [racon::Polisher::initialize] aligning overlaps [===============> ] 55.997949 s [racon::Polisher::initialize] aligning overlaps [================> ] 59.417965 s [racon::Polisher::initialize] aligning overlaps [=================> ] 62.214648 s [racon::Polisher::initialize] aligning overlaps [==================> ] 65.253986 s [racon::Polisher::initialize] aligning overlaps [===================>] 68.799057 s [racon::Polisher::initialize] aligning overlaps [====================] 71.875002 s -[racon::Polisher::initialize] transformed data into windows 0.260606 s -[racon::Polisher::polish] generating consensus [=> ] 72.908731 s [racon::Polisher::polish] generating consensus [==> ] 143.148793 s [racon::Polisher::polish] generating consensus [===> ] 189.996761 s [racon::Polisher::polish] generating consensus [====> ] 238.640856 s [racon::Polisher::polish] generating consensus [=====> ] 302.444839 s [racon::Polisher::polish] generating consensus [======> ] 358.304215 s [racon::Polisher::polish] generating consensus [=======> ] 405.509254 s [racon::Polisher::polish] generating consensus [========> ] 443.557429 s [racon::Polisher::polish] generating consensus [=========> ] 496.084803 s [racon::Polisher::polish] generating consensus [==========> ] 562.339597 s [racon::Polisher::polish] generating consensus [===========> ] 599.479506 s [racon::Polisher::polish] generating consensus [============> ] 658.312978 s [racon::Polisher::polish] generating consensus [=============> ] 714.544783 s [racon::Polisher::polish] generating consensus [==============> ] 773.181472 s [racon::Polisher::polish] generating consensus [===============> ] 818.504755 s [racon::Polisher::polish] generating consensus [================> ] 838.152849 s [racon::Polisher::polish] generating consensus [=================> ] 905.563469 s [racon::Polisher::polish] generating consensus [==================> ] 957.571464 s [racon::Polisher::polish] generating consensus [===================>] 991.101923 s [racon::Polisher::polish] generating consensus [====================] 1011.566734 s -[racon::Polisher::] total = 1084.510749 s -[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (1084607 ms) -[----------] 10 tests from RaconPolishingTest (3641855 ms total) +[racon::Polisher::initialize] loaded target sequences 0.334405 s +[racon::Polisher::initialize] loaded sequences 0.299009 s +[racon::Polisher::initialize] loaded overlaps 0.081409 s +[racon::Polisher::initialize] aligning overlaps [=> ] 3.701242 s [racon::Polisher::initialize] aligning overlaps [==> ] 6.058253 s [racon::Polisher::initialize] aligning overlaps [===> ] 8.495325 s [racon::Polisher::initialize] aligning overlaps [====> ] 11.758250 s [racon::Polisher::initialize] aligning overlaps [=====> ] 14.642246 s [racon::Polisher::initialize] aligning overlaps [======> ] 16.558249 s [racon::Polisher::initialize] aligning overlaps [=======> ] 19.606260 s [racon::Polisher::initialize] aligning overlaps [========> ] 23.274261 s [racon::Polisher::initialize] aligning overlaps [=========> ] 27.302266 s [racon::Polisher::initialize] aligning overlaps [==========> ] 30.965981 s [racon::Polisher::initialize] aligning overlaps [===========> ] 33.190277 s [racon::Polisher::initialize] aligning overlaps [============> ] 35.010220 s [racon::Polisher::initialize] aligning overlaps [=============> ] 37.294237 s [racon::Polisher::initialize] aligning overlaps [==============> ] 38.558261 s [racon::Polisher::initialize] aligning overlaps [===============> ] 40.270225 s [racon::Polisher::initialize] aligning overlaps [================> ] 41.274554 s [racon::Polisher::initialize] aligning overlaps [=================> ] 43.470504 s [racon::Polisher::initialize] aligning overlaps [==================> ] 45.702944 s [racon::Polisher::initialize] aligning overlaps [===================>] 47.187028 s [racon::Polisher::initialize] aligning overlaps [====================] 48.575272 s +[racon::Polisher::initialize] transformed data into windows 0.360205 s +[racon::Polisher::polish] generating consensus [=> ] 43.032554 s [racon::Polisher::polish] generating consensus [==> ] 92.088578 s [racon::Polisher::polish] generating consensus [===> ] 139.772637 s [racon::Polisher::polish] generating consensus [====> ] 190.328658 s [racon::Polisher::polish] generating consensus [=====> ] 219.420591 s [racon::Polisher::polish] generating consensus [======> ] 251.465695 s [racon::Polisher::polish] generating consensus [=======> ] 281.473693 s [racon::Polisher::polish] generating consensus [========> ] 314.724579 s [racon::Polisher::polish] generating consensus [=========> ] 347.516549 s [racon::Polisher::polish] generating consensus [==========> ] 393.093045 s [racon::Polisher::polish] generating consensus [===========> ] 428.317758 s [racon::Polisher::polish] generating consensus [============> ] 468.893205 s [racon::Polisher::polish] generating consensus [=============> ] 506.473657 s [racon::Polisher::polish] generating consensus [==============> ] 542.337751 s [racon::Polisher::polish] generating consensus [===============> ] 583.252577 s [racon::Polisher::polish] generating consensus [================> ] 607.289004 s [racon::Polisher::polish] generating consensus [=================> ] 649.381708 s [racon::Polisher::polish] generating consensus [==================> ] 685.717730 s [racon::Polisher::polish] generating consensus [===================>] 725.105662 s [racon::Polisher::polish] generating consensus [====================] 755.304161 s +[racon::Polisher::] total = 804.968030 s +[ OK ] RaconPolishingTest.FragmentCorrectionWithQualitiesFullMhap (805076 ms) +[----------] 10 tests from RaconPolishingTest (3086314 ms total) [----------] Global test environment tear-down -[==========] 15 tests from 2 test suites ran. (3641912 ms total) +[==========] 15 tests from 2 test suites ran. (3086426 ms total) [ PASSED ] 15 tests. make[1]: Leaving directory '/build/reproducible-path/racon-1.5.0' create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=cmake dh_prep -O--buildsystem=cmake dh_auto_install --destdir=debian/racon/ -O--buildsystem=cmake - cd obj-arm-linux-gnueabihf && make -j5 install DESTDIR=/build/reproducible-path/racon-1.5.0/debian/racon AM_UPDATE_INFO_DIR=no "INSTALL=install --strip-program=true" + cd obj-arm-linux-gnueabihf && make -j4 install DESTDIR=/build/reproducible-path/racon-1.5.0/debian/racon AM_UPDATE_INFO_DIR=no "INSTALL=install --strip-program=true" make[1]: Entering directory '/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf' /usr/bin/cmake -S/build/reproducible-path/racon-1.5.0 -B/build/reproducible-path/racon-1.5.0/obj-arm-linux-gnueabihf --check-build-system CMakeFiles/Makefile.cmake 0 make -f CMakeFiles/Makefile2 preinstall @@ -735,8 +771,8 @@ dh_gencontrol -O--buildsystem=cmake dh_md5sums -O--buildsystem=cmake dh_builddeb -O--buildsystem=cmake -dpkg-deb: building package 'racon-dbgsym' in '../racon-dbgsym_1.5.0-3_armhf.deb'. dpkg-deb: building package 'racon' in '../racon_1.5.0-3_armhf.deb'. +dpkg-deb: building package 'racon-dbgsym' in '../racon-dbgsym_1.5.0-3_armhf.deb'. dpkg-genbuildinfo --build=binary -O../racon_1.5.0-3_armhf.buildinfo dpkg-genchanges --build=binary -O../racon_1.5.0-3_armhf.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -744,12 +780,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/4205/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/4205/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/2761 and its subdirectories -I: Current time: Wed May 8 05:27:09 -12 2024 -I: pbuilder-time-stamp: 1715189229 +I: removing directory /srv/workspace/pbuilder/4205 and its subdirectories +I: Current time: Thu May 9 08:23:45 +14 2024 +I: pbuilder-time-stamp: 1715192625