0s autopkgtest [22:11:33]: starting date and time: 2024-03-25 22:11:33+0000
  0s autopkgtest [22:11:33]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
  0s autopkgtest [22:11:33]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.u2gzsm4y/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed --apt-upgrade ruby-ethon --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=ruby-ethon/0.16.0-1ubuntu1 curl/8.5.0-2ubuntu8 libpsl/0.21.2-1.1 openssl/3.0.13-0ubuntu2 orthanc-python/4.1+ds-2build3' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos02-s390x-16.secgroup --name adt-noble-s390x-ruby-ethon-20240325-221133-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
 92s autopkgtest [22:13:05]: testbed dpkg architecture: s390x
 92s autopkgtest [22:13:05]: testbed apt version: 2.7.12
 92s autopkgtest [22:13:05]: @@@@@@@@@@@@@@@@@@@@ test bed setup
 93s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
 94s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3981 kB]
 94s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [497 kB]
 94s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [7608 B]
 94s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.0 kB]
 95s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [692 kB]
 95s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B]
 95s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B]
 95s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B]
 95s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [4136 kB]
 95s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B]
 95s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [47.8 kB]
 95s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B]
 97s Fetched 9546 kB in 3s (3039 kB/s)
 97s Reading package lists...
 99s Reading package lists...
