0s autopkgtest [11:01:59]: starting date and time: 2024-03-26 11:01:59+0000 0s autopkgtest [11:01:59]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [11:01:59]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8ntaw682/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 --apt-upgrade python-libarchive-c --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python-libarchive-c/2.9-0.1ubuntu1 python3-defaults/3.12.2-0ubuntu1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-s390x-11.secgroup --name adt-noble-s390x-python-libarchive-c-20240326-110159-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-s390x-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/ 98s autopkgtest [11:03:37]: testbed dpkg architecture: s390x 98s autopkgtest [11:03:37]: testbed apt version: 2.7.12 98s autopkgtest [11:03:37]: @@@@@@@@@@@@@@@@@@@@ test bed setup 99s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 100s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3982 kB] 102s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [496 kB] 102s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.0 kB] 102s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [8504 B] 102s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [690 kB] 102s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B] 102s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B] 102s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B] 102s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [4126 kB] 103s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B] 103s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [47.8 kB] 103s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B] 104s Fetched 9535 kB in 4s (2131 kB/s) 105s Reading package lists... 106s Reading package lists... 107s Building dependency tree... 107s Reading state information... 107s Calculating upgrade... 107s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 107s Reading package lists... 107s Building dependency tree... 107s Reading state information... 107s 0 upgraded, 0 newly installed, 0 to remove and 242 not upgraded. 108s Unknown architecture, assuming PC-style ttyS0 108s sh: Attempting to set up Debian/Ubuntu apt sources automatically 108s sh: Distribution appears to be Ubuntu 108s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s eatmydata is already the newest version (131-1). 109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s dbus is already the newest version (1.14.10-4ubuntu1). 109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s Reading package lists... 109s Building dependency tree... 109s Reading state information... 110s rng-tools-debian is already the newest version (2.4). 110s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 110s The following packages will be REMOVED: 110s cloud-init* python3-configobj* python3-debconf* 110s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 110s After this operation, 3256 kB disk space will be freed. 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 ... 52170 files and directories currently installed.) 110s Removing cloud-init (24.1.2-0ubuntu1) ... 111s Removing python3-configobj (5.0.8-3) ... 111s Removing python3-debconf (1.5.86) ... 111s Processing triggers for man-db (2.12.0-3) ... 111s (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.) 111s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 112s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 112s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 112s invoke-rc.d: policy-rc.d denied execution of try-restart. 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s linux-generic is already the newest version (6.8.0-11.11+1). 112s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 113s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 113s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 114s Reading package lists... 114s Reading package lists... 115s Building dependency tree... 115s Reading state information... 115s Calculating upgrade... 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 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s autopkgtest [11:03:54]: rebooting testbed after setup commands that affected boot 135s autopkgtest [11:04:14]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Tue Feb 13 23:45:46 UTC 2024 137s autopkgtest [11:04:16]: @@@@@@@@@@@@@@@@@@@@ apt-source python-libarchive-c 139s Get:1 http://ftpmaster.internal/ubuntu noble/universe python-libarchive-c 2.9-0.1build1 (dsc) [2253 B] 139s Get:2 http://ftpmaster.internal/ubuntu noble/universe python-libarchive-c 2.9-0.1build1 (tar) [46.4 kB] 139s Get:3 http://ftpmaster.internal/ubuntu noble/universe python-libarchive-c 2.9-0.1build1 (diff) [7092 B] 139s gpgv: Signature made Sat Mar 9 07:23:16 2024 UTC 139s gpgv: using RSA key AC483F68DE728F43F2202FCA568D30F321B2133D 139s gpgv: issuer "steve.langasek@ubuntu.com" 139s gpgv: Can't check signature: No public key 139s dpkg-source: warning: cannot verify inline signature for ./python-libarchive-c_2.9-0.1build1.dsc: no acceptable signature found 139s autopkgtest [11:04:18]: testing package python-libarchive-c version 2.9-0.1build1 140s autopkgtest [11:04:19]: build not needed 140s autopkgtest [11:04:19]: test upstream-tests: preparing testbed 144s Reading package lists... 144s Building dependency tree... 144s Reading state information... 144s Starting pkgProblemResolver with broken count: 0 144s Starting 2 pkgProblemResolver with broken count: 0 144s Done 144s The following additional packages will be installed: 144s python3-iniconfig python3-libarchive-c python3-mock python3-packaging 144s python3-pluggy python3-pytest 144s Suggested packages: 144s python-mock-doc 144s The following NEW packages will be installed: 144s autopkgtest-satdep python3-iniconfig python3-libarchive-c python3-mock 144s python3-packaging python3-pluggy python3-pytest 144s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 144s Need to get 450 kB/451 kB of archives. 144s After this operation, 2000 kB of additional disk space will be used. 144s Get:1 /tmp/autopkgtest.lN75xS/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [724 B] 145s Get:2 http://ftpmaster.internal/ubuntu noble/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 145s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x python3-packaging all 23.2-1 [40.6 kB] 145s Get:4 http://ftpmaster.internal/ubuntu noble/universe s390x python3-pluggy all 1.4.0-1 [20.4 kB] 145s Get:5 http://ftpmaster.internal/ubuntu noble/universe s390x python3-pytest all 7.4.4-1 [305 kB] 145s Get:6 http://ftpmaster.internal/ubuntu noble/universe s390x python3-libarchive-c all 2.9-0.1build1 [14.1 kB] 145s Get:7 http://ftpmaster.internal/ubuntu noble/universe s390x python3-mock all 5.1.0-1 [64.1 kB] 145s Fetched 450 kB in 1s (528 kB/s) 145s Selecting previously unselected package python3-iniconfig. 146s (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.) 146s Preparing to unpack .../0-python3-iniconfig_1.1.1-2_all.deb ... 146s Unpacking python3-iniconfig (1.1.1-2) ... 146s Selecting previously unselected package python3-packaging. 146s Preparing to unpack .../1-python3-packaging_23.2-1_all.deb ... 146s Unpacking python3-packaging (23.2-1) ... 146s Selecting previously unselected package python3-pluggy. 146s Preparing to unpack .../2-python3-pluggy_1.4.0-1_all.deb ... 146s Unpacking python3-pluggy (1.4.0-1) ... 146s Selecting previously unselected package python3-pytest. 146s Preparing to unpack .../3-python3-pytest_7.4.4-1_all.deb ... 146s Unpacking python3-pytest (7.4.4-1) ... 146s Selecting previously unselected package python3-libarchive-c. 146s Preparing to unpack .../4-python3-libarchive-c_2.9-0.1build1_all.deb ... 146s Unpacking python3-libarchive-c (2.9-0.1build1) ... 146s Selecting previously unselected package python3-mock. 146s Preparing to unpack .../5-python3-mock_5.1.0-1_all.deb ... 146s Unpacking python3-mock (5.1.0-1) ... 146s Selecting previously unselected package autopkgtest-satdep. 146s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 146s Unpacking autopkgtest-satdep (0) ... 146s Setting up python3-iniconfig (1.1.1-2) ... 146s Setting up python3-libarchive-c (2.9-0.1build1) ... 146s Setting up python3-mock (5.1.0-1) ... 146s Setting up python3-packaging (23.2-1) ... 146s Setting up python3-pluggy (1.4.0-1) ... 146s Setting up python3-pytest (7.4.4-1) ... 147s Setting up autopkgtest-satdep (0) ... 147s Processing triggers for man-db (2.12.0-3) ... 149s (Reading database ... 51931 files and directories currently installed.) 149s Removing autopkgtest-satdep (0) ... 150s autopkgtest [11:04:29]: test upstream-tests: [----------------------- 150s 'tests' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests' 150s 'tests/__init__.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/__init__.py' 150s 'tests/data' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data' 150s 'tests/data/flags.tar' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/flags.tar' 150s 'tests/data/special.tar' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/special.tar' 150s 'tests/data/tar_relative.tar' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/tar_relative.tar' 150s 'tests/data/testtar.README' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/testtar.README' 150s 'tests/data/testtar.tar' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/testtar.tar' 150s 'tests/data/testtar.tar.json' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/testtar.tar.json' 150s 'tests/data/unicode.tar' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/unicode.tar' 150s 'tests/data/unicode.tar.json' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/unicode.tar.json' 150s 'tests/data/unicode.zip' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/unicode.zip' 150s 'tests/data/unicode.zip.json' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/unicode.zip.json' 150s 'tests/data/unicode2.zip' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/unicode2.zip' 150s 'tests/data/unicode2.zip.json' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/unicode2.zip.json' 150s 'tests/data/프로그램.README' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/프로그램.README' 150s 'tests/data/프로그램.zip' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/프로그램.zip' 150s 'tests/data/프로그램.zip.json' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/data/프로그램.zip.json' 150s 'tests/surrogateescape.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/surrogateescape.py' 150s 'tests/test_atime_mtime_ctime.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/test_atime_mtime_ctime.py' 150s 'tests/test_convert.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/test_convert.py' 150s 'tests/test_entry.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/test_entry.py' 150s 'tests/test_errors.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/test_errors.py' 150s 'tests/test_rwx.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/test_rwx.py' 150s 'tests/test_security_flags.py' -> '/tmp/autopkgtest.lN75xS/autopkgtest_tmp/tests/test_security_flags.py' 150s mkdir: created directory 'libarchive' 150s ============================= test session starts ============================== 150s platform linux -- Python 3.12.2, pytest-7.4.4, pluggy-1.4.0 -- /usr/bin/python3 150s cachedir: .pytest_cache 150s rootdir: /tmp/autopkgtest.lN75xS/autopkgtest_tmp 150s collecting ... collected 32 items 150s 150s tests/test_atime_mtime_ctime.py::test_memory_atime_ctime[zip-int] PASSED [ 3%] 150s tests/test_atime_mtime_ctime.py::test_memory_atime_ctime[pax-float] PASSED [ 6%] 150s tests/test_atime_mtime_ctime.py::test_file_atime_ctime[zip-int] PASSED [ 9%] 150s tests/test_atime_mtime_ctime.py::test_file_atime_ctime[pax-float] PASSED [ 12%] 150s tests/test_atime_mtime_ctime.py::test_memory_time_setters[zip-int] PASSED [ 15%] 150s tests/test_atime_mtime_ctime.py::test_memory_time_setters[pax-float] PASSED [ 18%] 150s tests/test_atime_mtime_ctime.py::test_file_time_setters[zip-int] PASSED [ 21%] 150s tests/test_atime_mtime_ctime.py::test_file_time_setters[pax-float] PASSED [ 25%] 150s tests/test_convert.py::test_convert PASSED [ 28%] 150s tests/test_entry.py::test_entry_properties PASSED [ 31%] 150s tests/test_entry.py::test_check_ArchiveEntry_against_TarInfo PASSED [ 34%] 150s tests/test_entry.py::test_check_archiveentry_using_python_testtar PASSED [ 37%] 150s tests/test_entry.py::test_check_archiveentry_with_unicode_and_binary_entries_tar PASSED [ 40%] 150s tests/test_entry.py::test_check_archiveentry_with_unicode_and_binary_entries_zip PASSED [ 43%] 150s tests/test_entry.py::test_check_archiveentry_with_unicode_and_binary_entries_zip2 PASSED [ 46%] 150s tests/test_entry.py::test_check_archiveentry_with_unicode_entries_and_name_zip PASSED [ 50%] 150s tests/test_errors.py::test_add_files_nonexistent PASSED [ 53%] 150s tests/test_errors.py::test_check_int_logs_warnings PASSED [ 56%] 150s tests/test_errors.py::test_check_null PASSED [ 59%] 150s tests/test_errors.py::test_error_string_decoding PASSED [ 62%] 150s tests/test_rwx.py::test_buffers PASSED [ 65%] 150s tests/test_rwx.py::test_fd PASSED [ 68%] 150s tests/test_rwx.py::test_files PASSED [ 71%] 150s tests/test_rwx.py::test_custom_writer_and_stream_reader PASSED [ 75%] 150s tests/test_rwx.py::test_write_fail PASSED [ 78%] 150s tests/test_rwx.py::test_write_not_fail PASSED [ 81%] 150s tests/test_rwx.py::test_adding_entry_from_memory[zip-content] PASSED [ 84%] 150s tests/test_rwx.py::test_adding_entry_from_memory[gnutar-] PASSED [ 87%] 150s tests/test_rwx.py::test_adding_entry_from_memory[pax-{"a": 1, "b": 2, "c": 3}] PASSED [ 90%] 150s tests/test_rwx.py::test_adding_entry_from_memory[7zip-lorem\x00ipsum] PASSED [ 93%] 150s tests/test_security_flags.py::test_no_dot_dot PASSED [ 96%] 150s tests/test_security_flags.py::test_absolute PASSED [100%] 150s 150s ============================== 32 passed in 0.13s ============================== 150s autopkgtest [11:04:29]: test upstream-tests: -----------------------] 151s upstream-tests PASS 151s autopkgtest [11:04:30]: test upstream-tests: - - - - - - - - - - results - - - - - - - - - - 152s autopkgtest [11:04:31]: @@@@@@@@@@@@@@@@@@@@ summary 152s upstream-tests PASS 164s Creating nova instance adt-noble-s390x-python-libarchive-c-20240326-110159-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-s390x-server-20240326.img (UUID c527e0e4-2e65-4e86-ad63-05d7f665f2fb)...