0s autopkgtest [11:18:35]: starting date and time: 2025-02-19 11:18:35+0000 0s autopkgtest [11:18:35]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [11:18:35]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.kfr8gis0/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:sphinx --apt-upgrade beautifulsoup4 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/8.1.3-5 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@lcy02-72.secgroup --name adt-plucky-amd64-beautifulsoup4-20250219-111834-juju-7f2275-prod-proposed-migration-environment-2-1d26c599-c010-46ef-be91-4daa2a908954 --image adt/ubuntu-plucky-amd64-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,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/ 55s autopkgtest [11:19:30]: testbed dpkg architecture: amd64 55s autopkgtest [11:19:30]: testbed apt version: 2.9.29 55s autopkgtest [11:19:30]: @@@@@@@@@@@@@@@@@@@@ test bed setup 55s autopkgtest [11:19:30]: testbed release detected to be: None 55s autopkgtest [11:19:30]: updating testbed package index (apt update) 56s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 56s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 56s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 56s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 56s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.1 kB] 56s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 56s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.9 kB] 56s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [750 kB] 56s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [101 kB] 56s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [81.8 kB] 56s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/restricted i386 Packages [2412 B] 56s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [7984 B] 56s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [697 kB] 56s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [265 kB] 56s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [3128 B] 56s Get:16 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [11.5 kB] 56s Fetched 2124 kB in 0s (5448 kB/s) 57s Reading package lists... 57s Reading package lists... 58s Building dependency tree... 58s Reading state information... 58s Calculating upgrade... 58s The following NEW packages will be installed: 58s libapt-pkg7.0 58s The following packages will be upgraded: 58s apt apt-utils iproute2 liblsof0 libp11-kit0 lsof rsyslog 58s 7 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 58s Need to get 5234 kB of archives. 58s After this operation, 4074 kB of additional disk space will be used. 58s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 libapt-pkg7.0 amd64 2.9.30 [1131 kB] 58s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 apt amd64 2.9.30 [1434 kB] 59s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 apt-utils amd64 2.9.30 [222 kB] 59s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 iproute2 amd64 6.13.0-1ubuntu1 [1277 kB] 59s Get:5 http://ftpmaster.internal/ubuntu plucky/main amd64 libp11-kit0 amd64 0.25.5-2ubuntu3 [311 kB] 59s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 rsyslog amd64 8.2412.0-2ubuntu1 [555 kB] 59s Get:7 http://ftpmaster.internal/ubuntu plucky/main amd64 lsof amd64 4.99.4+dfsg-1 [245 kB] 59s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 liblsof0 amd64 4.99.4+dfsg-1 [59.6 kB] 59s Preconfiguring packages ... 59s Fetched 5234 kB in 0s (26.6 MB/s) 59s Selecting previously unselected package libapt-pkg7.0:amd64. 59s (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 ... 108925 files and directories currently installed.) 59s Preparing to unpack .../libapt-pkg7.0_2.9.30_amd64.deb ... 59s Unpacking libapt-pkg7.0:amd64 (2.9.30) ... 59s Setting up libapt-pkg7.0:amd64 (2.9.30) ... 59s (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 ... 108974 files and directories currently installed.) 59s Preparing to unpack .../archives/apt_2.9.30_amd64.deb ... 59s Unpacking apt (2.9.30) over (2.9.29) ... 60s Setting up apt (2.9.30) ... 60s (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 ... 108974 files and directories currently installed.) 60s Preparing to unpack .../0-apt-utils_2.9.30_amd64.deb ... 60s Unpacking apt-utils (2.9.30) over (2.9.29) ... 60s Preparing to unpack .../1-iproute2_6.13.0-1ubuntu1_amd64.deb ... 61s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ... 61s Preparing to unpack .../2-libp11-kit0_0.25.5-2ubuntu3_amd64.deb ... 61s Unpacking libp11-kit0:amd64 (0.25.5-2ubuntu3) over (0.25.5-2ubuntu2) ... 61s Preparing to unpack .../3-rsyslog_8.2412.0-2ubuntu1_amd64.deb ... 61s Unpacking rsyslog (8.2412.0-2ubuntu1) over (8.2412.0-1ubuntu1) ... 61s Preparing to unpack .../4-lsof_4.99.4+dfsg-1_amd64.deb ... 61s Unpacking lsof (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ... 61s Preparing to unpack .../5-liblsof0_4.99.4+dfsg-1_amd64.deb ... 61s Unpacking liblsof0 (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ... 61s Setting up apt-utils (2.9.30) ... 61s Setting up liblsof0 (4.99.4+dfsg-1) ... 61s Setting up iproute2 (6.13.0-1ubuntu1) ... 61s Setting up rsyslog (8.2412.0-2ubuntu1) ... 61s info: The user `syslog' is already a member of `adm'. 62s Setting up libp11-kit0:amd64 (0.25.5-2ubuntu3) ... 62s Setting up lsof (4.99.4+dfsg-1) ... 62s Processing triggers for man-db (2.13.0-1) ... 64s Processing triggers for libc-bin (2.40-4ubuntu1) ... 65s Reading package lists... 66s Building dependency tree... 66s Reading state information... 66s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 66s autopkgtest [11:19:41]: upgrading testbed (apt dist-upgrade and autopurge) 66s Reading package lists... 66s Building dependency tree... 66s Reading state information... 67s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 67s Starting 2 pkgProblemResolver with broken count: 0 67s Done 67s Entering ResolveByKeep 68s 68s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 68s Reading package lists... 68s Building dependency tree... 68s Reading state information... 69s Starting pkgProblemResolver with broken count: 0 69s Starting 2 pkgProblemResolver with broken count: 0 69s Done 69s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 69s autopkgtest [11:19:44]: rebooting testbed after setup commands that affected boot 73s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 84s autopkgtest [11:19:59]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Tue Feb 4 16:02:16 UTC 2025 85s autopkgtest [11:20:00]: @@@@@@@@@@@@@@@@@@@@ apt-source beautifulsoup4 87s Get:1 http://ftpmaster.internal/ubuntu plucky/main beautifulsoup4 4.13.3-1 (dsc) [1874 B] 87s Get:2 http://ftpmaster.internal/ubuntu plucky/main beautifulsoup4 4.13.3-1 (tar) [620 kB] 87s Get:3 http://ftpmaster.internal/ubuntu plucky/main beautifulsoup4 4.13.3-1 (diff) [8092 B] 87s gpgv: Signature made Wed Feb 5 17:14:19 2025 UTC 87s gpgv: using EDDSA key EE9AD6F90520FA11F69F4824477B0DB0263A54D8 87s gpgv: issuer "stefanor@debian.org" 87s gpgv: Can't check signature: No public key 87s dpkg-source: warning: cannot verify inline signature for ./beautifulsoup4_4.13.3-1.dsc: no acceptable signature found 87s autopkgtest [11:20:02]: testing package beautifulsoup4 version 4.13.3-1 87s autopkgtest [11:20:02]: build not needed 87s autopkgtest [11:20:02]: test unittests3: preparing testbed 88s Reading package lists... 88s Building dependency tree... 88s Reading state information... 88s Starting pkgProblemResolver with broken count: 0 88s Starting 2 pkgProblemResolver with broken count: 0 88s Done 89s The following NEW packages will be installed: 89s libxslt1.1 python3-all python3-bs4 python3-html5lib python3-iniconfig 89s python3-lxml python3-packaging python3-pluggy python3-pytest 89s python3-soupsieve python3-webencodings python3.12 python3.12-minimal 89s 0 upgraded, 13 newly installed, 0 to remove and 0 not upgraded. 89s Need to get 5629 kB of archives. 89s After this operation, 21.7 MB of additional disk space will be used. 89s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.12-minimal amd64 3.12.9-1 [2348 kB] 89s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.12 amd64 3.12.9-1 [671 kB] 89s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 libxslt1.1 amd64 1.1.39-0exp1ubuntu2 [175 kB] 89s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-all amd64 3.13.1-1~exp2 [894 B] 89s Get:5 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-soupsieve all 2.6-1 [33.0 kB] 89s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-bs4 all 4.13.3-1 [136 kB] 89s Get:7 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-webencodings all 0.5.1-5 [11.5 kB] 89s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-html5lib all 1.2-1 [90.8 kB] 89s Get:9 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-iniconfig all 1.1.1-2 [6024 B] 89s Get:10 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-lxml amd64 5.3.1-1 [1831 kB] 89s Get:11 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-packaging all 24.2-1 [51.5 kB] 89s Get:12 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pluggy all 1.5.0-1 [21.0 kB] 89s Get:13 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pytest all 8.3.4-1 [252 kB] 89s Fetched 5629 kB in 0s (12.4 MB/s) 89s Selecting previously unselected package python3.12-minimal. 90s (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 ... 108975 files and directories currently installed.) 90s Preparing to unpack .../00-python3.12-minimal_3.12.9-1_amd64.deb ... 90s Unpacking python3.12-minimal (3.12.9-1) ... 90s Selecting previously unselected package python3.12. 90s Preparing to unpack .../01-python3.12_3.12.9-1_amd64.deb ... 90s Unpacking python3.12 (3.12.9-1) ... 90s Selecting previously unselected package libxslt1.1:amd64. 90s Preparing to unpack .../02-libxslt1.1_1.1.39-0exp1ubuntu2_amd64.deb ... 90s Unpacking libxslt1.1:amd64 (1.1.39-0exp1ubuntu2) ... 90s Selecting previously unselected package python3-all. 90s Preparing to unpack .../03-python3-all_3.13.1-1~exp2_amd64.deb ... 90s Unpacking python3-all (3.13.1-1~exp2) ... 90s Selecting previously unselected package python3-soupsieve. 90s Preparing to unpack .../04-python3-soupsieve_2.6-1_all.deb ... 90s Unpacking python3-soupsieve (2.6-1) ... 90s Selecting previously unselected package python3-bs4. 90s Preparing to unpack .../05-python3-bs4_4.13.3-1_all.deb ... 90s Unpacking python3-bs4 (4.13.3-1) ... 90s Selecting previously unselected package python3-webencodings. 90s Preparing to unpack .../06-python3-webencodings_0.5.1-5_all.deb ... 90s Unpacking python3-webencodings (0.5.1-5) ... 90s Selecting previously unselected package python3-html5lib. 90s Preparing to unpack .../07-python3-html5lib_1.2-1_all.deb ... 90s Unpacking python3-html5lib (1.2-1) ... 90s Selecting previously unselected package python3-iniconfig. 90s Preparing to unpack .../08-python3-iniconfig_1.1.1-2_all.deb ... 90s Unpacking python3-iniconfig (1.1.1-2) ... 90s Selecting previously unselected package python3-lxml:amd64. 90s Preparing to unpack .../09-python3-lxml_5.3.1-1_amd64.deb ... 90s Unpacking python3-lxml:amd64 (5.3.1-1) ... 90s Selecting previously unselected package python3-packaging. 90s Preparing to unpack .../10-python3-packaging_24.2-1_all.deb ... 90s Unpacking python3-packaging (24.2-1) ... 90s Selecting previously unselected package python3-pluggy. 90s Preparing to unpack .../11-python3-pluggy_1.5.0-1_all.deb ... 90s Unpacking python3-pluggy (1.5.0-1) ... 90s Selecting previously unselected package python3-pytest. 90s Preparing to unpack .../12-python3-pytest_8.3.4-1_all.deb ... 90s Unpacking python3-pytest (8.3.4-1) ... 90s Setting up python3-iniconfig (1.1.1-2) ... 90s Setting up python3.12-minimal (3.12.9-1) ... 91s Setting up python3.12 (3.12.9-1) ... 92s Setting up python3-all (3.13.1-1~exp2) ... 92s Setting up python3-webencodings (0.5.1-5) ... 92s Setting up python3-packaging (24.2-1) ... 93s Setting up python3-html5lib (1.2-1) ... 93s Setting up python3-pluggy (1.5.0-1) ... 93s Setting up libxslt1.1:amd64 (1.1.39-0exp1ubuntu2) ... 93s Setting up python3-soupsieve (2.6-1) ... 93s Setting up python3-pytest (8.3.4-1) ... 94s Setting up python3-bs4 (4.13.3-1) ... 94s Setting up python3-lxml:amd64 (5.3.1-1) ... 94s Processing triggers for systemd (257.2-3ubuntu1) ... 95s Processing triggers for man-db (2.13.0-1) ... 95s Processing triggers for libc-bin (2.40-4ubuntu1) ... 96s autopkgtest [11:20:11]: test unittests3: [----------------------- 96s === python3.12 === 97s ============================= test session starts ============================== 97s platform linux -- Python 3.12.9, pytest-8.3.4, pluggy-1.5.0 97s rootdir: /tmp/autopkgtest.COSXKT/autopkgtest_tmp 97s plugins: typeguard-4.4.1 97s collected 845 items 97s 97s test_builder.py ..... [ 0%] 97s test_builder_registry.py ........... [ 1%] 97s test_css.py ............................................................ [ 8%] 97s [ 8%] 97s test_dammit.py ............................................... [ 14%] 97s test_element.py ......... [ 15%] 97s test_filter.py ......................................................... [ 22%] 97s ................. [ 24%] 97s test_formatter.py ............................ [ 27%] 98s test_fuzz.py ...........sssssss [ 29%] 98s test_html5lib.py ....................................................... [ 36%] 98s .................................. [ 40%] 98s test_htmlparser.py ..................................................... [ 46%] 98s .......................... [ 49%] 98s test_lxml.py ........................................................... [ 56%] 98s ................................................. [ 62%] 98s test_navigablestring.py ........ [ 63%] 99s test_pageelement.py ...................................... [ 67%] 99s test_soup.py ........................................................... [ 74%] 99s ........................ [ 77%] 99s test_tag.py ........................ [ 80%] 99s test_tree.py ........................................................... [ 87%] 99s ........................................................................ [ 96%] 99s ................................. [100%] 99s 99s ======================== 838 passed, 7 skipped in 2.73s ======================== 99s === python3.13 === 100s ============================= test session starts ============================== 100s platform linux -- Python 3.13.2, pytest-8.3.4, pluggy-1.5.0 100s rootdir: /tmp/autopkgtest.COSXKT/autopkgtest_tmp 100s plugins: typeguard-4.4.1 100s collected 845 items 100s 100s test_builder.py ..... [ 0%] 100s test_builder_registry.py ........... [ 1%] 100s test_css.py ............................................................ [ 8%] 100s [ 8%] 100s test_dammit.py ............................................... [ 14%] 100s test_element.py ......... [ 15%] 100s test_filter.py ......................................................... [ 22%] 100s ................. [ 24%] 100s test_formatter.py ............................ [ 27%] 101s test_fuzz.py ...........sssssss [ 29%] 101s test_html5lib.py ....................................................... [ 36%] 101s .................................. [ 40%] 101s test_htmlparser.py ..................................................... [ 46%] 101s .......................... [ 49%] 101s test_lxml.py ........................................................... [ 56%] 101s ................................................. [ 62%] 101s test_navigablestring.py ........ [ 63%] 101s test_pageelement.py ...................................... [ 67%] 102s test_soup.py ........................................................... [ 74%] 102s ........................ [ 77%] 102s test_tag.py ........................ [ 80%] 102s test_tree.py ........................................................... [ 87%] 102s ........................................................................ [ 96%] 102s ................................. [100%] 102s 102s ======================== 838 passed, 7 skipped in 2.51s ======================== 102s autopkgtest [11:20:17]: test unittests3: -----------------------] 102s autopkgtest [11:20:17]: test unittests3: - - - - - - - - - - results - - - - - - - - - - 102s unittests3 PASS 103s autopkgtest [11:20:18]: @@@@@@@@@@@@@@@@@@@@ summary 103s unittests3 PASS 122s nova [W] Skipping flock for amd64 122s Creating nova instance adt-plucky-amd64-beautifulsoup4-20250219-111834-juju-7f2275-prod-proposed-migration-environment-2-1d26c599-c010-46ef-be91-4daa2a908954 from image adt/ubuntu-plucky-amd64-server-20250218.img (UUID 0c5f6311-785d-4524-a0d8-db541aaf5c09)... 122s nova [W] Timed out waiting for 4e56dc6c-3ca4-4761-9249-9dd7c52f7e0f to get deleted.