100s Building dependency tree...
100s Reading state information...
100s Calculating upgrade...
100s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
100s Reading package lists...
100s Building dependency tree...
100s Reading state information...
100s 0 upgraded, 0 newly installed, 0 to remove and 242 not upgraded.
101s Unknown architecture, assuming PC-style ttyS0
101s sh: Attempting to set up Debian/Ubuntu apt sources automatically
101s sh: Distribution appears to be Ubuntu
102s Reading package lists...
102s Building dependency tree...
102s Reading state information...
102s eatmydata is already the newest version (131-1).
102s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
102s Reading package lists...
102s Building dependency tree...
102s Reading state information...
102s dbus is already the newest version (1.14.10-4ubuntu1).
102s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
102s Reading package lists...
102s Building dependency tree...
102s Reading state information...
103s rng-tools-debian is already the newest version (2.4).
103s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
103s Reading package lists...
103s Building dependency tree...
103s Reading state information...
103s The following packages will be REMOVED:
103s   cloud-init* python3-configobj* python3-debconf*
103s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded.
103s After this operation, 3256 kB disk space will be freed.
103s (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 ... 52170 files and directories currently installed.)
103s Removing cloud-init (24.1.2-0ubuntu1) ...
104s Removing python3-configobj (5.0.8-3) ...
104s Removing python3-debconf (1.5.86) ...
104s Processing triggers for man-db (2.12.0-3) ...
104s (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 ... 51781 files and directories currently installed.)
104s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ...
105s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed
105s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
105s invoke-rc.d: policy-rc.d denied execution of try-restart.
105s Reading package lists...
105s Building dependency tree...
105s Reading state information...
105s linux-generic is already the newest version (6.8.0-11.11+1).
105s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
106s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease
106s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease
106s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease
108s Reading package lists...
108s Reading package lists...
108s Building dependency tree...
108s Reading state information...
109s Calculating upgrade...
109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
109s Reading package lists...
109s Building dependency tree...
109s Reading state information...
109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
109s autopkgtest [22:13:22]: rebooting testbed after setup commands that affected boot
126s autopkgtest [22:13:39]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Tue Feb 13 23:45:46 UTC 2024
129s autopkgtest [22:13:42]: @@@@@@@@@@@@@@@@@@@@ apt-source ruby-ethon
130s Get:1 http://ftpmaster.internal/ubuntu noble/main ruby-ethon 0.16.0-1 (dsc) [2198 B]
130s Get:2 http://ftpmaster.internal/ubuntu noble/main ruby-ethon 0.16.0-1 (tar) [57.4 kB]
130s Get:3 http://ftpmaster.internal/ubuntu noble/main ruby-ethon 0.16.0-1 (diff) [3864 B]
130s gpgv: Signature made Mon Jan 16 16:41:18 2023 UTC
130s gpgv:                using RSA key 8ED6C3F8BAC9DB7FC130A870F823A2729883C97C
130s gpgv:                issuer "kanashiro@debian.org"
130s gpgv: Can't check signature: No public key
130s dpkg-source: warning: cannot verify inline signature for ./ruby-ethon_0.16.0-1.dsc: no acceptable signature found
131s autopkgtest [22:13:44]: testing package ruby-ethon version 0.16.0-1
131s autopkgtest [22:13:44]: build not needed
132s autopkgtest [22:13:45]: test gem2deb-test-runner: preparing testbed
133s Reading package lists...
133s Building dependency tree...
133s Reading state information...
134s Starting pkgProblemResolver with broken count: 0
134s Starting 2 pkgProblemResolver with broken count: 0
134s Done
134s The following additional packages will be installed:
134s   gem2deb-test-runner libruby libruby3.1 rake ruby ruby-diff-lcs ruby-ethon
134s   ruby-ffi ruby-mime-types ruby-mime-types-data ruby-mustermann
134s   ruby-net-telnet ruby-rack ruby-rack-protection ruby-rspec ruby-rspec-core
134s   ruby-rspec-expectations ruby-rspec-mocks ruby-rspec-support
134s   ruby-ruby2-keywords ruby-rubygems ruby-sdbm ruby-sinatra ruby-tilt
134s   ruby-webrick ruby-xmlrpc ruby3.1 rubygems-integration
134s Suggested packages:
134s   ri ruby-dev bundler
134s Recommended packages:
134s   zip fonts-lato libjs-jquery
134s The following NEW packages will be installed:
134s   autopkgtest-satdep gem2deb-test-runner libruby libruby3.1 rake ruby
134s   ruby-diff-lcs ruby-ethon ruby-ffi ruby-mime-types ruby-mime-types-data
134s   ruby-mustermann ruby-net-telnet ruby-rack ruby-rack-protection ruby-rspec
134s   ruby-rspec-core ruby-rspec-expectations ruby-rspec-mocks ruby-rspec-support
134s   ruby-ruby2-keywords ruby-rubygems ruby-sdbm ruby-sinatra ruby-tilt
134s   ruby-webrick ruby-xmlrpc ruby3.1 rubygems-integration
134s 0 upgraded, 29 newly installed, 0 to remove and 0 not upgraded.
134s Need to get 6683 kB/6684 kB of archives.
134s After this operation, 34.4 MB of additional disk space will be used.
134s Get:1 /tmp/autopkgtest.dGDP6o/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [788 B]
134s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x rubygems-integration all 1.18 [5336 B]
134s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x ruby-net-telnet all 0.2.0-1 [13.3 kB]
134s Get:4 http://ftpmaster.internal/ubuntu noble/main s390x ruby-webrick all 1.8.1-1 [52.3 kB]
134s Get:5 http://ftpmaster.internal/ubuntu noble/main s390x ruby-xmlrpc all 0.3.2-2 [24.8 kB]
134s Get:6 http://ftpmaster.internal/ubuntu noble/main s390x libruby s390x 1:3.1+1 [4640 B]
134s Get:7 http://ftpmaster.internal/ubuntu noble/main s390x ruby-sdbm s390x 1.0.0-5build3 [19.1 kB]
134s Get:8 http://ftpmaster.internal/ubuntu noble/main s390x libruby3.1 s390x 3.1.2-7ubuntu4 [5197 kB]
135s Get:9 http://ftpmaster.internal/ubuntu noble/main s390x ruby3.1 s390x 3.1.2-7ubuntu4 [49.1 kB]
135s Get:10 http://ftpmaster.internal/ubuntu noble/main s390x ruby-rubygems all 3.4.20-1 [238 kB]
135s Get:11 http://ftpmaster.internal/ubuntu noble/main s390x ruby s390x 1:3.1+1 [3466 B]
135s Get:12 http://ftpmaster.internal/ubuntu noble/main s390x rake all 13.0.6-3 [61.6 kB]
135s Get:13 http://ftpmaster.internal/ubuntu noble/universe s390x gem2deb-test-runner s390x 2.2.2 [18.2 kB]
135s Get:14 http://ftpmaster.internal/ubuntu noble/universe s390x ruby-diff-lcs all 1.5.1-1 [22.8 kB]
135s Get:15 http://ftpmaster.internal/ubuntu noble/main s390x ruby-ffi s390x 1.16.3+dfsg-1build1 [121 kB]
135s Get:16 http://ftpmaster.internal/ubuntu noble/main s390x ruby-mime-types-data all 3.2024.0206-1 [134 kB]
135s Get:17 http://ftpmaster.internal/ubuntu noble/main s390x ruby-mime-types all 3.5.2-1 [21.7 kB]
135s Get:18 http://ftpmaster.internal/ubuntu noble/main s390x ruby-ethon all 0.16.0-1 [36.4 kB]
135s Get:19 http://ftpmaster.internal/ubuntu noble/main s390x ruby-ruby2-keywords all 0.0.5-1 [4280 B]
135s Get:20 http://ftpmaster.internal/ubuntu noble/main s390x ruby-mustermann all 3.0.0-2 [38.3 kB]
135s Get:21 http://ftpmaster.internal/ubuntu noble/main s390x ruby-rack all 2.2.7-1 [114 kB]
135s Get:22 http://ftpmaster.internal/ubuntu noble/main s390x ruby-rack-protection all 3.0.5-3 [17.3 kB]
135s Get:23 http://ftpmaster.internal/ubuntu noble/universe s390x ruby-rspec-support all 3.13.0c0e0m0s1-2 [29.2 kB]
135s Get:24 http://ftpmaster.internal/ubuntu noble/universe s390x ruby-rspec-core all 3.13.0c0e0m0s1-2 [164 kB]
135s Get:25 http://ftpmaster.internal/ubuntu noble/universe s390x ruby-rspec-expectations all 3.13.0c0e0m0s1-2 [89.8 kB]
135s Get:26 http://ftpmaster.internal/ubuntu noble/universe s390x ruby-rspec-mocks all 3.13.0c0e0m0s1-2 [81.0 kB]
135s Get:27 http://ftpmaster.internal/ubuntu noble/universe s390x ruby-rspec all 3.13.0c0e0m0s1-2 [3500 B]
136s Get:28 http://ftpmaster.internal/ubuntu noble/main s390x ruby-tilt all 2.0.11-2 [26.0 kB]
136s Get:29 http://ftpmaster.internal/ubuntu noble/main s390x ruby-sinatra all 3.0.5-3 [93.2 kB]
136s Fetched 6683 kB in 2s (4258 kB/s)
136s Selecting previously unselected package rubygems-integration.
136s (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 ... 51726 files and directories currently installed.)
136s Preparing to unpack .../00-rubygems-integration_1.18_all.deb ...
136s Unpacking rubygems-integration (1.18) ...
136s Selecting previously unselected package ruby-net-telnet.
136s Preparing to unpack .../01-ruby-net-telnet_0.2.0-1_all.deb ...
136s Unpacking ruby-net-telnet (0.2.0-1) ...
136s Selecting previously unselected package ruby-webrick.
136s Preparing to unpack .../02-ruby-webrick_1.8.1-1_all.deb ...
136s Unpacking ruby-webrick (1.8.1-1) ...
136s Selecting previously unselected package ruby-xmlrpc.
136s Preparing to unpack .../03-ruby-xmlrpc_0.3.2-2_all.deb ...
136s Unpacking ruby-xmlrpc (0.3.2-2) ...
136s Selecting previously unselected package libruby:s390x.
136s Preparing to unpack .../04-libruby_1%3a3.1+1_s390x.deb ...
136s Unpacking libruby:s390x (1:3.1+1) ...
136s Selecting previously unselected package ruby-sdbm:s390x.
136s Preparing to unpack .../05-ruby-sdbm_1.0.0-5build3_s390x.deb ...
136s Unpacking ruby-sdbm:s390x (1.0.0-5build3) ...
136s Selecting previously unselected package libruby3.1:s390x.
136s Preparing to unpack .../06-libruby3.1_3.1.2-7ubuntu4_s390x.deb ...
136s Unpacking libruby3.1:s390x (3.1.2-7ubuntu4) ...
136s Selecting previously unselected package ruby3.1.
136s Preparing to unpack .../07-ruby3.1_3.1.2-7ubuntu4_s390x.deb ...
136s Unpacking ruby3.1 (3.1.2-7ubuntu4) ...
136s Selecting previously unselected package ruby-rubygems.
136s Preparing to unpack .../08-ruby-rubygems_3.4.20-1_all.deb ...
136s Unpacking ruby-rubygems (3.4.20-1) ...
136s Selecting previously unselected package ruby.
136s Preparing to unpack .../09-ruby_1%3a3.1+1_s390x.deb ...
136s Unpacking ruby (1:3.1+1) ...
136s Selecting previously unselected package rake.
136s Preparing to unpack .../10-rake_13.0.6-3_all.deb ...
136s Unpacking rake (13.0.6-3) ...
136s Selecting previously unselected package gem2deb-test-runner.
136s Preparing to unpack .../11-gem2deb-test-runner_2.2.2_s390x.deb ...
136s Unpacking gem2deb-test-runner (2.2.2) ...
136s Selecting previously unselected package ruby-diff-lcs.
136s Preparing to unpack .../12-ruby-diff-lcs_1.5.1-1_all.deb ...
136s Unpacking ruby-diff-lcs (1.5.1-1) ...
136s Selecting previously unselected package ruby-ffi:s390x.
136s Preparing to unpack .../13-ruby-ffi_1.16.3+dfsg-1build1_s390x.deb ...
136s Unpacking ruby-ffi:s390x (1.16.3+dfsg-1build1) ...
136s Selecting previously unselected package ruby-mime-types-data.
136s Preparing to unpack .../14-ruby-mime-types-data_3.2024.0206-1_all.deb ...
136s Unpacking ruby-mime-types-data (3.2024.0206-1) ...
137s Selecting previously unselected package ruby-mime-types.
137s Preparing to unpack .../15-ruby-mime-types_3.5.2-1_all.deb ...
137s Unpacking ruby-mime-types (3.5.2-1) ...
137s Selecting previously unselected package ruby-ethon.
137s Preparing to unpack .../16-ruby-ethon_0.16.0-1_all.deb ...
137s Unpacking ruby-ethon (0.16.0-1) ...
137s Selecting previously unselected package ruby-ruby2-keywords.
137s Preparing to unpack .../17-ruby-ruby2-keywords_0.0.5-1_all.deb ...
137s Unpacking ruby-ruby2-keywords (0.0.5-1) ...
137s Selecting previously unselected package ruby-mustermann.
137s Preparing to unpack .../18-ruby-mustermann_3.0.0-2_all.deb ...
137s Unpacking ruby-mustermann (3.0.0-2) ...
137s Selecting previously unselected package ruby-rack.
137s Preparing to unpack .../19-ruby-rack_2.2.7-1_all.deb ...
137s Unpacking ruby-rack (2.2.7-1) ...
137s Selecting previously unselected package ruby-rack-protection.
137s Preparing to unpack .../20-ruby-rack-protection_3.0.5-3_all.deb ...
137s Unpacking ruby-rack-protection (3.0.5-3) ...
137s Selecting previously unselected package ruby-rspec-support.
137s Preparing to unpack .../21-ruby-rspec-support_3.13.0c0e0m0s1-2_all.deb ...
137s Unpacking ruby-rspec-support (3.13.0c0e0m0s1-2) ...
137s Selecting previously unselected package ruby-rspec-core.
137s Preparing to unpack .../22-ruby-rspec-core_3.13.0c0e0m0s1-2_all.deb ...
137s Unpacking ruby-rspec-core (3.13.0c0e0m0s1-2) ...
137s Selecting previously unselected package ruby-rspec-expectations.
137s Preparing to unpack .../23-ruby-rspec-expectations_3.13.0c0e0m0s1-2_all.deb ...
137s Unpacking ruby-rspec-expectations (3.13.0c0e0m0s1-2) ...
137s Selecting previously unselected package ruby-rspec-mocks.
137s Preparing to unpack .../24-ruby-rspec-mocks_3.13.0c0e0m0s1-2_all.deb ...
137s Unpacking ruby-rspec-mocks (3.13.0c0e0m0s1-2) ...
137s Selecting previously unselected package ruby-rspec.
137s Preparing to unpack .../25-ruby-rspec_3.13.0c0e0m0s1-2_all.deb ...
137s Unpacking ruby-rspec (3.13.0c0e0m0s1-2) ...
137s Selecting previously unselected package ruby-tilt.
137s Preparing to unpack .../26-ruby-tilt_2.0.11-2_all.deb ...
137s Unpacking ruby-tilt (2.0.11-2) ...
137s Selecting previously unselected package ruby-sinatra.
137s Preparing to unpack .../27-ruby-sinatra_3.0.5-3_all.deb ...
137s Unpacking ruby-sinatra (3.0.5-3) ...
137s Selecting previously unselected package autopkgtest-satdep.
137s Preparing to unpack .../28-1-autopkgtest-satdep.deb ...
137s Unpacking autopkgtest-satdep (0) ...
137s Setting up ruby-ruby2-keywords (0.0.5-1) ...
137s Setting up ruby-mustermann (3.0.0-2) ...
137s Setting up rubygems-integration (1.18) ...
137s Setting up ruby-net-telnet (0.2.0-1) ...
137s Setting up ruby-rspec-support (3.13.0c0e0m0s1-2) ...
137s Setting up ruby-webrick (1.8.1-1) ...
137s Setting up ruby-mime-types-data (3.2024.0206-1) ...
137s Setting up ruby-xmlrpc (0.3.2-2) ...
137s Setting up ruby-mime-types (3.5.2-1) ...
137s Setting up libruby:s390x (1:3.1+1) ...
137s Setting up ruby-rubygems (3.4.20-1) ...
137s Setting up ruby (1:3.1+1) ...
137s Setting up rake (13.0.6-3) ...
137s Setting up ruby-rspec-core (3.13.0c0e0m0s1-2) ...
137s Setting up ruby-tilt (2.0.11-2) ...
137s Setting up ruby-sdbm:s390x (1.0.0-5build3) ...
137s Setting up ruby-diff-lcs (1.5.1-1) ...
137s Setting up libruby3.1:s390x (3.1.2-7ubuntu4) ...
137s Setting up ruby-rack (2.2.7-1) ...
137s Setting up gem2deb-test-runner (2.2.2) ...
137s Setting up ruby-rspec-expectations (3.13.0c0e0m0s1-2) ...
137s Setting up ruby-rspec-mocks (3.13.0c0e0m0s1-2) ...
137s Setting up ruby3.1 (3.1.2-7ubuntu4) ...
137s Setting up ruby-ffi:s390x (1.16.3+dfsg-1build1) ...
137s Setting up ruby-rack-protection (3.0.5-3) ...
137s Setting up ruby-rspec (3.13.0c0e0m0s1-2) ...
137s Setting up ruby-sinatra (3.0.5-3) ...
137s Setting up ruby-ethon (0.16.0-1) ...
137s Setting up autopkgtest-satdep (0) ...
137s Processing triggers for libc-bin (2.39-0ubuntu6) ...
137s Processing triggers for man-db (2.12.0-3) ...
140s (Reading database ... 55873 files and directories currently installed.)
140s Removing autopkgtest-satdep (0) ...
140s autopkgtest [22:13:53]: test gem2deb-test-runner: gem2deb-test-runner --autopkgtest --check-dependencies 2>&1
140s autopkgtest [22:13:53]: test gem2deb-test-runner: [-----------------------
141s 
141s ┌──────────────────────────────────────────────────────────────────────────────┐
141s │ Checking Rubygems dependency resolution on ruby3.1                           │
141s └──────────────────────────────────────────────────────────────────────────────┘
141s 
141s RUBYLIB=. GEM_PATH= ruby3.1 -e gem\ \"ethon\"
141s mv lib ./.gem2deb.lib
141s mv ./.gem2deb.lib lib
141s 
141s ┌──────────────────────────────────────────────────────────────────────────────┐
141s │ Run tests for ruby3.1 from debian/ruby-tests.rake                            │
141s └──────────────────────────────────────────────────────────────────────────────┘
141s 
141s RUBYLIB=. GEM_PATH= ruby3.1 -S rake --rakelibdir /gem2deb-nonexistent -f debian/ruby-tests.rake
141s mv lib ./.gem2deb.lib
141s /usr/bin/ruby3.1 -I/usr/share/rubygems-integration/all/gems/rspec-support-3.13.1/lib:/usr/share/rubygems-integration/all/gems/rspec-core-3.13.0/lib /usr/share/rubygems-integration/all/gems/rspec-core-3.13.0/exe/rspec --pattern ./spec/\*\*/\*_spec.rb --format documentation
142s 
142s Ethon::Curl
142s   .init
142s     when global_init fails
142s       raises global init error
142s     when global_init works
142s       doesn't raises global init error
142s       logs
142s     when global_cleanup is called
142s       logs
142s 
142s Ethon::Easy::Callbacks
142s   #set_callbacks
142s     sets write-, debug-, and headerfunction
142s     resets @response_body
142s     resets @response_headers
142s     resets @debug_info
142s   #progress_callback
142s     returns 0
142s   #body_write_callback
142s     when body returns not :abort
142s       returns number bigger than 0
142s     when body returns :abort
142s       returns -1 to indicate abort to libcurl
142s   #header_write_callback
142s     when header returns not :abort
142s       returns number bigger than 0
142s     when header returns :abort
142s       returns -1 to indicate abort to libcurl
142s 
142s Ethon::Easy::DebugInfo
142s   #debug_info
142s     when verbose is not set to true
142s       does not save any debug info after a request
142s     when verbose is set to true
142s Uses proxy env variable no_proxy == '127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'
142s Found bundle for host: 0x2aa10d7aaf0 [serially]
142s Can not multiplex, even if we wanted to
142s Re-using existing connection with host localhost
142s GET / HTTP/1.1
142s Host: localhost:3001
142s Accept: */*
142s 
142s HTTP/1.1 200 OK
142s Content-Type: text/html;charset=utf-8
142s Content-Length: 890
142s X-Xss-Protection: 1; mode=block
142s X-Content-Type-Options: nosniff
142s X-Frame-Options: SAMEORIGIN
142s Server: WEBrick/1.8.1 (Ruby/3.1.2/2022-04-12)
142s Date: Mon, 25 Mar 2024 22:13:53 GMT
142s Connection: Keep-Alive
142s 
142s Connection #0 to host localhost left intact
142s       saves debug info after a request
142s Uses proxy env variable no_proxy == '127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'
142s Found bundle for host: 0x2aa10276e30 [serially]
142s Can not multiplex, even if we wanted to
142s Re-using existing connection with host localhost
142s GET / HTTP/1.1
142s Host: localhost:3001
142s Accept: */*
142s 
142s HTTP/1.1 200 OK
142s Content-Type: text/html;charset=utf-8
142s Content-Length: 890
142s X-Xss-Protection: 1; mode=block
142s X-Content-Type-Options: nosniff
142s X-Frame-Options: SAMEORIGIN
142s Server: WEBrick/1.8.1 (Ruby/3.1.2/2022-04-12)
142s Date: Mon, 25 Mar 2024 22:13:53 GMT
142s Connection: Keep-Alive
142s 
142s Connection #0 to host localhost left intact
142s       saves request headers
142s Uses proxy env variable no_proxy == '127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'
142s Found bundle for host: 0x2aa1027f3a0 [serially]
142s Can not multiplex, even if we wanted to
142s Re-using existing connection with host localhost
142s GET / HTTP/1.1
142s Host: localhost:3001
142s Accept: */*
142s 
142s HTTP/1.1 200 OK
142s Content-Type: text/html;charset=utf-8
142s Content-Length: 890
142s X-Xss-Protection: 1; mode=block
142s X-Content-Type-Options: nosniff
142s X-Frame-Options: SAMEORIGIN
142s Server: WEBrick/1.8.1 (Ruby/3.1.2/2022-04-12)
142s Date: Mon, 25 Mar 2024 22:13:53 GMT
142s Connection: Keep-Alive
142s 
142s Connection #0 to host localhost left intact
142s       saves response headers
142s Uses proxy env variable no_proxy == '127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'
142s Found bundle for host: 0x2aa10e1ae20 [serially]
142s Can not multiplex, even if we wanted to
142s Re-using existing connection with host localhost
142s GET / HTTP/1.1
142s Host: localhost:3001
142s Accept: */*
142s 
142s HTTP/1.1 200 OK
142s Content-Type: text/html;charset=utf-8
142s Content-Length: 890
142s X-Xss-Protection: 1; mode=block
142s X-Content-Type-Options: nosniff
142s X-Frame-Options: SAMEORIGIN
142s Server: WEBrick/1.8.1 (Ruby/3.1.2/2022-04-12)
142s Date: Mon, 25 Mar 2024 22:13:53 GMT
142s Connection: Keep-Alive
142s 
142s Connection #0 to host localhost left intact
142s       saves incoming data
142s Uses proxy env variable no_proxy == '127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'
142s Found bundle for host: 0x2aa10e9bef0 [serially]
142s Can not multiplex, even if we wanted to
142s Re-using existing connection with host localhost
142s GET / HTTP/1.1
142s Host: localhost:3001
142s Accept: */*
142s 
142s HTTP/1.1 200 OK
142s Content-Type: text/html;charset=utf-8
142s Content-Length: 890
142s X-Xss-Protection: 1; mode=block
142s X-Content-Type-Options: nosniff
142s X-Frame-Options: SAMEORIGIN
142s Server: WEBrick/1.8.1 (Ruby/3.1.2/2022-04-12)
142s Date: Mon, 25 Mar 2024 22:13:53 GMT
142s Connection: Keep-Alive
142s 
142s Connection #0 to host localhost left intact
142s       saves debug text
142s 
142s Ethon::Easy::Informations
142s   #supports_asynch_dns?
142s     returns boolean
142s   #supports_zlib?
142s     returns boolean
142s   #supports_timeout_ms?
142s     returns boolean
142s 
142s Ethon::Easy::Form
142s   .new
142s     assigns attribute to @params
142s   #first
142s     returns a pointer
142s   #last
142s     returns a pointer
142s   #multipart?
142s     when query_pairs contains string values
142s       returns false
142s     when query_pairs contains file
142s       returns true
142s     when options contains multipart=true
142s       returns true
142s   #materialize
142s     when query_pairs contains string values
142s       adds params to form
142s     when query_pairs contains nil
142s       adds params to form
142s     when query_pairs contains file
142s       adds file to form
142s     when query_pairs contains file and string values
142s       adds file to form
142s     when query_pairs contains file, string and int values
142s       adds file to form
142s 
142s Ethon::Easy::Header
142s   #headers=
142s     sets header
142s     when requesting
142s       sends
142s       when header value contains null byte
142s         escapes
142s       when header value has leading whitespace
142s         removes
142s       when header value has traiing whitespace
142s         removes
142s   #compose_header
142s     has space in between
142s     when value is a symbol
142s       works
142s   #header_list
142s     when no set_headers
142s       returns nil
142s     when set_headers
142s       returns pointer to header list
142s 
142s Ethon::Easy::Http::Custom
142s   #setup
142s     when nothing
142s       sets url
142s       makes a custom request
142s     when params
142s       attaches escaped to url
142s       when requesting
142s         is a custom verb
142s         does not use application/x-www-form-urlencoded content type
142s         requests parameterized url
142s     when body
142s       when multipart
142s         sets httppost
142s         when requesting
142s           returns ok
142s           is a custom verb
142s           uses multipart/form-data content type
142s           submits a body
142s           submits the data
142s       when not multipart
142s         sets escaped copypostfields
142s         sets postfieldsize
142s         when requesting
142s           returns ok
142s           is a custom verb
142s           uses multipart/form-data content type
142s           submits a body
142s           submits the data
142s       when string
142s         when requesting
142s           returns ok
142s           sends string
142s     when params and body
142s       when requesting
142s         url contains params
142s         body contains form
142s 
142s Ethon::Easy::Http::Delete
142s   when requesting
142s     makes a delete request
142s 
142s Ethon::Easy::Http::Get
142s   #setup
142s     sets url
142s     when body
142s       sets customrequest
142s     when no body
142s       doesn't set customrequest
142s     when requesting
142s       when url already contains params
142s         returns ok
142s         is a get request
142s         requests parameterized url
142s       when params and no body
142s         returns ok
142s         is a get request
142s         requests parameterized url
142s       when params and body
142s         returns ok
142s         is a get request
142s         requests parameterized url
142s       with :escape
142s         missing
142s           escapes values
142s         nil
142s           escapes values
142s         true
142s           escapes values
142s         false
142s           sends raw values
142s 
142s Ethon::Easy::Http::Head
142s   #setup
142s     when nothing
142s       sets nobody
142s       sets url
142s     when params
142s       sets nobody
142s       attaches escaped to url
142s       when requesting
142s         returns ok
142s         has no body
142s         requests parameterized url
142s         when url already contains params
142s           requests parameterized url
142s     when body
142s       when requesting
142s         returns ok
142s 
142s Ethon::Easy::Http::Options
142s   #setup
142s     sets customrequest
142s     sets url
142s     when requesting
142s       returns ok
142s       is a options request
142s       requests parameterized url
142s       when url already contains params
142s         requests parameterized url
142s 
142s Ethon::Easy::Http::Patch
142s   #setup
142s     sets customrequest
142s     sets url
142s     when requesting
142s       returns ok
142s       is a patch request
142s       requests parameterized url
142s       when url already contains params
142s         requests parameterized url
142s 
142s Ethon::Easy::Http::Post
142s   #setup
142s     when nothing
142s       sets url
142s       sets postfield_size
142s       sets copy_postfields
142s       makes a post request
142s     when params
142s       attaches escaped to url
142s       sets postfieldsize
142s       sets copypostfields
142s       with arrays
142s         by default
142s           encodes them with indexes
142s         when params_encoding is :rack
142s           encodes them without indexes
142s       with :escape
142s         missing
142s           escapes values
142s         nil
142s           escapes values
142s         true
142s           escapes values
142s         false
142s           sends raw values
142s       when requesting
142s         is a post
142s         uses application/x-www-form-urlencoded content type
142s         requests parameterized url
142s         when redirection
142s           when no postredirs
142s             is a get
142s           when postredirs
142s             is a post
142s     when body
142s       when multipart
142s         sets httppost
142s         when requesting
142s           returns ok
142s           is a post
142s           uses multipart/form-data content type
142s           submits a body
142s           submits the data
142s       when not multipart
142s         sets escaped copypostfields
142s         sets postfieldsize
142s         when requesting
142s           returns ok
142s           is a post
142s           uses multipart/form-data content type
142s           submits a body
142s           submits the data
142s       when string
142s         when requesting
142s           returns ok
142s           sends string
142s       when binary with null bytes
142s         when requesting
142s           returns ok
142s           sends binary data
142s       when arrays
142s         by default
142s           sets copypostfields with indexed, escaped representation
142s         when params_encoding is :rack
142s           sets copypostfields with non-indexed, escaped representation
142s     when params and body
142s       when requesting
142s         url contains params
142s         body contains form
142s 
142s Ethon::Easy::Http::Put
142s   #setup
142s     when nothing
142s       sets url
142s       sets upload
142s       sets infilesize
142s       when requesting
142s         makes a put request
142s     when params
142s       attaches escaped to url
142s       sets upload
142s       sets infilesize
142s       with arrays
142s         by default
142s           encodes them with indexes
142s         when params_encoding is :rack
142s           encodes them without indexes
142s       when requesting
142s         makes a put request
142s     when body
142s       sets infilesize
142s       sets readfunction
142s       sets upload
142s       when requesting
142s         sending string body
142s           makes a put request
142s           submits a body
142s         when injecting a file as body
142s           submits file
142s       when arrays
142s         by default
142s           submits an indexed, escaped representation
142s         when params_encoding is :rack
142s           submits an non-indexed, escaped representation
142s 
142s Ethon::Easy::Http
142s   #http_request
142s     instanciates action
142s     when requesting
142s       returns ok
142s       makes a GET request
142s       streams the response body from the GET request
142s       notifies when headers are ready
142s       returns ok
142s       makes a POST request
142s       streams the response body from the POST request
142s       notifies when headers are ready
142s       returns ok
142s       makes a PUT request
142s       streams the response body from the PUT request
142s       notifies when headers are ready
142s       returns ok
142s       makes a DELETE request
142s       streams the response body from the DELETE request
142s       notifies when headers are ready
142s       returns ok
142s       returns ok
142s       makes a PATCH request
142s       streams the response body from the PATCH request
142s       notifies when headers are ready
142s       returns ok
142s       makes a OPTIONS request
142s       streams the response body from the OPTIONS request
142s       notifies when headers are ready
142s       makes requests with custom HTTP verbs
142s 
142s Ethon::Easy::Informations
142s   #httpauth_avail
142s     returns
142s   #total_time
142s     returns float
142s   #starttransfer_time
142s     returns float
142s   #appconnect_time
142s     returns float
142s   #pretransfer_time
142s     returns float
142s   #connect_time
142s     returns float
142s   #namelookup_time
142s     returns float
142s   #redirect_time
142s     returns float
142s   #effective_url
142s     returns url
142s   #primary_ip
142s     returns localhost
142s   #response_code
142s     returns 200
142s   #redirect_count
142s     returns 0
142s   #redirect_url
142s     returns nil as there is no redirect
142s   #request_size
142s     returns 53
142s   #supports_zlib?
142s     returns true
142s   #size_upload
142s     returns float
142s   #size_download
142s     returns float
142s   #speed_upload
142s     returns float
142s   #speed_download
142s     returns float
142s 
142s Ethon::Easy::Mirror
142s   ::INFORMATIONS_TO_LOG
142s     contains return_code
142s     contains response_code
142s     contains response_body
142s     contains response_headers
142s     contains total_time
142s     contains starttransfer_time
142s     contains appconnect_time
142s     contains pretransfer_time
142s     contains connect_time
142s     contains namelookup_time
142s     contains redirect_time
142s     contains size_upload
142s     contains size_download
142s     contains speed_upload
142s     contains speed_upload
142s     contains effective_url
142s     contains primary_ip
142s     contains redirect_count
142s     contains redirect_url
142s     contains debug_info
142s   #to_hash
142s     returns mirror as hash
142s   #log_informations
142s     returns hash
142s     only calls methods that exist
142s     includes return code
142s 
142s Ethon::Easy::Operations
142s   #handle
142s     returns a pointer
142s   #perform
142s D, [2024-03-25T22:13:54.204680 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
142s D, [2024-03-25T22:13:54.204971 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
142s     calls Curl.easy_perform
142s D, [2024-03-25T22:13:54.205309 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
142s     calls Curl.easy_cleanup
142s D, [2024-03-25T22:13:54.205911 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
142s     logs
142s D, [2024-03-25T22:13:54.206604 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
142s D, [2024-03-25T22:13:54.206880 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
142s     doesn't log after completing because completing could reset
142s     when url
142s D, [2024-03-25T22:13:54.208526 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.001148
142s       returns ok
142s D, [2024-03-25T22:13:54.209819 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000876
142s       sets response body
142s D, [2024-03-25T22:13:54.210767 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000554
142s       sets response headers
142s       when request timed out
143s D, [2024-03-25T22:13:55.213146 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/?delay=1 response_code=0 return_code=operation_timedout total_time=1.001503
143s         returns operation_timedout
143s       when connection timed out
143s D, [2024-03-25T22:13:55.214911 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3009/ response_code=0 return_code=couldnt_connect total_time=0.000149
143s         returns couldnt_connect
143s       when no follow location
143s D, [2024-03-25T22:13:55.216406 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/redirect response_code=302 return_code=ok total_time=0.000995
143s         doesn't follow
143s       when follow location
143s D, [2024-03-25T22:13:55.263844 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.046384
143s         follows
143s         when infinite redirect loop
143s           when max redirect set
143s D, [2024-03-25T22:13:55.267924 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/bad_redirect response_code=302 return_code=too_many_redirects total_time=0.003499
143s             follows only x times
143s       when user agent
143s D, [2024-03-25T22:13:55.269273 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000918
143s         sets
143s     when auth url
143s       when basic auth
143s         when no user_pwd
143s D, [2024-03-25T22:13:55.279377 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/auth_basic/username/password response_code=401 return_code=ok total_time=0.003471
143s           returns 401
143s         when invalid user_pwd
143s D, [2024-03-25T22:13:55.280709 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/auth_basic/username/password response_code=401 return_code=ok total_time=0.00063
143s           returns 401
143s         when valid user_pwd
143s D, [2024-03-25T22:13:55.282078 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/auth_basic/username/password response_code=200 return_code=ok total_time=0.000918
143s           returns 200
143s         when user and password
143s D, [2024-03-25T22:13:55.283086 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/auth_basic/username/password response_code=200 return_code=ok total_time=0.000551
143s           returns 200
143s       when ntlm
143s         when no user_pwd
143s D, [2024-03-25T22:13:55.284403 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/auth_ntlm response_code=401 return_code=ok total_time=0.000529
143s           returns 401
143s         when user_pwd
143s D, [2024-03-25T22:13:55.285613 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/auth_ntlm response_code=200 return_code=ok total_time=0.000516
143s           returns 200
143s     when protocols
143s       when asking for a allowed url
143s D, [2024-03-25T22:13:55.286745 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000544
143s         returns ok
143s       when asking for a not allowed url
143s D, [2024-03-25T22:13:55.287186 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=0 return_code=unsupported_protocol total_time=0.0
143s         returns unsupported_protocol
143s     when multiple protocols
143s       when asking for a allowed url
143s         when http
143s D, [2024-03-25T22:13:55.288545 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.0006
143s           returns ok for http
143s         when https
143s D, [2024-03-25T22:13:55.327974 #1452] DEBUG -- : ETHON: performed EASY effective_url=https://localhost:3001/ response_code=0 return_code=ssl_connect_error total_time=0.038313
143s           returns ssl_connect_error for https
143s       when asking for a not allowed url
143s D, [2024-03-25T22:13:55.329046 #1452] DEBUG -- : ETHON: performed EASY effective_url=ssh://localhost/ response_code=0 return_code=unsupported_protocol total_time=0.0
143s         returns unsupported_protocol
143s     when redir_protocols
143s       when redirecting to a not allowed url
143s D, [2024-03-25T22:13:55.330276 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=302 return_code=unsupported_protocol total_time=0.000613
143s         returns unsupported_protocol
143s     when no url
143s D, [2024-03-25T22:13:55.330744 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
143s D, [2024-03-25T22:13:55.330809 #1452] DEBUG -- : ETHON: performed EASY effective_url= response_code=0 return_code=url_malformat total_time=0.0
143s       returns url_malformat
143s 
143s Ethon::Easy::Options
143s   accept_encoding=
143s     responds_to
143s     sets option
143s   cainfo=
143s     responds_to
143s     sets option
143s   capath=
143s     responds_to
143s     sets option
143s   connecttimeout=
143s     responds_to
143s     sets option
143s   connecttimeout_ms=
143s     responds_to
143s     sets option
143s   cookie=
143s     responds_to
143s     sets option
143s   cookiejar=
143s     responds_to
143s     sets option
143s   cookiefile=
143s     responds_to
143s     sets option
143s   copypostfields=
143s     responds_to
143s     sets option
143s   customrequest=
143s     responds_to
143s     sets option
143s   dns_cache_timeout=
143s     responds_to
143s     sets option
143s   followlocation=
143s     responds_to
143s     sets option
143s   forbid_reuse=
143s     responds_to
143s     sets option
143s   http_version=
143s     responds_to
143s     sets option
143s   httpauth=
143s     responds_to
143s     sets option
143s   httpget=
143s     responds_to
143s     sets option
143s   httppost=
143s     responds_to
143s     sets option
143s   infilesize=
143s     responds_to
143s     sets option
143s   interface=
143s     responds_to
143s     sets option
143s   keypasswd=
143s     responds_to
143s     sets option
143s   maxredirs=
143s     responds_to
143s     sets option
143s   nobody=
143s     responds_to
143s     sets option
143s   nosignal=
143s     responds_to
143s     sets option
143s   postfieldsize=
143s     responds_to
143s     sets option
143s   postredir=
143s     responds_to
143s     sets option
143s   protocols=
143s     responds_to
143s     sets option
143s   proxy=
143s     responds_to
143s     sets option
143s   proxyauth=
143s     responds_to
143s     sets option
143s   proxyport=
143s     responds_to
143s     sets option
143s   proxytype=
143s     responds_to
143s     sets option
143s   proxyuserpwd=
143s     responds_to
143s     sets option
143s   readdata=
143s     responds_to
143s     sets option
143s   readfunction=
143s     responds_to
143s     sets option
143s   redir_protocols=
143s     responds_to
143s     sets option
143s   ssl_verifyhost=
143s     responds_to
143s     sets option
143s   ssl_verifypeer=
143s     responds_to
143s     sets option
143s   sslcert=
143s     responds_to
143s     sets option
143s   sslcerttype=
143s     responds_to
143s     sets option
143s   sslkey=
143s     responds_to
143s     sets option
143s   sslkeytype=
143s     responds_to
143s     sets option
143s   sslversion=
143s     responds_to
143s     sets option
143s   timeout=
143s     responds_to
143s     sets option
143s   timeout_ms=
143s     responds_to
143s     sets option
143s   unrestricted_auth=
143s     responds_to
143s     sets option
143s   upload=
143s     responds_to
143s     sets option
143s   url=
143s     responds_to
143s     sets option
143s   useragent=
143s     responds_to
143s     sets option
143s   userpwd=
143s     responds_to
143s     sets option
143s   verbose=
143s     responds_to
143s     sets option
143s   pipewait=
143s     responds_to
143s     sets option
143s   dns_shuffle_addresses=
143s     responds_to
143s     sets option
143s   path_as_is=
143s     responds_to
143s     sets option
143s   #escape?
143s     by default
143s       returns true
143s     when #escape=nil
143s       returns true
143s     when #escape=true
143s       returns true
143s     when #escape=false
143s       returns true
143s   #multipart?
143s     by default
143s       returns false
143s     when #multipart=nil
143s       returns false
143s     when #multipart=true
143s       returns true
143s     when #multipart=false
143s       returns false
143s   #httppost=
143s     raises unless given a FFI::Pointer
143s   when requesting
143s     when userpwd
143s       when contains /
143s D, [2024-03-25T22:13:55.372659 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/auth_basic/test/te%2Fst response_code=200 return_code=ok total_time=0.000785
143s         works
143s     when timeout
143s       when request takes longer
144s D, [2024-03-25T22:13:56.375696 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/?delay=2 response_code=0 return_code=operation_timedout total_time=1.002261
144s         times out
144s     when connecttimeout
144s       when cannot connect
144s D, [2024-03-25T22:13:56.377360 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3002/ response_code=0 return_code=couldnt_connect total_time=0.000171
144s         times out
144s     when timeout_ms
144s       when request takes longer
145s D, [2024-03-25T22:13:56.478389 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/?delay=1 response_code=0 return_code=operation_timedout total_time=0.100514
145s         times out
145s     when connecttimeout_ms
145s       when cannot connect
145s D, [2024-03-25T22:13:56.479334 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3002/ response_code=0 return_code=couldnt_connect total_time=9.8e-05
145s         times out
145s 
145s Ethon::Easy::Queryable
145s   #to_s
145s     when query_pairs empty
145s       returns empty string
145s     when query_pairs not empty
145s       when escape
145s         turns "!" into %21
145s         turns "*" into %2A
145s         turns "'" into %27
145s         turns "(" into %28
145s         turns ")" into %29
145s         turns ";" into %3B
145s         turns ":" into %3A
145s         turns "@" into %40
145s         turns "&" into %26
145s         turns "=" into %3D
145s         turns "+" into %2B
145s         turns "$" into %24
145s         turns "," into %2C
145s         turns "/" into %2F
145s         turns "?" into %3F
145s         turns "#" into %23
145s         turns "[" into %5B
145s         turns "]" into %5D
145s         turns "<" into %3C
145s         turns ">" into %3E
145s         turns "\"" into %22
145s         turns "{" into %7B
145s         turns "}" into %7D
145s         turns "|" into %7C
145s         turns "\\" into %5C
145s         turns "`" into %60
145s         turns "^" into %5E
145s         turns "%" into %25
145s         turns " " into %20
145s         turns "\u0000" into %00
145s         turns "まつもと" into %E3%81%BE%E3%81%A4%E3%82%82%E3%81%A8
145s         leaves "." instead of turning into %2E
145s         leaves "-" instead of turning into %2D
145s         leaves "_" instead of turning into %5F
145s         leaves "~" instead of turning into %7E
145s       when no escape
145s         returns concatenated query string
145s     when query_pairs contains a string
145s       returns correct string
145s   #build_query_pairs
145s     when params is empty
145s       returns empty array
145s     when params is string
145s       wraps it in an array
145s     when params is simple hash
145s       transforms
145s     when params is a nested hash
145s       transforms
145s     when params contains an array
145s       by default
145s         transforms
145s       when params_encoding is :rack
145s         transforms without indexes
145s       when params_encoding is :none
145s         does no transformation
145s     when params contains something nested in an array
145s       when string
145s         transforms
145s       when hash
145s         transforms
145s       when file
145s         transforms
145s         when MIME
145s           when mime type
145s             sets mime type to text
145s           when no mime type
145s             sets mime type to default application/octet-stream
145s         when no MIME
145s           sets mime type to default application/octet-stream
145s     when params contains file
145s       transforms
145s     when params key contains a null byte
145s       preserves
145s     when params value contains a null byte
145s       preserves
145s   #empty?
145s     when params empty
145s       returns true
145s     when params not empty
145s       returns false
145s 
145s Ethon::Easy::ResponseCallbacks
145s   #on_complete
145s     responds
145s     when no block given
145s       returns @on_complete
145s     when block given
145s       stores
145s     when multiple blocks given
145s       stores
145s   #on_headers
145s     responds
145s     when no block given
145s       returns @on_headers
145s     when block given
145s       stores
145s     when multiple blocks given
145s       stores
145s   #on_body
145s     responds
145s     when no block given
145s       returns @on_body
145s     when block given
145s       stores
145s     when multiple blocks given
145s       stores
145s   #on_progress
145s     responds
145s     when no block given
145s       returns @on_progress
145s     when block given
145s       stores
145s     when multiple blocks given
145s       stores
145s   #complete
145s     executes blocks and passes self
145s     when @on_complete nil
145s       doesn't raise
145s   #headers
145s     executes blocks and passes self
145s     when @on_headers nil
145s       doesn't raise
145s   #progress
145s     when requesting for realz
145s D, [2024-03-25T22:13:56.506484 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.001197
145s       executes callback
145s     when pretending
145s       executes blocks and passes dltotal
145s       executes blocks and passes dlnow
145s       executes blocks and passes ultotal
145s       executes blocks and passes ulnow
145s       when @on_progress nil
145s         doesn't raise
145s   #body
145s     executes blocks and passes self
145s     executes blocks and passes chunk
145s     when @on_body nil
145s       doesn't raise
145s 
145s Ethon::Easy::Util
145s   escape_zero_byte
145s     when value has no zero byte
145s       returns same value
145s     when value has zero byte
145s       returns escaped
145s 
145s Ethon::Easy
145s   .new
145s     inits curl
145s     when options are empty
145s       sets only callbacks
145s     when options not empty
145s       when followlocation is set
145s         sets followlocation
145s   #set_attributes
145s     when options are empty
145s       sets only callbacks
145s     when options aren't empty
145s       when valid key
145s         sets
145s       when invalid key
145s         raises invalid option error
145s   #reset
145s     resets url
145s     resets escape?
145s     resets hash
145s     resets easy handle
145s     resets on_complete
145s     resets on_headers
145s     resets on_body
145s   #dup
145s     sets a new handle
145s     preserves url
145s     preserves on_complete callback
145s     preserves on_headers callback
145s D, [2024-03-25T22:13:56.524097 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.001341
145s D, [2024-03-25T22:13:56.573991 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.001341
145s     preserves body_write_callback of original handle
145s     preserves on_progress callback
145s D, [2024-03-25T22:13:56.575931 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000904
145s D, [2024-03-25T22:13:56.623851 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000904
145s     sets new body_write_callback of duplicated handle
145s D, [2024-03-25T22:13:56.625672 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.001022
145s D, [2024-03-25T22:13:56.673841 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.001022
145s     preserves headers_write_callback of original handle
145s D, [2024-03-25T22:13:56.675358 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000824
145s D, [2024-03-25T22:13:56.723864 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000824
145s     sets new headers_write_callback of duplicated handle
145s     resets response_body
145s     resets response_headers
145s D, [2024-03-25T22:13:56.726405 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000943
145s     sets response_body for duplicated Easy
145s D, [2024-03-25T22:13:56.727785 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000727
145s     sets response_headers for duplicated Easy
145s D, [2024-03-25T22:13:56.728945 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000754
145s     preserves response_body for original Easy
145s D, [2024-03-25T22:13:56.730209 #1452] DEBUG -- : ETHON: performed EASY effective_url=http://localhost:3001/ response_code=200 return_code=ok total_time=0.000835
145s     preserves response_headers for original Easy
145s   #mirror
145s     returns a Mirror
145s     builds from easy
145s   #log_inspect
145s     contains url
145s     contains response_code
145s     contains return_code
145s     contains total_time
145s 
145s Ethon::Libc
145s   #getdtablesize
145s     returns an integer
145s     returns bigger zero
145s 
145s Ethon::Loggable
145s   #logger=
145s     sets the logger
145s 
145s Ethon::Multi::Operations
145s   #handle
145s     returns a pointer
145s   #running_count
145s     when hydra has no easy
145s       returns nil
145s     when hydra has easy
145s       returns 1
145s     when hydra has more easys
145s       returns 2
145s   #get_timeout
145s     when code ok
145s       doesn't raise
145s       when timeout smaller zero
145s         returns 1
145s       when timeout bigger or equal zero
145s         returns timeout
145s     when code not ok
145s       raises MultiTimeout error
145s   #set_fds
145s     when code ok
145s       doesn't raise
145s       when max_fd -1
145s         waits 100ms
145s       when max_fd not -1
145s         when code smaller zero
145s           raises Select error
145s         when code bigger or equal zero
145s           doesn't raise
145s     when code not ok
145s       raises MultiFdset error
145s   #perform
145s     when no easy handles
145s       returns nil
145s       logs
145s     when easy handle
145s       requests
145s       sets easy
145s     when four easy handles
145s       sets response codes
145s   #ongoing?
145s     when easy_handles
145s       when running_count not greater 0
145s         returns true
145s       when running_count greater 0
145s         returns true
145s     when no easy_handles
145s       when running_count not greater 0
145s         returns false
145s       when running_count greater 0
145s         returns true
145s   #init_vars
145s     sets @timeout
145s     sets @timeval
145s     sets @fd_read
145s     sets @fd_write
145s     sets @fd_excep
145s     sets @max_fd
145s   #reset_fds
145s     resets @fd_read
145s     resets @fd_write
145s     resets @fd_excep
145s   #check
145s     example at ./spec/ethon/multi/operations_spec.rb:274 (PENDING: untested)
145s   #run
145s     example at ./spec/ethon/multi/operations_spec.rb:278 (PENDING: untested)
145s   #trigger
145s     calls multi perform
145s     sets running count
145s     returns multi perform code
145s 
145s Ethon::Multi::Options
145s   maxconnects=
145s     responds_to
145s     sets option
145s   pipelining=
145s     responds_to
145s     sets option
145s   socketdata=
145s     responds_to
145s     sets option
145s   socketfunction=
145s     responds_to
145s     sets option
145s   timerdata=
145s     responds_to
145s     sets option
145s   timerfunction=
145s     responds_to
145s     sets option
145s   max_total_connections=
145s     responds_to
145s     sets option
145s   socket_action mode
145s     #socketfunction callbacks
145s       allows multi_code return values
145s       allows integer return values (compatibility)
145s       errors on invalid return codes
145s     #timerfunction callbacks
145s       allows multi_code return values
145s       allows integer return values (compatibility)
145s       errors on invalid return codes
145s   #value_for
145s     when option in bool
145s       when value true
145s         returns 1
145s       when value false
145s         returns 0
145s     when value in int
145s       returns value casted to int
145s     when value in unspecific_options
145s       when value a string
145s         returns zero byte escaped string
145s       when value not a string
145s         returns value
145s 
145s Ethon::Multi::Stack
145s   #add
145s     when easy already added
145s       returns nil
145s     when easy new
145s       adds easy to multi
145s       adds easy to easy_handles
145s     when multi_add_handle fails
145s       raises multi add error
145s     when multi cleaned up before
145s       raises multi add error
145s   #delete
145s     when easy in easy_handles
145s       deletes easy from multi
145s       deletes easy from easy_handles
145s     when easy is not in easy_handles
145s       does nothing
145s       adds easy to easy_handles
145s     when multi_remove_handle fails
145s       raises multi remove error
145s 
145s Ethon::Multi
145s   .new
145s     inits curl
145s     with default options
145s       allows running #perform with the default execution_mode
145s       refuses to run #socket_action
145s     when options not empty
145s       when pipelining is set
145s         sets pipelining
145s       when execution_mode option is :socket_action
145s         refuses to run #perform
145s         allows running #socket_action
145s   #socket_action
145s     supports an end-to-end request
146s     supports multiple concurrent requests
146s 
146s Pending: (Failures listed here are expected and do not affect your suite's status)
146s 
146s   1) Ethon::Multi::Operations#check 
146s      # untested
146s      # ./spec/ethon/multi/operations_spec.rb:274
146s 
146s   2) Ethon::Multi::Operations#run 
146s      # untested
146s      # ./spec/ethon/multi/operations_spec.rb:278
146s 
146s 
146s Finished in 4.24 seconds (files took 0.52962 seconds to load)
146s 578 examples, 0 failures, 2 pending
146s 
146s /usr/share/rubygems-integration/all/gems/rspec-core-3.13.0/exe/rspec: warning: Exception in finalizer #<FFI::AutoPointer::Releaser:0x000003ffb19e0ed0 @ptr=#<FFI::Pointer address=0x000002aa11477be0>, @proc=#<Method: Ethon::Curl.easy_cleanup(*)>, @autorelease=true>
146s /usr/lib/s390x-linux-gnu/rubygems-integration/3.1.0/gems/ffi-1.16.3/lib/ffi/enum.rb:162:in `to_native': invalid enum value, "hi" (ArgumentError)
146s 	from /usr/lib/s390x-linux-gnu/rubygems-integration/3.1.0/gems/ffi-1.16.3/lib/ffi/autopointer.rb:160:in `easy_cleanup'
146s 	from /usr/lib/s390x-linux-gnu/rubygems-integration/3.1.0/gems/ffi-1.16.3/lib/ffi/autopointer.rb:160:in `call'
146s 	from /usr/lib/s390x-linux-gnu/rubygems-integration/3.1.0/gems/ffi-1.16.3/lib/ffi/autopointer.rb:160:in `release'
146s 	from /usr/lib/s390x-linux-gnu/rubygems-integration/3.1.0/gems/ffi-1.16.3/lib/ffi/autopointer.rb:151:in `call'
146s mv ./.gem2deb.lib lib
146s autopkgtest [22:13:59]: test gem2deb-test-runner: -----------------------]
147s gem2deb-test-runner  PASS
147s autopkgtest [22:14:00]: test gem2deb-test-runner:  - - - - - - - - - - results - - - - - - - - - -
147s autopkgtest [22:14:00]: @@@@@@@@@@@@@@@@@@@@ summary
147s gem2deb-test-runner  PASS
159s Creating nova instance adt-noble-s390x-ruby-ethon-20240325-221133-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-s390x-server-20240325.img (UUID 9f25d9bc-613c-4979-9452-2ea8e4d84cd0)...