0s autopkgtest [09:59:57]: starting date and time: 2024-11-13 09:59:57+0000 0s autopkgtest [09:59:57]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [09:59:57]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.pnshrq3u/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 pykcs11 --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-20@bos03-arm64-26.secgroup --name adt-plucky-arm64-pykcs11-20241113-095956-juju-7f2275-prod-proposed-migration-environment-20-bf54edfc-7056-4f85-8786-a0ac8fb365d6 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --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/ 93s autopkgtest [10:01:30]: testbed dpkg architecture: arm64 93s autopkgtest [10:01:30]: testbed apt version: 2.9.8 93s autopkgtest [10:01:30]: @@@@@@@@@@@@@@@@@@@@ test bed setup 94s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 94s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.4 kB] 94s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [849 kB] 94s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 94s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 94s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [104 kB] 94s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [50.3 kB] 94s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [601 kB] 95s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [17.1 kB] 95s Fetched 1794 kB in 1s (1974 kB/s) 95s Reading package lists... 99s Reading package lists... 99s Building dependency tree... 99s Reading state information... 100s Calculating upgrade... 100s The following NEW packages will be installed: 100s python3.13-gdbm 100s The following packages will be upgraded: 100s libpython3-stdlib python3 python3-gdbm python3-minimal 101s 4 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 101s Need to get 101 kB of archives. 101s After this operation, 141 kB of additional disk space will be used. 101s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3-minimal arm64 3.12.7-1 [27.4 kB] 101s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3 arm64 3.12.7-1 [24.0 kB] 101s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libpython3-stdlib arm64 3.12.7-1 [10.0 kB] 101s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 python3.13-gdbm arm64 3.13.0-2 [30.7 kB] 101s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3-gdbm arm64 3.12.7-1 [8642 B] 101s Fetched 101 kB in 0s (265 kB/s) 102s (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 ... 79924 files and directories currently installed.) 102s Preparing to unpack .../python3-minimal_3.12.7-1_arm64.deb ... 102s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 102s Setting up python3-minimal (3.12.7-1) ... 102s (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 ... 79924 files and directories currently installed.) 102s Preparing to unpack .../python3_3.12.7-1_arm64.deb ... 102s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 102s Preparing to unpack .../libpython3-stdlib_3.12.7-1_arm64.deb ... 102s Unpacking libpython3-stdlib:arm64 (3.12.7-1) over (3.12.6-0ubuntu1) ... 102s Selecting previously unselected package python3.13-gdbm. 102s Preparing to unpack .../python3.13-gdbm_3.13.0-2_arm64.deb ... 102s Unpacking python3.13-gdbm (3.13.0-2) ... 102s Preparing to unpack .../python3-gdbm_3.12.7-1_arm64.deb ... 102s Unpacking python3-gdbm:arm64 (3.12.7-1) over (3.12.6-1ubuntu1) ... 102s Setting up python3.13-gdbm (3.13.0-2) ... 102s Setting up libpython3-stdlib:arm64 (3.12.7-1) ... 102s Setting up python3 (3.12.7-1) ... 103s Setting up python3-gdbm:arm64 (3.12.7-1) ... 103s Processing triggers for man-db (2.12.1-3) ... 104s Reading package lists... 104s Building dependency tree... 104s Reading state information... 106s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 106s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 106s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 106s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 106s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 108s Reading package lists... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 109s Calculating upgrade... 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... 112s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s autopkgtest [10:01:52]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 14:19:41 UTC 2024 115s autopkgtest [10:01:52]: @@@@@@@@@@@@@@@@@@@@ apt-source pykcs11 117s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pykcs11 1.5.17-1 (dsc) [2127 B] 117s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pykcs11 1.5.17-1 (tar) [82.7 kB] 117s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pykcs11 1.5.17-1 (diff) [8256 B] 117s gpgv: Signature made Wed Oct 16 11:52:54 2024 UTC 117s gpgv: using RSA key F5E11B9FFE911146F41D953D78A1B4DFE8F9C57E 117s gpgv: issuer "rousseau@debian.org" 117s gpgv: Can't check signature: No public key 117s dpkg-source: warning: cannot verify inline signature for ./pykcs11_1.5.17-1.dsc: no acceptable signature found 117s autopkgtest [10:01:54]: testing package pykcs11 version 1.5.17-1 119s autopkgtest [10:01:56]: build not needed 119s autopkgtest [10:01:56]: test unittest: preparing testbed 121s Reading package lists... 121s Building dependency tree... 121s Reading state information... 122s Starting pkgProblemResolver with broken count: 0 122s Starting 2 pkgProblemResolver with broken count: 0 122s Done 123s The following additional packages will be installed: 123s libsofthsm2 python3-asn1crypto python3-pykcs11 softhsm2 softhsm2-common 123s The following NEW packages will be installed: 123s autopkgtest-satdep libsofthsm2 python3-asn1crypto python3-pykcs11 softhsm2 123s softhsm2-common 123s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 123s Need to get 665 kB/666 kB of archives. 123s After this operation, 3199 kB of additional disk space will be used. 123s Get:1 /tmp/autopkgtest.HpjHQ5/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [740 B] 123s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-asn1crypto all 1.5.1-3 [79.7 kB] 123s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-pykcs11 arm64 1.5.17-1 [165 kB] 123s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 softhsm2-common arm64 2.6.1-2.2ubuntu3 [6196 B] 123s Get:5 http://ftpmaster.internal/ubuntu plucky/universe arm64 libsofthsm2 arm64 2.6.1-2.2ubuntu3 [247 kB] 124s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 softhsm2 arm64 2.6.1-2.2ubuntu3 [167 kB] 124s Fetched 665 kB in 1s (1252 kB/s) 124s Selecting previously unselected package python3-asn1crypto. 124s (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 ... 79931 files and directories currently installed.) 124s Preparing to unpack .../0-python3-asn1crypto_1.5.1-3_all.deb ... 124s Unpacking python3-asn1crypto (1.5.1-3) ... 124s Selecting previously unselected package python3-pykcs11. 124s Preparing to unpack .../1-python3-pykcs11_1.5.17-1_arm64.deb ... 124s Unpacking python3-pykcs11 (1.5.17-1) ... 124s Selecting previously unselected package softhsm2-common. 124s Preparing to unpack .../2-softhsm2-common_2.6.1-2.2ubuntu3_arm64.deb ... 124s Unpacking softhsm2-common (2.6.1-2.2ubuntu3) ... 124s Selecting previously unselected package libsofthsm2. 124s Preparing to unpack .../3-libsofthsm2_2.6.1-2.2ubuntu3_arm64.deb ... 124s Unpacking libsofthsm2 (2.6.1-2.2ubuntu3) ... 124s Selecting previously unselected package softhsm2. 124s Preparing to unpack .../4-softhsm2_2.6.1-2.2ubuntu3_arm64.deb ... 124s Unpacking softhsm2 (2.6.1-2.2ubuntu3) ... 124s Selecting previously unselected package autopkgtest-satdep. 125s Preparing to unpack .../5-1-autopkgtest-satdep.deb ... 125s Unpacking autopkgtest-satdep (0) ... 125s Setting up softhsm2-common (2.6.1-2.2ubuntu3) ... 125s 125s Creating config file /etc/softhsm/softhsm2.conf with new version 125s Setting up python3-pykcs11 (1.5.17-1) ... 125s Setting up python3-asn1crypto (1.5.1-3) ... 125s Setting up libsofthsm2 (2.6.1-2.2ubuntu3) ... 125s Setting up softhsm2 (2.6.1-2.2ubuntu3) ... 125s Setting up autopkgtest-satdep (0) ... 125s Processing triggers for man-db (2.12.1-3) ... 129s (Reading database ... 80028 files and directories currently installed.) 129s Removing autopkgtest-satdep (0) ... 130s autopkgtest [10:02:07]: test unittest: [----------------------- 131s The token has been initialized and is reassigned to slot 1316992406 131s test_CKH (test_CK.TestUtil.test_CKH) ... ok 131s test_CKM (test_CK.TestUtil.test_CKM) ... ok 131s test_CKR (test_CK.TestUtil.test_CKR) ... ok 131s test_LowLevel (test_LowLevel.TestUtil.test_LowLevel) ... ok 131s test_RSA_OAEP (test_asymetric.TestUtil.test_RSA_OAEP) ... ok 131s test_RSA_OAEPwithAAD (test_asymetric.TestUtil.test_RSA_OAEPwithAAD) ... skipped "'AAD' not (yet) supported." 131s test_RSA_PSS_SHA1 (test_asymetric.TestUtil.test_RSA_PSS_SHA1) ... ok 131s test_RSA_PSS_SHA256 (test_asymetric.TestUtil.test_RSA_PSS_SHA256) ... ok 131s test_encrypt_PKCS (test_asymetric.TestUtil.test_encrypt_PKCS) ... ok 131s test_encrypt_X509 (test_asymetric.TestUtil.test_encrypt_X509) ... ok 131s test_pubKey (test_asymetric.TestUtil.test_pubKey) ... ok 131s test_sign_PKCS (test_asymetric.TestUtil.test_sign_PKCS) ... ok 131s test_sign_PKCS_SHA256 (test_asymetric.TestUtil.test_sign_PKCS_SHA256) ... ok 131s test_sign_X509 (test_asymetric.TestUtil.test_sign_X509) ... ok 131s test_sign_integer (test_asymetric.TestUtil.test_sign_integer) ... ok 132s test_sign_integer (test_asymetric_ECC.TestUtil.test_sign_integer) ... ok 132s test_sign_text (test_asymetric_ECC.TestUtil.test_sign_text) ... ok 132s test_gost (test_asymetric_gost.TestUtil.test_gost) ... skipped 'GOST not supported by SoftHSMv2 on Windows?' 132s test_append (test_ckbytelist.Testutil.test_append) ... ok 132s test_data (test_ckbytelist.Testutil.test_data) ... ok 132s test_empty (test_ckbytelist.Testutil.test_empty) ... ok 132s test_init_bytes (test_ckbytelist.Testutil.test_init_bytes) ... ok 132s test_init_ckbytelist (test_ckbytelist.Testutil.test_init_ckbytelist) ... ok 132s test_init_list0 (test_ckbytelist.Testutil.test_init_list0) ... ok 132s test_init_list1 (test_ckbytelist.Testutil.test_init_list1) ... ok 132s test_init_list5 (test_ckbytelist.Testutil.test_init_list5) ... ok 132s test_init_str (test_ckbytelist.Testutil.test_init_str) ... ok 132s test_length0 (test_ckbytelist.Testutil.test_length0) ... ok 132s test_length5 (test_ckbytelist.Testutil.test_length5) ... ok 132s test_resize (test_ckbytelist.Testutil.test_resize) ... ok 132s test_string (test_ckbytelist.Testutil.test_string) ... ok 132s test_unknown_format (test_ckbytelist.Testutil.test_unknown_format) ... ok 132s test_deriveKey_CKM_CONCATENATE_BASE_AND_DATA (test_derive.TestUtil.test_deriveKey_CKM_CONCATENATE_BASE_AND_DATA) ... skipped 'CKM_CONCATENATE_BASE_AND_DATA is not supported by SoftHSM <= 2.6' 132s test_deriveKey_CKM_CONCATENATE_BASE_AND_KEY (test_derive.TestUtil.test_deriveKey_CKM_CONCATENATE_BASE_AND_KEY) ... skipped 'CKM_CONCATENATE_BASE_AND_KEY is not supported by SoftHSM <= 2.6' 132s test_deriveKey_CKM_CONCATENATE_DATA_AND_BASE (test_derive.TestUtil.test_deriveKey_CKM_CONCATENATE_DATA_AND_BASE) ... skipped 'CKM_CONCATENATE_DATA_AND_BASE is not supported by SoftHSM <= 2.6' 132s test_deriveKey_CKM_XOR_BASE_AND_DATA (test_derive.TestUtil.test_deriveKey_CKM_XOR_BASE_AND_DATA) ... skipped 'SoftHSM does not support CKM_XOR_BASE_AND_DATA' 132s test_deriveKey_ECDH1_DERIVE (test_derive.TestUtil.test_deriveKey_ECDH1_DERIVE) ... ok 132s test_digest (test_digest.TestUtil.test_digest) ... ok 132s test_digestSession (test_digest.TestUtil.test_digestSession) ... ok 132s test_CKR_OK (test_exception.Testutil.test_CKR_OK) ... ok 132s test_CKR_PIN_INVALID (test_exception.Testutil.test_CKR_PIN_INVALID) ... ok 132s test_Load (test_exception.Testutil.test_Load) ... ok 132s test_empty (test_exception.Testutil.test_empty) ... ok 132s test_raise (test_exception.Testutil.test_raise) ... ok 132s test_unknown (test_exception.Testutil.test_unknown) ... ok 132s test_vendor0 (test_exception.Testutil.test_vendor0) ... ok 132s test_vendor10 (test_exception.Testutil.test_vendor10) ... ok 132s test_gc (test_gc.TestUtil.test_gc) ... ok 132s test_getInfo (test_info.TestUtil.test_getInfo) ... ok 132s test_getMechanismList (test_info.TestUtil.test_getMechanismList) ... ok 132s test_getSessionInfo (test_info.TestUtil.test_getSessionInfo) ... ok 132s test_getSlotInfo (test_info.TestUtil.test_getSlotInfo) ... ok 132s test_getTokenInfo (test_info.TestUtil.test_getTokenInfo) ... ok 132s test_initPin (test_init.TestUtil.test_initPin) ... ok 132s test_initToken (test_init.TestUtil.test_initToken) ... ok 132s test_initToken_utf8 (test_init.TestUtil.test_initToken_utf8) ... ok 132s test_setPin (test_init.TestUtil.test_setPin) ... ok 132s test_invalid_load (test_load.TestUtil.test_invalid_load) ... ok 132s test_load (test_load.TestUtil.test_load) ... ok 132s test_multiple_load (test_load.TestUtil.test_multiple_load) ... ok 132s test_specific_load (test_load.TestUtil.test_specific_load) ... ok 132s test_unload (test_load.TestUtil.test_unload) ... ok 132s test_getAttributeValue (test_objects.TestGetSetAttributeValues.test_getAttributeValue) ... ok 132s test_setAttributeValue_with_a_list_of_attributes (test_objects.TestGetSetAttributeValues.test_setAttributeValue_with_a_list_of_attributes) ... ok 132s test_setAttributeValue_with_label_attribute (test_objects.TestGetSetAttributeValues.test_setAttributeValue_with_label_attribute) ... ok 132s test_setAttributeValue_with_single_binary_attribute (test_objects.TestGetSetAttributeValues.test_setAttributeValue_with_single_binary_attribute) ... ok 132s test_BoolAttributes (test_objects.TestUtil.test_BoolAttributes) ... ok 132s test_objects (test_objects.TestUtil.test_objects) ... ok 132s test_binary (test_pin.TestUtil.test_binary) ... ok 132s test_ckbytelist (test_pin.TestUtil.test_ckbytelist) ... ok 132s test_login (test_pin.TestUtil.test_login) ... ok 132s test_null (test_pin.TestUtil.test_null) ... ok 132s test_wrong (test_pin.TestUtil.test_wrong) ... ok 132s test_generateRandom (test_random.TestUtil.test_generateRandom) ... ok 132s test_seedRandom (test_random.TestUtil.test_seedRandom) ... ok 132s test_symetric (test_symetric.TestUtil.test_symetric) ... ok 132s test_wrapKey (test_wrap.TestUtil.test_wrapKey) ... ok 132s test_wrapKey_OAEP (test_wrap.TestUtil.test_wrapKey_OAEP) ... ok 132s test_wrapKey_UNWRAP_TEMPLATE (test_wrap.TestUtil.test_wrapKey_UNWRAP_TEMPLATE) ... ok 132s 132s ---------------------------------------------------------------------- 132s Ran 79 tests in 1.779s 132s 132s OK (skipped=6) 132s src/dyn_unix.c:34:SYS_dyn_LoadLibrary() NoFile: cannot open shared object file: No such file or directory 132s src/dyn_unix.c:76:SYS_dyn_GetAddress() C_GetFunctionList: /lib/aarch64-linux-gnu/libc.so.6: undefined symbol: C_GetFunctionList 132s src/dyn_unix.c:34:SYS_dyn_LoadLibrary() nolib: cannot open shared object file: No such file or directory 132s src/dyn_unix.c:76:SYS_dyn_GetAddress() C_GetFunctionList: /lib/aarch64-linux-gnu/libc.so.6: undefined symbol: C_GetFunctionList 132s src/dyn_unix.c:76:SYS_dyn_GetAddress() C_GetFunctionList: /lib/aarch64-linux-gnu/libc.so.6: undefined symbol: C_GetFunctionList 133s autopkgtest [10:02:10]: test unittest: -----------------------] 133s unittest PASS 133s autopkgtest [10:02:10]: test unittest: - - - - - - - - - - results - - - - - - - - - - 135s autopkgtest [10:02:12]: @@@@@@@@@@@@@@@@@@@@ summary 135s unittest PASS 163s nova [W] Skipping flock in bos03-arm64 163s Creating nova instance adt-plucky-arm64-pykcs11-20241113-095956-juju-7f2275-prod-proposed-migration-environment-20-bf54edfc-7056-4f85-8786-a0ac8fb365d6 from image adt/ubuntu-plucky-arm64-server-20241113.img (UUID 2d7760e6-2439-4200-89d6-5ed33e5c6330)...