0s autopkgtest [12:01:00]: starting date and time: 2024-03-22 12:01:00+0000
  0s autopkgtest [12:01:00]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
  0s autopkgtest [12:01:00]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.o2mccl33/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=src:sphinx --apt-upgrade logzero --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/7.2.6-6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos02-s390x-11.secgroup --name adt-noble-s390x-logzero-20240322-120100-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
101s autopkgtest [12:02:41]: testbed dpkg architecture: s390x
102s autopkgtest [12:02:42]: testbed apt version: 2.7.12
102s autopkgtest [12:02:42]: @@@@@@@@@@@@@@@@@@@@ test bed setup
103s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
103s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3807 kB]
104s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
104s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [54.0 kB]
104s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [496 kB]
104s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [665 kB]
104s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B]
104s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B]
104s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B]
104s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [3992 kB]
104s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B]
104s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [45.1 kB]
104s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B]
106s Fetched 9195 kB in 3s (3540 kB/s)
106s Reading package lists...
109s Reading package lists...
109s Building dependency tree...
109s Reading state information...
109s Calculating upgrade...
109s The following packages will be upgraded:
109s   cloud-init debianutils fonts-ubuntu-console python3-markupsafe
109s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
109s Need to get 719 kB of archives.
109s After this operation, 11.3 kB disk space will be freed.
109s Get:1 http://ftpmaster.internal/ubuntu noble/main s390x debianutils s390x 5.17 [90.1 kB]
110s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x fonts-ubuntu-console all 0.869+git20240321-0ubuntu1 [18.7 kB]
110s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x python3-markupsafe s390x 2.1.5-1build1 [12.8 kB]
110s Get:4 http://ftpmaster.internal/ubuntu noble/main s390x cloud-init all 24.1.2-0ubuntu1 [597 kB]
110s Preconfiguring packages ...
110s Fetched 719 kB in 1s (817 kB/s)
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 ... 52171 files and directories currently installed.)
110s Preparing to unpack .../debianutils_5.17_s390x.deb ...
110s Unpacking debianutils (5.17) over (5.16) ...
110s Setting up debianutils (5.17) ...
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 ... 52171 files and directories currently installed.)
110s Preparing to unpack .../fonts-ubuntu-console_0.869+git20240321-0ubuntu1_all.deb ...
110s Unpacking fonts-ubuntu-console (0.869+git20240321-0ubuntu1) over (0.869-0ubuntu1) ...
110s Preparing to unpack .../python3-markupsafe_2.1.5-1build1_s390x.deb ...
111s Unpacking python3-markupsafe (2.1.5-1build1) over (2.1.5-1) ...
111s Preparing to unpack .../cloud-init_24.1.2-0ubuntu1_all.deb ...
111s Unpacking cloud-init (24.1.2-0ubuntu1) over (24.1.1-0ubuntu1) ...
111s Setting up fonts-ubuntu-console (0.869+git20240321-0ubuntu1) ...
111s Setting up cloud-init (24.1.2-0ubuntu1) ...
112s Setting up python3-markupsafe (2.1.5-1build1) ...
112s Processing triggers for man-db (2.12.0-3) ...
113s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
113s Reading package lists...
113s Building dependency tree...
113s Reading state information...
113s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
114s Unknown architecture, assuming PC-style ttyS0
114s sh: Attempting to set up Debian/Ubuntu apt sources automatically
114s sh: Distribution appears to be Ubuntu
115s Reading package lists...
115s Building dependency tree...
115s Reading state information...
115s eatmydata is already the newest version (131-1).
115s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
115s Reading package lists...
115s Building dependency tree...
115s Reading state information...
115s dbus is already the newest version (1.14.10-4ubuntu1).
115s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
115s Reading package lists...
116s Building dependency tree...
116s Reading state information...
116s rng-tools-debian is already the newest version (2.4).
116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
116s Reading package lists...
116s Building dependency tree...
116s Reading state information...
116s The following packages will be REMOVED:
116s   cloud-init* python3-configobj* python3-debconf*
116s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded.
116s After this operation, 3256 kB disk space will be freed.
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 ... 52170 files and directories currently installed.)
116s Removing cloud-init (24.1.2-0ubuntu1) ...
116s Removing python3-configobj (5.0.8-3) ...
116s Removing python3-debconf (1.5.86) ...
116s Processing triggers for man-db (2.12.0-3) ...
117s (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.)
117s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ...
117s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed
117s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
117s invoke-rc.d: policy-rc.d denied execution of try-restart.
118s Reading package lists...
118s Building dependency tree...
118s Reading state information...
118s linux-generic is already the newest version (6.8.0-11.11+1).
118s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
118s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease
118s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease
118s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease
120s Reading package lists...
120s Reading package lists...
120s Building dependency tree...
120s Reading state information...
120s Calculating upgrade...
120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
120s Reading package lists...
121s Building dependency tree...
121s Reading state information...
121s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
121s autopkgtest [12:03:01]: rebooting testbed after setup commands that affected boot
150s autopkgtest [12:03:30]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Tue Feb 13 23:45:46 UTC 2024
152s autopkgtest [12:03:32]: @@@@@@@@@@@@@@@@@@@@ apt-source logzero
155s Get:1 http://ftpmaster.internal/ubuntu noble/universe logzero 1.7.0-1 (dsc) [1949 B]
155s Get:2 http://ftpmaster.internal/ubuntu noble/universe logzero 1.7.0-1 (tar) [578 kB]
155s Get:3 http://ftpmaster.internal/ubuntu noble/universe logzero 1.7.0-1 (diff) [6012 B]
155s gpgv: Signature made Wed Aug 18 02:11:16 2021 UTC
155s gpgv:                using RSA key A36878F464108681600CB64844173FA13D058888
155s gpgv:                issuer "paulliu@debian.org"
155s gpgv: Can't check signature: No public key
155s dpkg-source: warning: cannot verify inline signature for ./logzero_1.7.0-1.dsc: no acceptable signature found
155s autopkgtest [12:03:35]: testing package logzero version 1.7.0-1
155s autopkgtest [12:03:35]: build not needed
156s autopkgtest [12:03:36]: test example1: preparing testbed
157s Reading package lists...
158s Building dependency tree...
158s Reading state information...
158s Starting pkgProblemResolver with broken count: 0
158s Starting 2 pkgProblemResolver with broken count: 0
158s Done
158s The following additional packages will be installed:
158s   fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore
158s   python-logzero-doc python3-logzero sphinx-rtd-theme-common
158s Recommended packages:
158s   javascript-common
158s The following NEW packages will be installed:
158s   autopkgtest-satdep fonts-font-awesome fonts-lato libjs-jquery
158s   libjs-sphinxdoc libjs-underscore python-logzero-doc python3-logzero
158s   sphinx-rtd-theme-common
158s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded.
158s Need to get 5493 kB/5493 kB of archives.
158s After this operation, 16.8 MB of additional disk space will be used.
158s Get:1 /tmp/autopkgtest.kUCG4i/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [716 B]
158s Get:2 http://ftpmaster.internal/ubuntu noble/main s390x fonts-lato all 2.015-1 [2781 kB]
160s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB]
160s Get:4 http://ftpmaster.internal/ubuntu noble/main s390x libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB]
160s Get:5 http://ftpmaster.internal/ubuntu noble/main s390x libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB]
160s Get:6 http://ftpmaster.internal/ubuntu noble/main s390x libjs-sphinxdoc all 7.2.6-4 [149 kB]
160s Get:7 http://ftpmaster.internal/ubuntu noble/main s390x sphinx-rtd-theme-common all 2.0.0+dfsg-1 [1012 kB]
160s Get:8 http://ftpmaster.internal/ubuntu noble/universe s390x python-logzero-doc all 1.7.0-1 [573 kB]
160s Get:9 http://ftpmaster.internal/ubuntu noble/universe s390x python3-logzero all 1.7.0-1 [16.5 kB]
161s Fetched 5493 kB in 2s (2295 kB/s)
161s Selecting previously unselected package fonts-lato.
161s (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.)
161s Preparing to unpack .../0-fonts-lato_2.015-1_all.deb ...
161s Unpacking fonts-lato (2.015-1) ...
161s Selecting previously unselected package fonts-font-awesome.
161s Preparing to unpack .../1-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ...
161s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ...
161s Selecting previously unselected package libjs-jquery.
161s Preparing to unpack .../2-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ...
161s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
161s Selecting previously unselected package libjs-underscore.
161s Preparing to unpack .../3-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ...
161s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ...
161s Selecting previously unselected package libjs-sphinxdoc.
161s Preparing to unpack .../4-libjs-sphinxdoc_7.2.6-4_all.deb ...
161s Unpacking libjs-sphinxdoc (7.2.6-4) ...
161s Selecting previously unselected package sphinx-rtd-theme-common.
161s Preparing to unpack .../5-sphinx-rtd-theme-common_2.0.0+dfsg-1_all.deb ...
161s Unpacking sphinx-rtd-theme-common (2.0.0+dfsg-1) ...
161s Selecting previously unselected package python-logzero-doc.
161s Preparing to unpack .../6-python-logzero-doc_1.7.0-1_all.deb ...
161s Unpacking python-logzero-doc (1.7.0-1) ...
161s Selecting previously unselected package python3-logzero.
161s Preparing to unpack .../7-python3-logzero_1.7.0-1_all.deb ...
161s Unpacking python3-logzero (1.7.0-1) ...
161s Selecting previously unselected package autopkgtest-satdep.
161s Preparing to unpack .../8-1-autopkgtest-satdep.deb ...
161s Unpacking autopkgtest-satdep (0) ...
161s Setting up python3-logzero (1.7.0-1) ...
161s Setting up fonts-lato (2.015-1) ...
161s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
161s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ...
161s Setting up sphinx-rtd-theme-common (2.0.0+dfsg-1) ...
161s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ...
161s Setting up libjs-sphinxdoc (7.2.6-4) ...
161s Setting up python-logzero-doc (1.7.0-1) ...
161s Setting up autopkgtest-satdep (0) ...
164s (Reading database ... 51968 files and directories currently installed.)
164s Removing autopkgtest-satdep (0) ...
164s autopkgtest [12:03:44]: test example1: [-----------------------
164s [D 240322 12:03:43 example1:6] hello
164s [I 240322 12:03:43 example1:7] info
164s [W 240322 12:03:43 example1:8] warning
164s [E 240322 12:03:43 example1:9] error
164s [E 240322 12:03:43 example1:15] this is a demo exception
164s     Traceback (most recent call last):
164s       File "/tmp/autopkgtest.kUCG4i/build.27D/src/debian/tests/example1", line 13, in <module>
164s         raise Exception("this is a demo exception")
164s     Exception: this is a demo exception
165s autopkgtest [12:03:45]: test example1: -----------------------]
165s example1             PASS
165s autopkgtest [12:03:45]: test example1:  - - - - - - - - - - results - - - - - - - - - -
166s autopkgtest [12:03:46]: @@@@@@@@@@@@@@@@@@@@ summary
166s example1             PASS
178s Creating nova instance adt-noble-s390x-logzero-20240322-120100-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-s390x-server-20240321.img (UUID f7ee8f0f-480f-4014-94f0-3be2a19e259d)...