0s autopkgtest [13:03:04]: starting date and time: 2025-04-14 13:03:04+0000 0s autopkgtest [13:03:04]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [13:03:04]: host juju-7f2275-prod-proposed-migration-environment-21; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.p9b8jqhb/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:unicorn --apt-upgrade rainbows --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=unicorn/6.1.0+git.20250131.1370f52-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-21@bos03-arm64-10.secgroup --name adt-plucky-arm64-rainbows-20250414-092719-juju-7f2275-prod-proposed-migration-environment-21-ebfa2eb7-321d-45e4-b9bc-98c3663c2fe5 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-21 --net-id=net_prod-proposed-migration -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 89s autopkgtest [13:04:33]: testbed dpkg architecture: arm64 89s autopkgtest [13:04:33]: testbed apt version: 3.0.0 90s autopkgtest [13:04:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup 90s autopkgtest [13:04:34]: testbed release detected to be: None 90s autopkgtest [13:04:34]: updating testbed package index (apt update) 91s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [265 kB] 91s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 91s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 91s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 91s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [205 kB] 91s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [5192 B] 91s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [9948 B] 91s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [3176 B] 91s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [252 B] 91s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [224 B] 91s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [129 kB] 91s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [8288 B] 91s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [2004 B] 91s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [324 B] 93s Fetched 629 kB in 1s (835 kB/s) 94s Reading package lists... 94s autopkgtest [13:04:38]: upgrading testbed (apt dist-upgrade and autopurge) 94s Reading package lists... 95s Building dependency tree... 95s Reading state information... 95s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 95s Starting 2 pkgProblemResolver with broken count: 0 95s Done 96s Entering ResolveByKeep 96s 96s Calculating upgrade... 97s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 97s Reading package lists... 97s Building dependency tree... 97s Reading state information... 97s Starting pkgProblemResolver with broken count: 0 98s Starting 2 pkgProblemResolver with broken count: 0 98s Done 98s Solving dependencies... 98s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 101s autopkgtest [13:04:45]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Sun Apr 6 14:37:51 UTC 2025 101s autopkgtest [13:04:45]: @@@@@@@@@@@@@@@@@@@@ apt-source rainbows 103s Get:1 http://ftpmaster.internal/ubuntu plucky/universe rainbows 5.2.1-2 (dsc) [2046 B] 103s Get:2 http://ftpmaster.internal/ubuntu plucky/universe rainbows 5.2.1-2 (tar) [159 kB] 103s Get:3 http://ftpmaster.internal/ubuntu plucky/universe rainbows 5.2.1-2 (diff) [5288 B] 103s gpgv: Signature made Tue Jan 28 10:16:57 2025 UTC 103s gpgv: using RSA key B2DEE66036C40829FCD0F10CFC0DB1BBCD460BDE 103s gpgv: Can't check signature: No public key 103s dpkg-source: warning: cannot verify inline signature for ./rainbows_5.2.1-2.dsc: no acceptable signature found 103s autopkgtest [13:04:47]: testing package rainbows version 5.2.1-2 103s autopkgtest [13:04:47]: build not needed 104s autopkgtest [13:04:48]: test test-ThreadSpawn: preparing testbed 104s Reading package lists... 104s Building dependency tree... 104s Reading state information... 105s Starting pkgProblemResolver with broken count: 0 105s Starting 2 pkgProblemResolver with broken count: 0 105s Done 105s The following NEW packages will be installed: 105s apache2-utils libapr1t64 libaprutil1t64 libruby libruby3.3 rainbows rake 105s ruby ruby-did-you-mean ruby-kgio ruby-minitest ruby-net-telnet 105s ruby-power-assert ruby-rack ruby-raindrops ruby-rubygems ruby-test-unit 105s ruby-webrick ruby-xmlrpc ruby3.3 rubygems-integration socat unicorn 106s 0 upgraded, 23 newly installed, 0 to remove and 0 not upgraded. 106s Need to get 7545 kB of archives. 106s After this operation, 42.1 MB of additional disk space will be used. 106s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libapr1t64 arm64 1.7.5-1 [106 kB] 106s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 libaprutil1t64 arm64 1.6.3-3ubuntu2 [95.1 kB] 106s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 apache2-utils arm64 2.4.63-1ubuntu1 [98.0 kB] 106s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 rubygems-integration all 1.19 [5550 B] 106s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby3.3 arm64 3.3.7-1ubuntu2 [49.1 kB] 106s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-rubygems all 3.6.3-1 [332 kB] 106s Get:7 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby arm64 1:3.3~ubuntu3 [3618 B] 106s Get:8 http://ftpmaster.internal/ubuntu plucky/main arm64 rake all 13.2.1-1 [45.8 kB] 106s Get:9 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-did-you-mean all 1.6.3-2 [14.8 kB] 106s Get:10 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-minitest all 5.25.4-2ubuntu1 [48.9 kB] 106s Get:11 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-net-telnet all 0.2.0-1 [13.3 kB] 106s Get:12 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-power-assert all 2.0.3-1 [12.0 kB] 106s Get:13 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-test-unit all 3.6.2-1 [67.0 kB] 106s Get:14 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-webrick all 1.8.1-1ubuntu1 [52.6 kB] 106s Get:15 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-xmlrpc all 0.3.3-2 [24.8 kB] 106s Get:16 http://ftpmaster.internal/ubuntu plucky/main arm64 libruby3.3 arm64 3.3.7-1ubuntu2 [5836 kB] 106s Get:17 http://ftpmaster.internal/ubuntu plucky/main arm64 libruby arm64 1:3.3~ubuntu3 [5038 B] 106s Get:18 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-rack all 2.2.7-1.1 [114 kB] 106s Get:19 http://ftpmaster.internal/ubuntu plucky/universe arm64 ruby-kgio arm64 2.11.2-2build7 [29.7 kB] 106s Get:20 http://ftpmaster.internal/ubuntu plucky/universe arm64 ruby-raindrops arm64 0.20.0-2 [30.8 kB] 106s Get:21 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 unicorn arm64 6.1.0+git.20250131.1370f52-1 [101 kB] 106s Get:22 http://ftpmaster.internal/ubuntu plucky/universe arm64 rainbows all 5.2.1-2 [80.3 kB] 106s Get:23 http://ftpmaster.internal/ubuntu plucky/main arm64 socat arm64 1.8.0.2-1 [379 kB] 107s Fetched 7545 kB in 1s (7834 kB/s) 107s Selecting previously unselected package libapr1t64:arm64. 107s (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 ... 117820 files and directories currently installed.) 107s Preparing to unpack .../00-libapr1t64_1.7.5-1_arm64.deb ... 107s Unpacking libapr1t64:arm64 (1.7.5-1) ... 107s Selecting previously unselected package libaprutil1t64:arm64. 107s Preparing to unpack .../01-libaprutil1t64_1.6.3-3ubuntu2_arm64.deb ... 107s Unpacking libaprutil1t64:arm64 (1.6.3-3ubuntu2) ... 107s Selecting previously unselected package apache2-utils. 107s Preparing to unpack .../02-apache2-utils_2.4.63-1ubuntu1_arm64.deb ... 107s Unpacking apache2-utils (2.4.63-1ubuntu1) ... 107s Selecting previously unselected package rubygems-integration. 107s Preparing to unpack .../03-rubygems-integration_1.19_all.deb ... 107s Unpacking rubygems-integration (1.19) ... 107s Selecting previously unselected package ruby3.3. 107s Preparing to unpack .../04-ruby3.3_3.3.7-1ubuntu2_arm64.deb ... 107s Unpacking ruby3.3 (3.3.7-1ubuntu2) ... 107s Selecting previously unselected package ruby-rubygems. 107s Preparing to unpack .../05-ruby-rubygems_3.6.3-1_all.deb ... 107s Unpacking ruby-rubygems (3.6.3-1) ... 107s Selecting previously unselected package ruby. 107s Preparing to unpack .../06-ruby_1%3a3.3~ubuntu3_arm64.deb ... 107s Unpacking ruby (1:3.3~ubuntu3) ... 107s Selecting previously unselected package rake. 107s Preparing to unpack .../07-rake_13.2.1-1_all.deb ... 107s Unpacking rake (13.2.1-1) ... 107s Selecting previously unselected package ruby-did-you-mean. 107s Preparing to unpack .../08-ruby-did-you-mean_1.6.3-2_all.deb ... 107s Unpacking ruby-did-you-mean (1.6.3-2) ... 107s Selecting previously unselected package ruby-minitest. 108s Preparing to unpack .../09-ruby-minitest_5.25.4-2ubuntu1_all.deb ... 108s Unpacking ruby-minitest (5.25.4-2ubuntu1) ... 108s Selecting previously unselected package ruby-net-telnet. 108s Preparing to unpack .../10-ruby-net-telnet_0.2.0-1_all.deb ... 108s Unpacking ruby-net-telnet (0.2.0-1) ... 108s Selecting previously unselected package ruby-power-assert. 108s Preparing to unpack .../11-ruby-power-assert_2.0.3-1_all.deb ... 108s Unpacking ruby-power-assert (2.0.3-1) ... 108s Selecting previously unselected package ruby-test-unit. 108s Preparing to unpack .../12-ruby-test-unit_3.6.2-1_all.deb ... 108s Unpacking ruby-test-unit (3.6.2-1) ... 108s Selecting previously unselected package ruby-webrick. 108s Preparing to unpack .../13-ruby-webrick_1.8.1-1ubuntu1_all.deb ... 108s Unpacking ruby-webrick (1.8.1-1ubuntu1) ... 108s Selecting previously unselected package ruby-xmlrpc. 108s Preparing to unpack .../14-ruby-xmlrpc_0.3.3-2_all.deb ... 108s Unpacking ruby-xmlrpc (0.3.3-2) ... 108s Selecting previously unselected package libruby3.3:arm64. 108s Preparing to unpack .../15-libruby3.3_3.3.7-1ubuntu2_arm64.deb ... 108s Unpacking libruby3.3:arm64 (3.3.7-1ubuntu2) ... 108s Selecting previously unselected package libruby:arm64. 108s Preparing to unpack .../16-libruby_1%3a3.3~ubuntu3_arm64.deb ... 108s Unpacking libruby:arm64 (1:3.3~ubuntu3) ... 108s Selecting previously unselected package ruby-rack. 108s Preparing to unpack .../17-ruby-rack_2.2.7-1.1_all.deb ... 108s Unpacking ruby-rack (2.2.7-1.1) ... 108s Selecting previously unselected package ruby-kgio. 108s Preparing to unpack .../18-ruby-kgio_2.11.2-2build7_arm64.deb ... 108s Unpacking ruby-kgio (2.11.2-2build7) ... 108s Selecting previously unselected package ruby-raindrops:arm64. 108s Preparing to unpack .../19-ruby-raindrops_0.20.0-2_arm64.deb ... 108s Unpacking ruby-raindrops:arm64 (0.20.0-2) ... 108s Selecting previously unselected package unicorn. 108s Preparing to unpack .../20-unicorn_6.1.0+git.20250131.1370f52-1_arm64.deb ... 108s Unpacking unicorn (6.1.0+git.20250131.1370f52-1) ... 108s Selecting previously unselected package rainbows. 108s Preparing to unpack .../21-rainbows_5.2.1-2_all.deb ... 108s Unpacking rainbows (5.2.1-2) ... 108s Selecting previously unselected package socat. 108s Preparing to unpack .../22-socat_1.8.0.2-1_arm64.deb ... 108s Unpacking socat (1.8.0.2-1) ... 108s Setting up ruby-power-assert (2.0.3-1) ... 108s Setting up rubygems-integration (1.19) ... 108s Setting up ruby-minitest (5.25.4-2ubuntu1) ... 108s Setting up ruby-test-unit (3.6.2-1) ... 108s Setting up socat (1.8.0.2-1) ... 108s Setting up ruby-net-telnet (0.2.0-1) ... 108s Setting up ruby-webrick (1.8.1-1ubuntu1) ... 108s Setting up libapr1t64:arm64 (1.7.5-1) ... 108s Setting up ruby-did-you-mean (1.6.3-2) ... 108s Setting up ruby-xmlrpc (0.3.3-2) ... 108s Setting up libaprutil1t64:arm64 (1.6.3-3ubuntu2) ... 108s Setting up apache2-utils (2.4.63-1ubuntu1) ... 108s Setting up ruby-rubygems (3.6.3-1) ... 108s Setting up rake (13.2.1-1) ... 108s Setting up libruby3.3:arm64 (3.3.7-1ubuntu2) ... 108s Setting up ruby3.3 (3.3.7-1ubuntu2) ... 108s Setting up libruby:arm64 (1:3.3~ubuntu3) ... 108s Setting up ruby-raindrops:arm64 (0.20.0-2) ... 108s Setting up ruby (1:3.3~ubuntu3) ... 108s Setting up ruby-kgio (2.11.2-2build7) ... 108s Setting up ruby-rack (2.2.7-1.1) ... 108s Setting up unicorn (6.1.0+git.20250131.1370f52-1) ... 109s Created symlink '/etc/systemd/system/multi-user.target.wants/unicorn.service' → '/usr/lib/systemd/system/unicorn.service'. 109s Setting up rainbows (5.2.1-2) ... 109s Processing triggers for man-db (2.13.0-1) ... 110s Processing triggers for libc-bin (2.41-6ubuntu1) ... 111s autopkgtest [13:04:55]: test test-ThreadSpawn: [----------------------- 111s 30+0 records in 111s 30+0 records out 111s 31457280 bytes (31 MB, 30 MiB) copied, 0.0958005 s, 328 MB/s 111s ===> t0000-simple-http.sh <=== 112s 1..25 # simple HTTP connection keepalive/pipelining tests for ThreadSpawn 112s ok 1 - checking for config.ru for ThreadSpawn 112s ok 2 - setup and start 112s ok 3 - pid file exists 1617s autopkgtest-virt-ssh [13:30:01]: ------- nova console-log 1c4a8ef9-4658-4209-b7a3-68c5568854a8 (adt-plucky-arm64-rainbows-20250414-092719-juju-7f2275-prod-proposed-migration-environment-21-ebfa2eb7-321d-45e4-b9bc-98c3663c2fe5) ------ 1617s ERROR (CommandError): No server with a name or ID of '1c4a8ef9-4658-4209-b7a3-68c5568854a8' exists. 1617s --------------------------------------------------- 1617s ------- nova show 1c4a8ef9-4658-4209-b7a3-68c5568854a8 (adt-plucky-arm64-rainbows-20250414-092719-juju-7f2275-prod-proposed-migration-environment-21-ebfa2eb7-321d-45e4-b9bc-98c3663c2fe5) ------ 1617s ERROR (CommandError): No server with a name or ID of '1c4a8ef9-4658-4209-b7a3-68c5568854a8' exists. 1617s --------------------------------------------------- 1617s 4242s nova [W] Using flock in prodstack6-arm64 4242s Creating nova instance adt-plucky-arm64-rainbows-20250414-092719-juju-7f2275-prod-proposed-migration-environment-21-ebfa2eb7-321d-45e4-b9bc-98c3663c2fe5 from image adt/ubuntu-plucky-arm64-server-20250414.img (UUID 9726ef59-66f3-4d3e-972f-cefa0b96da61)... 4242s nova [W] Timed out waiting for 1c4a8ef9-4658-4209-b7a3-68c5568854a8 to get deleted. 4242s autopkgtest [14:13:46]: ERROR: testbed failure: testbed auxverb failed with exit code 255