Diff of the two buildlogs: -- --- b1/build.log 2020-04-29 13:39:11.489714449 +0000 +++ b2/build.log 2020-04-29 13:54:47.603308693 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue Jun 1 07:59:44 -12 2021 -I: pbuilder-time-stamp: 1622577584 +I: Current time: Thu Apr 30 03:39:14 +14 2020 +I: pbuilder-time-stamp: 1588167555 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/buster-reproducible-base.tgz] I: copying local configuration @@ -18,7 +18,7 @@ I: Extracting source gpgv: unknown type of key resource 'trustedkeys.kbx' gpgv: keyblock resource '/root/.gnupg/trustedkeys.kbx': General error -gpgv: Signature made Tue Mar 20 19:35:11 2018 -12 +gpgv: Signature made Wed Mar 21 21:35:11 2018 +14 gpgv: using RSA key 9CCD6B319DBF8E40AB1ABD1A89AF82B739CD217A gpgv: Can't check signature: No public key dpkg-source: warning: failed to verify signature on ./ruby-kgio_2.11.2-1.dsc @@ -31,6 +31,18 @@ dpkg-source: info: applying 0003-Remove-usage-of-olddoc-in-gemspec.patch I: using fakeroot in build. I: Installing the build-deps +I: user script /srv/workspace/pbuilder/3865/tmp/hooks/D01_modify_environment starting +debug: Running on profitbricks-build2-i386. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +Removing 'diversion of /bin/sh to /bin/sh.distrib by dash' +Adding 'diversion of /bin/sh to /bin/sh.distrib by bash' +Removing 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by dash' +Adding 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by bash' +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/3865/tmp/hooks/D01_modify_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -198,7 +210,7 @@ Get: 126 http://deb.debian.org/debian buster/main i386 ruby-all-dev i386 1:2.5.1 [10.9 kB] Get: 127 http://deb.debian.org/debian buster/main i386 ruby-setup all 3.4.1-9 [34.2 kB] Get: 128 http://deb.debian.org/debian buster/main i386 gem2deb i386 0.43 [59.2 kB] -Fetched 43.3 MB in 1s (59.7 MB/s) +Fetched 43.3 MB in 7s (6189 kB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libbsd0:i386. (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 ... 19231 files and directories currently installed.) @@ -742,7 +754,7 @@ fakeroot is already the newest version (1.23-1). 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/ruby-kgio-2.11.2/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b +I: Running cd /build/ruby-kgio-2.11.2/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b dpkg-buildpackage: info: source package ruby-kgio dpkg-buildpackage: info: source version 2.11.2-1 dpkg-buildpackage: info: source distribution unstable @@ -792,7 +804,7 @@ /usr/bin/ruby2.5 /usr/lib/ruby/vendor_ruby/gem2deb/extension_builder.rb /build/ruby-kgio-2.11.2 debian/ruby-kgio current directory: /build/ruby-kgio-2.11.2/ext/kgio -/usr/bin/ruby2.5 -r ./siteconf20210601-12907-kbm8ry.rb extconf.rb +/usr/bin/ruby2.5 -r ./siteconf20200430-22681-mr1bdx.rb extconf.rb checking for CLOCK_MONOTONIC in time.h... yes checking for clockid_t in time.h... yes checking for clock_gettime() in -lrt... yes @@ -854,9 +866,9 @@ current directory: /build/ruby-kgio-2.11.2/ext/kgio make V=1 "DESTDIR=" install make[1]: Entering directory '/build/ruby-kgio-2.11.2/ext/kgio' -/bin/mkdir -p . ./.gem.20210601-12907-1ftp9e1 +/bin/mkdir -p . ./.gem.20200430-22681-t16slk exit > .sitearchdir.time -/usr/bin/install -c -m 0755 kgio_ext.so ./.gem.20210601-12907-1ftp9e1 +/usr/bin/install -c -m 0755 kgio_ext.so ./.gem.20200430-22681-t16slk make[1]: Leaving directory '/build/ruby-kgio-2.11.2/ext/kgio' rm -f /build/ruby-kgio-2.11.2/debian/ruby-kgio/usr/lib/i386-linux-gnu/ruby/vendor_ruby/2.5.0/mkmf.log @@ -902,411 +914,411 @@ Loaded suite /usr/lib/ruby/vendor_ruby/rake/rake_test_loader Started TesTcpClientReadServerWrite: - test_monster_trywrite: .: (0.012748) - test_monster_trywritev: .: (0.051962) - test_monster_write: .: (0.013605) - test_monster_write_wait_writable: .: (0.014083) - test_monster_writev: .: (0.027590) - test_monster_writev_wait_writable: .: (0.044619) - test_read_bang_eof: .: (0.000398) - test_read_eof: .: (0.000246) - test_read_extra_buf: .: (0.000253) - test_read_shared: .: (0.000337) - test_read_shared_2: .: (0.000302) - test_read_short: .: (0.000242) - test_read_too_much: .: (0.000193) - test_read_zero: .: (0.000209) - test_tryread_empty: .: (0.000185) - test_tryread_eof: .: (0.000194) - test_tryread_extra_buf_eagain_clears_buffer: .: (0.000190) - test_tryread_extra_buf_eof_clears_buffer: .: (0.000198) - test_tryread_shared: .: (0.000269) - test_tryread_shared_2: .: (0.000311) - test_tryread_short: .: (0.000316) - test_tryread_too_much: .: (0.000257) - test_tryread_wait_readable_method: .: (0.000274) - test_tryread_zero: .: (0.000193) - test_trywrite_closed: .: (0.000205) - test_trywrite_conv: .: (0.000223) - test_trywrite_empty: .: (0.000190) - test_trywrite_full: .: (1.222919) - test_trywrite_return_wait_writable: .: (8.506691) - test_trywrite_wait_readable_method: .: (0.001585) - test_trywritev_closed: .: (0.000319) - test_trywritev_empty: .: (0.000282) - test_trywritev_full: .: (1.247754) - test_trywritev_return_wait_writable: .: (9.347463) - test_wait_readable_method: .: (0.000380) - test_wait_readable_ruby_default: .: (1.000652) - test_wait_writable_method: .: (0.218054) - test_wait_writable_ruby_default: .: (1.007479) - test_write_closed: .: (0.000379) - test_write_conv: .: (0.000272) - test_write_empty: .: (0.000247) - test_writev_closed: .: (0.000201) - test_writev_empty: .: (0.000204) + test_monster_trywrite: .: (0.080659) + test_monster_trywritev: .: (0.128618) + test_monster_write: .: (0.043897) + test_monster_write_wait_writable: .: (0.088877) + test_monster_writev: .: (0.128507) + test_monster_writev_wait_writable: .: (0.191214) + test_read_bang_eof: .: (0.000462) + test_read_eof: .: (0.000345) + test_read_extra_buf: .: (0.001852) + test_read_shared: .: (0.000390) + test_read_shared_2: .: (0.000449) + test_read_short: .: (0.000333) + test_read_too_much: .: (0.000409) + test_read_zero: .: (0.000394) + test_tryread_empty: .: (0.000397) + test_tryread_eof: .: (0.000332) + test_tryread_extra_buf_eagain_clears_buffer: .: (0.000318) + test_tryread_extra_buf_eof_clears_buffer: .: (0.000327) + test_tryread_shared: .: (0.000377) + test_tryread_shared_2: .: (0.000347) + test_tryread_short: .: (0.000331) + test_tryread_too_much: .: (0.000325) + test_tryread_wait_readable_method: .: (0.000264) + test_tryread_zero: .: (0.000329) + test_trywrite_closed: .: (0.001716) + test_trywrite_conv: .: (0.000348) + test_trywrite_empty: .: (0.039583) + test_trywrite_full: .: (1.822354) + test_trywrite_return_wait_writable: .: (57.614240) + test_trywrite_wait_readable_method: .: (0.007506) + test_trywritev_closed: .: (0.000485) + test_trywritev_empty: .: (0.001633) + test_trywritev_full: .: (2.335855) + test_trywritev_return_wait_writable: .: (71.263564) + test_wait_readable_method: .: (0.000691) + test_wait_readable_ruby_default: .: (1.023416) + test_wait_writable_method: .: (1.447564) + test_wait_writable_ruby_default: .: (1.056266) + test_write_closed: .: (0.000635) + test_write_conv: .: (0.007289) + test_write_empty: .: (0.000447) + test_writev_closed: .: (0.000402) + test_writev_empty: .: (0.000326) TesTcpServerReadClientWrite: - test_monster_trywrite: .: (0.014431) - test_monster_trywritev: .: (0.082795) - test_monster_write: .: (0.019566) - test_monster_write_wait_writable: .: (0.012771) - test_monster_writev: .: (0.029518) - test_monster_writev_wait_writable: .: (0.039770) - test_read_bang_eof: .: (0.000471) - test_read_eof: .: (0.000316) - test_read_extra_buf: .: (0.000340) - test_read_shared: .: (0.000337) - test_read_shared_2: .: (0.000321) - test_read_short: .: (0.000319) - test_read_too_much: .: (0.000229) - test_read_zero: .: (0.000236) - test_tryread_empty: .: (0.000180) - test_tryread_eof: .: (0.000216) - test_tryread_extra_buf_eagain_clears_buffer: .: (0.000213) - test_tryread_extra_buf_eof_clears_buffer: .: (0.000205) - test_tryread_shared: .: (0.000205) - test_tryread_shared_2: .: (0.000229) - test_tryread_short: .: (0.000246) - test_tryread_too_much: .: (0.000272) - test_tryread_wait_readable_method: .: (0.000261) - test_tryread_zero: .: (0.000191) - test_trywrite_closed: .: (0.000260) - test_trywrite_conv: .: (0.000269) - test_trywrite_empty: .: (0.000165) - test_trywrite_full: .: (1.222384) - test_trywrite_return_wait_writable: .: (8.190221) - test_trywrite_wait_readable_method: .: (0.001599) - test_trywritev_closed: .: (0.000310) - test_trywritev_empty: .: (0.000176) - test_trywritev_full: .: (1.247673) - test_trywritev_return_wait_writable: .: (9.213213) - test_wait_readable_method: .: (0.000346) - test_wait_readable_ruby_default: .: (1.000670) - test_wait_writable_method: .: (0.211854) - test_wait_writable_ruby_default: .: (1.006642) - test_write_closed: .: (0.000332) - test_write_conv: .: (0.000297) - test_write_empty: .: (0.000204) - test_writev_closed: .: (0.000245) - test_writev_empty: .: (0.000240) + test_monster_trywrite: .: (0.086424) + test_monster_trywritev: .: (0.193781) + test_monster_write: .: (0.242500) + test_monster_write_wait_writable: .: (0.153822) + test_monster_writev: .: (0.215114) + test_monster_writev_wait_writable: .: (0.300317) + test_read_bang_eof: .: (0.006018) + test_read_eof: .: (0.000409) + test_read_extra_buf: .: (0.000386) + test_read_shared: .: (0.000371) + test_read_shared_2: .: (0.000387) + test_read_short: .: (0.000402) + test_read_too_much: .: (0.000330) + test_read_zero: .: (0.005338) + test_tryread_empty: .: (0.000419) + test_tryread_eof: .: (0.000353) + test_tryread_extra_buf_eagain_clears_buffer: .: (0.000398) + test_tryread_extra_buf_eof_clears_buffer: .: (0.000421) + test_tryread_shared: .: (0.000466) + test_tryread_shared_2: .: (0.000464) + test_tryread_short: .: (0.000461) + test_tryread_too_much: .: (0.000446) + test_tryread_wait_readable_method: .: (0.004103) + test_tryread_zero: .: (0.000525) + test_trywrite_closed: .: (0.000457) + test_trywrite_conv: .: (0.000455) + test_trywrite_empty: .: (0.000332) + test_trywrite_full: .: (2.373786) + test_trywrite_return_wait_writable: .: (70.260764) + test_trywrite_wait_readable_method: .: (0.003066) + test_trywritev_closed: .: (0.008501) + test_trywritev_empty: .: (0.007518) + test_trywritev_full: .: (2.627760) + test_trywritev_return_wait_writable: .: (74.453060) + test_wait_readable_method: .: (0.007269) + test_wait_readable_ruby_default: .: (1.028340) + test_wait_writable_method: .: (1.418809) + test_wait_writable_ruby_default: .: (1.044259) + test_write_closed: .: (0.000648) + test_write_conv: .: (0.007287) + test_write_empty: .: (0.000258) + test_writev_closed: .: (0.000319) + test_writev_empty: .: (0.000262) TestAcceptClass: - test_accepted_class: .: (0.001199) - test_invalid: .: (0.000146) - test_tcp_socket: .: (0.000075) + test_accepted_class: .: (0.011517) + test_invalid: .: (0.000235) + test_tcp_socket: .: (0.000140) TestAcceptFlags: - test_accept_flags: .: (0.000816) + test_accept_flags: .: (0.004213) TestAutopush: - test_autopush_accessors: .: (0.000311) - test_autopush_false: .: (0.201053) - test_autopush_true: .: (0.000367) - test_autopush_true_unix: .: (0.000654) + test_autopush_accessors: .: (0.006532) + test_autopush_false: .: (0.203491) + test_autopush_true: .: (0.000577) + test_autopush_true_unix: .: (0.005392) TestConnectFDLeak: - test_unix_socket: .: (0.082586) + test_unix_socket: .: (0.796462) TestCrossThreadClose: - test_cross_thread_close: .: (0.100520) + test_cross_thread_close: .: (0.121215) TestDefaultWait: - test_pipe: .: (0.000173) - test_socket_pair: .: (0.000157) - test_wait_readable_timed: .: (1.105754) - test_wait_writable_timed: .: (1.105824) + test_pipe: .: (0.000317) + test_socket_pair: .: (0.000318) + test_wait_readable_timed: .: (1.103136) + test_wait_writable_timed: .: (1.103851) TestKgioAddr: - test_tcp: .: (0.000378) + test_tcp: .: (0.000826) TestKgioPipe: - test_monster_trywrite: .: (0.012491) - test_monster_trywritev: .: (0.041975) - test_monster_write: .: (0.022928) - test_monster_write_wait_writable: .: (0.022824) - test_monster_writev: .: (0.044877) - test_monster_writev_wait_writable: .: (0.067155) - test_read_bang_eof: .: (0.000168) - test_read_eof: .: (0.000068) - test_read_extra_buf: .: (0.000098) - test_read_shared: .: (0.000106) - test_read_shared_2: .: (0.000120) - test_read_short: .: (0.000083) - test_read_too_much: .: (0.000074) - test_read_zero: .: (0.000070) - test_tryread_empty: .: (0.000060) - test_tryread_eof: .: (0.000061) - test_tryread_extra_buf_eagain_clears_buffer: .: (0.000109) - test_tryread_extra_buf_eof_clears_buffer: .: (0.000078) - test_tryread_shared: .: (0.000113) - test_tryread_shared_2: .: (0.000096) - test_tryread_short: .: (0.000102) - test_tryread_too_much: .: (0.000082) - test_tryread_wait_readable_method: .: (0.000065) - test_tryread_zero: .: (0.000071) - test_trywrite_closed: .: (0.000126) - test_trywrite_conv: .: (0.000124) - test_trywrite_empty: .: (0.000065) - test_trywrite_full: .: (1.347311) - test_trywrite_return_wait_writable: .: (0.214917) - test_trywrite_wait_readable_method: .: (0.000136) - test_trywritev_closed: .: (0.000131) - test_trywritev_empty: .: (0.000102) - test_trywritev_full: .: (1.627803) - test_trywritev_return_wait_writable: .: (0.218330) - test_wait_readable_method: .: (0.000113) - test_wait_readable_ruby_default: .: (1.000441) - test_wait_writable_method: .: (0.007297) - test_wait_writable_ruby_default: .: (1.000868) - test_write_closed: .: (0.000141) - test_write_conv: .: (0.000122) - test_write_empty: .: (0.000062) - test_writev_closed: .: (0.000085) - test_writev_empty: .: (0.000130) + test_monster_trywrite: .: (0.087014) + test_monster_trywritev: .: (0.252683) + test_monster_write: .: (1.889472) + test_monster_write_wait_writable: .: (2.065233) + test_monster_writev: .: (2.133742) + test_monster_writev_wait_writable: .: (4.161269) + test_read_bang_eof: .: (0.000183) + test_read_eof: .: (0.000128) + test_read_extra_buf: .: (0.000436) + test_read_shared: .: (0.000204) + test_read_shared_2: .: (0.000228) + test_read_short: .: (0.000176) + test_read_too_much: .: (0.000149) + test_read_zero: .: (0.000149) + test_tryread_empty: .: (0.000126) + test_tryread_eof: .: (0.000120) + test_tryread_extra_buf_eagain_clears_buffer: .: (0.000138) + test_tryread_extra_buf_eof_clears_buffer: .: (0.000140) + test_tryread_shared: .: (0.000178) + test_tryread_shared_2: .: (0.000183) + test_tryread_short: .: (0.000192) + test_tryread_too_much: .: (0.000189) + test_tryread_wait_readable_method: .: (0.000140) + test_tryread_zero: .: (0.000179) + test_trywrite_closed: .: (0.000183) + test_trywrite_conv: .: (0.000176) + test_trywrite_empty: .: (0.000178) + test_trywrite_full: .: (6.400155) + test_trywrite_return_wait_writable: .: (1.561103) + test_trywrite_wait_readable_method: .: (0.000254) + test_trywritev_closed: .: (0.000195) + test_trywritev_empty: .: (0.000149) + test_trywritev_full: .: (13.098114) + test_trywritev_return_wait_writable: .: (1.591049) + test_wait_readable_method: .: (0.000247) + test_wait_readable_ruby_default: .: (1.001101) + test_wait_writable_method: .: (0.016656) + test_wait_writable_ruby_default: .: (1.027932) + test_write_closed: .: (0.000223) + test_write_conv: .: (0.000193) + test_write_empty: .: (0.000133) + test_writev_closed: .: (0.000237) + test_writev_empty: .: (0.000113) TestKgioSocket: - test_socket_args: .: (0.000447) + test_socket_args: .: (0.000651) TestKgioSyssend: - test_syssend: # terminated with exception (report_on_exception is true): + test_syssend: # terminated with exception (report_on_exception is true): /build/ruby-kgio-2.11.2/test/test_syssend.rb:38:in `kgio_syssend': stream closed in another thread (IOError) from /build/ruby-kgio-2.11.2/test/test_syssend.rb:38:in `block (2 levels) in test_syssend' from /build/ruby-kgio-2.11.2/test/test_syssend.rb:38:in `loop' from /build/ruby-kgio-2.11.2/test/test_syssend.rb:38:in `block in test_syssend' -.: (0.174721) +.: (0.254216) TestKgioTCPServer: - test_blocking_accept: .: (1.003751) - test_blocking_accept_flags: .: (0.000370) - test_blocking_accept_with_nonblock_socket: .: (8.011745) - test_tryaccept_fail: .: (0.000260) - test_tryaccept_flags: .: (0.000259) - test_tryaccept_success: .: (0.000217) + test_blocking_accept: .: (1.031758) + test_blocking_accept_flags: .: (0.000461) + test_blocking_accept_with_nonblock_socket: .: (8.099246) + test_tryaccept_fail: .: (0.000802) + test_tryaccept_flags: .: (0.000362) + test_tryaccept_success: .: (0.000331) TestKgioTcpConnect: - test_new: .: (0.000334) - test_socket_start: .: (0.000332) - test_start: .: (0.000310) - test_tcp_socket_new: .: (0.000248) - test_tcp_socket_new_invalid: .: (0.000340) - test_wait_writable_set: .: (0.000312) + test_new: .: (0.000444) + test_socket_start: .: (0.000271) + test_start: .: (0.000264) + test_tcp_socket_new: .: (0.000385) + test_tcp_socket_new_invalid: .: (0.000409) + test_wait_writable_set: .: (0.005500) TestKgioUNIXServer: - test_blocking_accept: .: (1.005330) - test_blocking_accept_flags: .: (0.000666) - test_blocking_accept_with_nonblock_socket: .: (8.008446) - test_tryaccept_fail: .: (0.000666) - test_tryaccept_flags: .: (0.000553) - test_tryaccept_success: .: (0.000654) + test_blocking_accept: .: (1.106432) + test_blocking_accept_flags: .: (0.076447) + test_blocking_accept_with_nonblock_socket: .: (8.196586) + test_tryaccept_fail: .: (0.062792) + test_tryaccept_flags: .: (0.051917) + test_tryaccept_success: .: (0.068420) TestKgioUNIXSocketPair: - test_monster_trywrite: .: (0.013421) - test_monster_trywritev: .: (0.041451) - test_monster_write: .: (0.015933) - test_monster_write_wait_writable: .: (0.015962) - test_monster_writev: .: (0.030827) - test_monster_writev_wait_writable: .: (0.054589) - test_read_bang_eof: .: (0.000197) - test_read_eof: .: (0.000254) - test_read_extra_buf: .: (0.000238) - test_read_shared: .: (0.000205) - test_read_shared_2: .: (0.000206) - test_read_short: .: (0.000180) - test_read_too_much: .: (0.000191) - test_read_zero: .: (0.000194) - test_tryread_empty: .: (0.000160) - test_tryread_eof: .: (0.000160) - test_tryread_extra_buf_eagain_clears_buffer: .: (0.000155) - test_tryread_extra_buf_eof_clears_buffer: .: (0.000160) - test_tryread_shared: .: (0.000179) - test_tryread_shared_2: .: (0.000205) - test_tryread_short: .: (0.000173) - test_tryread_too_much: .: (0.000168) - test_tryread_wait_readable_method: .: (0.000136) - test_tryread_zero: .: (0.000157) - test_trywrite_closed: .: (0.000176) - test_trywrite_conv: .: (0.000150) - test_trywrite_empty: .: (0.000138) - test_trywrite_full: .: (1.263869) - test_trywrite_return_wait_writable: .: (0.002340) - test_trywrite_wait_readable_method: .: (0.000331) - test_trywritev_closed: .: (0.000260) - test_trywritev_empty: .: (0.000136) - test_trywritev_full: .: (1.324113) - test_trywritev_return_wait_writable: .: (0.002797) - test_wait_readable_method: .: (0.000409) - test_wait_readable_ruby_default: .: (1.000509) - test_wait_writable_method: .: (0.000688) - test_wait_writable_ruby_default: .: (1.000993) - test_write_closed: .: (0.000440) - test_write_conv: .: (0.000234) - test_write_empty: .: (0.000189) - test_writev_closed: .: (0.000209) - test_writev_empty: .: (0.000182) + test_monster_trywrite: .: (0.102989) + test_monster_trywritev: .: (0.201100) + test_monster_write: .: (0.655241) + test_monster_write_wait_writable: .: (0.551928) + test_monster_writev: .: (0.920235) + test_monster_writev_wait_writable: .: (1.517796) + test_read_bang_eof: .: (0.001328) + test_read_eof: .: (0.000947) + test_read_extra_buf: .: (0.010622) + test_read_shared: .: (0.000450) + test_read_shared_2: .: (0.006825) + test_read_short: .: (0.000369) + test_read_too_much: .: (0.000295) + test_read_zero: .: (0.000301) + test_tryread_empty: .: (0.000252) + test_tryread_eof: .: (0.000281) + test_tryread_extra_buf_eagain_clears_buffer: .: (0.000291) + test_tryread_extra_buf_eof_clears_buffer: .: (0.000279) + test_tryread_shared: .: (0.000334) + test_tryread_shared_2: .: (0.000353) + test_tryread_short: .: (0.000382) + test_tryread_too_much: .: (0.000417) + test_tryread_wait_readable_method: .: (0.000311) + test_tryread_zero: .: (0.000335) + test_trywrite_closed: .: (0.000331) + test_trywrite_conv: .: (0.000309) + test_trywrite_empty: .: (0.003984) + test_trywrite_full: .: (4.891113) + test_trywrite_return_wait_writable: .: (0.008090) + test_trywrite_wait_readable_method: .: (0.000396) + test_trywritev_closed: .: (0.000207) + test_trywritev_empty: .: (0.000154) + test_trywritev_full: .: (2.719594) + test_trywritev_return_wait_writable: .: (0.036901) + test_wait_readable_method: .: (0.000325) + test_wait_readable_ruby_default: .: (1.021296) + test_wait_writable_method: .: (0.001598) + test_wait_writable_ruby_default: .: (1.018696) + test_write_closed: .: (0.000267) + test_write_conv: .: (0.000202) + test_write_empty: .: (0.000190) + test_writev_closed: .: (0.000210) + test_writev_empty: .: (0.000169) TestKgioUnixConnect: - test_new: .: (0.001078) - test_socket_start: .: (0.000587) - test_start: .: (0.000556) - test_unix_socket_new: .: (0.000591) - test_unix_socket_new_invalid: .: (0.000926) - test_wait_writable_set: .: (0.000549) + test_new: .: (0.014807) + test_socket_start: .: (0.000943) + test_start: .: (0.000776) + test_unix_socket_new: .: (0.000862) + test_unix_socket_new_invalid: .: (0.004505) + test_wait_writable_set: .: (0.008464) TestNoDnsOnTcpConnect: - test_connect_localhost: .: (0.000170) - test_connect_remote: .: (0.000077) + test_connect_localhost: .: (0.000337) + test_connect_remote: .: (0.000154) TestPeek: - test_peek: .: (0.000487) - test_peek_singleton: .: (0.000237) + test_peek: .: (0.008272) + test_peek_singleton: .: (0.000413) TestPipePopen: - test_popen: .: (1.502171) + test_popen: .: (1.545301) TestPoll: - test_constants: .: (0.000231) - test_poll_EINTR: .: (1.005130) - test_poll_close: .: (0.100449) - test_poll_integer: .: (0.000114) - test_poll_signal_torture: .: (5.117429) - test_poll_symbol: .: (0.000117) - test_poll_timeout: .: (0.010327) - test_signal_close: .: (0.100708) + test_constants: .: (0.000706) + test_poll_EINTR: .: (1.006933) + test_poll_close: .: (0.119955) + test_poll_integer: .: (0.000211) + test_poll_signal_torture: .: (5.348616) + test_poll_symbol: .: (0.000263) + test_poll_timeout: .: (0.010581) + test_signal_close: .: (0.116334) TestSingletonReadWrite: - test_arg_error: .: (0.000189) - test_unix_socketpair: .: (0.000289) + test_arg_error: .: (0.000390) + test_unix_socketpair: .: (0.011099) TestTFO: - test_constants: .: (0.004309) + test_constants: .: (0.092148) test_tfo_client_server: TCP Fast Open not enabled on this system (check kernel docs) -.: (0.000226) +.: (0.011433) TestTcp6ClientReadServerWrite: - test_monster_trywrite: .: (0.018802) - test_monster_trywritev: .: (0.037168) - test_monster_write: .: (0.014388) - test_monster_write_wait_writable: .: (0.013528) - test_monster_writev: .: (0.026932) - test_monster_writev_wait_writable: .: (0.040586) - test_read_bang_eof: .: (0.000383) - test_read_eof: .: (0.000196) - test_read_extra_buf: .: (0.000241) - test_read_shared: .: (0.000273) - test_read_shared_2: .: (0.000249) - test_read_short: .: (0.000224) - test_read_too_much: .: (0.000200) - test_read_zero: .: (0.000214) - test_tryread_empty: .: (0.000235) - test_tryread_eof: .: (0.000231) - test_tryread_extra_buf_eagain_clears_buffer: .: (0.000208) - test_tryread_extra_buf_eof_clears_buffer: .: (0.000270) - test_tryread_shared: .: (0.000248) - test_tryread_shared_2: .: (0.000230) - test_tryread_short: .: (0.000216) - test_tryread_too_much: .: (0.000228) - test_tryread_wait_readable_method: .: (0.000203) - test_tryread_zero: .: (0.000189) - test_trywrite_closed: .: (0.000237) - test_trywrite_conv: .: (0.000250) - test_trywrite_empty: .: (0.000195) - test_trywrite_full: .: (1.225770) - test_trywrite_return_wait_writable: .: (8.216813) - test_trywrite_wait_readable_method: .: (0.001698) - test_trywritev_closed: .: (0.000291) - test_trywritev_empty: .: (0.000250) - test_trywritev_full: .: (1.251004) - test_trywritev_return_wait_writable: .: (9.064768) - test_wait_readable_method: .: (0.000447) - test_wait_readable_ruby_default: .: (1.000569) - test_wait_writable_method: .: (0.214582) - test_wait_writable_ruby_default: .: (1.006689) - test_write_closed: .: (0.000304) - test_write_conv: .: (0.000320) - test_write_empty: .: (0.000300) - test_writev_closed: .: (0.000214) - test_writev_empty: .: (0.000189) + test_monster_trywrite: .: (0.179776) + test_monster_trywritev: .: (0.300602) + test_monster_write: .: (0.193331) + test_monster_write_wait_writable: .: (0.105857) + test_monster_writev: .: (0.184508) + test_monster_writev_wait_writable: .: (0.375141) + test_read_bang_eof: .: (0.004181) + test_read_eof: .: (0.000576) + test_read_extra_buf: .: (0.000384) + test_read_shared: .: (0.000394) + test_read_shared_2: .: (0.000328) + test_read_short: .: (0.006110) + test_read_too_much: .: (0.003969) + test_read_zero: .: (0.000372) + test_tryread_empty: .: (0.000331) + test_tryread_eof: .: (0.000289) + test_tryread_extra_buf_eagain_clears_buffer: .: (0.000300) + test_tryread_extra_buf_eof_clears_buffer: .: (0.000322) + test_tryread_shared: .: (0.002246) + test_tryread_shared_2: .: (0.000466) + test_tryread_short: .: (0.007718) + test_tryread_too_much: .: (0.000445) + test_tryread_wait_readable_method: .: (0.000291) + test_tryread_zero: .: (0.000284) + test_trywrite_closed: .: (0.000376) + test_trywrite_conv: .: (0.000443) + test_trywrite_empty: .: (0.000349) + test_trywrite_full: .: (2.384613) + test_trywrite_return_wait_writable: .: (57.566085) + test_trywrite_wait_readable_method: .: (0.002901) + test_trywritev_closed: .: (0.007171) + test_trywritev_empty: .: (0.000328) + test_trywritev_full: .: (2.143169) + test_trywritev_return_wait_writable: .: (60.054851) + test_wait_readable_method: .: (0.000577) + test_wait_readable_ruby_default: .: (1.020746) + test_wait_writable_method: .: (1.175446) + test_wait_writable_ruby_default: .: (1.044068) + test_write_closed: .: (0.000498) + test_write_conv: .: (0.000318) + test_write_empty: .: (0.007188) + test_writev_closed: .: (0.000552) + test_writev_empty: .: (0.000409) TestTryopen: test_tryopen_EACCES: cannot test EACCES when euid == 0 -.: (0.000414) - test_tryopen_ENOENT: .: (0.000186) - test_tryopen_mode: .: (0.000200) - test_tryopen_readwrite: .: (0.000165) - test_tryopen_success: .: (0.000202) - test_tryopen_try_readwrite: .: (0.000183) +.: (0.011024) + test_tryopen_ENOENT: .: (0.000526) + test_tryopen_mode: .: (0.000464) + test_tryopen_readwrite: .: (0.000256) + test_tryopen_success: .: (0.018058) + test_tryopen_try_readwrite: .: (0.000653) TestUnixClientReadServerWrite: - test_monster_trywrite: .: (0.013621) - test_monster_trywritev: .: (0.041950) - test_monster_write: .: (0.016157) - test_monster_write_wait_writable: .: (0.016985) - test_monster_writev: .: (0.032195) - test_monster_writev_wait_writable: .: (0.057293) - test_read_bang_eof: .: (0.000661) - test_read_eof: .: (0.000537) - test_read_extra_buf: .: (0.000593) - test_read_shared: .: (0.000554) - test_read_shared_2: .: (0.000547) - test_read_short: .: (0.000600) - test_read_too_much: .: (0.000554) - test_read_zero: .: (0.000543) - test_tryread_empty: .: (0.000567) - test_tryread_eof: .: (0.000558) - test_tryread_extra_buf_eagain_clears_buffer: .: (0.000573) - test_tryread_extra_buf_eof_clears_buffer: .: (0.000550) - test_tryread_shared: .: (0.000583) - test_tryread_shared_2: .: (0.000608) - test_tryread_short: .: (0.000611) - test_tryread_too_much: .: (0.000567) - test_tryread_wait_readable_method: .: (0.000540) - test_tryread_zero: .: (0.000577) - test_trywrite_closed: .: (0.000623) - test_trywrite_conv: .: (0.000640) - test_trywrite_empty: .: (0.000565) - test_trywrite_full: .: (1.260103) - test_trywrite_return_wait_writable: .: (0.002651) - test_trywrite_wait_readable_method: .: (0.000736) - test_trywritev_closed: .: (0.000633) - test_trywritev_empty: .: (0.000533) - test_trywritev_full: .: (1.324140) - test_trywritev_return_wait_writable: .: (0.003329) - test_wait_readable_method: .: (0.000711) - test_wait_readable_ruby_default: .: (1.001383) - test_wait_writable_method: .: (0.001358) - test_wait_writable_ruby_default: .: (1.001505) - test_write_closed: .: (0.000865) - test_write_conv: .: (0.000804) - test_write_empty: .: (0.000725) - test_writev_closed: .: (0.000707) - test_writev_empty: .: (0.000718) + test_monster_trywrite: .: (0.115878) + test_monster_trywritev: .: (0.287461) + test_monster_write: .: (0.772161) + test_monster_write_wait_writable: .: (0.851851) + test_monster_writev: .: (0.178548) + test_monster_writev_wait_writable: .: (0.310798) + test_read_bang_eof: .: (0.001191) + test_read_eof: .: (0.005389) + test_read_extra_buf: .: (0.001172) + test_read_shared: .: (0.000907) + test_read_shared_2: .: (0.002555) + test_read_short: .: (0.000993) + test_read_too_much: .: (0.000839) + test_read_zero: .: (0.000958) + test_tryread_empty: .: (0.000852) + test_tryread_eof: .: (0.000773) + test_tryread_extra_buf_eagain_clears_buffer: .: (0.000812) + test_tryread_extra_buf_eof_clears_buffer: .: (0.000854) + test_tryread_shared: .: (0.000896) + test_tryread_shared_2: .: (0.009115) + test_tryread_short: .: (0.007256) + test_tryread_too_much: .: (0.000902) + test_tryread_wait_readable_method: .: (0.000862) + test_tryread_zero: .: (0.005219) + test_trywrite_closed: .: (0.001249) + test_trywrite_conv: .: (0.000934) + test_trywrite_empty: .: (0.006014) + test_trywrite_full: .: (5.395712) + test_trywrite_return_wait_writable: .: (0.035729) + test_trywrite_wait_readable_method: .: (0.016306) + test_trywritev_closed: .: (0.001237) + test_trywritev_empty: .: (0.010256) + test_trywritev_full: .: (1.733795) + test_trywritev_return_wait_writable: .: (0.010475) + test_wait_readable_method: .: (0.002515) + test_wait_readable_ruby_default: .: (1.017474) + test_wait_writable_method: .: (0.002127) + test_wait_writable_ruby_default: .: (1.021283) + test_write_closed: .: (0.000952) + test_write_conv: .: (0.000756) + test_write_empty: .: (0.000699) + test_writev_closed: .: (0.000833) + test_writev_empty: .: (0.004708) TestUnixServerReadClientWrite: - test_monster_trywrite: .: (0.012296) - test_monster_trywritev: .: (0.042743) - test_monster_write: .: (0.016797) - test_monster_write_wait_writable: .: (0.016075) - test_monster_writev: .: (0.027200) - test_monster_writev_wait_writable: .: (0.049920) - test_read_bang_eof: .: (0.000952) - test_read_eof: .: (0.000798) - test_read_extra_buf: .: (0.000767) - test_read_shared: .: (0.000776) - test_read_shared_2: .: (0.000790) - test_read_short: .: (0.000860) - test_read_too_much: .: (0.000734) - test_read_zero: .: (0.000791) - test_tryread_empty: .: (0.000679) - test_tryread_eof: .: (0.000766) - test_tryread_extra_buf_eagain_clears_buffer: .: (0.027854) - test_tryread_extra_buf_eof_clears_buffer: .: (0.000753) - test_tryread_shared: .: (0.000784) - test_tryread_shared_2: .: (0.000728) - test_tryread_short: .: (0.000748) - test_tryread_too_much: .: (0.007108) - test_tryread_wait_readable_method: .: (0.000858) - test_tryread_zero: .: (0.000840) - test_trywrite_closed: .: (0.000787) - test_trywrite_conv: .: (0.000773) - test_trywrite_empty: .: (0.000688) - test_trywrite_full: .: (1.256244) - test_trywrite_return_wait_writable: .: (0.002948) - test_trywrite_wait_readable_method: .: (0.000956) - test_trywritev_closed: .: (0.000901) - test_trywritev_empty: .: (0.000700) - test_trywritev_full: .: (1.323981) - test_trywritev_return_wait_writable: .: (0.002605) - test_wait_readable_method: .: (0.000705) - test_wait_readable_ruby_default: .: (1.001043) - test_wait_writable_method: .: (0.001203) - test_wait_writable_ruby_default: .: (1.001423) - test_write_closed: .: (0.000622) - test_write_conv: .: (0.000517) - test_write_empty: .: (0.000536) - test_writev_closed: .: (0.000538) - test_writev_empty: .: (0.000582) + test_monster_trywrite: .: (0.061560) + test_monster_trywritev: .: (0.196456) + test_monster_write: .: (0.078326) + test_monster_write_wait_writable: .: (0.160605) + test_monster_writev: .: (0.974478) + test_monster_writev_wait_writable: .: (1.903961) + test_read_bang_eof: .: (0.007440) + test_read_eof: .: (0.008774) + test_read_extra_buf: .: (0.000981) + test_read_shared: .: (0.000862) + test_read_shared_2: .: (0.000995) + test_read_short: .: (0.000899) + test_read_too_much: .: (0.000827) + test_read_zero: .: (0.006600) + test_tryread_empty: .: (0.000992) + test_tryread_eof: .: (0.000834) + test_tryread_extra_buf_eagain_clears_buffer: .: (0.000826) + test_tryread_extra_buf_eof_clears_buffer: .: (0.004994) + test_tryread_shared: .: (0.001056) + test_tryread_shared_2: .: (0.000788) + test_tryread_short: .: (0.006376) + test_tryread_too_much: .: (0.000893) + test_tryread_wait_readable_method: .: (0.000864) + test_tryread_zero: .: (0.004957) + test_trywrite_closed: .: (0.001613) + test_trywrite_conv: .: (0.001139) + test_trywrite_empty: .: (0.006293) + test_trywrite_full: .: (2.182372) + test_trywrite_return_wait_writable: .: (0.016285) + test_trywrite_wait_readable_method: .: (0.005175) + test_trywritev_closed: .: (0.000966) + test_trywritev_empty: .: (0.006589) + test_trywritev_full: .: (2.699689) + test_trywritev_return_wait_writable: .: (0.008484) + test_wait_readable_method: .: (0.000986) + test_wait_readable_ruby_default: .: (1.002260) + test_wait_writable_method: .: (0.015509) + test_wait_writable_ruby_default: .: (1.012249) + test_write_closed: .: (0.011729) + test_write_conv: .: (0.001125) + test_write_empty: .: (0.006887) + test_writev_closed: .: (0.004395) + test_writev_empty: .: (0.007042) -Finished in 115.848311246 seconds. +Finished in 520.424705572 seconds. ------------------------------------------------------------------------------- -365 tests, 7975574 assertions, 0 failures, 0 errors, 0 pendings, 0 omissions, 0 notifications +365 tests, 8136759 assertions, 0 failures, 0 errors, 0 pendings, 0 omissions, 0 notifications 100% passed ------------------------------------------------------------------------------- -3.15 tests/s, 68844.97 assertions/s +0.70 tests/s, 15634.84 assertions/s ┌──────────────────────────────────────────────────────────────────────────────┐ │ dh_ruby --install finished │ @@ -1325,29 +1337,31 @@ dh_strip -O--buildsystem=ruby dh_makeshlibs -O--buildsystem=ruby dh_shlibdeps -O--buildsystem=ruby +dpkg-shlibdeps: warning: package could avoid a useless dependency if debian/ruby-kgio/usr/lib/i386-linux-gnu/ruby/vendor_ruby/2.5.0/kgio_ext.so was not linked against libgmp.so.10 (it uses none of the library's symbols) dpkg-shlibdeps: warning: package could avoid a useless dependency if debian/ruby-kgio/usr/lib/i386-linux-gnu/ruby/vendor_ruby/2.5.0/kgio_ext.so was not linked against libm.so.6 (it uses none of the library's symbols) dpkg-shlibdeps: warning: package could avoid a useless dependency if debian/ruby-kgio/usr/lib/i386-linux-gnu/ruby/vendor_ruby/2.5.0/kgio_ext.so was not linked against libcrypt.so.1 (it uses none of the library's symbols) dpkg-shlibdeps: warning: package could avoid a useless dependency if debian/ruby-kgio/usr/lib/i386-linux-gnu/ruby/vendor_ruby/2.5.0/kgio_ext.so was not linked against libdl.so.2 (it uses none of the library's symbols) -dpkg-shlibdeps: warning: package could avoid a useless dependency if debian/ruby-kgio/usr/lib/i386-linux-gnu/ruby/vendor_ruby/2.5.0/kgio_ext.so was not linked against libgmp.so.10 (it uses none of the library's symbols) dh_ruby_fixdepends -O--buildsystem=ruby dh_installdeb -O--buildsystem=ruby dh_gencontrol -O--buildsystem=ruby dh_md5sums -O--buildsystem=ruby dh_builddeb -O--buildsystem=ruby -dpkg-deb: building package 'ruby-kgio-dbgsym' in '../ruby-kgio-dbgsym_2.11.2-1_i386.deb'. dpkg-deb: building package 'ruby-kgio' in '../ruby-kgio_2.11.2-1_i386.deb'. +dpkg-deb: building package 'ruby-kgio-dbgsym' in '../ruby-kgio-dbgsym_2.11.2-1_i386.deb'. dpkg-genbuildinfo --build=binary dpkg-genchanges --build=binary >../ruby-kgio_2.11.2-1_i386.changes dpkg-genchanges: info: binary-only upload (no source code included) dpkg-source --after-build . dpkg-buildpackage: info: binary-only upload (no source included) I: copying local configuration +I: user script /srv/workspace/pbuilder/3865/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/3865/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/8856 and its subdirectories -I: Current time: Tue Jun 1 08:02:10 -12 2021 -I: pbuilder-time-stamp: 1622577730 +I: removing directory /srv/workspace/pbuilder/3865 and its subdirectories +I: Current time: Thu Apr 30 03:54:47 +14 2020 +I: pbuilder-time-stamp: 1588168487