0s autopkgtest [18:48:34]: starting date and time: 2025-03-15 18:48:34+0000 0s autopkgtest [18:48:34]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [18:48:34]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.iiie998q/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-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-20.secgroup --name adt-plucky-s390x-ruby-prof-20250315-184834-juju-7f2275-prod-proposed-migration-environment-2-1c2c00c3-1267-4fac-b2ee-ee769ba98130 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -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/ 103s autopkgtest [18:50:17]: testbed dpkg architecture: s390x 104s autopkgtest [18:50:18]: testbed apt version: 2.9.33 104s autopkgtest [18:50:18]: @@@@@@@@@@@@@@@@@@@@ test bed setup 104s autopkgtest [18:50:18]: testbed release detected to be: None 105s autopkgtest [18:50:19]: updating testbed package index (apt update) 105s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 105s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 105s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 106s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 106s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 106s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 106s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 106s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [113 kB] 106s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 106s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 106s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [320 kB] 106s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.4 kB] 106s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3776 B] 106s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 106s Fetched 1073 kB in 1s (918 kB/s) 107s Reading package lists... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 108s Calculating upgrade... 108s Calculating upgrade... 108s The following packages were automatically installed and are no longer required: 108s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 108s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 108s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 108s linux-tools-6.11.0-8-generic 108s Use 'sudo apt autoremove' to remove them. 108s The following packages will be upgraded: 108s pinentry-curses python3-jinja2 strace 108s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 108s Need to get 652 kB of archives. 108s After this operation, 27.6 kB of additional disk space will be used. 108s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 109s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 109s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 109s Fetched 652 kB in 1s (938 kB/s) 109s (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 ... 81428 files and directories currently installed.) 109s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 109s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 109s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 109s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 109s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 109s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 109s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 109s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 109s Setting up strace (6.13+ds-1ubuntu1) ... 109s Processing triggers for man-db (2.13.0-1) ... 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 110s Solving dependencies... 110s The following packages will be REMOVED: 110s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 110s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 110s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 110s linux-tools-6.11.0-8-generic* 110s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 110s After this operation, 167 MB disk space will be freed. 110s (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 ... 81428 files and directories currently installed.) 110s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 110s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 110s Removing libpython3.12t64:s390x (3.12.9-1) ... 110s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 110s Removing libnsl2:s390x (1.3.0-3build3) ... 110s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 110s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 111s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 111s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 111s Processing triggers for libc-bin (2.41-1ubuntu1) ... 111s (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 ... 56328 files and directories currently installed.) 111s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 111s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 112s autopkgtest [18:50:26]: upgrading testbed (apt dist-upgrade and autopurge) 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 112s Starting 2 pkgProblemResolver with broken count: 0 112s Done 112s Entering ResolveByKeep 112s 112s Calculating upgrade... 113s The following packages will be upgraded: 113s libc-bin libc-dev-bin libc6 libc6-dev locales 113s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s Need to get 9512 kB of archives. 113s After this operation, 8192 B of additional disk space will be used. 113s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 113s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 113s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB] 114s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB] 114s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB] 115s Preconfiguring packages ... 115s Fetched 9512 kB in 3s (3604 kB/s) 115s (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 ... 56326 files and directories currently installed.) 115s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 115s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 116s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 116s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 116s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 116s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 116s Setting up libc6:s390x (2.41-1ubuntu2) ... 116s (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 ... 56326 files and directories currently installed.) 116s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ... 116s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 116s Setting up libc-bin (2.41-1ubuntu2) ... 116s (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 ... 56326 files and directories currently installed.) 116s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 116s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 116s Setting up locales (2.41-1ubuntu2) ... 116s Generating locales (this might take a while)... 117s en_US.UTF-8... done 117s Generation complete. 117s Setting up libc-dev-bin (2.41-1ubuntu2) ... 117s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 117s Processing triggers for man-db (2.13.0-1) ... 118s Processing triggers for systemd (257.3-1ubuntu3) ... 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s Starting pkgProblemResolver with broken count: 0 119s Starting 2 pkgProblemResolver with broken count: 0 119s Done 119s Solving dependencies... 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s autopkgtest [18:50:34]: rebooting testbed after setup commands that affected boot 139s autopkgtest [18:50:53]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 141s autopkgtest [18:50:55]: @@@@@@@@@@@@@@@@@@@@ apt-source ruby-prof 143s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ruby-prof 1.7.0-1build1 (dsc) [2065 B] 143s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ruby-prof 1.7.0-1build1 (tar) [84.2 kB] 143s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ruby-prof 1.7.0-1build1 (diff) [8720 B] 143s gpgv: Signature made Fri Aug 16 09:54:52 2024 UTC 143s gpgv: using RSA key 8ED6C3F8BAC9DB7FC130A870F823A2729883C97C 143s gpgv: issuer "kanashiro@ubuntu.com" 143s gpgv: Can't check signature: No public key 143s dpkg-source: warning: cannot verify inline signature for ./ruby-prof_1.7.0-1build1.dsc: no acceptable signature found 143s autopkgtest [18:50:57]: testing package ruby-prof version 1.7.0-1build1 144s autopkgtest [18:50:58]: build not needed 144s autopkgtest [18:50:58]: test ruby-prof-help: preparing testbed 144s Reading package lists... 145s Building dependency tree... 145s Reading state information... 145s Starting pkgProblemResolver with broken count: 0 145s Starting 2 pkgProblemResolver with broken count: 0 145s Done 145s The following NEW packages will be installed: 145s fonts-lato libjs-jquery libruby libruby3.3 rake ruby ruby-did-you-mean 145s ruby-minitest ruby-net-telnet ruby-power-assert ruby-prof ruby-rubygems 145s ruby-sdbm ruby-test-unit ruby-webrick ruby-xmlrpc ruby3.3 145s rubygems-integration 145s 0 upgraded, 18 newly installed, 0 to remove and 0 not upgraded. 145s Need to get 9724 kB of archives. 145s After this operation, 45.9 MB of additional disk space will be used. 145s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x fonts-lato all 2.015-1 [2781 kB] 146s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 146s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x rubygems-integration all 1.19 [5550 B] 146s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x ruby3.3 s390x 3.3.6-1.1ubuntu1 [49.1 kB] 146s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-rubygems all 3.6.3-1 [332 kB] 146s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x ruby s390x 1:3.3~ubuntu3 [3618 B] 146s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x rake all 13.2.1-1 [45.8 kB] 146s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-did-you-mean all 1.6.3-2 [14.8 kB] 146s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-minitest all 5.25.4-2ubuntu1 [48.9 kB] 146s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-net-telnet all 0.2.0-1 [13.3 kB] 146s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-power-assert all 2.0.3-1 [12.0 kB] 146s Get:12 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-test-unit all 3.6.2-1 [67.0 kB] 146s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-webrick all 1.8.1-1ubuntu1 [52.6 kB] 146s Get:14 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-xmlrpc all 0.3.3-2 [24.8 kB] 146s Get:15 http://ftpmaster.internal/ubuntu plucky/main s390x ruby-sdbm s390x 1.0.0-5build5 [16.3 kB] 146s Get:16 http://ftpmaster.internal/ubuntu plucky/main s390x libruby3.3 s390x 3.3.6-1.1ubuntu1 [5869 kB] 147s Get:17 http://ftpmaster.internal/ubuntu plucky/main s390x libruby s390x 1:3.3~ubuntu3 [5038 B] 147s Get:18 http://ftpmaster.internal/ubuntu plucky/universe s390x ruby-prof s390x 1.7.0-1build1 [54.6 kB] 148s Fetched 9724 kB in 2s (4051 kB/s) 148s Selecting previously unselected package fonts-lato. 148s (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 ... 56326 files and directories currently installed.) 148s Preparing to unpack .../00-fonts-lato_2.015-1_all.deb ... 148s Unpacking fonts-lato (2.015-1) ... 148s Selecting previously unselected package libjs-jquery. 148s Preparing to unpack .../01-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 148s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 148s Selecting previously unselected package rubygems-integration. 148s Preparing to unpack .../02-rubygems-integration_1.19_all.deb ... 148s Unpacking rubygems-integration (1.19) ... 148s Selecting previously unselected package ruby3.3. 148s Preparing to unpack .../03-ruby3.3_3.3.6-1.1ubuntu1_s390x.deb ... 148s Unpacking ruby3.3 (3.3.6-1.1ubuntu1) ... 148s Selecting previously unselected package ruby-rubygems. 148s Preparing to unpack .../04-ruby-rubygems_3.6.3-1_all.deb ... 148s Unpacking ruby-rubygems (3.6.3-1) ... 148s Selecting previously unselected package ruby. 148s Preparing to unpack .../05-ruby_1%3a3.3~ubuntu3_s390x.deb ... 148s Unpacking ruby (1:3.3~ubuntu3) ... 148s Selecting previously unselected package rake. 148s Preparing to unpack .../06-rake_13.2.1-1_all.deb ... 148s Unpacking rake (13.2.1-1) ... 148s Selecting previously unselected package ruby-did-you-mean. 148s Preparing to unpack .../07-ruby-did-you-mean_1.6.3-2_all.deb ... 148s Unpacking ruby-did-you-mean (1.6.3-2) ... 148s Selecting previously unselected package ruby-minitest. 148s Preparing to unpack .../08-ruby-minitest_5.25.4-2ubuntu1_all.deb ... 148s Unpacking ruby-minitest (5.25.4-2ubuntu1) ... 148s Selecting previously unselected package ruby-net-telnet. 148s Preparing to unpack .../09-ruby-net-telnet_0.2.0-1_all.deb ... 148s Unpacking ruby-net-telnet (0.2.0-1) ... 148s Selecting previously unselected package ruby-power-assert. 148s Preparing to unpack .../10-ruby-power-assert_2.0.3-1_all.deb ... 148s Unpacking ruby-power-assert (2.0.3-1) ... 148s Selecting previously unselected package ruby-test-unit. 148s Preparing to unpack .../11-ruby-test-unit_3.6.2-1_all.deb ... 148s Unpacking ruby-test-unit (3.6.2-1) ... 148s Selecting previously unselected package ruby-webrick. 148s Preparing to unpack .../12-ruby-webrick_1.8.1-1ubuntu1_all.deb ... 148s Unpacking ruby-webrick (1.8.1-1ubuntu1) ... 148s Selecting previously unselected package ruby-xmlrpc. 148s Preparing to unpack .../13-ruby-xmlrpc_0.3.3-2_all.deb ... 148s Unpacking ruby-xmlrpc (0.3.3-2) ... 148s Selecting previously unselected package ruby-sdbm:s390x. 148s Preparing to unpack .../14-ruby-sdbm_1.0.0-5build5_s390x.deb ... 148s Unpacking ruby-sdbm:s390x (1.0.0-5build5) ... 148s Selecting previously unselected package libruby3.3:s390x. 148s Preparing to unpack .../15-libruby3.3_3.3.6-1.1ubuntu1_s390x.deb ... 148s Unpacking libruby3.3:s390x (3.3.6-1.1ubuntu1) ... 148s Selecting previously unselected package libruby:s390x. 148s Preparing to unpack .../16-libruby_1%3a3.3~ubuntu3_s390x.deb ... 148s Unpacking libruby:s390x (1:3.3~ubuntu3) ... 148s Selecting previously unselected package ruby-prof. 148s Preparing to unpack .../17-ruby-prof_1.7.0-1build1_s390x.deb ... 148s Unpacking ruby-prof (1.7.0-1build1) ... 148s Setting up fonts-lato (2.015-1) ... 148s Setting up ruby-power-assert (2.0.3-1) ... 148s Setting up rubygems-integration (1.19) ... 148s Setting up ruby-minitest (5.25.4-2ubuntu1) ... 148s Setting up ruby-test-unit (3.6.2-1) ... 148s Setting up ruby-net-telnet (0.2.0-1) ... 148s Setting up ruby-webrick (1.8.1-1ubuntu1) ... 148s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 148s Setting up ruby-did-you-mean (1.6.3-2) ... 148s Setting up ruby-xmlrpc (0.3.3-2) ... 148s Setting up rake (13.2.1-1) ... 148s Setting up libruby:s390x (1:3.3~ubuntu3) ... 148s Setting up ruby-rubygems (3.6.3-1) ... 148s Setting up ruby-sdbm:s390x (1.0.0-5build5) ... 148s Setting up libruby3.3:s390x (3.3.6-1.1ubuntu1) ... 148s Setting up ruby3.3 (3.3.6-1.1ubuntu1) ... 148s Setting up ruby (1:3.3~ubuntu3) ... 148s Setting up ruby-prof (1.7.0-1build1) ... 148s Processing triggers for libc-bin (2.41-1ubuntu2) ... 148s Processing triggers for man-db (2.13.0-1) ... 150s autopkgtest [18:51:04]: test ruby-prof-help: ruby-prof --help 150s autopkgtest [18:51:04]: test ruby-prof-help: [----------------------- 150s ruby_prof 1.7.0 150s Usage: ruby-prof [options] [--] [profiled-script-command-line-options] 150s 150s Options: 150s --allow_exceptions Raise exceptions encountered during profiling (true) or suppress them (false) 150s -E, --eval-noprof=code execute the ruby statements (not profiled) 150s --exclude=methods A comma separated list of methods to exclude. 150s Specify instance methods via # (Integer#times) 150s Specify class methods via . (Integer.superclass) 150s --exclude-common Remove common methods from the profile 150s -f, --file=path Output results to a file instead of standard out. 150s -m, --min_percent=min_percent The minimum percent a method must take before 150s being included in output reports. 150s This option is not supported for call tree. 150s --mode=measure_mode Select what ruby-prof should measure: 150s wall - Wall time (default). 150s process - Process time. 150s allocations - Object allocations (requires patched Ruby interpreter). 150s memory - Allocated memory in KB (requires patched Ruby interpreter). 150s -p, --printer=printer Select a printer: 150s flat - Prints a flat profile as text (default). 150s graph - Prints a graph profile as text. 150s graph_html - Prints a graph profile as html. 150s call_tree - format for KCacheGrind 150s call_stack - prints a HTML visualization of the call tree 150s dot - Prints a graph profile as a dot file 150s multi - Creates several reports in output directory 150s -R, --require-noprof=lib require a specific library (not profiled) 150s -s, --sort=sort_mode Select how ruby-prof results should be sorted: 150s total - Total time 150s self - Self time 150s wait - Wait time 150s child - Child time 150s --track_allocations Track allocations while profiling 150s -v, --version version Show version (1.7.0) 150s -h, --help Show help message 150s autopkgtest [18:51:04]: test ruby-prof-help: -----------------------] 151s ruby-prof-help PASS (superficial) 151s autopkgtest [18:51:05]: test ruby-prof-help: - - - - - - - - - - results - - - - - - - - - - 151s autopkgtest [18:51:05]: test gem2deb-test-runner: preparing testbed 151s Reading package lists... 152s Building dependency tree... 152s Reading state information... 152s Starting pkgProblemResolver with broken count: 0 152s Starting 2 pkgProblemResolver with broken count: 0 152s Done 152s The following NEW packages will be installed: 152s gem2deb-test-runner 152s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 152s Need to get 18.3 kB of archives. 152s After this operation, 60.4 kB of additional disk space will be used. 152s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x gem2deb-test-runner s390x 2.2.5 [18.3 kB] 152s Fetched 18.3 kB in 0s (87.6 kB/s) 152s Selecting previously unselected package gem2deb-test-runner. 152s (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 ... 59903 files and directories currently installed.) 152s Preparing to unpack .../gem2deb-test-runner_2.2.5_s390x.deb ... 152s Unpacking gem2deb-test-runner (2.2.5) ... 152s Setting up gem2deb-test-runner (2.2.5) ... 152s Processing triggers for man-db (2.13.0-1) ... 154s autopkgtest [18:51:08]: test gem2deb-test-runner: gem2deb-test-runner --autopkgtest --check-dependencies 2>&1 154s autopkgtest [18:51:08]: test gem2deb-test-runner: [----------------------- 154s 154s ┌──────────────────────────────────────────────────────────────────────────────┐ 154s │ Checking Rubygems dependency resolution on ruby3.3 │ 154s └──────────────────────────────────────────────────────────────────────────────┘ 154s 154s RUBYLIB=. GEM_PATH= ruby3.3 -e gem\ \"ruby-prof\" 154s mv lib ./.gem2deb.lib 154s mv ext ./.gem2deb.ext 154s mv ./.gem2deb.lib lib 154s mv ./.gem2deb.ext ext 154s 154s ┌──────────────────────────────────────────────────────────────────────────────┐ 154s │ Run tests for ruby3.3 from debian/ruby-tests.rake │ 154s └──────────────────────────────────────────────────────────────────────────────┘ 154s 154s RUBYLIB=. GEM_PATH= ruby3.3 -S rake --rakelibdir /gem2deb-nonexistent -f debian/ruby-tests.rake 154s mv lib ./.gem2deb.lib 154s mv ext ./.gem2deb.ext 154s /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 155s Run options: -v --seed 63069 155s 155s # Running: 155s 158s ExcludeThreadsTest#test_exclude_threads = 2.50 s = . 158s EnumerableTest#test_enumerable = 0.00 s = . 158s PrinterGraphHtmlTest#test_graph_html_result_sorting = 0.27 s = . 158s PrinterGraphHtmlTest#test_graph_html_result_sorting_by_total_time_is_default = 0.24 s = . 158s PrinterGraphHtmlTest#test_graph_html_string = 0.29 s = . 158s MethodInfoTest#test_compare = 0.00 s = . 158s MethodInfoTest#test_eql? = 0.00 s = . 159s MethodInfoTest#test_equal? = 0.00 s = . 159s MethodInfoTest#test_equality = 0.00 s = . 159s MethodInfoTest#test_hash = 0.00 s = . 159s MethodInfoTest#test_initialize = 0.00 s = . 159s MethodInfoTest#test_initialize_nil_klass = 0.00 s = . 159s MethodInfoTest#test_initialize_nil_method_name = 0.00 s = . 159s MethodInfoTest#test_initialize_unknown_location = 0.00 s = . 159s MethodInfoTest#test_measurement = 0.00 s = . 159s MethodInfoTest#test_to_s = 0.00 s = . 159s CompatibilityTest#test_double_profile = 0.00 s = . 159s CompatibilityTest#test_no_block = 0.00 s = . 159s CompatibilityTest#test_running = 0.00 s = . 159s CompatibilityTest#test_traceback = 0.00 s = . 159s AliasTest#test_alias = 0.10 s = . 159s CallTreesTest#test_call_infos = 0.00 s = . 159s CallTreesTest#test_gc = 0.20 s = . 159s LineNumbersTest#test_function_line_no = 0.00 s = . 159s RackTest#test_allows_lazy_filename_setting = 0.00 s = . 159s RackTest#test_create_print_path = 0.00 s = . 159s RackTest#test_create_profile_reports = 0.00 s = . 159s RackTest#test_only_paths = 0.00 s = . 159s RackTest#test_skip_paths = 0.00 s = . 159s MultiPrinterTest#test_refuses_io_objects = 0.00 s = . 159s MultiPrinterTest#test_refuses_non_hashes = 0.00 s = . 161s PrintingRecursiveGraphTest#test_printing_rescursive_graph = 2.00 s = . 161s ExcludeMethodsTest#test_exclude_common_methods1 = 0.20 s = . 162s ExcludeMethodsTest#test_exclude_common_methods2 = 1.00 s = . 162s ExcludeMethodsTest#test_methods_can_be_hidden1 = 0.20 s = . 162s ExcludeMethodsTest#test_methods_can_be_hidden2 = 0.20 s = . 163s ExcludeMethodsTest#test_methods_can_be_profiled = 0.20 s = . 163s CallTreeTest#test_add_child = 0.00 s = . 163s CallTreeTest#test_add_child_gc = 0.09 s = . 163s CallTreeTest#test_compare = 0.00 s = . 163s CallTreeTest#test_initialize = 0.00 s = . 163s CallTreeTest#test_measurement = 0.00 s = . 163s CallTreeTest#test_to_s = 0.00 s = . 163s PrinterFlatTest#test_flat_result_filter_by_self_time = 0.27 s = . 163s PrinterFlatTest#test_flat_result_filter_by_total_time = 0.23 s = . 163s PrinterFlatTest#test_flat_result_max_percent = 0.26 s = . 164s PrinterFlatTest#test_flat_result_sorting = 0.27 s = . 164s PrinterFlatTest#test_flat_result_sorting_by_self_time_is_default = 0.32 s = . 164s PrinterFlatTest#test_flat_string = 0.27 s = . 164s MarshalTest#test_marshal_1 = 0.20 s = . 165s MarshalTest#test_marshal_2 = 0.20 s = . 165s MarshalTest#test_singleton = 0.00 s = . 165s PrinterCallStackTest#test_graph_html_string = 0.29 s = . 165s CallTreeVisitorTest#test_visit = 0.10 s = . 165s MeasurementTest#test_clone = 0.00 s = . 165s MeasurementTest#test_dup = 0.00 s = . 165s MeasurementTest#test_initialize = 0.00 s = . 165s MeasurementTest#test_merge! = 0.00 s = . 165s MeasurementTest#test_set_called = 0.00 s = . 165s MeasurementTest#test_set_self_time = 0.00 s = . 165s MeasurementTest#test_set_total_time = 0.00 s = . 165s MeasurementTest#test_set_wait_time = 0.00 s = . 165s ExceptionsTest#test_profile = 0.00 s = . 165s ExceptionsTest#test_profile_allows_exceptions = 0.00 s = . 167s GcTest#test_hold_onto_call_trees = 2.13 s = . 168s GcTest#test_hold_onto_measurements = 0.53 s = . 169s GcTest#test_hold_onto_method = 1.37 s = . 170s GcTest#test_hold_onto_root_call_tree = 0.89 s = . 171s GcTest#test_hold_onto_thread = 0.87 s = . 171s SingletonTest#test_singleton = 0.00 s = . 171s PrinterCallTreeTest#test_call_tree_string = 0.27 s = . 171s DuplicateNamesTest#test_names = 0.00 s = . 171s 171s Finished in 16.011422s, 4.4968 runs/s, 63.9543 assertions/s. 171s 171s 72 runs, 1024 assertions, 0 failures, 0 errors, 0 skips 171s mv ./.gem2deb.lib lib 171s mv ./.gem2deb.ext ext 171s autopkgtest [18:51:25]: test gem2deb-test-runner: -----------------------] 172s gem2deb-test-runner PASS 172s autopkgtest [18:51:26]: test gem2deb-test-runner: - - - - - - - - - - results - - - - - - - - - - 172s autopkgtest [18:51:26]: @@@@@@@@@@@@@@@@@@@@ summary 172s ruby-prof-help PASS (superficial) 172s gem2deb-test-runner PASS 190s nova [W] Using flock in prodstack6-s390x 190s Creating nova instance adt-plucky-s390x-ruby-prof-20250315-184834-juju-7f2275-prod-proposed-migration-environment-2-1c2c00c3-1267-4fac-b2ee-ee769ba98130 from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 190s nova [W] Timed out waiting for 33c0b411-eb02-45d4-9e18-097c99e51561 to get deleted.