0s autopkgtest [15:53:43]: starting date and time: 2024-03-23 15:53:43+0000 0s autopkgtest [15:53:43]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [15:53:43]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vfvabs93/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-3@bos03-arm64-9.secgroup --name adt-noble-arm64-logzero-20240323-152625-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --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/ 69s autopkgtest [15:54:52]: testbed dpkg architecture: arm64 69s autopkgtest [15:54:52]: testbed apt version: 2.7.12 69s autopkgtest [15:54:52]: @@@@@@@@@@@@@@@@@@@@ test bed setup 69s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 70s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [493 kB] 70s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3969 kB] 70s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB] 70s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 70s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [667 kB] 70s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 70s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.7 kB] 70s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 70s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4345 kB] 70s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 70s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [69.8 kB] 71s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 72s Fetched 9770 kB in 2s (4786 kB/s) 72s Reading package lists... 76s Reading package lists... 76s Building dependency tree... 76s Reading state information... 77s Calculating upgrade... 78s The following packages will be upgraded: 78s cloud-init fonts-ubuntu-console libbsd0 libc-bin libc6 locales 78s python3-markupsafe 78s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 78s Need to get 8268 kB of archives. 78s After this operation, 63.5 kB disk space will be freed. 78s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 libc6 arm64 2.39-0ubuntu6 [2776 kB] 79s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libc-bin arm64 2.39-0ubuntu6 [591 kB] 79s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 libbsd0 arm64 0.12.1-1 [41.0 kB] 79s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 locales all 2.39-0ubuntu6 [4232 kB] 79s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 fonts-ubuntu-console all 0.869+git20240321-0ubuntu1 [18.7 kB] 79s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 python3-markupsafe arm64 2.1.5-1build1 [12.5 kB] 79s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 cloud-init all 24.1.2-0ubuntu1 [597 kB] 79s Preconfiguring packages ... 80s Fetched 8268 kB in 1s (9369 kB/s) 80s (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 ... 74820 files and directories currently installed.) 80s Preparing to unpack .../libc6_2.39-0ubuntu6_arm64.deb ... 80s Unpacking libc6:arm64 (2.39-0ubuntu6) over (2.39-0ubuntu2) ... 80s Setting up libc6:arm64 (2.39-0ubuntu6) ... 81s (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 ... 74820 files and directories currently installed.) 81s Preparing to unpack .../libc-bin_2.39-0ubuntu6_arm64.deb ... 81s Unpacking libc-bin (2.39-0ubuntu6) over (2.39-0ubuntu2) ... 81s Setting up libc-bin (2.39-0ubuntu6) ... 81s (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 ... 74820 files and directories currently installed.) 81s Preparing to unpack .../libbsd0_0.12.1-1_arm64.deb ... 81s Unpacking libbsd0:arm64 (0.12.1-1) over (0.11.8-1) ... 81s Preparing to unpack .../locales_2.39-0ubuntu6_all.deb ... 81s Unpacking locales (2.39-0ubuntu6) over (2.39-0ubuntu2) ... 82s Preparing to unpack .../fonts-ubuntu-console_0.869+git20240321-0ubuntu1_all.deb ... 82s Unpacking fonts-ubuntu-console (0.869+git20240321-0ubuntu1) over (0.869-0ubuntu1) ... 82s Preparing to unpack .../python3-markupsafe_2.1.5-1build1_arm64.deb ... 82s Unpacking python3-markupsafe (2.1.5-1build1) over (2.1.5-1) ... 82s Preparing to unpack .../cloud-init_24.1.2-0ubuntu1_all.deb ... 82s Unpacking cloud-init (24.1.2-0ubuntu1) over (24.1.1-0ubuntu1) ... 82s Setting up fonts-ubuntu-console (0.869+git20240321-0ubuntu1) ... 82s Setting up cloud-init (24.1.2-0ubuntu1) ... 84s Setting up locales (2.39-0ubuntu6) ... 84s Generating locales (this might take a while)... 87s en_US.UTF-8... done 87s Generation complete. 87s Setting up python3-markupsafe (2.1.5-1build1) ... 87s Setting up libbsd0:arm64 (0.12.1-1) ... 87s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 87s Processing triggers for man-db (2.12.0-3) ... 88s Processing triggers for libc-bin (2.39-0ubuntu6) ... 89s Reading package lists... 89s Building dependency tree... 89s Reading state information... 90s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 90s sh: Attempting to set up Debian/Ubuntu apt sources automatically 90s sh: Distribution appears to be Ubuntu 91s Reading package lists... 91s Building dependency tree... 91s Reading state information... 92s eatmydata is already the newest version (131-1). 92s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 92s Reading package lists... 92s Building dependency tree... 92s Reading state information... 93s dbus is already the newest version (1.14.10-4ubuntu1). 93s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 93s Reading package lists... 93s Building dependency tree... 93s Reading state information... 93s rng-tools-debian is already the newest version (2.4). 93s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 93s Reading package lists... 94s Building dependency tree... 94s Reading state information... 94s The following packages will be REMOVED: 94s cloud-init* python3-configobj* python3-debconf* 94s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 94s After this operation, 3256 kB disk space will be freed. 94s (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 ... 74819 files and directories currently installed.) 94s Removing cloud-init (24.1.2-0ubuntu1) ... 95s Removing python3-configobj (5.0.8-3) ... 95s Removing python3-debconf (1.5.86) ... 95s Processing triggers for man-db (2.12.0-3) ... 95s (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 ... 74430 files and directories currently installed.) 95s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 96s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 96s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 96s invoke-rc.d: policy-rc.d denied execution of try-restart. 96s Reading package lists... 96s Building dependency tree... 96s Reading state information... 97s linux-generic is already the newest version (6.8.0-11.11+1). 97s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 98s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 98s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 98s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 100s Reading package lists... 100s Reading package lists... 100s Building dependency tree... 100s Reading state information... 101s Calculating upgrade... 101s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 102s Reading package lists... 102s Building dependency tree... 102s Reading state information... 102s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 103s autopkgtest [15:55:26]: rebooting testbed after setup commands that affected boot 130s autopkgtest [15:55:53]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024 134s autopkgtest [15:55:57]: @@@@@@@@@@@@@@@@@@@@ apt-source logzero 137s Get:1 http://ftpmaster.internal/ubuntu noble/universe logzero 1.7.0-1 (dsc) [1949 B] 137s Get:2 http://ftpmaster.internal/ubuntu noble/universe logzero 1.7.0-1 (tar) [578 kB] 137s Get:3 http://ftpmaster.internal/ubuntu noble/universe logzero 1.7.0-1 (diff) [6012 B] 137s gpgv: Signature made Wed Aug 18 02:11:16 2021 UTC 137s gpgv: using RSA key A36878F464108681600CB64844173FA13D058888 137s gpgv: issuer "paulliu@debian.org" 137s gpgv: Can't check signature: No public key 137s dpkg-source: warning: cannot verify inline signature for ./logzero_1.7.0-1.dsc: no acceptable signature found 137s autopkgtest [15:56:00]: testing package logzero version 1.7.0-1 138s autopkgtest [15:56:01]: build not needed 138s autopkgtest [15:56:01]: test example1: preparing testbed 141s Reading package lists... 142s Building dependency tree... 142s Reading state information... 142s Starting pkgProblemResolver with broken count: 0 142s Starting 2 pkgProblemResolver with broken count: 0 142s Done 143s The following additional packages will be installed: 143s fonts-font-awesome fonts-lato libjs-jquery libjs-sphinxdoc libjs-underscore 143s python-logzero-doc python3-logzero sphinx-rtd-theme-common 143s Recommended packages: 143s javascript-common 143s The following NEW packages will be installed: 143s autopkgtest-satdep fonts-font-awesome fonts-lato libjs-jquery 143s libjs-sphinxdoc libjs-underscore python-logzero-doc python3-logzero 143s sphinx-rtd-theme-common 143s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 143s Need to get 5493 kB/5493 kB of archives. 143s After this operation, 16.8 MB of additional disk space will be used. 143s Get:1 /tmp/autopkgtest.IgXGTo/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [724 B] 143s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 fonts-lato all 2.015-1 [2781 kB] 144s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 fonts-font-awesome all 5.0.10+really4.7.0~dfsg-4.1 [516 kB] 144s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 144s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 144s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-sphinxdoc all 7.2.6-4 [149 kB] 144s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 sphinx-rtd-theme-common all 2.0.0+dfsg-1 [1012 kB] 144s Get:8 http://ftpmaster.internal/ubuntu noble/universe arm64 python-logzero-doc all 1.7.0-1 [573 kB] 144s Get:9 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-logzero all 1.7.0-1 [16.5 kB] 144s Fetched 5493 kB in 1s (6995 kB/s) 144s Selecting previously unselected package fonts-lato. 144s (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 ... 74375 files and directories currently installed.) 144s Preparing to unpack .../0-fonts-lato_2.015-1_all.deb ... 144s Unpacking fonts-lato (2.015-1) ... 145s Selecting previously unselected package fonts-font-awesome. 145s Preparing to unpack .../1-fonts-font-awesome_5.0.10+really4.7.0~dfsg-4.1_all.deb ... 145s Unpacking fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 145s Selecting previously unselected package libjs-jquery. 145s Preparing to unpack .../2-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 145s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 145s Selecting previously unselected package libjs-underscore. 145s Preparing to unpack .../3-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 145s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 145s Selecting previously unselected package libjs-sphinxdoc. 145s Preparing to unpack .../4-libjs-sphinxdoc_7.2.6-4_all.deb ... 145s Unpacking libjs-sphinxdoc (7.2.6-4) ... 145s Selecting previously unselected package sphinx-rtd-theme-common. 145s Preparing to unpack .../5-sphinx-rtd-theme-common_2.0.0+dfsg-1_all.deb ... 145s Unpacking sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 145s Selecting previously unselected package python-logzero-doc. 145s Preparing to unpack .../6-python-logzero-doc_1.7.0-1_all.deb ... 145s Unpacking python-logzero-doc (1.7.0-1) ... 145s Selecting previously unselected package python3-logzero. 145s Preparing to unpack .../7-python3-logzero_1.7.0-1_all.deb ... 145s Unpacking python3-logzero (1.7.0-1) ... 145s Selecting previously unselected package autopkgtest-satdep. 145s Preparing to unpack .../8-1-autopkgtest-satdep.deb ... 145s Unpacking autopkgtest-satdep (0) ... 145s Setting up python3-logzero (1.7.0-1) ... 145s Setting up fonts-lato (2.015-1) ... 145s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 145s Setting up fonts-font-awesome (5.0.10+really4.7.0~dfsg-4.1) ... 145s Setting up sphinx-rtd-theme-common (2.0.0+dfsg-1) ... 145s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 145s Setting up libjs-sphinxdoc (7.2.6-4) ... 145s Setting up python-logzero-doc (1.7.0-1) ... 145s Setting up autopkgtest-satdep (0) ... 149s (Reading database ... 74617 files and directories currently installed.) 149s Removing autopkgtest-satdep (0) ... 150s autopkgtest [15:56:13]: test example1: [----------------------- 150s [D 240323 15:56:14 example1:6] hello 150s [I 240323 15:56:14 example1:7] info 150s [W 240323 15:56:14 example1:8] warning 150s [E 240323 15:56:14 example1:9] error 150s [E 240323 15:56:14 example1:15] this is a demo exception 150s Traceback (most recent call last): 150s File "/tmp/autopkgtest.IgXGTo/build.Ctd/src/debian/tests/example1", line 13, in 150s raise Exception("this is a demo exception") 150s Exception: this is a demo exception 151s autopkgtest [15:56:14]: test example1: -----------------------] 151s autopkgtest [15:56:14]: test example1: - - - - - - - - - - results - - - - - - - - - - 151s example1 PASS 152s autopkgtest [15:56:15]: @@@@@@@@@@@@@@@@@@@@ summary 152s example1 PASS 156s Creating nova instance adt-noble-arm64-logzero-20240323-152625-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-arm64-server-20240321.img (UUID 28ecccfc-4cb0-4cc6-a280-209e2d140e10)...