0s autopkgtest [07:26:49]: starting date and time: 2026-02-08 07:26:49+0000 0s autopkgtest [07:26:49]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [07:26:49]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.veahw2ze/out --timeout-copy=6000 --needs-internet=try --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:ruby3.3 --apt-upgrade ruby-eventmachine --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=ruby3.3/3.3.8-2ubuntu3 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-s390x-17.secgroup --name adt-resolute-s390x-ruby-eventmachine-20260208-072649-juju-7f2275-prod-proposed-migration-environment-20-938dfcf6-51d1-4a85-a6fa-2471d8705fad --image adt/ubuntu-resolute-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-s390x-ruby-eventmachine-20260208-072649-juju-7f2275-prod-proposed-migration-environment-20-938dfcf6-51d1-4a85-a6fa-2471d8705fad from image adt/ubuntu-resolute-s390x-server-20260208.img (UUID bf8d2066-816d-4293-b7d1-06f39d3d29cb)... 123s autopkgtest [07:28:52]: testbed dpkg architecture: s390x 124s autopkgtest [07:28:53]: testbed apt version: 3.1.15 124s autopkgtest [07:28:53]: @@@@@@@@@@@@@@@@@@@@ test bed setup 124s autopkgtest [07:28:53]: testbed release detected to be: None 125s autopkgtest [07:28:54]: updating testbed package index (apt update) 125s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 126s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 126s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 126s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 126s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [177 kB] 126s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [28.2 kB] 126s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1554 kB] 126s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x Packages [204 kB] 126s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/universe s390x Packages [1358 kB] 126s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse s390x Packages [7384 B] 128s Fetched 3453 kB in 2s (1472 kB/s) 134s Reading package lists... 136s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 136s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 136s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 137s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 142s Reading package lists... 143s Reading package lists... 144s Building dependency tree... 144s Reading state information... 145s Calculating upgrade... 146s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 146s autopkgtest [07:29:15]: upgrading testbed (apt dist-upgrade and autopurge) 147s Reading package lists... 149s Building dependency tree... 149s Reading state information... 149s Calculating upgrade... 151s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 151s Reading package lists... 152s Building dependency tree... 152s Reading state information... 152s Solving dependencies... 154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 161s autopkgtest [07:29:30]: testbed running kernel: Linux 6.19.0-3-generic #3-Ubuntu SMP Fri Jan 23 19:02:49 UTC 2026 162s autopkgtest [07:29:31]: @@@@@@@@@@@@@@@@@@@@ apt-source ruby-eventmachine 167s Get:1 http://ftpmaster.internal/ubuntu resolute/universe ruby-eventmachine 1.3~pre20220315-df4ab006-5build1 (dsc) [2380 B] 167s Get:2 http://ftpmaster.internal/ubuntu resolute/universe ruby-eventmachine 1.3~pre20220315-df4ab006-5build1 (tar) [211 kB] 167s Get:3 http://ftpmaster.internal/ubuntu resolute/universe ruby-eventmachine 1.3~pre20220315-df4ab006-5build1 (diff) [8412 B] 168s gpgv: Signature made Sat Aug 17 19:48:17 2024 UTC 168s gpgv: using RSA key 8ED6C3F8BAC9DB7FC130A870F823A2729883C97C 168s gpgv: issuer "kanashiro@ubuntu.com" 168s gpgv: Can't check signature: No public key 168s dpkg-source: warning: cannot verify inline signature for ./ruby-eventmachine_1.3~pre20220315-df4ab006-5build1.dsc: no acceptable signature found 169s autopkgtest [07:29:38]: testing package ruby-eventmachine version 1.3~pre20220315-df4ab006-5build1 170s autopkgtest [07:29:39]: build not needed 171s autopkgtest [07:29:40]: test gem2deb-test-runner: preparing testbed 172s Reading package lists... 173s Building dependency tree... 173s Reading state information... 174s Solving dependencies... 175s The following NEW packages will be installed: 175s gem2deb-test-runner libruby libruby3.3 libssl-dev rake rake-compiler ruby 175s ruby-csv ruby-did-you-mean ruby-eventmachine ruby-minitest ruby-net-telnet 175s ruby-power-assert ruby-ruby2-keywords ruby-rubygems ruby-test-unit 175s ruby-webrick ruby-xmlrpc ruby3.3 rubygems-integration 175s 0 upgraded, 20 newly installed, 0 to remove and 0 not upgraded. 175s Need to get 9398 kB of archives. 175s After this operation, 49.6 MB of additional disk space will be used. 175s Get:1 http://ftpmaster.internal/ubuntu resolute/main s390x rubygems-integration all 1.19build1 [5666 B] 175s Get:2 http://ftpmaster.internal/ubuntu resolute/main s390x ruby-csv all 3.3.4-1 [43.0 kB] 175s Get:3 http://ftpmaster.internal/ubuntu resolute/main s390x ruby-did-you-mean all 1.6.3-2build1 [14.9 kB] 175s Get:4 http://ftpmaster.internal/ubuntu resolute/main s390x ruby-net-telnet all 0.2.0-1build1 [13.5 kB] 175s Get:5 http://ftpmaster.internal/ubuntu resolute/main s390x ruby-ruby2-keywords all 0.0.5-1build1 [4398 B] 175s Get:6 http://ftpmaster.internal/ubuntu resolute/main s390x ruby-webrick all 1.9.1-1build1 [60.9 kB] 175s Get:7 http://ftpmaster.internal/ubuntu resolute/main s390x ruby-xmlrpc all 0.3.3-2build1 [24.9 kB] 175s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libruby3.3 s390x 3.3.8-2ubuntu3 [5868 kB] 176s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x ruby3.3 s390x 3.3.8-2ubuntu3 [49.1 kB] 176s Get:10 http://ftpmaster.internal/ubuntu resolute/main s390x libruby s390x 1:3.3 [5162 B] 176s Get:11 http://ftpmaster.internal/ubuntu resolute/main s390x ruby-rubygems all 3.6.7-2ubuntu2 [332 kB] 176s Get:12 http://ftpmaster.internal/ubuntu resolute/main s390x ruby s390x 1:3.3 [3668 B] 176s Get:13 http://ftpmaster.internal/ubuntu resolute/main s390x rake all 13.2.1-1build1 [45.9 kB] 176s Get:14 http://ftpmaster.internal/ubuntu resolute/universe s390x ruby-minitest all 5.26.1-1 [49.3 kB] 176s Get:15 http://ftpmaster.internal/ubuntu resolute/universe s390x ruby-power-assert all 2.0.5-1 [12.0 kB] 176s Get:16 http://ftpmaster.internal/ubuntu resolute/universe s390x ruby-test-unit all 3.6.2-1 [67.0 kB] 176s Get:17 http://ftpmaster.internal/ubuntu resolute/universe s390x gem2deb-test-runner s390x 2.2.5 [18.3 kB] 177s Get:18 http://ftpmaster.internal/ubuntu resolute/main s390x libssl-dev s390x 3.5.3-1ubuntu2 [2601 kB] 177s Get:19 http://ftpmaster.internal/ubuntu resolute/universe s390x rake-compiler all 1.3.1-1 [25.0 kB] 177s Get:20 http://ftpmaster.internal/ubuntu resolute/universe s390x ruby-eventmachine s390x 1.3~pre20220315-df4ab006-5build1 [154 kB] 180s Fetched 9398 kB in 2s (4444 kB/s) 180s Selecting previously unselected package rubygems-integration. 182s (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 ... 88711 files and directories currently installed.) 182s Preparing to unpack .../00-rubygems-integration_1.19build1_all.deb ... 182s Unpacking rubygems-integration (1.19build1) ... 182s Selecting previously unselected package ruby-csv. 182s Preparing to unpack .../01-ruby-csv_3.3.4-1_all.deb ... 182s Unpacking ruby-csv (3.3.4-1) ... 183s Selecting previously unselected package ruby-did-you-mean. 183s Preparing to unpack .../02-ruby-did-you-mean_1.6.3-2build1_all.deb ... 183s Unpacking ruby-did-you-mean (1.6.3-2build1) ... 183s Selecting previously unselected package ruby-net-telnet. 183s Preparing to unpack .../03-ruby-net-telnet_0.2.0-1build1_all.deb ... 183s Unpacking ruby-net-telnet (0.2.0-1build1) ... 183s Selecting previously unselected package ruby-ruby2-keywords. 183s Preparing to unpack .../04-ruby-ruby2-keywords_0.0.5-1build1_all.deb ... 183s Unpacking ruby-ruby2-keywords (0.0.5-1build1) ... 183s Selecting previously unselected package ruby-webrick. 183s Preparing to unpack .../05-ruby-webrick_1.9.1-1build1_all.deb ... 183s Unpacking ruby-webrick (1.9.1-1build1) ... 183s Selecting previously unselected package ruby-xmlrpc. 183s Preparing to unpack .../06-ruby-xmlrpc_0.3.3-2build1_all.deb ... 183s Unpacking ruby-xmlrpc (0.3.3-2build1) ... 184s Selecting previously unselected package libruby3.3:s390x. 184s Preparing to unpack .../07-libruby3.3_3.3.8-2ubuntu3_s390x.deb ... 184s Unpacking libruby3.3:s390x (3.3.8-2ubuntu3) ... 187s Selecting previously unselected package ruby3.3. 187s Preparing to unpack .../08-ruby3.3_3.3.8-2ubuntu3_s390x.deb ... 187s Unpacking ruby3.3 (3.3.8-2ubuntu3) ... 188s Selecting previously unselected package libruby:s390x. 188s Preparing to unpack .../09-libruby_1%3a3.3_s390x.deb ... 188s Unpacking libruby:s390x (1:3.3) ... 188s Selecting previously unselected package ruby-rubygems. 188s Preparing to unpack .../10-ruby-rubygems_3.6.7-2ubuntu2_all.deb ... 188s Unpacking ruby-rubygems (3.6.7-2ubuntu2) ... 189s Selecting previously unselected package ruby. 189s Preparing to unpack .../11-ruby_1%3a3.3_s390x.deb ... 189s Unpacking ruby (1:3.3) ... 189s Selecting previously unselected package rake. 189s Preparing to unpack .../12-rake_13.2.1-1build1_all.deb ... 189s Unpacking rake (13.2.1-1build1) ... 189s Selecting previously unselected package ruby-minitest. 189s Preparing to unpack .../13-ruby-minitest_5.26.1-1_all.deb ... 189s Unpacking ruby-minitest (5.26.1-1) ... 189s Selecting previously unselected package ruby-power-assert. 189s Preparing to unpack .../14-ruby-power-assert_2.0.5-1_all.deb ... 189s Unpacking ruby-power-assert (2.0.5-1) ... 190s Selecting previously unselected package ruby-test-unit. 190s Preparing to unpack .../15-ruby-test-unit_3.6.2-1_all.deb ... 190s Unpacking ruby-test-unit (3.6.2-1) ... 190s Selecting previously unselected package gem2deb-test-runner. 190s Preparing to unpack .../16-gem2deb-test-runner_2.2.5_s390x.deb ... 190s Unpacking gem2deb-test-runner (2.2.5) ... 190s Selecting previously unselected package libssl-dev:s390x. 190s Preparing to unpack .../17-libssl-dev_3.5.3-1ubuntu2_s390x.deb ... 190s Unpacking libssl-dev:s390x (3.5.3-1ubuntu2) ... 191s Selecting previously unselected package rake-compiler. 191s Preparing to unpack .../18-rake-compiler_1.3.1-1_all.deb ... 191s Unpacking rake-compiler (1.3.1-1) ... 191s Selecting previously unselected package ruby-eventmachine:s390x. 191s Preparing to unpack .../19-ruby-eventmachine_1.3~pre20220315-df4ab006-5build1_s390x.deb ... 191s Unpacking ruby-eventmachine:s390x (1.3~pre20220315-df4ab006-5build1) ... 191s Setting up ruby-ruby2-keywords (0.0.5-1build1) ... 191s Setting up ruby-power-assert (2.0.5-1) ... 191s Setting up rubygems-integration (1.19build1) ... 191s Setting up ruby-minitest (5.26.1-1) ... 191s Setting up ruby-test-unit (3.6.2-1) ... 191s Setting up ruby-net-telnet (0.2.0-1build1) ... 191s Setting up ruby-csv (3.3.4-1) ... 191s Setting up libssl-dev:s390x (3.5.3-1ubuntu2) ... 191s Setting up ruby-webrick (1.9.1-1build1) ... 191s Setting up ruby-did-you-mean (1.6.3-2build1) ... 191s Setting up ruby-xmlrpc (0.3.3-2build1) ... 191s Setting up rake (13.2.1-1build1) ... 191s Setting up ruby3.3 (3.3.8-2ubuntu3) ... 191s Setting up libruby3.3:s390x (3.3.8-2ubuntu3) ... 191s Setting up ruby-rubygems (3.6.7-2ubuntu2) ... 191s Setting up libruby:s390x (1:3.3) ... 191s Setting up ruby-eventmachine:s390x (1.3~pre20220315-df4ab006-5build1) ... 191s Setting up ruby (1:3.3) ... 191s Setting up rake-compiler (1.3.1-1) ... 191s Setting up gem2deb-test-runner (2.2.5) ... 191s Processing triggers for man-db (2.13.1-1build1) ... 199s Processing triggers for libc-bin (2.42-2ubuntu4) ... 203s autopkgtest [07:30:12]: test gem2deb-test-runner: gem2deb-test-runner --autopkgtest --check-dependencies 2>&1 203s autopkgtest [07:30:12]: test gem2deb-test-runner: [----------------------- 205s 205s ┌──────────────────────────────────────────────────────────────────────────────┐ 205s │ Checking Rubygems dependency resolution on ruby3.3 │ 205s └──────────────────────────────────────────────────────────────────────────────┘ 205s 205s RUBYLIB=. GEM_PATH= ruby3.3 -e gem\ \"eventmachine\" 205s mv lib ./.gem2deb.lib 205s mv ext ./.gem2deb.ext 205s mv ./.gem2deb.lib lib 205s mv ./.gem2deb.ext ext 205s 205s ┌──────────────────────────────────────────────────────────────────────────────┐ 205s │ Run tests for ruby3.3 from debian/ruby-tests.rake │ 205s └──────────────────────────────────────────────────────────────────────────────┘ 205s 205s RUBYLIB=. GEM_PATH= ruby3.3 -S rake --rakelibdir /gem2deb-nonexistent -f debian/ruby-tests.rake 205s mv lib ./.gem2deb.lib 205s mv ext ./.gem2deb.ext 207s /usr/bin/ruby3.3 -w -I"tests" /usr/share/rubygems-integration/all/gems/rake-13.2.1/lib/rake/rake_test_loader.rb "tests/jruby/test_jeventmachine.rb" "tests/test_attach.rb" "tests/test_basic.rb" "tests/test_channel.rb" "tests/test_completion.rb" "tests/test_connection_count.rb" "tests/test_connection_write.rb" "tests/test_defer.rb" "tests/test_deferrable.rb" "tests/test_epoll.rb" "tests/test_error_handler.rb" "tests/test_file_watch.rb" "tests/test_fork.rb" "tests/test_futures.rb" "tests/test_handler_check.rb" "tests/test_hc.rb" "tests/test_io_streamer.rb" "tests/test_ipv4.rb" "tests/test_ipv6.rb" "tests/test_iterator.rb" "tests/test_keepalive.rb" "tests/test_line_protocol.rb" "tests/test_ltp.rb" "tests/test_ltp2.rb" "tests/test_many_fds.rb" "tests/test_next_tick.rb" "tests/test_object_protocol.rb" "tests/test_pause.rb" "tests/test_pool.rb" "tests/test_process_watch.rb" "tests/test_processes.rb" "tests/test_proxy_connection.rb" "tests/test_pure.rb" "tests/test_queue.rb" "tests/test_running.rb" "tests/test_sasl.rb" "tests/test_send_file.rb" "tests/test_servers.rb" "tests/test_shutdown_hooks.rb" "tests/test_smtpclient.rb" "tests/test_smtpserver.rb" "tests/test_sock_opt.rb" "tests/test_spawn.rb" "tests/test_ssl_args.rb" "tests/test_ssl_dhparam.rb" "tests/test_ssl_ecdh_curve.rb" "tests/test_ssl_extensions.rb" "tests/test_ssl_inline_cert.rb" "tests/test_ssl_methods.rb" "tests/test_ssl_protocols.rb" "tests/test_ssl_verify.rb" "tests/test_stomp.rb" "tests/test_system.rb" "tests/test_threaded_resource.rb" "tests/test_tick_loop.rb" "tests/test_timers.rb" "tests/test_ud.rb" -v 209s no IPv6 in this host, skipping tests in /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_ipv6.rb 209s Ignoring tests in /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/jruby/test_jeventmachine.rb. They must be run in JRuby 209s 209s ruby 3.3.8 (2025-04-09 revision b200bad6cd) [s390x-linux-gnu] 209s 209s EM.library_type extension EM.ssl? true 209s OpenSSL OPENSSL_LIBRARY_VERSION: OpenSSL 3.5.3 16 Sep 2025 209s OPENSSL_VERSION: OpenSSL 3.5.4 30 Sep 2025 209s EM OPENSSL_LIBRARY_VERSION: OpenSSL 3.5.3 16 Sep 2025 209s OPENSSL_VERSION: OpenSSL 3.3.1 4 Jun 2024 209s SSL_AVAIL: TLSv1 TLSv1_1 TLSv1_2 TLSv1_3 209s 209s Loaded suite /usr/share/rubygems-integration/all/gems/rake-13.2.1/lib/rake/rake_test_loader 209s Started 209s TestAttach: 209s test_attach: .: (0.102379) 209s test_attach_data: .: (0.000518) 209s test_attach_pipe: .: (0.007631) 210s test_attach_server: .: (0.106266) 210s test_read_write_pipe: .: (0.000787) 210s test_set_readable: .: (0.000283) 210s test_watch_only: .: (0.000166) 210s TestBasic: 210s test_bind_connect: .: (0.003071) 210s test_bubble_errors_from_initialize: .: (0.001345) 210s test_bubble_errors_from_post_init: .: (0.000400) 210s test_byte_range_send: .: (0.002716) 210s test_connection_class_cache: .: (0.004591) 210s test_em: .: (0.001074) 210s test_error_handler_idempotent: .: (0.001987) 210s test_invalid_address_bind_connect_dst: .: (0.001677) 210s test_invalid_address_bind_connect_src: .: (0.007945) 210s test_reactor_thread?: .: (0.000213) 210s test_run_block: .: (0.000123) 210s test_schedule_close: .: (0.005193) 210s test_schedule_from_thread: .: (0.000249) 210s test_schedule_on_reactor_thread: .: (0.000098) 210s test_server: .: (0.000559) 210s test_set_heartbeat_interval: .: (0.000114) 210s test_timer: .: (0.223026) 210s test_unbind_error: .: (0.000447) 210s test_unbind_error_during_stop: .: (0.000225) 210s TestCompletion: 210s test_callback: .: (0.000209) 210s test_cleared_completions: .: (0.000107) 210s test_completed: .: (0.000068) 210s test_completions: .: (0.000091) 210s test_does_not_enqueue_when_completed: .: (0.000072) 210s test_errback: .: (0.000065) 210s test_fail: .: (0.000072) 210s test_late_defined_callbacks: .: (0.000079) 210s test_latent_completion: .: (0.000076) 210s test_recursive_callbacks: .: (0.000079) 210s test_skip_completed_callbacks: .: (0.000084) 210s test_state: .: (0.000045) 210s test_stateback: .: (0.000066) 210s test_succeed: .: (0.000140) 210s test_timeout: .: (0.000082) 210s test_timeout_gets_cancelled: .: (0.000062) 210s TestConnectionCount: 210s test_idle_connection_count: .: (0.000101) 210s test_idle_connection_count_epoll: .: (0.000065) 210s test_idle_connection_count_kqueue: .: (0.000049) 210s test_num_close_scheduled: .: (0.000120) 210s test_with_some_connections: .: (0.000213) 210s TestConnectionWrite: 210s test_with_naughty_callback: .: (0.000137) 210s TestDefer: 210s test_defers: .: (0.004100) 210s test_errbacks: .: (0.286663) 210s TestDeferrable: 210s test_timeout_with_args: .: (0.000451) 210s test_timeout_without_args: .: (0.000118) 210s TestEMChannel: 210s test_channel_num_subscribers: .: (0.000321) 210s test_channel_pop: .: (0.000086) 210s test_channel_reactor_thread_callback: .: (0.000941) 210s test_channel_reactor_thread_push: .: (0.184188) 210s test_channel_subscribe: .: (0.000099) 210s test_channel_unsubscribe: .: (0.000756) 210s TestEMQueue: 212s test_big_queue: .: (1.174064) 212s test_num_waiting: .: (0.000180) 212s test_queue_pop: .: (0.000076) 212s test_queue_push: .: (0.000057) 212s test_queue_reactor_thread: .: (0.000311) 212s TestEmTickLoop: 212s test_em_tick_loop: .: (0.000177) 212s test_immediate_stops: .: (0.000047) 212s test_start_twice: .: (0.000100) 212s test_stop: .: (0.000082) 212s test_stopped: .: (0.000048) 212s test_tick_loop_on_stop: .: (0.000061) 212s TestEpoll: 212s test_attach_detach: .: (0.089241) 212s test_datagrams: .: (0.001810) 212s test_rlimit: .: (0.000166) 212s TestErrorHandler: 212s test_error_handler: .: (0.000200) 212s test_without_error_handler: .: (0.000098) 212s TestFileWatch: 212s test_events: .: (0.015584) 212s test_invalid_signature: .: (0.187061) 212s TestFork: 212s test_fork_reactor: .: (0.164491) 212s test_fork_safe: .: (0.102035) 212s TestFutures: 212s test_delayed_callbacks: .: (0.000265) 212s test_double_calls: .: (0.000063) 212s test_future: .: (0.000076) 212s test_future_1: .: (0.000099) 212s test_future_2: .: (0.000057) 212s test_future_3: .: (0.000049) 212s test_recursive_callbacks: .: (0.000085) 212s test_syntactic_sugar: .: (0.000790) 212s test_timeout: .: (0.010302) 212s TestHandlerCheck: 212s test_with_correct_class: .: (0.000302) 212s test_with_incorrect_class: .: (0.000130) 212s test_with_module: .: (0.000119) 212s TestHeaderAndContentProtocol: 212s test_content: .: (0.010531) 212s test_interpret_headers: .: (0.010779) 212s test_no_content: .: (0.038998) 212s test_several_requests: .: (0.011726) 212s TestIOStreamer: 212s test_io_stream: .: (0.000415) 212s TestIPv4: 212s test_ipv4_tcp_local_server: .: (0.000453) 212s test_ipv4_udp_local_server: .: (0.000196) 212s test_tcp_connect_to_invalid_ipv4: .: (0.000171) 212s test_udp_send_datagram_to_invalid_ipv4: .: (0.000113) 212s TestIPv6: 212s test_ipv6_unavailable: .: (0.000084) 212s TestIterator: 214s test_changing_concurrency_affects_active_iteration: .: (1.519909) 215s test_concurrency_bigger_than_list_size: .: (1.008947) 215s test_concurrency_is_0: .: (0.000233) 215s test_default_concurrency: .: (0.550198) 216s test_default_concurrency_with_a_proc: .: (0.853313) 216s test_inject: .: (0.087186) 218s test_map: .: (1.537671) 218s TestKeepalive: 218s test_disable_keepalive: .: (0.000682) 218s test_enable_keepalive: .: (0.000225) 218s test_enable_keepalive_values: .: (0.000268) 218s TestLineAndTextProtocol: 218s test_binary_text: .: (0.100824) 218s test_lines_and_text: .: (0.195472) 218s test_overlength_lines: .: (0.195252) 219s test_simple_lines: .: (0.187973) 219s TestLineProtocol: 219s test_simple_lines: .: (0.000227) 219s test_simple_split_line: .: (0.000066) 219s TestLineText2: 219s test_basic: .: (0.000172) 219s test_binary: .: (0.000160) 219s test_binary_pairs: .: (0.000080) 219s test_binary_tail: .: (0.001110) 219s test_change_delimiter: .: (0.000115) 219s test_multichar: .: (0.000089) 219s test_preserve_newlines: .: (0.000059) 219s test_receive_end_of_binary_data: .: (0.089965) 219s test_regex_delimiter: .: (0.003767) 219s test_throw_back: .: (0.000143) 219s test_unsized_binary: .: (0.002665) 219s TestManyFDs: 220s test_connection_class_cache: .: (0.773411) 220s TestNextTick: 220s test_cleanup_after_stop: .: (0.000367) 220s test_pre_run_queue: .: (0.000071) 220s test_run_run: .: (0.000059) 220s test_run_run_2: .: (0.000061) 220s test_run_run_3: .: (0.000069) 220s test_schedule_from_thread: .: (0.000217) 220s test_schedule_on_reactor_thread: .: (0.000059) 220s test_tick_arg: .: (0.000058) 220s test_tick_block: .: (0.000054) 220s TestObjectProtocol: 220s test_send_receive: .: (0.000557) 220s TestPause: 220s test_pause_in_receive_data: .: (0.781337) 220s test_pause_resume: F 220s =============================================================================== 220s Failure: test_pause_resume(TestPause) 220s /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_pause.rb:54:in `block (2 levels) in test_pause_resume' 220s 51: tmr = darwin? ? 0.10 : 0.05 220s 52: 220s 53: EM.add_timer(tmr) do 220s => 54: assert_equal 1, s_rx 220s 55: assert_equal 0, c_rx 220s 56: assert server.paused? 220s 57: 220s /usr/lib/ruby/vendor_ruby/eventmachine.rb:196:in `run_machine' 220s /usr/lib/ruby/vendor_ruby/eventmachine.rb:196:in `run' 220s /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_pause.rb:47:in `test_pause_resume' 220s <1> expected but was 220s <0> 220s =============================================================================== 220s : (0.090980) 220s TestPool: 220s test_catches_successful_deferrables: .: (0.000325) 220s test_contents: .: (0.000063) 220s test_contents_when_perform_errors_and_on_error_is_not_set: .: (0.000104) 220s test_contents_when_perform_errors_and_on_error_is_set:.: (0.000108) 220s test_exceptions_in_the_work_block_bubble_up_raise_and_fail_the_resource: .: (0.000189) 220s test_num_waiting: .: (0.000144) 220s test_prunes_locked_and_removed_resources: .: (0.000095) 220s test_removed_list_does_not_leak_on_errors: .: (0.000087) 220s test_reques_resources_on_error: .: (0.000117) 220s test_supports_custom_on_error: .: (0.000095) 220s test_supports_more_work_than_resources: .: (0.000101) 220s TestProcesses: 220s test_deferrable_child_process: .: (0.008759) 221s test_em_popen_pause_resume: .: (0.533506) 221s test_em_system: .: (0.521930) 221s test_em_system_bad_exitstatus: .: (0.035284) 221s test_em_system_cmd_arguments: .: (0.026663) 221s test_em_system_pid: .: (0.114031) 222s test_em_system_spaced_arguments: .: (0.561860) 222s test_em_system_with_proc: .: (0.005798) 222s test_em_system_with_two_procs: .: (0.002907) 222s TestProxyConnection: 222s test_early_close: .: (0.000896) 222s test_partial_proxy_connection: .: (0.001854) 222s test_proxied_bytes: .: (0.000305) 222s test_proxy_connection: .: (0.000281) 222s TestPure: 222s test_connaccepted: .: (0.000257) 222s test_connrefused: .: (0.000121) 222s test_exception_handling_releases_resources: .: (0.000377) 223s test_periodic_timer: .: (0.935280) 223s test_reactor_running: .: (0.000268) 223s test_start_tls: .: (0.107863) 223s TestRunning: 223s test_running: .: (0.000240) 223s TestSASL: 223s test_sasl: .: (0.000462) 223s TestSSLArgs: 223s test_tls_cert_not_defined_twice: .: (0.000360) 223s test_tls_key_not_defined_twice: .: (0.000146) 223s test_tls_key_requires_cert: .: (0.000178) 223s test_tls_params_file_doesnt_exist: .: (0.000300) 223s TestSSLDhParam: 225s test_dhparam_1_2: .: (1.903151) 225s test_dhparam_1_3: .: (0.192499) 225s test_no_dhparam: 000003FFA8BF3740:error:0A0000C1:SSL routines:tls_post_process_client_hello:no shared cipher:../ssl/statem/statem_srvr.c:2333: 225s .: (0.091758) 225s TestSSLEcdhCurve: 225s test_ecdh_curve_tlsv1_2: .: (0.114329) 226s test_ecdh_curve_tlsv1_3: .: (0.301680) 226s test_no_ecdh_curve: O 226s =============================================================================== 226s Omission: OpenSSL 1.1.x (and later) auto selects curve [test_no_ecdh_curve(TestSSLEcdhCurve)] 226s /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_ssl_ecdh_curve.rb:12:in `test_no_ecdh_curve' 226s =============================================================================== 226s : (0.066727) 226s TestSSLExtensions: 226s test_tlsext_sni_hostname_1_2: .: (0.019784) 226s test_tlsext_sni_hostname_1_3: .: (0.256451) 226s TestSSLInlineCert: 226s test_accept_client_encoded_key_inline_cert_from_file: .: (0.159321) 226s test_accept_client_encoded_key_inline_cert_inlince: .: (0.243905) 227s test_accept_client_key_from_file_cert_inline: .: (0.424200) 227s test_accept_client_key_inline_cert_from_file: .: (0.327959) 228s test_accept_client_key_inline_cert_inline: .: (0.380957) 228s test_accept_server_encoded_key_inline_cert_from_file: .: (0.030774) 228s test_accept_server_encoded_key_inline_cert_inlince: .: (0.193587) 228s test_accept_server_key_from_file_cert_inline: .: (0.333448) 228s test_accept_server_key_inline_cert_from_file: .: (0.167496) 228s test_accept_server_key_inline_cert_inline: .: (0.151089) 228s test_proper_key_required_for_client: .: (0.001894) 228s test_proper_key_required_for_server: .: (0.002810) 228s TestSSLMethods: 229s test_ssl_methods: .: (0.270913) 229s TestSSLProtocols: 229s test_any_to_any: .: (0.138222) 229s test_any_to_tlsv1_2: .: (0.115052) 229s test_any_to_v3: O 229s =============================================================================== 229s Omission: SSLv3 is (correctly) unavailable [test_any_to_v3(TestSSLProtocols)] 229s /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_ssl_protocols.rb:28:in `test_any_to_v3' 229s =============================================================================== 229s : (0.000645) 229s test_any_with_external_client_tlsv1_2: .: (0.300350) 230s test_any_with_external_client_tlsv1_3: .: (0.362266) 230s test_case_insensitivity: .: (0.369422) 230s test_default_to_default: .: (0.206418) 230s test_invalid_ssl_version: .: (0.000690) 230s test_tlsv1_2_required_with_external_client: 000003FFA8BF3740:error:0A0000F4:SSL routines:ssl3_read_bytes:unexpected message:../ssl/record/rec_layer_s3.c:853: 230s .: (0.191950) 231s test_tlsv1_2_to_any: .: (0.084447) 231s test_tlsv1_2_to_tlsv1_2: .: (0.211309) 231s test_tlsv1_2_with_external_client: .: (0.180057) 231s test_tlsv1_3_to_tlsv1_3: .: (0.104357) 232s test_tlsv1_3_with_external_client: .: (0.478669) 232s test_v3_to_any: O 232s =============================================================================== 232s Omission: SSLv3 is (correctly) unavailable [test_v3_to_any(TestSSLProtocols)] 232s /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_ssl_protocols.rb:53:in `test_v3_to_any' 232s =============================================================================== 232s : (0.000746) 232s test_v3_to_v3: O 232s =============================================================================== 232s Omission: SSLv3 is (correctly) unavailable [test_v3_to_v3(TestSSLProtocols)] 232s /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_ssl_protocols.rb:69:in `test_v3_to_v3' 232s =============================================================================== 232s : (0.000498) 232s test_v3_with_external_client: O 232s =============================================================================== 232s Omission: SSLv3 is (correctly) unavailable [test_v3_with_external_client(TestSSLProtocols)] 232s /tmp/autopkgtest.0pn0Bq/build.ewk/src/tests/test_ssl_protocols.rb:139:in `test_v3_with_external_client' 232s =============================================================================== 232s : (0.009747) 232s TestSSLVerify: 232s test_accept_client: .: (0.029843) 232s test_accept_server: .: (0.396934) 232s test_deny_client: 000003FFA8BF3740:error:0A000086:SSL routines:tls_post_process_server_certificate:certificate verify failed:../ssl/statem/statem_clnt.c:2123: 232s .: (0.299409) 232s test_deny_server: 000003FFA8BF3740:error:0A000086:SSL routines:tls_process_client_certificate:certificate verify failed:../ssl/statem/statem_srvr.c:3744: 232s .: (0.109880) 233s test_encoded_accept_client: .: (0.213892) 233s test_encoded_accept_server: .: (0.218311) 233s test_fail_no_peer_cert: 000003FFA8BF3740:error:0A0000C7:SSL routines:tls_process_client_certificate:peer did not return a certificate:../ssl/statem/statem_srvr.c:3731: 233s .: (0.077526) 233s TestSendFile: 233s test_send_file: .: (0.000791) 233s test_send_large_file: .: (0.000764) 233s test_stream_bad_file: .: (0.000269) 233s test_stream_chunked_file_data: .: (0.000293) 233s test_stream_file_data: .: (0.000256) 233s test_stream_large_chunked_file_data: /usr/lib/ruby/vendor_ruby/em/streamer.rb:70: warning: undefining the allocator of T_DATA class EventMachine::FastFileReader::Mapper 233s .: (0.000748) 233s test_stream_large_file_data: .: (0.000410) 233s TestServers: 233s test_stop_server: .: (0.241520) 233s TestShutdownHooks: 233s test_hook_order: .: (0.000211) 233s test_shutdown_hooks: .: (0.000056) 233s TestSmtpClient: 233s test_a: .: (0.000324) 233s test_content: .: (0.000129) 233s test_escaping: .: (0.000093) 233s TestSmtpServer: 233s test_mail: .: (0.000605) 233s test_multiple_messages_per_connection: .: (0.184578) 233s TestSockOpt: 233s test_get_sock_opt: .: (0.000779) 233s test_set_sock_opt: .: (0.000339) 233s TestSpawn: 233s test_another_fibonacci: .: (0.000392) 233s test_block_scope: .: (0.000108) 233s test_fibonacci: .: (0.000151) 233s test_fibonacci_chain: .: (0.000294) 233s test_multiparms: .: (0.000253) 233s test_parms: .: (0.000074) 233s test_ping_pong: .: (0.000109) 233s test_race: .: (0.000074) 233s test_resume: .: (0.000073) 233s test_run: .: (0.000070) 233s test_self_notify: .: (0.000087) 233s test_stop: .: (0.000070) 233s test_yield: .: (0.000096) 233s test_yield_and_notify: .: (0.000095) 233s TestStomp: 233s test_content_length_in_bytes: .: (0.000196) 233s TestSystem: 233s test_system: .: (0.007608) 233s test_system_with_string: .: (0.003438) 233s TestThreadedResource: 233s test_dispatch_completion: .: (0.003394) 233s test_dispatch_failure: .: (0.000222) 233s test_dispatch_threading: .: (0.000265) 233s test_shutdown: .: (0.000276) 233s TestTimers: 233s test_add_periodic_timer: .: (0.062212) 233s test_add_periodic_timer_cancel: .: (0.020505) 233s test_add_timer_increments_timer_count: .: (0.012395) 233s test_oneshot_timer_large_future_value: .: (0.020287) 233s test_periodic_timer: .: (0.070352) 234s test_periodic_timer_cancel: .: (0.080321) 234s test_periodic_timer_self_cancel: .: (0.000118) 234s test_timer_cancel: .: (0.020497) 234s test_timer_change_max_outstanding: .: (0.002171) 234s test_timer_run_decrements_timer_count: .: (0.012437) 234s test_timer_with_block: .: (0.062592) 234s test_timer_with_proc: .: (0.000114) 234s TestUserDefinedEvents: 234s test_a: .: (0.000139) 234s 234s Finished in 24.340230096 seconds. 234s ------------------------------------------------------------------------------- 234s 272 tests, 3603 assertions, 1 failures, 0 errors, 0 pendings, 5 omissions, 0 notifications 234s 99.6255% passed 234s ------------------------------------------------------------------------------- 234s 11.17 tests/s, 148.03 assertions/s 234s rake aborted! 234s Command failed with status (1): [ruby -w -I"tests" /usr/share/rubygems-integration/all/gems/rake-13.2.1/lib/rake/rake_test_loader.rb "tests/jruby/test_jeventmachine.rb" "tests/test_attach.rb" "tests/test_basic.rb" "tests/test_channel.rb" "tests/test_completion.rb" "tests/test_connection_count.rb" "tests/test_connection_write.rb" "tests/test_defer.rb" "tests/test_deferrable.rb" "tests/test_epoll.rb" "tests/test_error_handler.rb" "tests/test_file_watch.rb" "tests/test_fork.rb" "tests/test_futures.rb" "tests/test_handler_check.rb" "tests/test_hc.rb" "tests/test_io_streamer.rb" "tests/test_ipv4.rb" "tests/test_ipv6.rb" "tests/test_iterator.rb" "tests/test_keepalive.rb" "tests/test_line_protocol.rb" "tests/test_ltp.rb" "tests/test_ltp2.rb" "tests/test_many_fds.rb" "tests/test_next_tick.rb" "tests/test_object_protocol.rb" "tests/test_pause.rb" "tests/test_pool.rb" "tests/test_process_watch.rb" "tests/test_processes.rb" "tests/test_proxy_connection.rb" "tests/test_pure.rb" "tests/test_queue.rb" "tests/test_running.rb" "tests/test_sasl.rb" "tests/test_send_file.rb" "tests/test_servers.rb" "tests/test_shutdown_hooks.rb" "tests/test_smtpclient.rb" "tests/test_smtpserver.rb" "tests/test_sock_opt.rb" "tests/test_spawn.rb" "tests/test_ssl_args.rb" "tests/test_ssl_dhparam.rb" "tests/test_ssl_ecdh_curve.rb" "tests/test_ssl_extensions.rb" "tests/test_ssl_inline_cert.rb" "tests/test_ssl_methods.rb" "tests/test_ssl_protocols.rb" "tests/test_ssl_verify.rb" "tests/test_stomp.rb" "tests/test_system.rb" "tests/test_threaded_resource.rb" "tests/test_tick_loop.rb" "tests/test_timers.rb" "tests/test_ud.rb" -v] 234s /tmp/autopkgtest.0pn0Bq/build.ewk/src/debian/ruby-tests.rake:37:in `block in ' 234s /usr/share/rubygems-integration/all/gems/rake-13.2.1/exe/rake:27:in `' 234s Tasks: TOP => spec 234s (See full trace by running task with --trace) 234s mv ./.gem2deb.lib lib 234s mv ./.gem2deb.ext ext 235s autopkgtest [07:30:44]: test gem2deb-test-runner: -----------------------] 235s gem2deb-test-runner FAIL non-zero exit status 1 235s autopkgtest [07:30:44]: test gem2deb-test-runner: - - - - - - - - - - results - - - - - - - - - - 236s autopkgtest [07:30:45]: @@@@@@@@@@@@@@@@@@@@ summary 236s gem2deb-test-runner FAIL non-zero exit status 1