0s autopkgtest [09:49:02]: starting date and time: 2024-11-13 09:49:02+0000 0s autopkgtest [09:49:02]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [09:49:02]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.mshy0rt6/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults,src:python3-stdlib-extensions --apt-upgrade pyscard --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python3-defaults/3.12.7-1 python3-stdlib-extensions/3.12.7-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@lcy02-19.secgroup --name adt-plucky-amd64-pyscard-20241113-094902-juju-7f2275-prod-proposed-migration-environment-2-4644a938-6907-4ea0-a2e3-c50e25ff03b7 --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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 791s autopkgtest [10:02:13]: testbed dpkg architecture: amd64 791s autopkgtest [10:02:13]: testbed apt version: 2.9.8 791s autopkgtest [10:02:13]: @@@@@@@@@@@@@@@@@@@@ test bed setup 792s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 792s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 792s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 792s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [849 kB] 792s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.4 kB] 792s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [111 kB] 792s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [65.2 kB] 792s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [32.6 kB] 792s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [639 kB] 792s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [255 kB] 792s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [37.7 kB] 792s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [13.0 kB] 792s Fetched 2175 kB in 0s (5675 kB/s) 792s Reading package lists... 794s Reading package lists... 795s Building dependency tree... 795s Reading state information... 795s Calculating upgrade... 795s The following NEW packages will be installed: 795s python3.13-gdbm 795s The following packages will be upgraded: 795s libgpgme11t64 libpython3-stdlib python3 python3-gdbm python3-minimal 795s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 795s Need to get 253 kB of archives. 795s After this operation, 147 kB of additional disk space will be used. 795s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3-minimal amd64 3.12.7-1 [27.4 kB] 795s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3 amd64 3.12.7-1 [24.0 kB] 795s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 libpython3-stdlib amd64 3.12.7-1 [10.0 kB] 795s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 python3.13-gdbm amd64 3.13.0-2 [31.3 kB] 795s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 python3-gdbm amd64 3.12.7-1 [8642 B] 795s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 libgpgme11t64 amd64 1.23.2-5ubuntu4 [152 kB] 796s Fetched 253 kB in 0s (4710 kB/s) 796s (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 ... 75541 files and directories currently installed.) 796s Preparing to unpack .../python3-minimal_3.12.7-1_amd64.deb ... 796s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 796s Setting up python3-minimal (3.12.7-1) ... 796s (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 ... 75541 files and directories currently installed.) 796s Preparing to unpack .../python3_3.12.7-1_amd64.deb ... 796s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 796s Preparing to unpack .../libpython3-stdlib_3.12.7-1_amd64.deb ... 796s Unpacking libpython3-stdlib:amd64 (3.12.7-1) over (3.12.6-0ubuntu1) ... 796s Selecting previously unselected package python3.13-gdbm. 796s Preparing to unpack .../python3.13-gdbm_3.13.0-2_amd64.deb ... 796s Unpacking python3.13-gdbm (3.13.0-2) ... 796s Preparing to unpack .../python3-gdbm_3.12.7-1_amd64.deb ... 796s Unpacking python3-gdbm:amd64 (3.12.7-1) over (3.12.6-1ubuntu1) ... 796s Preparing to unpack .../libgpgme11t64_1.23.2-5ubuntu4_amd64.deb ... 796s Unpacking libgpgme11t64:amd64 (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ... 796s Setting up libgpgme11t64:amd64 (1.23.2-5ubuntu4) ... 796s Setting up python3.13-gdbm (3.13.0-2) ... 796s Setting up libpython3-stdlib:amd64 (3.12.7-1) ... 796s Setting up python3 (3.12.7-1) ... 797s Setting up python3-gdbm:amd64 (3.12.7-1) ... 797s Processing triggers for man-db (2.12.1-3) ... 797s Processing triggers for libc-bin (2.40-1ubuntu3) ... 798s Reading package lists... 798s Building dependency tree... 798s Reading state information... 799s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 799s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 799s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 799s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 799s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 800s Reading package lists... 800s Reading package lists... 800s Building dependency tree... 800s Reading state information... 801s Calculating upgrade... 801s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 801s Reading package lists... 801s Building dependency tree... 801s Reading state information... 802s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 803s autopkgtest [10:02:25]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 13:41:20 UTC 2024 803s autopkgtest [10:02:25]: @@@@@@@@@@@@@@@@@@@@ apt-source pyscard 804s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pyscard 2.2.0-2 (dsc) [2390 B] 804s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pyscard 2.2.0-2 (tar) [155 kB] 804s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pyscard 2.2.0-2 (asc) [833 B] 804s Get:4 http://ftpmaster.internal/ubuntu plucky/universe pyscard 2.2.0-2 (diff) [8624 B] 804s gpgv: Signature made Wed Oct 23 12:21:14 2024 UTC 804s gpgv: using RSA key F5E11B9FFE911146F41D953D78A1B4DFE8F9C57E 804s gpgv: issuer "rousseau@debian.org" 804s gpgv: Can't check signature: No public key 804s dpkg-source: warning: cannot verify inline signature for ./pyscard_2.2.0-2.dsc: no acceptable signature found 804s autopkgtest [10:02:26]: testing package pyscard version 2.2.0-2 805s autopkgtest [10:02:27]: build not needed 805s autopkgtest [10:02:27]: test pyscard-tests: preparing testbed 805s Reading package lists... 806s Building dependency tree... 806s Reading state information... 806s Starting pkgProblemResolver with broken count: 0 806s Starting 2 pkgProblemResolver with broken count: 0 806s Done 807s The following additional packages will be installed: 807s libccid libpcsclite1 pcscd python3-iniconfig python3-packaging 807s python3-pluggy python3-pyscard python3-pytest 807s Suggested packages: 807s pcmciautils python3-wxgtk4.0 807s The following NEW packages will be installed: 807s autopkgtest-satdep libccid libpcsclite1 pcscd python3-iniconfig 807s python3-packaging python3-pluggy python3-pyscard python3-pytest 807s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 807s Need to get 581 kB/582 kB of archives. 807s After this operation, 2850 kB of additional disk space will be used. 807s Get:1 /tmp/autopkgtest.uQoQr8/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [740 B] 807s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 libpcsclite1 amd64 2.3.0-1 [23.9 kB] 807s Get:3 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-iniconfig all 1.1.1-2 [6024 B] 807s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-packaging all 24.1-1 [41.4 kB] 807s Get:5 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pluggy all 1.5.0-1 [21.0 kB] 807s Get:6 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pyscard amd64 2.2.0-2 [86.0 kB] 807s Get:7 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pytest all 8.3.3-1 [251 kB] 807s Get:8 http://ftpmaster.internal/ubuntu plucky/universe amd64 libccid amd64 1.6.1-2 [92.0 kB] 807s Get:9 http://ftpmaster.internal/ubuntu plucky/universe amd64 pcscd amd64 2.3.0-1 [59.5 kB] 807s Fetched 581 kB in 0s (12.0 MB/s) 807s Selecting previously unselected package libpcsclite1:amd64. 808s (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 ... 75548 files and directories currently installed.) 808s Preparing to unpack .../0-libpcsclite1_2.3.0-1_amd64.deb ... 808s Unpacking libpcsclite1:amd64 (2.3.0-1) ... 808s Selecting previously unselected package python3-iniconfig. 808s Preparing to unpack .../1-python3-iniconfig_1.1.1-2_all.deb ... 808s Unpacking python3-iniconfig (1.1.1-2) ... 808s Selecting previously unselected package python3-packaging. 808s Preparing to unpack .../2-python3-packaging_24.1-1_all.deb ... 808s Unpacking python3-packaging (24.1-1) ... 808s Selecting previously unselected package python3-pluggy. 808s Preparing to unpack .../3-python3-pluggy_1.5.0-1_all.deb ... 808s Unpacking python3-pluggy (1.5.0-1) ... 808s Selecting previously unselected package python3-pyscard. 808s Preparing to unpack .../4-python3-pyscard_2.2.0-2_amd64.deb ... 808s Unpacking python3-pyscard (2.2.0-2) ... 808s Selecting previously unselected package python3-pytest. 808s Preparing to unpack .../5-python3-pytest_8.3.3-1_all.deb ... 808s Unpacking python3-pytest (8.3.3-1) ... 808s Selecting previously unselected package libccid. 808s Preparing to unpack .../6-libccid_1.6.1-2_amd64.deb ... 808s Unpacking libccid (1.6.1-2) ... 808s Selecting previously unselected package pcscd. 808s Preparing to unpack .../7-pcscd_2.3.0-1_amd64.deb ... 808s Unpacking pcscd (2.3.0-1) ... 808s Selecting previously unselected package autopkgtest-satdep. 808s Preparing to unpack .../8-1-autopkgtest-satdep.deb ... 808s Unpacking autopkgtest-satdep (0) ... 808s Setting up python3-iniconfig (1.1.1-2) ... 808s Setting up libccid (1.6.1-2) ... 808s Setting up python3-packaging (24.1-1) ... 808s Setting up libpcsclite1:amd64 (2.3.0-1) ... 808s Setting up python3-pluggy (1.5.0-1) ... 808s Setting up python3-pyscard (2.2.0-2) ... 809s Setting up python3-pytest (8.3.3-1) ... 809s Setting up pcscd (2.3.0-1) ... 809s Created symlink '/etc/systemd/system/sockets.target.wants/pcscd.socket' → '/usr/lib/systemd/system/pcscd.socket'. 810s pcscd.service is a disabled or a static unit, not starting it. 810s Setting up autopkgtest-satdep (0) ... 810s Processing triggers for man-db (2.12.1-3) ... 811s Processing triggers for libc-bin (2.40-1ubuntu3) ... 814s (Reading database ... 75874 files and directories currently installed.) 814s Removing autopkgtest-satdep (0) ... 814s autopkgtest [10:02:36]: test pyscard-tests: [----------------------- 814s PCSCD_ARGS=--disable-polkit 815s ============================= test session starts ============================== 815s platform linux -- Python 3.12.7, pytest-8.3.3, pluggy-1.5.0 -- /usr/bin/python3 815s cachedir: .pytest_cache 815s rootdir: /tmp/autopkgtest.uQoQr8/build.zp6/src 815s configfile: pyproject.toml 815s plugins: typeguard-4.4.1 815s collecting ... collected 83 items 815s 815s test/test_ATR.py::test_atr1 PASSED [ 1%] 815s test/test_ATR.py::test_atr2 PASSED [ 2%] 815s test/test_ATR.py::test_atr3 PASSED [ 3%] 815s test/test_ATR.py::test_atr4 PASSED [ 4%] 815s test/test_ATR.py::test_atr5 PASSED [ 6%] 815s test/test_ATR.py::test_atr6 PASSED [ 7%] 815s test/test_ATR.py::test_atr_ts PASSED [ 8%] 815s test/test_ATR.py::test_atr_get PASSED [ 9%] 815s test/test_ATR.py::test_map_lengths[clockrateconversion-16] PASSED [ 10%] 815s test/test_ATR.py::test_map_lengths[bitratefactor-16] PASSED [ 12%] 815s test/test_Exceptions.py::test_hresult_value PASSED [ 13%] 815s test/test_Exceptions.py::test_list_readers_exception PASSED [ 14%] 815s test/test_Exceptions.py::test_no_readers_exception PASSED [ 15%] 815s test/test_Exceptions.py::test_invalid_reader_exception PASSED [ 16%] 815s test/test_Exceptions.py::test_card_connection_exception PASSED [ 18%] 815s test/test_Exceptions.py::test_hresult PASSED [ 19%] 815s test/test_Exceptions.py::test_wrong_type[arg0] PASSED [ 20%] 815s test/test_Exceptions.py::test_wrong_type[foo] PASSED [ 21%] 815s test/test_Exceptions.py::test_card_request_timeout_exception PASSED [ 22%] 815s test/test_Exceptions.py::test_invalid_atr_mask_length_exception PASSED [ 24%] 815s test/test_Exceptions.py::test_no_card_exception PASSED [ 25%] 815s test/test_PCSC.py::test_low_level PASSED [ 26%] 815s test/test_PCSCExceptions.py::test_list_readers_exception PASSED [ 27%] 815s test/test_PCSCExceptions.py::test_establish_context_exception PASSED [ 28%] 815s test/test_PCSCExceptions.py::test_introduce_reader_exception PASSED [ 30%] 815s test/test_PCSCExceptions.py::test_remove_reader_from_group_exception PASSED [ 31%] 815s test/test_PCSCExceptions.py::test_add_reader_to_group_exception PASSED [ 32%] 815s test/test_PCSCExceptions.py::test_release_context_exception PASSED [ 33%] 815s test/test_PCSCExceptions.py::test_base_scard_exception PASSED [ 34%] 815s test/test_SCardGetErrorMessage.py::test_scard_get_error_message PASSED [ 36%] 815s test/test_guid.py::test_roundtrip_string PASSED [ 37%] 815s test/test_guid.py::test_roundtrip_list_of_ints PASSED [ 38%] 815s test/test_observer.py::test_state_changes PASSED [ 39%] 815s test/test_observer.py::test_synchronization[addObserver] PASSED [ 40%] 815s test/test_observer.py::test_synchronization[countObservers] PASSED [ 42%] 815s test/test_observer.py::test_synchronization[deleteObserver] PASSED [ 43%] 815s test/test_observer.py::test_synchronization[deleteObservers] PASSED [ 44%] 815s test/test_observer.py::test_synchronization[notifyObservers] PASSED [ 45%] 815s test/test_observer.py::test_synchronization[clearChanged] PASSED [ 46%] 815s test/test_observer.py::test_synchronization[hasChanged] PASSED [ 48%] 815s test/test_observer.py::test_synchronization[setChanged] PASSED [ 49%] 815s test/test_observer.py::test_registered_observers_are_always_notified PASSED [ 50%] 815s test/test_observer.py::test_double_observer_additions PASSED [ 51%] 815s test/test_observer.py::test_double_observer_removals PASSED [ 53%] 815s test/test_observer.py::test_no_notifications_when_no_changes PASSED [ 54%] 815s test/test_observer.py::test_default_observer_updates PASSED [ 55%] 815s test/test_readergroups.py::test_reader_groups_acts_like_a_singleton PASSED [ 56%] 815s test/test_readergroups.py::test_reader_groups_method_calls PASSED [ 57%] 815s test/test_readergroups.py::test_reader_groups_is_a_singleton XFAIL (...) [ 59%] 815s test/test_readergroups.py::test_demonstrate_initlist_values_may_be_silently_ignored XFAIL [ 60%] 815s test/test_readergroups.py::test_demonstrate_adding_is_impossible PASSED [ 61%] 815s test/test_readergroups.py::test_demonstrate_removing_is_impossible PASSED [ 62%] 815s test/test_readergroups.py::test_demonstrate_getting_is_impossible PASSED [ 63%] 815s test/test_synchronization.py::test_synchronize[wrap nothing (str)] PASSED [ 65%] 815s test/test_synchronization.py::test_synchronize[wrap nothing (a, str)] PASSED [ 66%] 815s test/test_synchronization.py::test_synchronize[wrap nothing (a+b, str)] PASSED [ 67%] 815s test/test_synchronization.py::test_synchronize[wrap nothing (list)] PASSED [ 68%] 815s test/test_synchronization.py::test_synchronize[wrap nothing (a, list)] PASSED [ 69%] 815s test/test_synchronization.py::test_synchronize[wrap nothing (a+b, list)] PASSED [ 71%] 815s test/test_synchronization.py::test_synchronize[wrap all] PASSED [ 72%] 815s test/test_synchronization.py::test_synchronize[wrap all (a)] PASSED [ 73%] 815s test/test_synchronization.py::test_synchronize[wrap all (a+b)] PASSED [ 74%] 815s test/test_synchronization.py::test_synchronize[wrap a only (a, str)] PASSED [ 75%] 815s test/test_synchronization.py::test_synchronize[wrap a only (a+b, str)] PASSED [ 77%] 815s test/test_synchronization.py::test_synchronize[wrap a only (a, list)] PASSED [ 78%] 815s test/test_synchronization.py::test_synchronize[wrap a only (a+b, list)] PASSED [ 79%] 815s test/test_synchronization.py::test_synchronization_reentrant_lock PASSED [ 80%] 815s test/test_synchronization.py::test_synchronization_wrapping PASSED [ 81%] 815s test/test_synchronization.py::test_synchronization_kwargs PASSED [ 83%] 815s test/test_ulist.py::test_demonstrate_ulist_cannot_be_instantiated PASSED [ 84%] 815s test/test_ulist.py::test_demonstrate_order_is_not_respected XFAIL (o...) [ 85%] 815s test/test_ulist.py::test_demonstrate_non_unique_behavior XFAIL (not ...) [ 86%] 815s test/test_ulist.py::test_ulist_methods PASSED [ 87%] 815s test/test_util.py::test_to_bytes PASSED [ 89%] 815s test/test_util.py::test_padd PASSED [ 90%] 815s test/test_util.py::test_to_ascii_bytes PASSED [ 91%] 815s test/test_util.py::test_to_ascii_string PASSED [ 92%] 815s test/test_util.py::test_to_gsm3_38_bytes PASSED [ 93%] 815s test/test_util.py::test_to_hex_string PASSED [ 95%] 815s test/test_util.py::test_hex_list_to_bin_string PASSED [ 96%] 815s test/test_util.py::test_bin_string_to_hex_list PASSED [ 97%] 815s test/test_util.py::test_hl2bs PASSED [ 98%] 815s test/test_util.py::test_bs2hl PASSED [100%] 815s 815s ======================== 79 passed, 4 xfailed in 0.38s ========================= 815s autopkgtest [10:02:37]: test pyscard-tests: -----------------------] 816s autopkgtest [10:02:38]: test pyscard-tests: - - - - - - - - - - results - - - - - - - - - - 816s pyscard-tests PASS 816s autopkgtest [10:02:38]: @@@@@@@@@@@@@@@@@@@@ summary 816s pyscard-tests PASS 829s virt: nova [W] Skipping flock for amd64 829s virt: Creating nova instance adt-plucky-amd64-pyscard-20241113-094902-juju-7f2275-prod-proposed-migration-environment-2-4644a938-6907-4ea0-a2e3-c50e25ff03b7 from image adt/ubuntu-plucky-amd64-server-20241113.img (UUID 76b850f9-98f4-4b79-af06-fa11000b95b2)...