0s autopkgtest [09:34:42]: starting date and time: 2024-12-03 09:34:42+0000 0s autopkgtest [09:34:42]: git checkout: be626eda Fix armhf LXD image generation for plucky 0s autopkgtest [09:34:42]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.sm5fnoy8/out --timeout-copy=6000 --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 autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-24.secgroup --name adt-plucky-arm64-apt-clone-20241203-093441-juju-7f2275-prod-proposed-migration-environment-2-e9a3d334-2b71-4967-8404-42b62316a9ee --image adt/ubuntu-plucky-arm64-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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 154s autopkgtest [09:37:16]: testbed dpkg architecture: arm64 155s autopkgtest [09:37:17]: testbed apt version: 2.9.14ubuntu1 155s autopkgtest [09:37:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup 155s autopkgtest [09:37:17]: testbed release detected to be: None 156s autopkgtest [09:37:18]: updating testbed package index (apt update) 157s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 157s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 157s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 157s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 157s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [781 kB] 157s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [65.3 kB] 157s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 157s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.1 kB] 157s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [145 kB] 157s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [58.2 kB] 157s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [669 kB] 157s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [21.3 kB] 158s Fetched 1838 kB in 1s (1886 kB/s) 159s Reading package lists... 160s Reading package lists... 160s Building dependency tree... 160s Reading state information... 161s Calculating upgrade... 161s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 161s Reading package lists... 162s Building dependency tree... 162s Reading state information... 164s 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. 164s autopkgtest [09:37:26]: upgrading testbed (apt dist-upgrade and autopurge) 164s Reading package lists... 165s Building dependency tree... 165s Reading state information... 166s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 166s Starting 2 pkgProblemResolver with broken count: 0 166s Done 168s Entering ResolveByKeep 168s 170s The following packages will be upgraded: 170s python-apt-common python3-apt 170s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 170s Need to get 202 kB of archives. 170s After this operation, 12.3 kB disk space will be freed. 170s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python-apt-common all 2.9.1 [20.5 kB] 170s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3-apt arm64 2.9.1 [181 kB] 171s Fetched 202 kB in 1s (399 kB/s) 171s (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 ... 80333 files and directories currently installed.) 171s Preparing to unpack .../python-apt-common_2.9.1_all.deb ... 171s Unpacking python-apt-common (2.9.1) over (2.9.0ubuntu2) ... 171s Preparing to unpack .../python3-apt_2.9.1_arm64.deb ... 171s Unpacking python3-apt (2.9.1) over (2.9.0ubuntu2) ... 172s Setting up python-apt-common (2.9.1) ... 172s Setting up python3-apt (2.9.1) ... 172s Reading package lists... 173s Building dependency tree... 173s Reading state information... 173s Starting pkgProblemResolver with broken count: 0 173s Starting 2 pkgProblemResolver with broken count: 0 173s Done 174s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 178s autopkgtest [09:37:40]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 14:19:41 UTC 2024 178s autopkgtest [09:37:40]: @@@@@@@@@@@@@@@@@@@@ apt-source apt-clone 180s Get:1 http://ftpmaster.internal/ubuntu plucky/universe apt-clone 0.4.3+nmu2ubuntu2 (dsc) [1773 B] 180s Get:2 http://ftpmaster.internal/ubuntu plucky/universe apt-clone 0.4.3+nmu2ubuntu2 (tar) [460 kB] 181s gpgv: Signature made Fri Apr 19 18:02:31 2024 UTC 181s gpgv: using RSA key CED62F17BB727A48FC50762E2A15898770574541 181s gpgv: Can't check signature: No public key 181s dpkg-source: warning: cannot verify inline signature for ./apt-clone_0.4.3+nmu2ubuntu2.dsc: no acceptable signature found 181s autopkgtest [09:37:43]: testing package apt-clone version 0.4.3+nmu2ubuntu2 181s autopkgtest [09:37:43]: build not needed 182s autopkgtest [09:37:44]: test run-tests: preparing testbed 182s Reading package lists... 182s Building dependency tree... 182s Reading state information... 183s Starting pkgProblemResolver with broken count: 0 183s Starting 2 pkgProblemResolver with broken count: 0 183s Done 184s The following NEW packages will be installed: 184s apt-clone pycodestyle pyflakes3 python3-distro-info python3-mock 184s python3-pycodestyle python3-pyflakes 184s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 184s Need to get 177 kB of archives. 184s After this operation, 1008 kB of additional disk space will be used. 184s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-distro-info all 1.12 [7754 B] 184s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pycodestyle all 2.12.1-1 [30.1 kB] 184s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 pycodestyle all 2.12.1-1 [5262 B] 184s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pyflakes all 3.2.0-2 [52.9 kB] 184s Get:5 http://ftpmaster.internal/ubuntu plucky/universe arm64 pyflakes3 all 3.2.0-2 [3474 B] 184s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 apt-clone all 0.4.3+nmu2ubuntu2 [13.6 kB] 184s Get:7 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-mock all 5.1.0-1 [64.1 kB] 185s Fetched 177 kB in 0s (432 kB/s) 185s Selecting previously unselected package python3-distro-info. 185s (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 ... 80332 files and directories currently installed.) 185s Preparing to unpack .../0-python3-distro-info_1.12_all.deb ... 185s Unpacking python3-distro-info (1.12) ... 185s Selecting previously unselected package python3-pycodestyle. 185s Preparing to unpack .../1-python3-pycodestyle_2.12.1-1_all.deb ... 185s Unpacking python3-pycodestyle (2.12.1-1) ... 185s Selecting previously unselected package pycodestyle. 185s Preparing to unpack .../2-pycodestyle_2.12.1-1_all.deb ... 185s Unpacking pycodestyle (2.12.1-1) ... 185s Selecting previously unselected package python3-pyflakes. 185s Preparing to unpack .../3-python3-pyflakes_3.2.0-2_all.deb ... 185s Unpacking python3-pyflakes (3.2.0-2) ... 185s Selecting previously unselected package pyflakes3. 185s Preparing to unpack .../4-pyflakes3_3.2.0-2_all.deb ... 185s Unpacking pyflakes3 (3.2.0-2) ... 185s Selecting previously unselected package apt-clone. 185s Preparing to unpack .../5-apt-clone_0.4.3+nmu2ubuntu2_all.deb ... 185s Unpacking apt-clone (0.4.3+nmu2ubuntu2) ... 185s Selecting previously unselected package python3-mock. 185s Preparing to unpack .../6-python3-mock_5.1.0-1_all.deb ... 185s Unpacking python3-mock (5.1.0-1) ... 185s Setting up python3-pyflakes (3.2.0-2) ... 185s Setting up apt-clone (0.4.3+nmu2ubuntu2) ... 185s Setting up python3-mock (5.1.0-1) ... 185s Setting up python3-pycodestyle (2.12.1-1) ... 186s Setting up python3-distro-info (1.12) ... 186s Setting up pycodestyle (2.12.1-1) ... 186s Setting up pyflakes3 (3.2.0-2) ... 186s Processing triggers for man-db (2.13.0-1) ... 188s autopkgtest [09:37:50]: test run-tests: [----------------------- 189s if find \! -user $USER | grep -q .; then \ 189s sudo chown -R $USER:$USER .; \ 189s fi 189s pyflakes3 ../apt-clone ../apt_clone.py 189s set -e; for f in *.py; do \ 189s for ver in python3; do \ 189s PYTHONPATH=.. $ver $f -v 2>&1; \ 189s done; \ 189s done; \ 189s # cruft from the tests 189s 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'> 189s if method() is not None: 189s ResourceWarning: Enable tracemalloc to get the object allocation traceback 189s /usr/lib/python3.12/unittest/case.py:589: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 189s if method() is not None: 189s ResourceWarning: Enable tracemalloc to get the object allocation traceback 189s ok 189s test_restore_state (__main__.TestClone.test_restore_state) ... /tmp/autopkgtest.2VghKh/build.vER/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. 189s tar.extractall(targetdir) 189s /tmp/autopkgtest.2VghKh/build.vER/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. 189s tar.extract(self.TARPREFIX+"etc/apt/trusted.gpg", targetdir) 189s /tmp/autopkgtest.2VghKh/build.vER/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. 189s tar.extract(self.TARPREFIX+"etc/apt/trusted.gpg.d", targetdir) 189s /tmp/autopkgtest.2VghKh/build.vER/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. 189s tar.extractall(targetdir,debsdir) 189s /usr/lib/python3/dist-packages/mock/mock.py:1452: ResourceWarning: unclosed file <_io.TextIOWrapper name=4 mode='w' encoding='UTF-8'> 189s return func(*newargs, **newkeywargs) 189s ResourceWarning: Enable tracemalloc to get the object allocation traceback 189s /usr/lib/python3/dist-packages/mock/mock.py:1452: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 189s return func(*newargs, **newkeywargs) 189s ResourceWarning: Enable tracemalloc to get the object allocation traceback 189s ok 189s test_restore_state_on_new_distro_release_livecd (__main__.TestClone.test_restore_state_on_new_distro_release_livecd) 189s test lucid -> maverick apt-clone-ugprade as if it will be used ... ok 189s 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/tmpy_y1losc/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 189s self._depcache = apt_pkg.DepCache(self._cache) 190s /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/tmpy_y1losc/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 190s self._depcache = apt_pkg.DepCache(self._cache) 190s ok 190s test_restore_state_simulate_with_new_release (__main__.TestClone.test_restore_state_simulate_with_new_release) ... ok 190s test_restore_state_with_not_downloadable_debs (__main__.TestClone.test_restore_state_with_not_downloadable_debs) ... ok 190s test_save_state (__main__.TestClone.test_save_state) ... /tmp/autopkgtest.2VghKh/build.vER/src/tests/test_clone.py:54: ResourceWarning: unclosed file <_io.TextIOWrapper name=4 mode='w' encoding='UTF-8'> 190s self._save_state(False) 190s ResourceWarning: Enable tracemalloc to get the object allocation traceback 190s /tmp/autopkgtest.2VghKh/build.vER/src/tests/test_clone.py:54: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 190s self._save_state(False) 190s ResourceWarning: Enable tracemalloc to get the object allocation traceback 190s ok 190s test_save_state_with_dpkg_repack (__main__.TestClone.test_save_state_with_dpkg_repack) ... /tmp/autopkgtest.2VghKh/build.vER/src/tests/test_clone.py:58: ResourceWarning: unclosed file <_io.TextIOWrapper name=4 mode='w' encoding='UTF-8'> 190s self._save_state(True) 190s ResourceWarning: Enable tracemalloc to get the object allocation traceback 190s /tmp/autopkgtest.2VghKh/build.vER/src/tests/test_clone.py:58: ResourceWarning: unclosed file <_io.TextIOWrapper name=3 mode='r' encoding='UTF-8'> 190s self._save_state(True) 190s ResourceWarning: Enable tracemalloc to get the object allocation traceback 190s ok 190s test_unowned_in_etc (__main__.TestClone.test_unowned_in_etc) ... ok 190s 190s ---------------------------------------------------------------------- 190s Ran 9 tests in 1.130s 190s 190s OK 190s test_clone_upgrade_regression (__main__.TestCloneUpgrade.test_clone_upgrade_regression) 190s regression test against known installs ... skipped 'need to update apt-clone-state-ubuntu.tar.gz first' 190s test_clone_upgrade_synthetic (__main__.TestCloneUpgrade.test_clone_upgrade_synthetic) 191s test clone upgrade with on-the-fly generated chroots ... /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpdo8a22a4/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 191s self._depcache = apt_pkg.DepCache(self._cache) 195s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpuf8k1hd1/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 195s self._depcache = apt_pkg.DepCache(self._cache) 202s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmp4uaqha08/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 202s self._depcache = apt_pkg.DepCache(self._cache) 207s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpc539yenu/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 207s self._depcache = apt_pkg.DepCache(self._cache) 212s /tmp/autopkgtest.2VghKh/build.vER/src/tests/test_clone_upgrade.py:60: ResourceWarning: unclosed file <_io.TextIOWrapper name=9 mode='w' encoding='UTF-8'> 212s clone = AptClone() 212s ResourceWarning: Enable tracemalloc to get the object allocation traceback 212s /tmp/autopkgtest.2VghKh/build.vER/src/tests/test_clone_upgrade.py:60: ResourceWarning: unclosed file <_io.TextIOWrapper name=8 mode='r' encoding='UTF-8'> 212s clone = AptClone() 212s ResourceWarning: Enable tracemalloc to get the object allocation traceback 213s WARNING:root:can't add libappindicator3-1 (pkg libappindicator3-1 not marked upgrade) 213s WARNING:root:can't add pulseaudio (pkg pulseaudio not marked upgrade) 213s WARNING:root:can't add pulseaudio-module-bluetooth (pkg pulseaudio-module-bluetooth not marked upgrade) 214s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmp8gb6dnf2/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 214s self._depcache = apt_pkg.DepCache(self._cache) 218s /usr/lib/python3/dist-packages/apt/cache.py:215: Warning: W:Unable to read /tmp/tmpebq5tn7a/etc/apt/preferences.d/ - DirectoryExists (2: No such file or directory) 218s self._depcache = apt_pkg.DepCache(self._cache) 223s /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. 231s Aborted (core dumped) 231s make: *** [Makefile:7: test] Error 134 232s autopkgtest [09:38:34]: test run-tests: -----------------------] 232s autopkgtest [09:38:34]: test run-tests: - - - - - - - - - - results - - - - - - - - - - 232s run-tests FAIL non-zero exit status 2 232s autopkgtest [09:38:34]: test run-tests: - - - - - - - - - - stderr - - - - - - - - - - 232s make: *** [Makefile:7: test] Error 134 233s autopkgtest [09:38:35]: @@@@@@@@@@@@@@@@@@@@ summary 233s run-tests FAIL non-zero exit status 2 245s nova [W] Using flock in prodstack6-arm64 245s Creating nova instance adt-plucky-arm64-apt-clone-20241203-093441-juju-7f2275-prod-proposed-migration-environment-2-e9a3d334-2b71-4967-8404-42b62316a9ee from image adt/ubuntu-plucky-arm64-server-20241203.img (UUID b9293590-1195-42ea-ba16-5ab4b1e94eab)...