0s autopkgtest [20:11:10]: starting date and time: 2024-12-02 20:11:10+0000 0s autopkgtest [20:11:10]: git checkout: be626eda Fix armhf LXD image generation for plucky 0s autopkgtest [20:11:10]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.bm7rszfo/out --timeout-copy=6000 -a i386 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python-apt --apt-upgrade apt-clone --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python-apt/2.9.1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-32.secgroup --name adt-plucky-i386-apt-clone-20241202-201110-juju-7f2275-prod-proposed-migration-environment-15-bc2ead05-92cb-4f48-b203-e628270573bb --image adt/ubuntu-plucky-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-amd64 -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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 68s autopkgtest [20:12:18]: testbed dpkg architecture: amd64 68s autopkgtest [20:12:18]: testbed apt version: 2.9.14ubuntu1 68s autopkgtest [20:12:18]: @@@@@@@@@@@@@@@@@@@@ test bed setup 69s autopkgtest [20:12:19]: testbed release detected to be: None 69s autopkgtest [20:12:19]: updating testbed package index (apt update) 70s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 70s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 70s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 70s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 70s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [784 kB] 70s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.7 kB] 70s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [67.5 kB] 70s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 70s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [83.1 kB] 70s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [126 kB] 70s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/restricted i386 Packages [2572 B] 70s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [40.6 kB] 70s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [702 kB] 70s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [268 kB] 70s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [22.2 kB] 71s Get:16 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [6364 B] 71s Fetched 2201 kB in 1s (2235 kB/s) 72s Reading package lists... 72s Reading package lists... 73s Building dependency tree... 73s Reading state information... 73s Calculating upgrade... 73s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 74s Reading package lists... 74s Building dependency tree... 74s Reading state information... 74s 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. 74s autopkgtest [20:12:24]: upgrading testbed (apt dist-upgrade and autopurge) 75s Reading package lists... 75s Building dependency tree... 75s Reading state information... 75s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 75s Starting 2 pkgProblemResolver with broken count: 0 75s Done 76s Entering ResolveByKeep 77s 77s The following packages will be upgraded: 77s python-apt-common python3-apt 77s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 77s Need to get 200 kB of archives. 77s After this operation, 6144 B disk space will be freed. 77s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python-apt-common all 2.9.1 [20.5 kB] 77s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3-apt amd64 2.9.1 [179 kB] 78s Fetched 200 kB in 0s (481 kB/s) 78s (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 ... 75952 files and directories currently installed.) 78s Preparing to unpack .../python-apt-common_2.9.1_all.deb ... 78s Unpacking python-apt-common (2.9.1) over (2.9.0ubuntu2) ... 78s Preparing to unpack .../python3-apt_2.9.1_amd64.deb ... 78s Unpacking python3-apt (2.9.1) over (2.9.0ubuntu2) ... 78s Setting up python-apt-common (2.9.1) ... 78s Setting up python3-apt (2.9.1) ... 79s Reading package lists... 79s Building dependency tree... 79s Reading state information... 80s Starting pkgProblemResolver with broken count: 0 80s Starting 2 pkgProblemResolver with broken count: 0 80s Done 81s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 83s autopkgtest [20:12:33]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 13:41:20 UTC 2024 83s autopkgtest [20:12:33]: @@@@@@@@@@@@@@@@@@@@ apt-source apt-clone 85s Get:1 http://ftpmaster.internal/ubuntu plucky/universe apt-clone 0.4.3+nmu2ubuntu2 (dsc) [1773 B] 85s Get:2 http://ftpmaster.internal/ubuntu plucky/universe apt-clone 0.4.3+nmu2ubuntu2 (tar) [460 kB] 85s gpgv: Signature made Fri Apr 19 18:02:31 2024 UTC 85s gpgv: using RSA key CED62F17BB727A48FC50762E2A15898770574541 85s gpgv: Can't check signature: No public key 85s dpkg-source: warning: cannot verify inline signature for ./apt-clone_0.4.3+nmu2ubuntu2.dsc: no acceptable signature found 86s autopkgtest [20:12:36]: testing package apt-clone version 0.4.3+nmu2ubuntu2 86s autopkgtest [20:12:36]: build not needed 86s autopkgtest [20:12:36]: test run-tests: preparing testbed 87s Reading package lists... 87s Building dependency tree... 87s Reading state information... 87s Starting pkgProblemResolver with broken count: 0 87s Starting 2 pkgProblemResolver with broken count: 0 87s Done 88s The following NEW packages will be installed: 88s apt-clone pycodestyle pyflakes3 python3-distro-info python3-mock 88s python3-pycodestyle python3-pyflakes 88s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 88s Need to get 177 kB of archives. 88s After this operation, 1008 kB of additional disk space will be used. 88s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-distro-info all 1.12 [7754 B] 88s Get:2 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pycodestyle all 2.12.1-1 [30.1 kB] 88s Get:3 http://ftpmaster.internal/ubuntu plucky/universe amd64 pycodestyle all 2.12.1-1 [5262 B] 88s Get:4 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pyflakes all 3.2.0-2 [52.9 kB] 88s Get:5 http://ftpmaster.internal/ubuntu plucky/universe amd64 pyflakes3 all 3.2.0-2 [3474 B] 88s Get:6 http://ftpmaster.internal/ubuntu plucky/universe amd64 apt-clone all 0.4.3+nmu2ubuntu2 [13.6 kB] 88s Get:7 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-mock all 5.1.0-1 [64.1 kB] 89s Fetched 177 kB in 0s (436 kB/s) 89s Selecting previously unselected package python3-distro-info. 89s (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 ... 75951 files and directories currently installed.) 89s Preparing to unpack .../0-python3-distro-info_1.12_all.deb ... 89s Unpacking python3-distro-info (1.12) ... 89s Selecting previously unselected package python3-pycodestyle. 89s Preparing to unpack .../1-python3-pycodestyle_2.12.1-1_all.deb ... 89s Unpacking python3-pycodestyle (2.12.1-1) ... 89s Selecting previously unselected package pycodestyle. 89s Preparing to unpack .../2-pycodestyle_2.12.1-1_all.deb ... 89s Unpacking pycodestyle (2.12.1-1) ... 89s Selecting previously unselected package python3-pyflakes. 89s Preparing to unpack .../3-python3-pyflakes_3.2.0-2_all.deb ... 89s Unpacking python3-pyflakes (3.2.0-2) ... 89s Selecting previously unselected package pyflakes3. 89s Preparing to unpack .../4-pyflakes3_3.2.0-2_all.deb ... 89s Unpacking pyflakes3 (3.2.0-2) ... 89s Selecting previously unselected package apt-clone. 89s Preparing to unpack .../5-apt-clone_0.4.3+nmu2ubuntu2_all.deb ... 89s Unpacking apt-clone (0.4.3+nmu2ubuntu2) ... 89s Selecting previously unselected package python3-mock. 89s Preparing to unpack .../6-python3-mock_5.1.0-1_all.deb ... 89s Unpacking python3-mock (5.1.0-1) ... 89s Setting up python3-pyflakes (3.2.0-2) ... 89s Setting up apt-clone (0.4.3+nmu2ubuntu2) ... 90s Setting up python3-mock (5.1.0-1) ... 90s Setting up python3-pycodestyle (2.12.1-1) ... 90s Setting up python3-distro-info (1.12) ... 90s Setting up pycodestyle (2.12.1-1) ... 90s Setting up pyflakes3 (3.2.0-2) ... 90s Processing triggers for man-db (2.13.0-1) ... 93s autopkgtest [20:12:43]: test run-tests: [----------------------- 93s if find \! -user $USER | grep -q .; then \ 93s sudo chown -R $USER:$USER .; \ 93s fi 93s pyflakes3 ../apt-clone ../apt_clone.py 94s set -e; for f in *.py; do \ 94s for ver in python3; do \ 94s PYTHONPATH=.. $ver $f -v 2>&1; \ 94s done; \ 94s done; \ 94s # cruft from the tests 94s test_modified_conffiles (__main__.TestClone.test_modified_conffiles) ... /usr/lib/python3.12/unittest/case.py:589: ResourceWarning: unclosed file <_io.TextIOWrapper name=4 mode='w' encoding='UTF-8'> 94s if method() is not None: 94s ResourceWarning: Enable tracemalloc to get the object allocation traceback 94s /usr/lib/python3.12/unittest/case.py:589: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 94s if method() is not None: 94s ResourceWarning: Enable tracemalloc to get the object allocation traceback 94s ok 94s test_restore_state (__main__.TestClone.test_restore_state) ... /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/../apt_clone.py:551: DeprecationWarning: Python 3.14 will, by default, filter extracted tar archives and reject files or modify their metadata. Use the filter argument to control this behavior. 94s tar.extractall(targetdir) 94s /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/../apt_clone.py:577: DeprecationWarning: Python 3.14 will, by default, filter extracted tar archives and reject files or modify their metadata. Use the filter argument to control this behavior. 94s tar.extract(self.TARPREFIX+"etc/apt/trusted.gpg", targetdir) 94s /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/../apt_clone.py:581: DeprecationWarning: Python 3.14 will, by default, filter extracted tar archives and reject files or modify their metadata. Use the filter argument to control this behavior. 94s tar.extract(self.TARPREFIX+"etc/apt/trusted.gpg.d", targetdir) 94s /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/../apt_clone.py:682: DeprecationWarning: Python 3.14 will, by default, filter extracted tar archives and reject files or modify their metadata. Use the filter argument to control this behavior. 94s tar.extractall(targetdir,debsdir) 94s /usr/lib/python3/dist-packages/mock/mock.py:1452: ResourceWarning: unclosed file <_io.TextIOWrapper name=4 mode='w' encoding='UTF-8'> 94s return func(*newargs, **newkeywargs) 94s ResourceWarning: Enable tracemalloc to get the object allocation traceback 94s /usr/lib/python3/dist-packages/mock/mock.py:1452: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 94s return func(*newargs, **newkeywargs) 94s ResourceWarning: Enable tracemalloc to get the object allocation traceback 94s ok 94s test_restore_state_on_new_distro_release_livecd (__main__.TestClone.test_restore_state_on_new_distro_release_livecd) 94s test lucid -> maverick apt-clone-ugprade as if it will be used ... ok 94s test_restore_state_simulate (__main__.TestClone.test_restore_state_simulate) ... /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpzy1bz0lj/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 94s self._depcache = apt_pkg.DepCache(self._cache) 94s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Updating from such a repository can't be done securely, and is therefore disabled by default., W:See apt-secure(8) manpage for repository creation and user configuration details., W:Unable to read /tmp/tmpzy1bz0lj/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 94s self._depcache = apt_pkg.DepCache(self._cache) 94s ok 95s test_restore_state_simulate_with_new_release (__main__.TestClone.test_restore_state_simulate_with_new_release) ... ok 95s test_restore_state_with_not_downloadable_debs (__main__.TestClone.test_restore_state_with_not_downloadable_debs) ... ok 95s test_save_state (__main__.TestClone.test_save_state) ... /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/test_clone.py:54: ResourceWarning: unclosed file <_io.TextIOWrapper name=4 mode='w' encoding='UTF-8'> 95s self._save_state(False) 95s ResourceWarning: Enable tracemalloc to get the object allocation traceback 95s /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/test_clone.py:54: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 95s self._save_state(False) 95s ResourceWarning: Enable tracemalloc to get the object allocation traceback 95s ok 95s test_save_state_with_dpkg_repack (__main__.TestClone.test_save_state_with_dpkg_repack) ... /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/test_clone.py:58: ResourceWarning: unclosed file <_io.TextIOWrapper name=4 mode='w' encoding='UTF-8'> 95s self._save_state(True) 95s ResourceWarning: Enable tracemalloc to get the object allocation traceback 95s /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/test_clone.py:58: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 95s self._save_state(True) 95s ResourceWarning: Enable tracemalloc to get the object allocation traceback 95s ok 95s test_unowned_in_etc (__main__.TestClone.test_unowned_in_etc) ... ok 95s 95s ---------------------------------------------------------------------- 95s Ran 9 tests in 1.438s 95s 95s OK 95s test_clone_upgrade_regression (__main__.TestCloneUpgrade.test_clone_upgrade_regression) 95s regression test against known installs ... skipped 'need to update apt-clone-state-ubuntu.tar.gz first' 95s test_clone_upgrade_synthetic (__main__.TestCloneUpgrade.test_clone_upgrade_synthetic) 96s test clone upgrade with on-the-fly generated chroots ... /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpv2h6bzt4/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 96s self._depcache = apt_pkg.DepCache(self._cache) 100s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpys4zsix2/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 100s self._depcache = apt_pkg.DepCache(self._cache) 105s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmp446509eb/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 105s self._depcache = apt_pkg.DepCache(self._cache) 110s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpl4q1vgx3/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 110s self._depcache = apt_pkg.DepCache(self._cache) 114s /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/test_clone_upgrade.py:60: ResourceWarning: unclosed file <_io.TextIOWrapper name=9 mode='w' encoding='UTF-8'> 114s clone = AptClone() 114s ResourceWarning: Enable tracemalloc to get the object allocation traceback 114s /tmp/autopkgtest.N6qiZx/build.YWA/src/tests/test_clone_upgrade.py:60: ResourceWarning: unclosed file <_io.TextIOWrapper name=8 mode='r' encoding='UTF-8'> 114s clone = AptClone() 114s ResourceWarning: Enable tracemalloc to get the object allocation traceback 115s WARNING:root:can't add libappindicator3-1 (pkg libappindicator3-1 not marked upgrade) 115s WARNING:root:can't add pulseaudio (pkg pulseaudio not marked upgrade) 115s WARNING:root:can't add pulseaudio-module-bluetooth (pkg pulseaudio-module-bluetooth not marked upgrade) 116s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpgyfne0ho/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 116s self._depcache = apt_pkg.DepCache(self._cache) 120s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpqksq4y3p/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 120s self._depcache = apt_pkg.DepCache(self._cache) 125s /usr/include/c++/14/bits/stl_vector.h:1130: std::vector<_Tp, _Alloc>::reference std::vector<_Tp, _Alloc>::operator[](size_type) [with _Tp = pkgCacheGenerator::VersionExtra; _Alloc = std::allocator; reference = pkgCacheGenerator::VersionExtra&; size_type = long unsigned int]: Assertion '__n < this->size()' failed. 135s Aborted (core dumped) 135s make: *** [Makefile:7: test] Error 134 135s autopkgtest [20:13:25]: test run-tests: -----------------------] 136s autopkgtest [20:13:26]: test run-tests: - - - - - - - - - - results - - - - - - - - - - 136s run-tests FAIL non-zero exit status 2 136s autopkgtest [20:13:26]: test run-tests: - - - - - - - - - - stderr - - - - - - - - - - 136s make: *** [Makefile:7: test] Error 134 137s autopkgtest [20:13:27]: @@@@@@@@@@@@@@@@@@@@ summary 137s run-tests FAIL non-zero exit status 2 154s nova [W] Skipping flock for amd64 154s Creating nova instance adt-plucky-i386-apt-clone-20241202-201110-juju-7f2275-prod-proposed-migration-environment-15-bc2ead05-92cb-4f48-b203-e628270573bb from image adt/ubuntu-plucky-amd64-server-20241202.img (UUID e2dd381a-9f8d-4c68-9282-8ccd9f59e142)...