0s autopkgtest [16:23:49]: starting date and time: 2025-03-15 16:23:49+0000
  0s autopkgtest [16:23:49]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production'
  0s autopkgtest [16:23:49]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.p5v65guh/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade ruby-prof --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-arm64-32.secgroup --name adt-plucky-arm64-ruby-prof-20250315-162349-juju-7f2275-prod-proposed-migration-environment-20-7ae2066e-6afa-405e-872d-8ef08ddd6cc8 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --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,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
147s autopkgtest [16:26:16]: testbed dpkg architecture: arm64
148s autopkgtest [16:26:17]: testbed apt version: 2.9.33
148s autopkgtest [16:26:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup
148s autopkgtest [16:26:17]: testbed release detected to be: None
149s autopkgtest [16:26:18]: updating testbed package index (apt update)
149s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB]
150s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
150s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
150s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
150s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB]
150s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB]
150s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB]
150s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [111 kB]
150s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1856 B]
151s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B]
151s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [324 kB]
151s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [14.7 kB]
151s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4948 B]
151s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [268 B]
151s Fetched 1078 kB in 2s (650 kB/s)
152s Reading package lists...
153s Reading package lists...
153s Building dependency tree...
153s Reading state information...
154s Calculating upgrade...
154s Calculating upgrade...
154s The following packages will be upgraded:
154s   pinentry-curses python3-jinja2 strace
155s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
155s Need to get 647 kB of archives.
155s After this operation, 11.3 kB of additional disk space will be used.
155s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB]
155s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 pinentry-curses arm64 1.3.1-2ubuntu3 [39.2 kB]
155s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB]
156s Fetched 647 kB in 1s (568 kB/s)
157s (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 ... 117701 files and directories currently installed.)
157s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ...
157s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ...
157s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_arm64.deb ...
157s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ...
157s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ...
157s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ...
157s Setting up pinentry-curses (1.3.1-2ubuntu3) ...
157s Setting up python3-jinja2 (3.1.5-2ubuntu1) ...
157s Setting up strace (6.13+ds-1ubuntu1) ...
157s Processing triggers for man-db (2.13.0-1) ...
158s Reading package lists...
159s Building dependency tree...
159s Reading state information...
160s Solving dependencies...
161s The following packages will be REMOVED:
161s   libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64*
161s   libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic*
161s   linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic*
161s   linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic*
162s 0 upgraded, 0 newly installed, 11 to remove and 5 not upgraded.
162s After this operation, 267 MB disk space will be freed.
162s (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 ... 117701 files and directories currently installed.)
162s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ...
162s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ...
162s Removing libpython3.12t64:arm64 (3.12.9-1) ...
162s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ...
162s Removing libnsl2:arm64 (1.3.0-3build3) ...
162s Removing libpython3.12-minimal:arm64 (3.12.9-1) ...
162s Removing libunwind8:arm64 (1.6.2-3.1) ...
162s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ...
162s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ...
164s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ...
164s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic
164s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic
164s /etc/kernel/postrm.d/initramfs-tools:
164s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic
165s /etc/kernel/postrm.d/zz-flash-kernel:
165s flash-kernel: Kernel 6.11.0-8-generic has been removed.
165s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required.
167s /etc/kernel/postrm.d/zz-update-grub:
167s Sourcing file `/etc/default/grub'
167s autopkgtest [16:26:36]: upgrading testbed (apt dist-upgrade and autopurge)
167s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
167s Generating grub configuration file ...
167s Found linux image: /boot/vmlinuz-6.14.0-10-generic
167s Found initrd image: /boot/initrd.img-6.14.0-10-generic
167s Warning: os-prober will not be executed to detect other bootable partitions.
167s Systems on them will not be added to the GRUB boot configuration.
167s Check GRUB_DISABLE_OS_PROBER documentation entry.
167s Adding boot menu entry for UEFI Firmware Settings ...
167s done
167s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
167s Processing triggers for libc-bin (2.41-1ubuntu1) ...
167s (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 ... 81650 files and directories currently installed.)
167s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ...
167s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ...
167s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
167s Reading package lists...
168s Building dependency tree...
168s Reading state information...
169s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
169s Starting 2 pkgProblemResolver with broken count: 0
169s Done
170s Entering ResolveByKeep
170s 
170s Calculating upgrade...
171s The following packages will be upgraded:
171s   libc-bin libc-dev-bin libc6 libc6-dev locales
171s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
171s Need to get 9530 kB of archives.
171s After this operation, 0 B of additional disk space will be used.
171s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu2 [1750 kB]
173s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu2 [24.0 kB]
173s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu2 [2910 kB]
177s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu2 [600 kB]
177s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu2 [4246 kB]
182s Preconfiguring packages ...
183s Fetched 9530 kB in 11s (846 kB/s)
183s (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 ... 81647 files and directories currently installed.)
183s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_arm64.deb ...
183s Unpacking libc6-dev:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
183s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_arm64.deb ...
183s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
183s Preparing to unpack .../libc6_2.41-1ubuntu2_arm64.deb ...
183s Unpacking libc6:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
183s Setting up libc6:arm64 (2.41-1ubuntu2) ...
184s (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 ... 81647 files and directories currently installed.)
184s Preparing to unpack .../libc-bin_2.41-1ubuntu2_arm64.deb ...
184s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
184s Setting up libc-bin (2.41-1ubuntu2) ...
184s (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 ... 81647 files and directories currently installed.)
184s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ...
184s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
184s Setting up locales (2.41-1ubuntu2) ...
185s Generating locales (this might take a while)...
187s   en_US.UTF-8... done
187s Generation complete.
187s Setting up libc-dev-bin (2.41-1ubuntu2) ...
187s Setting up libc6-dev:arm64 (2.41-1ubuntu2) ...
187s Processing triggers for man-db (2.13.0-1) ...
188s Processing triggers for systemd (257.3-1ubuntu3) ...
189s Reading package lists...
189s Building dependency tree...
189s Reading state information...
190s Starting pkgProblemResolver with broken count: 0
190s Starting 2 pkgProblemResolver with broken count: 0
190s Done
190s Solving dependencies...
191s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
191s autopkgtest [16:27:00]: rebooting testbed after setup commands that affected boot
214s autopkgtest [16:27:23]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025
217s autopkgtest [16:27:26]: @@@@@@@@@@@@@@@@@@@@ apt-source ruby-prof
219s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ruby-prof 1.7.0-1build1 (dsc) [2065 B]
219s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ruby-prof 1.7.0-1build1 (tar) [84.2 kB]
219s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ruby-prof 1.7.0-1build1 (diff) [8720 B]
219s gpgv: Signature made Fri Aug 16 09:54:52 2024 UTC
219s gpgv:                using RSA key 8ED6C3F8BAC9DB7FC130A870F823A2729883C97C
219s gpgv:                issuer "kanashiro@ubuntu.com"
219s gpgv: Can't check signature: No public key
219s dpkg-source: warning: cannot verify inline signature for ./ruby-prof_1.7.0-1build1.dsc: no acceptable signature found
219s autopkgtest [16:27:28]: testing package ruby-prof version 1.7.0-1build1
220s autopkgtest [16:27:29]: build not needed
221s autopkgtest [16:27:30]: test ruby-prof-help: preparing testbed
221s Reading package lists...
221s Building dependency tree...
221s Reading state information...
221s Starting pkgProblemResolver with broken count: 0
222s Starting 2 pkgProblemResolver with broken count: 0
222s Done
222s The following NEW packages will be installed:
222s   fonts-lato libjs-jquery libruby libruby3.3 rake ruby ruby-did-you-mean
222s   ruby-minitest ruby-net-telnet ruby-power-assert ruby-prof ruby-rubygems
222s   ruby-sdbm ruby-test-unit ruby-webrick ruby-xmlrpc ruby3.3
222s   rubygems-integration
222s 0 upgraded, 18 newly installed, 0 to remove and 0 not upgraded.
222s Need to get 9688 kB of archives.
222s After this operation, 50.5 MB of additional disk space will be used.
222s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 fonts-lato all 2.015-1 [2781 kB]
226s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB]
226s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 rubygems-integration all 1.19 [5550 B]
226s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby3.3 arm64 3.3.6-1.1ubuntu1 [49.1 kB]
226s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-rubygems all 3.6.3-1 [332 kB]
227s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby arm64 1:3.3~ubuntu3 [3618 B]
227s Get:7 http://ftpmaster.internal/ubuntu plucky/main arm64 rake all 13.2.1-1 [45.8 kB]
227s Get:8 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-did-you-mean all 1.6.3-2 [14.8 kB]
227s Get:9 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-minitest all 5.25.4-2ubuntu1 [48.9 kB]
227s Get:10 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-net-telnet all 0.2.0-1 [13.3 kB]
227s Get:11 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-power-assert all 2.0.3-1 [12.0 kB]
227s Get:12 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-test-unit all 3.6.2-1 [67.0 kB]
227s Get:13 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-webrick all 1.8.1-1ubuntu1 [52.6 kB]
227s Get:14 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-xmlrpc all 0.3.3-2 [24.8 kB]
227s Get:15 http://ftpmaster.internal/ubuntu plucky/main arm64 ruby-sdbm arm64 1.0.0-5build5 [15.5 kB]
227s Get:16 http://ftpmaster.internal/ubuntu plucky/main arm64 libruby3.3 arm64 3.3.6-1.1ubuntu1 [5835 kB]
233s Get:17 http://ftpmaster.internal/ubuntu plucky/main arm64 libruby arm64 1:3.3~ubuntu3 [5038 B]
233s Get:18 http://ftpmaster.internal/ubuntu plucky/universe arm64 ruby-prof arm64 1.7.0-1build1 [54.6 kB]
234s Fetched 9688 kB in 11s (863 kB/s)
234s Selecting previously unselected package fonts-lato.
234s (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 ... 81647 files and directories currently installed.)
234s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ...
234s Unpacking fonts-lato (2.015-1) ...
235s Selecting previously unselected package libjs-jquery.
235s Preparing to unpack .../01-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ...
235s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
235s Selecting previously unselected package rubygems-integration.
235s Preparing to unpack .../02-rubygems-integration_1.19_all.deb ...
235s Unpacking rubygems-integration (1.19) ...
235s Selecting previously unselected package ruby3.3.
235s Preparing to unpack .../03-ruby3.3_3.3.6-1.1ubuntu1_arm64.deb ...
235s Unpacking ruby3.3 (3.3.6-1.1ubuntu1) ...
235s Selecting previously unselected package ruby-rubygems.
235s Preparing to unpack .../04-ruby-rubygems_3.6.3-1_all.deb ...
235s Unpacking ruby-rubygems (3.6.3-1) ...
235s Selecting previously unselected package ruby.
235s Preparing to unpack .../05-ruby_1%3a3.3~ubuntu3_arm64.deb ...
235s Unpacking ruby (1:3.3~ubuntu3) ...
235s Selecting previously unselected package rake.
235s Preparing to unpack .../06-rake_13.2.1-1_all.deb ...
235s Unpacking rake (13.2.1-1) ...
235s Selecting previously unselected package ruby-did-you-mean.
235s Preparing to unpack .../07-ruby-did-you-mean_1.6.3-2_all.deb ...
235s Unpacking ruby-did-you-mean (1.6.3-2) ...
235s Selecting previously unselected package ruby-minitest.
235s Preparing to unpack .../08-ruby-minitest_5.25.4-2ubuntu1_all.deb ...
235s Unpacking ruby-minitest (5.25.4-2ubuntu1) ...
235s Selecting previously unselected package ruby-net-telnet.
235s Preparing to unpack .../09-ruby-net-telnet_0.2.0-1_all.deb ...
235s Unpacking ruby-net-telnet (0.2.0-1) ...
235s Selecting previously unselected package ruby-power-assert.
235s Preparing to unpack .../10-ruby-power-assert_2.0.3-1_all.deb ...
235s Unpacking ruby-power-assert (2.0.3-1) ...
235s Selecting previously unselected package ruby-test-unit.
235s Preparing to unpack .../11-ruby-test-unit_3.6.2-1_all.deb ...
235s Unpacking ruby-test-unit (3.6.2-1) ...
235s Selecting previously unselected package ruby-webrick.
235s Preparing to unpack .../12-ruby-webrick_1.8.1-1ubuntu1_all.deb ...
235s Unpacking ruby-webrick (1.8.1-1ubuntu1) ...
235s Selecting previously unselected package ruby-xmlrpc.
235s Preparing to unpack .../13-ruby-xmlrpc_0.3.3-2_all.deb ...
235s Unpacking ruby-xmlrpc (0.3.3-2) ...
235s Selecting previously unselected package ruby-sdbm:arm64.
235s Preparing to unpack .../14-ruby-sdbm_1.0.0-5build5_arm64.deb ...
235s Unpacking ruby-sdbm:arm64 (1.0.0-5build5) ...
235s Selecting previously unselected package libruby3.3:arm64.
235s Preparing to unpack .../15-libruby3.3_3.3.6-1.1ubuntu1_arm64.deb ...
235s Unpacking libruby3.3:arm64 (3.3.6-1.1ubuntu1) ...
236s Selecting previously unselected package libruby:arm64.
236s Preparing to unpack .../16-libruby_1%3a3.3~ubuntu3_arm64.deb ...
236s Unpacking libruby:arm64 (1:3.3~ubuntu3) ...
236s Selecting previously unselected package ruby-prof.
236s Preparing to unpack .../17-ruby-prof_1.7.0-1build1_arm64.deb ...
236s Unpacking ruby-prof (1.7.0-1build1) ...
236s Setting up fonts-lato (2.015-1) ...
236s Setting up ruby-power-assert (2.0.3-1) ...
236s Setting up rubygems-integration (1.19) ...
236s Setting up ruby-minitest (5.25.4-2ubuntu1) ...
236s Setting up ruby-test-unit (3.6.2-1) ...
236s Setting up ruby-net-telnet (0.2.0-1) ...
236s Setting up ruby-webrick (1.8.1-1ubuntu1) ...
236s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
236s Setting up ruby-did-you-mean (1.6.3-2) ...
236s Setting up ruby-xmlrpc (0.3.3-2) ...
236s Setting up rake (13.2.1-1) ...
236s Setting up libruby:arm64 (1:3.3~ubuntu3) ...
236s Setting up ruby-rubygems (3.6.3-1) ...
236s Setting up ruby-sdbm:arm64 (1.0.0-5build5) ...
236s Setting up libruby3.3:arm64 (3.3.6-1.1ubuntu1) ...
236s Setting up ruby3.3 (3.3.6-1.1ubuntu1) ...
236s Setting up ruby (1:3.3~ubuntu3) ...
236s Setting up ruby-prof (1.7.0-1build1) ...
236s Processing triggers for libc-bin (2.41-1ubuntu2) ...
236s Processing triggers for man-db (2.13.0-1) ...
238s autopkgtest [16:27:47]: test ruby-prof-help: ruby-prof --help
238s autopkgtest [16:27:47]: test ruby-prof-help: [-----------------------
238s ruby_prof 1.7.0
238s Usage: ruby-prof [options] <script.rb> [--] [profiled-script-command-line-options]
238s 
238s Options:
238s         --allow_exceptions           Raise exceptions encountered during profiling (true) or suppress them (false)
238s     -E, --eval-noprof=code           execute the ruby statements (not profiled)
238s         --exclude=methods            A comma separated list of methods to exclude.
238s                                        Specify instance methods via # (Integer#times)
238s                                        Specify class methods via . (Integer.superclass)
238s         --exclude-common             Remove common methods from the profile
238s     -f, --file=path                  Output results to a file instead of standard out.
238s     -m, --min_percent=min_percent    The minimum percent a method must take before 
238s                                        being included in output reports.
238s                                        This option is not supported for call tree.
238s         --mode=measure_mode          Select what ruby-prof should measure:
238s                                        wall - Wall time (default).
238s                                        process - Process time.
238s                                        allocations - Object allocations (requires patched Ruby interpreter).
238s                                        memory - Allocated memory in KB (requires patched Ruby interpreter).
238s     -p, --printer=printer            Select a printer:
238s                                        flat - Prints a flat profile as text (default).
238s                                        graph - Prints a graph profile as text.
238s                                        graph_html - Prints a graph profile as html.
238s                                        call_tree - format for KCacheGrind
238s                                        call_stack - prints a HTML visualization of the call tree
238s                                        dot - Prints a graph profile as a dot file
238s                                        multi - Creates several reports in output directory
238s     -R, --require-noprof=lib         require a specific library (not profiled)
238s     -s, --sort=sort_mode             Select how ruby-prof results should be sorted:
238s                                        total - Total time
238s                                        self - Self time
238s                                        wait - Wait time
238s                                        child - Child time
238s         --track_allocations          Track allocations while profiling
238s     -v, --version version            Show version (1.7.0)
238s     -h, --help                       Show help message
238s autopkgtest [16:27:47]: test ruby-prof-help: -----------------------]
239s ruby-prof-help       PASS (superficial)
239s autopkgtest [16:27:48]: test ruby-prof-help:  - - - - - - - - - - results - - - - - - - - - -
239s autopkgtest [16:27:48]: test gem2deb-test-runner: preparing testbed
239s Reading package lists...
240s Building dependency tree...
240s Reading state information...
240s Starting pkgProblemResolver with broken count: 0
240s Starting 2 pkgProblemResolver with broken count: 0
240s Done
241s The following NEW packages will be installed:
241s   gem2deb-test-runner
241s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
241s Need to get 18.3 kB of archives.
241s After this operation, 60.4 kB of additional disk space will be used.
241s Get:1 http://ftpmaster.internal/ubuntu plucky/universe arm64 gem2deb-test-runner arm64 2.2.5 [18.3 kB]
241s Fetched 18.3 kB in 0s (84.0 kB/s)
241s Selecting previously unselected package gem2deb-test-runner.
241s (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 ... 85224 files and directories currently installed.)
241s Preparing to unpack .../gem2deb-test-runner_2.2.5_arm64.deb ...
241s Unpacking gem2deb-test-runner (2.2.5) ...
242s Setting up gem2deb-test-runner (2.2.5) ...
242s Processing triggers for man-db (2.13.0-1) ...
243s autopkgtest [16:27:52]: test gem2deb-test-runner: gem2deb-test-runner --autopkgtest --check-dependencies 2>&1
243s autopkgtest [16:27:52]: test gem2deb-test-runner: [-----------------------
243s 
243s ┌──────────────────────────────────────────────────────────────────────────────┐
243s │ Checking Rubygems dependency resolution on ruby3.3                           │
243s └──────────────────────────────────────────────────────────────────────────────┘
243s 
243s RUBYLIB=. GEM_PATH= ruby3.3 -e gem\ \"ruby-prof\"
243s mv lib ./.gem2deb.lib
243s mv ext ./.gem2deb.ext
243s mv ./.gem2deb.lib lib
243s mv ./.gem2deb.ext ext
243s 
243s ┌──────────────────────────────────────────────────────────────────────────────┐
243s │ Run tests for ruby3.3 from debian/ruby-tests.rake                            │
243s └──────────────────────────────────────────────────────────────────────────────┘
243s 
243s RUBYLIB=. GEM_PATH= ruby3.3 -S rake --rakelibdir /gem2deb-nonexistent -f debian/ruby-tests.rake
243s mv lib ./.gem2deb.lib
243s mv ext ./.gem2deb.ext
243s /usr/bin/ruby3.3 -w -I"test" /usr/share/rubygems-integration/all/gems/rake-13.2.1/lib/rake/rake_test_loader.rb "test/abstract_printer_test.rb" "test/alias_test.rb" "test/call_tree_test.rb" "test/call_tree_visitor_test.rb" "test/call_trees_test.rb" "test/compatibility_test.rb" "test/duplicate_names_test.rb" "test/enumerable_test.rb" "test/exceptions_test.rb" "test/exclude_methods_test.rb" "test/exclude_threads_test.rb" "test/gc_test.rb" "test/line_number_test.rb" "test/marshal_test.rb" "test/measurement_test.rb" "test/method_info_test.rb" "test/multi_printer_test.rb" "test/no_method_class_test.rb" "test/printer_call_stack_test.rb" "test/printer_call_tree_test.rb" "test/printer_flat_test.rb" "test/printer_graph_html_test.rb" "test/printing_recursive_graph_test.rb" "test/rack_test.rb" "test/singleton_test.rb"  -v
245s Run options: -v --seed 33249
245s 
245s # Running:
245s 
245s LineNumbersTest#test_function_line_no = 0.00 s = .
245s MultiPrinterTest#test_refuses_io_objects = 0.01 s = .
245s MultiPrinterTest#test_refuses_non_hashes = 0.00 s = .
245s CompatibilityTest#test_double_profile = 0.00 s = .
245s CompatibilityTest#test_no_block = 0.00 s = .
245s CompatibilityTest#test_running = 0.01 s = .
245s CompatibilityTest#test_traceback = 0.00 s = .
245s MethodInfoTest#test_compare = 0.00 s = .
245s MethodInfoTest#test_eql? = 0.00 s = .
245s MethodInfoTest#test_equal? = 0.00 s = .
245s MethodInfoTest#test_equality = 0.00 s = .
245s MethodInfoTest#test_hash = 0.00 s = .
245s MethodInfoTest#test_initialize = 0.00 s = .
245s MethodInfoTest#test_initialize_nil_klass = 0.00 s = .
245s MethodInfoTest#test_initialize_nil_method_name = 0.00 s = .
245s MethodInfoTest#test_initialize_unknown_location = 0.00 s = .
245s MethodInfoTest#test_measurement = 0.00 s = .
245s MethodInfoTest#test_to_s = 0.00 s = .
245s CallTreeVisitorTest#test_visit = 0.10 s = .
245s PrinterCallStackTest#test_graph_html_string = 0.38 s = .
245s PrinterCallTreeTest#test_call_tree_string = 0.30 s = .
245s CallTreeTest#test_add_child = 0.00 s = .
246s CallTreeTest#test_add_child_gc = 0.23 s = .
246s CallTreeTest#test_compare = 0.00 s = .
246s CallTreeTest#test_initialize = 0.00 s = .
246s CallTreeTest#test_measurement = 0.00 s = .
246s CallTreeTest#test_to_s = 0.00 s = .
251s GcTest#test_hold_onto_call_trees = 5.26 s = .
252s GcTest#test_hold_onto_measurements = 1.38 s = .
256s GcTest#test_hold_onto_method = 3.53 s = .
258s GcTest#test_hold_onto_root_call_tree = 2.25 s = .
260s GcTest#test_hold_onto_thread = 2.18 s = .
263s PrintingRecursiveGraphTest#test_printing_rescursive_graph = 2.00 s = .
263s PrinterGraphHtmlTest#test_graph_html_result_sorting = 0.33 s = .
263s PrinterGraphHtmlTest#test_graph_html_result_sorting_by_total_time_is_default = 0.26 s = .
263s PrinterGraphHtmlTest#test_graph_html_string = 0.25 s = .
263s AliasTest#test_alias = 0.10 s = .
264s PrinterFlatTest#test_flat_result_filter_by_self_time = 0.25 s = .
264s PrinterFlatTest#test_flat_result_filter_by_total_time = 0.30 s = .
264s PrinterFlatTest#test_flat_result_max_percent = 0.29 s = .
265s PrinterFlatTest#test_flat_result_sorting = 0.32 s = .
265s PrinterFlatTest#test_flat_result_sorting_by_self_time_is_default = 0.30 s = .
265s PrinterFlatTest#test_flat_string = 0.32 s = .
265s MarshalTest#test_marshal_1 = 0.20 s = .
266s MarshalTest#test_marshal_2 = 0.20 s = .
266s MarshalTest#test_singleton = 0.00 s = .
266s MeasurementTest#test_clone = 0.00 s = .
266s MeasurementTest#test_dup = 0.00 s = .
266s MeasurementTest#test_initialize = 0.00 s = .
266s MeasurementTest#test_merge! = 0.00 s = .
266s MeasurementTest#test_set_called = 0.00 s = .
266s MeasurementTest#test_set_self_time = 0.00 s = .
266s MeasurementTest#test_set_total_time = 0.00 s = .
266s MeasurementTest#test_set_wait_time = 0.00 s = .
266s ExceptionsTest#test_profile = 0.00 s = .
266s ExceptionsTest#test_profile_allows_exceptions = 0.00 s = .
266s SingletonTest#test_singleton = 0.00 s = .
266s EnumerableTest#test_enumerable = 0.00 s = .
266s ExcludeMethodsTest#test_exclude_common_methods1 = 0.20 s = .
267s ExcludeMethodsTest#test_exclude_common_methods2 = 1.00 s = .
267s ExcludeMethodsTest#test_methods_can_be_hidden1 = 0.20 s = .
267s ExcludeMethodsTest#test_methods_can_be_hidden2 = 0.20 s = .
267s ExcludeMethodsTest#test_methods_can_be_profiled = 0.20 s = .
267s RackTest#test_allows_lazy_filename_setting = 0.00 s = .
267s RackTest#test_create_print_path = 0.00 s = .
267s RackTest#test_create_profile_reports = 0.00 s = .
267s RackTest#test_only_paths = 0.00 s = .
267s RackTest#test_skip_paths = 0.00 s = .
267s DuplicateNamesTest#test_names = 0.00 s = .
270s ExcludeThreadsTest#test_exclude_threads = 2.50 s = .
270s CallTreesTest#test_call_infos = 0.00 s = .
271s CallTreesTest#test_gc = 0.65 s = .
271s 
271s Finished in 25.747829s, 2.7964 runs/s, 39.7703 assertions/s.
271s 
271s 72 runs, 1024 assertions, 0 failures, 0 errors, 0 skips
271s mv ./.gem2deb.lib lib
271s mv ./.gem2deb.ext ext
271s autopkgtest [16:28:20]: test gem2deb-test-runner: -----------------------]
271s gem2deb-test-runner  PASS
271s autopkgtest [16:28:20]: test gem2deb-test-runner:  - - - - - - - - - - results - - - - - - - - - -
272s autopkgtest [16:28:21]: @@@@@@@@@@@@@@@@@@@@ summary
272s ruby-prof-help       PASS (superficial)
272s gem2deb-test-runner  PASS
277s nova [W] Using flock in prodstack6-arm64
277s Creating nova instance adt-plucky-arm64-ruby-prof-20250315-162349-juju-7f2275-prod-proposed-migration-environment-20-7ae2066e-6afa-405e-872d-8ef08ddd6cc8 from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)...
277s nova [W] Timed out waiting for 9146610f-8e20-4cb4-b6a9-d8f6fd74f6a8 to get deleted.