0s autopkgtest [12:48:54]: starting date and time: 2024-03-26 12:48:54+0000 0s autopkgtest [12:48:54]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [12:48:54]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.qff1j8h8/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 iotop --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=iotop/0.6-42-ga14256a-0.2 python3-defaults/3.12.2-0ubuntu1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos02-s390x-7.secgroup --name adt-noble-s390x-iotop-20240326-124854-juju-7f2275-prod-proposed-migration-environment-2-2d6cbba2-e0b1-4952-ba94-400b3091a56c --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/ 147s autopkgtest [12:51:21]: testbed dpkg architecture: s390x 147s autopkgtest [12:51:21]: testbed apt version: 2.7.12 147s autopkgtest [12:51:21]: @@@@@@@@@@@@@@@@@@@@ test bed setup 148s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 148s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [4019 kB] 149s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [8504 B] 149s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [496 kB] 149s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.0 kB] 149s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [690 kB] 149s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B] 149s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B] 149s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B] 149s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [4128 kB] 150s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B] 150s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [47.8 kB] 150s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B] 151s Fetched 9575 kB in 3s (3132 kB/s) 152s Reading package lists... 153s Reading package lists... 153s Building dependency tree... 153s Reading state information... 154s Calculating upgrade... 154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 154s Reading package lists... 154s Building dependency tree... 154s Reading state information... 154s 0 upgraded, 0 newly installed, 0 to remove and 244 not upgraded. 155s Unknown architecture, assuming PC-style ttyS0 155s sh: Attempting to set up Debian/Ubuntu apt sources automatically 155s sh: Distribution appears to be Ubuntu 155s Reading package lists... 156s Building dependency tree... 156s Reading state information... 156s eatmydata is already the newest version (131-1). 156s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 156s Reading package lists... 156s Building dependency tree... 156s Reading state information... 156s dbus is already the newest version (1.14.10-4ubuntu1). 156s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 156s Reading package lists... 157s Building dependency tree... 157s Reading state information... 157s rng-tools-debian is already the newest version (2.4). 157s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 157s Reading package lists... 157s Building dependency tree... 157s Reading state information... 157s The following packages will be REMOVED: 157s cloud-init* python3-configobj* python3-debconf* 157s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 157s After this operation, 3256 kB disk space will be freed. 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 ... 52170 files and directories currently installed.) 157s Removing cloud-init (24.1.2-0ubuntu1) ... 158s Removing python3-configobj (5.0.8-3) ... 158s Removing python3-debconf (1.5.86) ... 158s Processing triggers for man-db (2.12.0-3) ... 158s (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.) 158s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 159s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 159s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 159s invoke-rc.d: policy-rc.d denied execution of try-restart. 159s Reading package lists... 159s Building dependency tree... 159s Reading state information... 159s linux-generic is already the newest version (6.8.0-11.11+1). 159s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 160s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 160s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 160s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 162s Reading package lists... 162s Reading package lists... 162s Building dependency tree... 162s Reading state information... 162s Calculating upgrade... 162s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 163s Reading package lists... 163s Building dependency tree... 163s Reading state information... 163s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 163s autopkgtest [12:51:37]: rebooting testbed after setup commands that affected boot 178s autopkgtest [12:51:52]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Tue Feb 13 23:45:46 UTC 2024 181s autopkgtest [12:51:55]: @@@@@@@@@@@@@@@@@@@@ apt-source iotop 182s Get:1 http://ftpmaster.internal/ubuntu noble/main iotop 0.6-42-ga14256a-0.1build3 (dsc) [1904 B] 182s Get:2 http://ftpmaster.internal/ubuntu noble/main iotop 0.6-42-ga14256a-0.1build3 (tar) [28.8 kB] 182s Get:3 http://ftpmaster.internal/ubuntu noble/main iotop 0.6-42-ga14256a-0.1build3 (diff) [7748 B] 182s gpgv: Signature made Tue Oct 31 17:02:27 2023 UTC 182s gpgv: using RSA key 25E3FF2D7F469DBE7D0D4E50AFCFEC8E669CE1C2 182s gpgv: Can't check signature: No public key 182s dpkg-source: warning: cannot verify inline signature for ./iotop_0.6-42-ga14256a-0.1build3.dsc: no acceptable signature found 183s autopkgtest [12:51:57]: testing package iotop version 0.6-42-ga14256a-0.1build3 183s autopkgtest [12:51:57]: build not needed 183s autopkgtest [12:51:57]: test command1: preparing testbed 184s Reading package lists... 184s Building dependency tree... 184s Reading state information... 184s Starting pkgProblemResolver with broken count: 0 184s Starting 2 pkgProblemResolver with broken count: 0 185s Done 185s The following additional packages will be installed: 185s iotop python3-all 185s The following NEW packages will be installed: 185s autopkgtest-satdep iotop python3-all 185s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 185s Need to get 25.4 kB/26.1 kB of archives. 185s After this operation, 114 kB of additional disk space will be used. 185s Get:1 /tmp/autopkgtest.QxbhUj/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [712 B] 185s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x iotop s390x 0.6-42-ga14256a-0.1build3 [24.5 kB] 185s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x python3-all s390x 3.12.1-0ubuntu2 [908 B] 185s Fetched 25.4 kB in 0s (88.2 kB/s) 185s Selecting previously unselected package iotop. 186s (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.) 186s Preparing to unpack .../iotop_0.6-42-ga14256a-0.1build3_s390x.deb ... 186s Unpacking iotop (0.6-42-ga14256a-0.1build3) ... 186s Selecting previously unselected package python3-all. 186s Preparing to unpack .../python3-all_3.12.1-0ubuntu2_s390x.deb ... 186s Unpacking python3-all (3.12.1-0ubuntu2) ... 186s Selecting previously unselected package autopkgtest-satdep. 186s Preparing to unpack .../1-autopkgtest-satdep.deb ... 186s Unpacking autopkgtest-satdep (0) ... 186s Setting up python3-all (3.12.1-0ubuntu2) ... 186s Setting up iotop (0.6-42-ga14256a-0.1build3) ... 186s update-alternatives: using /usr/sbin/iotop-py to provide /usr/sbin/iotop (iotop) in auto mode 186s Setting up autopkgtest-satdep (0) ... 186s Processing triggers for man-db (2.12.0-3) ... 188s (Reading database ... 51749 files and directories currently installed.) 188s Removing autopkgtest-satdep (0) ... 189s autopkgtest [12:52:03]: test command1: set -e ; for py in $(py3versions -r 2>/dev/null) ; do cd "$AUTOPKGTEST_TMP" ; echo "Testing with $py:" ; $py -c "import iotop; print(iotop)" ; done 189s autopkgtest [12:52:03]: test command1: [----------------------- 189s Testing with python3.12: 189s 189s autopkgtest [12:52:03]: test command1: -----------------------] 190s command1 PASS 190s autopkgtest [12:52:04]: test command1: - - - - - - - - - - results - - - - - - - - - - 190s autopkgtest [12:52:04]: test command2: preparing testbed 378s autopkgtest [12:55:12]: testbed dpkg architecture: s390x 378s autopkgtest [12:55:12]: testbed apt version: 2.7.12 378s autopkgtest [12:55:12]: @@@@@@@@@@@@@@@@@@@@ test bed setup 379s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 380s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [4019 kB] 382s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [8504 B] 382s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.0 kB] 382s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [496 kB] 382s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [690 kB] 382s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B] 382s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B] 382s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B] 382s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [4128 kB] 383s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B] 383s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [47.8 kB] 383s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B] 385s Fetched 9575 kB in 5s (2028 kB/s) 385s Reading package lists... 387s Reading package lists... 387s Building dependency tree... 387s Reading state information... 387s Calculating upgrade... 387s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 387s Reading package lists... 387s Building dependency tree... 387s Reading state information... 387s 0 upgraded, 0 newly installed, 0 to remove and 244 not upgraded. 388s Unknown architecture, assuming PC-style ttyS0 388s sh: Attempting to set up Debian/Ubuntu apt sources automatically 388s sh: Distribution appears to be Ubuntu 389s Reading package lists... 389s Building dependency tree... 389s Reading state information... 389s eatmydata is already the newest version (131-1). 389s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 389s Reading package lists... 389s Building dependency tree... 389s Reading state information... 389s dbus is already the newest version (1.14.10-4ubuntu1). 389s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 389s Reading package lists... 389s Building dependency tree... 389s Reading state information... 390s rng-tools-debian is already the newest version (2.4). 390s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 390s Reading package lists... 390s Building dependency tree... 390s Reading state information... 390s The following packages will be REMOVED: 390s cloud-init* python3-configobj* python3-debconf* 390s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 390s After this operation, 3256 kB disk space will be freed. 390s (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.) 390s Removing cloud-init (24.1.2-0ubuntu1) ... 391s Removing python3-configobj (5.0.8-3) ... 391s Removing python3-debconf (1.5.86) ... 391s Processing triggers for man-db (2.12.0-3) ... 391s (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.) 391s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 392s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 392s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 392s invoke-rc.d: policy-rc.d denied execution of try-restart. 392s Reading package lists... 392s Building dependency tree... 392s Reading state information... 392s linux-generic is already the newest version (6.8.0-11.11+1). 392s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 393s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 393s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 393s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 394s Reading package lists... 394s Reading package lists... 395s Building dependency tree... 395s Reading state information... 395s Calculating upgrade... 395s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 395s Reading package lists... 395s Building dependency tree... 395s Reading state information... 395s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 395s autopkgtest [12:55:29]: rebooting testbed after setup commands that affected boot 413s Reading package lists... 413s Building dependency tree... 413s Reading state information... 413s Starting pkgProblemResolver with broken count: 0 413s Starting 2 pkgProblemResolver with broken count: 0 413s Done 414s The following additional packages will be installed: 414s iotop 414s The following NEW packages will be installed: 414s autopkgtest-satdep iotop 414s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 414s Need to get 24.5 kB/25.2 kB of archives. 414s After this operation, 108 kB of additional disk space will be used. 414s Get:1 /tmp/autopkgtest.QxbhUj/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [700 B] 414s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x iotop s390x 0.6-42-ga14256a-0.1build3 [24.5 kB] 414s Fetched 24.5 kB in 0s (111 kB/s) 414s Selecting previously unselected package iotop. 414s (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.) 414s Preparing to unpack .../iotop_0.6-42-ga14256a-0.1build3_s390x.deb ... 414s Unpacking iotop (0.6-42-ga14256a-0.1build3) ... 414s Selecting previously unselected package autopkgtest-satdep. 414s Preparing to unpack .../2-autopkgtest-satdep.deb ... 414s Unpacking autopkgtest-satdep (0) ... 414s Setting up iotop (0.6-42-ga14256a-0.1build3) ... 414s update-alternatives: using /usr/sbin/iotop-py to provide /usr/sbin/iotop (iotop) in auto mode 414s Setting up autopkgtest-satdep (0) ... 414s Processing triggers for man-db (2.12.0-3) ... 417s (Reading database ... 51748 files and directories currently installed.) 417s Removing autopkgtest-satdep (0) ... 418s autopkgtest [12:55:52]: test command2: cd "$AUTOPKGTEST_TMP" ; iotop --only --batch --time --quiet --iter 10 418s autopkgtest [12:55:52]: test command2: [----------------------- 418s 12:55:51 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 418s 12:55:51 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 418s TIME TID PRIO USER DISK READ DISK WRITE SWAPIN IO COMMAND 419s 12:55:52 Total DISK READ: 0.00 B/s | Total DISK WRITE: 3.99 K/s 419s 12:55:52 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 419s 12:55:52 1098 be/4 root 0.00 B/s 3.99 K/s ?unavailable? tee -a -- /tmp/autopkgtest.QxbhUj/command2-stdout 420s 12:55:53 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 420s 12:55:53 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 421s 12:55:54 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 421s 12:55:54 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 422s 12:55:55 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 422s 12:55:55 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 423s 12:55:56 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 423s 12:55:56 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 424s 12:55:57 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 424s 12:55:57 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 425s 12:55:58 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 425s 12:55:58 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 426s 12:55:59 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 426s 12:55:59 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 427s 12:56:00 Total DISK READ: 0.00 B/s | Total DISK WRITE: 0.00 B/s 427s 12:56:00 Current DISK READ: 0.00 B/s | Current DISK WRITE: 0.00 B/s 428s autopkgtest [12:56:02]: test command2: -----------------------] 428s autopkgtest [12:56:02]: test command2: - - - - - - - - - - results - - - - - - - - - - 428s command2 PASS 428s autopkgtest [12:56:02]: @@@@@@@@@@@@@@@@@@@@ summary 428s command1 PASS 428s command2 PASS 440s Creating nova instance adt-noble-s390x-iotop-20240326-124854-juju-7f2275-prod-proposed-migration-environment-2-2d6cbba2-e0b1-4952-ba94-400b3091a56c from image adt/ubuntu-noble-s390x-server-20240326.img (UUID c527e0e4-2e65-4e86-ad63-05d7f665f2fb)... 440s Creating nova instance adt-noble-s390x-iotop-20240326-124854-juju-7f2275-prod-proposed-migration-environment-2-2d6cbba2-e0b1-4952-ba94-400b3091a56c from image adt/ubuntu-noble-s390x-server-20240326.img (UUID c527e0e4-2e65-4e86-ad63-05d7f665f2fb)...