0s autopkgtest [14:01:19]: starting date and time: 2024-03-22 14:01:19+0000 0s autopkgtest [14:01:19]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [14:01:19]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.5wehcl_k/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=src:sphinx --apt-upgrade bibtexparser --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/7.2.6-6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-11.secgroup --name adt-noble-arm64-bibtexparser-20240322-140119-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-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,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 365s Creating nova instance adt-noble-arm64-bibtexparser-20240322-140119-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240321.img (UUID 28ecccfc-4cb0-4cc6-a280-209e2d140e10)... 365s nova boot failed (attempt #1): 365s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 365s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 365s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 365s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 365s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 365s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 365s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps6.canonical.com:5000/v3 -H "Accept: application/json" -H "User-Agent: nova keystoneauth1/4.0.0 python-requests/2.22.0 CPython/3.8.10" 365s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps6.canonical.com:5000 365s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 365s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 22 Mar 2024 14:01:42 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-24b4d13f-b14a-49ac-a9f7-650c788cc62b 365s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps6.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 365s DEBUG (session:946) GET call to https://keystone.ps6.canonical.com:5000/v3 used request id req-24b4d13f-b14a-49ac-a9f7-650c788cc62b 365s DEBUG (base:182) Making authentication request to https://keystone.ps6.canonical.com:5000/v3/auth/tokens 365s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 12445 365s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "369f50a481564a2c9433776a4ebd224d", "name": "prod-proposed-migration-arm64", "password_expires_at": null}, "audit_ids": ["no2o1ci3QfKxSfKJ5C2quA"], "expires_at": "2024-03-23T14:01:42.000000Z", "issued_at": "2024-03-22T14:01:42.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "bd8b3df3f03d43a0a9303b7c0434fdab", "name": "prod-proposed-migration-arm64_project"}, "is_domain": false, "roles": [{"id": "15cf997650e345b7b21c02b5cdb7d84a", "name": "member"}, {"id": "86bf3043974746c2bf52c2a9f362f986", "name": "reader"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "213cdf38198c4581bd5b7d6d0836923b", "interface": "internal", "region_id": "prodstack6", "url": "https://radosgw-internal.ps6.canonical.com:443/", "region": "prodstack6"}, {"id": "67061eee26944a1a8009f9d07be19738", "interface": "public", "region_id": "prodstack6", "url": "https://radosgw.ps6.canonical.com:443/", "region": "prodstack6"}, {"id": "fc88c52c749a47d08a24a2c7efbde01b", "interface": "admin", "region_id": "prodstack6", "url": "https://radosgw-admin.ps6.canonical.com:443/", "region": "prodstack6"}], "id": "06e4714942634054bf9aa11715312b4e", "type": "s3", "name": "s3"}, {"endpoints": [{"id": "8aa44c94b63746bd9b37f1008ad55fa8", "interface": "admin", "region_id": "prodstack6", "url": "https://aodh-admin.ps6.canonical.com:8042", "region": "prodstack6"}, {"id": "92cf08a80a0242ebbca8ec893cf332b1", "interface": "public", "region_id": "prodstack6", "url": "https://aodh.ps6.canonical.com:8042", "region": "prodstack6"}, {"id": "d8139c6e11ae4edcb78981c12bd53212", "interface": "internal", "region_id": "prodstack6", "url": "https://aodh-internal.ps6.canonical.com:8042", "region": "prodstack6"}], "id": "2fb939b0b969435c8f0c5fa4edb4de94", "type": "alarming", "name": "aodh"}, {"endpoints": [{"id": "a49fcc80e658411885f88cdd8432a571", "interface": "internal", "region_id": "prodstack6", "url": "https://heat-internal.ps6.canonical.com:8000/v1", "region": "prodstack6"}, {"id": "b23866fddba8415885b06c064c34b94b", "interface": "public", "region_id": "prodstack6", "url": "https://heat.ps6.canonical.com:8000/v1", "region": "prodstack6"}, {"id": "f84ae55197f94b8392a678f35c82ca26", "interface": "admin", "region_id": "prodstack6", "url": "https://heat-admin.ps6.canonical.com:8000/v1", "region": "prodstack6"}], "id": "3d4b59f7dab644b2b527e8e96b697545", "type": "cloudformation", "name": "heat-cfn"}, {"endpoints": [{"id": "2e0143334c6241169f45f1c11970c6bc", "interface": "public", "region_id": "prodstack6", "url": "https://heat.ps6.canonical.com:8004/v1/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "5e19c32243c04a3faf1e5f9ab900c260", "interface": "internal", "region_id": "prodstack6", "url": "https://heat-internal.ps6.canonical.com:8004/v1/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "b3fc5c88ec8543a691fec75726b86967", "interface": "admin", "region_id": "prodstack6", "url": "https://heat-admin.ps6.canonical.com:8004/v1/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}], "id": "43b926205044476b8093b18d8ce0a9e4", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "a47569b96e5b4146a312e4673504557c", "interface": "public", "region_id": "prodstack6", "url": "https://glance.ps6.canonical.com:9292", "region": "prodstack6"}, {"id": "bba35c4ab04f4114a2a34e65568537bd", "interface": "internal", "region_id": "prodstack6", "url": "https://glance-internal.ps6.canonical.com:9292", "region": "prodstack6"}, {"id": "ef769f1117c74a62a279131486c89628", "interface": "admin", "region_id": "prodstack6", "url": "https://glance-admin.ps6.canonical.com:9292", "region": "prodstack6"}], "id": "49de724549524bd78e9cd46a4477226f", "type": "image", "name": "glance"}, {"endpoints": [{"id": "a1a41e9a1e2d42e5b6cd5380cd1e21bf", "interface": "admin", "region_id": "prodstack6", "url": "https://cinder-admin.ps6.canonical.com:8776/v3/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "d2309a99724b4111827482c68a832c0c", "interface": "public", "region_id": "prodstack6", "url": "https://cinder.ps6.canonical.com:8776/v3/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "f8a02e3949ff42afa772eb5e74dbef9f", "interface": "internal", "region_id": "prodstack6", "url": "https://cinder-internal.ps6.canonical.com:8776/v3/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}], "id": "5bf6578a631349e3af4bf36d7adb18e1", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "01d84128f36444e9b01549b86bd69116", "interface": "admin", "region_id": "prodstack6", "url": "https://barbican-admin.ps6.canonical.com:9312", "region": "prodstack6"}, {"id": "0ce4a8777e0b40a88f7fc0f77e34a605", "interface": "public", "region_id": "prodstack6", "url": "https://barbican.ps6.canonical.com:9311", "region": "prodstack6"}, {"id": "f507ba49e4a7435cb330234217c92449", "interface": "internal", "region_id": "prodstack6", "url": "https://barbican-internal.ps6.canonical.com:9311", "region": "prodstack6"}], "id": "62cb1c3d9f6c45979c13516a6b3ff114", "type": "key-manager", "name": "barbican"}, {"endpoints": [{"id": "3cb6121bd8f14da8aa2fba7be823a2b4", "interface": "internal", "region_id": "prodstack6", "url": "https://neutron-internal.ps6.canonical.com:9696", "region": "prodstack6"}, {"id": "46ba11d133fe4e8f9e8f9097ba737682", "interface": "admin", "region_id": "prodstack6", "url": "https://neutron-admin.ps6.canonical.com:9696", "region": "prodstack6"}, {"id": "d872eb6aa23d40009165aa3dcdce3948", "interface": "public", "region_id": "prodstack6", "url": "https://neutron.ps6.canonical.com:9696", "region": "prodstack6"}], "id": "759cb6fdfbc146dd8b9d1ba444c4b9db", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "4349d565f72446da9699269f85df5e8b", "interface": "internal", "region_id": "prodstack6", "url": "https://manila-internal.ps6.canonical.com:8786/v2/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "a483dcc58f5e415e9ec739c94474e609", "interface": "public", "region_id": "prodstack6", "url": "https://manila.ps6.canonical.com:8786/v2/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "c1f14236723e42878562d8dd63d5a6a0", "interface": "admin", "region_id": "prodstack6", "url": "https://manila-admin.ps6.canonical.com:8786/v2/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}], "id": "93fc4008035946deb1f433c2dd905a5d", "type": "sharev2", "name": "manilav2"}, {"endpoints": [{"id": "0fa148793c7249c8b187b6b4ff425731", "interface": "internal", "region_id": "prodstack6", "url": "https://radosgw-internal.ps6.canonical.com:443/swift/v1/AUTH_e4b04ca58d734ed0aa29e306adad4f79/simplestreams/data", "region": "prodstack6"}, {"id": "555ade266a6b4bcc81b6e5abf607aec5", "interface": "public", "region_id": "prodstack6", "url": "https://radosgw.ps6.canonical.com:443/swift/v1/AUTH_e4b04ca58d734ed0aa29e306adad4f79/simplestreams/data", "region": "prodstack6"}, {"id": "7dad1a7b1552465686424fc014463173", "interface": "admin", "region_id": "prodstack6", "url": "https://radosgw-admin.ps6.canonical.com:443/swift/simplestreams/data", "region": "prodstack6"}], "id": "977dd359af1a4fcc91a9daf4dc33b0f3", "type": "product-streams", "name": "image-stream"}, {"endpoints": [{"id": "12d30eabcdec4831bd15273d55b1cbab", "interface": "internal", "region_id": "prodstack6", "url": "https://manila-internal.ps6.canonical.com:8786/v1/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "29d35b2b483346479f1ff1a13604d50e", "interface": "admin", "region_id": "prodstack6", "url": "https://manila-admin.ps6.canonical.com:8786/v1/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "4aa1422b8f5945d8aed9ba6a8d670e5c", "interface": "public", "region_id": "prodstack6", "url": "https://manila.ps6.canonical.com:8786/v1/bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}], "id": "ac5e4f28fa794cde99f1d7ffc1b664e5", "type": "share", "name": "manila"}, {"endpoints": [{"id": "c7db93d54a684d8caeae1d9e18a59118", "interface": "admin", "region_id": "prodstack6", "url": "https://nova-admin.ps6.canonical.com:8774/v2.1", "region": "prodstack6"}, {"id": "dd7a796f401b477f9f1b5bbc05747d8d", "interface": "public", "region_id": "prodstack6", "url": "https://nova.ps6.canonical.com:8774/v2.1", "region": "prodstack6"}, {"id": "e7ecb038d830462ea67b0b463af5e013", "interface": "internal", "region_id": "prodstack6", "url": "https://nova-internal.ps6.canonical.com:8774/v2.1", "region": "prodstack6"}], "id": "b4519af08e174d4a8333a2d14ac3ba3b", "type": "compute", "name": "nova"}, {"endpoints": [{"id": "02ef5b6154934ffd97d8b5b8e4d70d2a", "interface": "internal", "region_id": "prodstack6", "url": "https://radosgw-internal.ps6.canonical.com:443/swift/v1/AUTH_bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "2741abe526e94842a4fa801423ba1ef0", "interface": "public", "region_id": "prodstack6", "url": "https://radosgw.ps6.canonical.com:443/swift/v1/AUTH_bd8b3df3f03d43a0a9303b7c0434fdab", "region": "prodstack6"}, {"id": "3742f9406c604516933d6fd8c29e0880", "interface": "admin", "region_id": "prodstack6", "url": "https://radosgw-admin.ps6.canonical.com:443/swift", "region": "prodstack6"}], "id": "c7f07a7b3b3c408c96200dfd1d1a0f6f", "type": "object-store", "name": "swift"}, {"endpoints": [{"id": "06d4ed6c160a43f2b7fa7f80ad1dc709", "interface": "internal", "region_id": "prodstack6", "url": "https://designate-internal.ps6.canonical.com:9001", "region": "prodstack6"}, {"id": "1e240624a50c4ca0aaa6ef63cbc94f1b", "interface": "admin", "region_id": "prodstack6", "url": "https://designate-admin.ps6.canonical.com:9001", "region": "prodstack6"}, {"id": "f94d7d17997a43fd9c63b34c43301c6e", "interface": "public", "region_id": "prodstack6", "url": "https://designate.ps6.canonical.com:9001", "region": "prodstack6"}], "id": "cf82013d63844fedbe96bcacb6bd1fef", "type": "dns", "name": "designate"}, {"endpoints": [{"id": "4a688340be464710bfa60bf3f88f41c4", "interface": "admin", "region_id": "prodstack6", "url": "https://gnocchi-admin.ps6.canonical.com:8041", "region": "prodstack6"}, {"id": "a5a95506c96d4716adb4efc3ac9051be", "interface": "public", "region_id": "prodstack6", "url": "https://gnocchi.ps6.canonical.com:8041", "region": "prodstack6"}, {"id": "eebc17a086834f8fa8bb6b35c8061a8c", "interface": "internal", "region_id": "prodstack6", "url": "https://gnocchi-internal.ps6.canonical.com:8041", "region": "prodstack6"}], "id": "d10589e854a446a5b852593f33f170a7", "type": "metric", "name": "gnocchi"}, {"endpoints": [{"id": "08f66df28d0f47f3bec12f29e06d85ac", "interface": "admin", "region_id": "prodstack6", "url": "https://keystone-admin.ps6.canonical.com:35357/v3", "region": "prodstack6"}, {"id": "46d270b45ceb42db902f4d241afa6a70", "interface": "public", "region_id": "prodstack6", "url": "https://keystone.ps6.canonical.com:5000/v3", "region": "prodstack6"}, {"id": "a4addee11d9349cfa46ec6660dbad947", "interface": "internal", "region_id": "prodstack6", "url": "https://keystone-internal.ps6.canonical.com:5000/v3", "region": "prodstack6"}], "id": "deb38a775a9b4e87a8de9e3eed779882", "type": "identity", "name": "keystone"}, {"endpoints": [{"id": "18b4af5f40664babb94e884c6a53ccf3", "interface": "admin", "region_id": "prodstack6", "url": "https://octavia-admin.ps6.canonical.com:9876", "region": "prodstack6"}, {"id": "2b6f7ba7f9944ee1aebd6dccc5223b2d", "interface": "internal", "region_id": "prodstack6", "url": "https://octavia-internal.ps6.canonical.com:9876", "region": "prodstack6"}, {"id": "5e3012e9c79e4890be4d964b6208f5c6", "interface": "public", "region_id": "prodstack6", "url": "https://octavia.ps6.canonical.com:9876", "region": "prodstack6"}], "id": "e00337be20d54948b66a1c3109b885c6", "type": "load-balancer", "name": "octavia"}, {"endpoints": [{"id": "2d2942b35f3041389ad810f679d02f22", "interface": "public", "region_id": "prodstack6", "url": "https://placement.ps6.canonical.com:8778", "region": "prodstack6"}, {"id": "2e3beaac7ac14284b72e2592820ad725", "interface": "admin", "region_id": "prodstack6", "url": "https://placement-admin.ps6.canonical.com:8778", "region": "prodstack6"}, {"id": "91060f6df9ae444f81808adf40540d94", "interface": "internal", "region_id": "prodstack6", "url": "https://placement-internal.ps6.canonical.com:8778", "region": "prodstack6"}], "id": "edc6e37f154f4c0ab3dd4d52b82bf873", "type": "placement", "name": "placement"}]}} 365s REQ: curl -g -i -X GET https://nova.ps6.canonical.com:8774/v2.1 -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}caf18d3000135ed69b265e2fc83bc573b13d844491672d62f9508972b7006d14" 365s DEBUG (session:517) REQ: curl -g -i -X GET https://nova.ps6.canonical.com:8774/v2.1 -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}caf18d3000135ed69b265e2fc83bc573b13d844491672d62f9508972b7006d14" 365s DEBUG (connectionpool:962) Starting new HTTPS connection (1): nova.ps6.canonical.com:8774 365s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1 HTTP/1.1" 302 0 365s RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Fri, 22 Mar 2024 14:01:42 GMT Keep-Alive: timeout=75, max=1000 Location: https://nova.ps6.canonical.com:8774/v2.1/ Server: Apache/2.4.52 (Ubuntu) x-compute-request-id: req-36379204-7615-4a6f-a513-b1a78d9abc7c x-openstack-request-id: req-36379204-7615-4a6f-a513-b1a78d9abc7c 365s DEBUG (session:548) RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Fri, 22 Mar 2024 14:01:42 GMT Keep-Alive: timeout=75, max=1000 Location: https://nova.ps6.canonical.com:8774/v2.1/ Server: Apache/2.4.52 (Ubuntu) x-compute-request-id: req-36379204-7615-4a6f-a513-b1a78d9abc7c x-openstack-request-id: req-36379204-7615-4a6f-a513-b1a78d9abc7c 365s RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged. 365s DEBUG (session:580) RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged. 365s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/ HTTP/1.1" 200 397 365s RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Fri, 22 Mar 2024 14:01:42 GMT Keep-Alive: timeout=75, max=999 OpenStack-API-Version: compute 2.1 Server: Apache/2.4.52 (Ubuntu) Vary: OpenStack-API-Version,X-OpenStack-Nova-API-Version X-OpenStack-Nova-API-Version: 2.1 x-compute-request-id: req-0d5e11f4-94c6-4fa0-8aec-0aebd1b92d70 x-openstack-request-id: req-0d5e11f4-94c6-4fa0-8aec-0aebd1b92d70 365s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Fri, 22 Mar 2024 14:01:42 GMT Keep-Alive: timeout=75, max=999 OpenStack-API-Version: compute 2.1 Server: Apache/2.4.52 (Ubuntu) Vary: OpenStack-API-Version,X-OpenStack-Nova-API-Version X-OpenStack-Nova-API-Version: 2.1 x-compute-request-id: req-0d5e11f4-94c6-4fa0-8aec-0aebd1b92d70 x-openstack-request-id: req-0d5e11f4-94c6-4fa0-8aec-0aebd1b92d70 365s RESP BODY: {"version": {"id": "v2.1", "status": "CURRENT", "version": "2.90", "min_version": "2.1", "updated": "2013-07-23T11:33:21Z", "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/"}, {"rel": "describedby", "type": "text/html", "href": "http://docs.openstack.org/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.compute+json;version=2.1"}]}} 365s DEBUG (session:580) RESP BODY: {"version": {"id": "v2.1", "status": "CURRENT", "version": "2.90", "min_version": "2.1", "updated": "2013-07-23T11:33:21Z", "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/"}, {"rel": "describedby", "type": "text/html", "href": "http://docs.openstack.org/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.compute+json;version=2.1"}]}} 365s GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-0d5e11f4-94c6-4fa0-8aec-0aebd1b92d70 365s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-0d5e11f4-94c6-4fa0-8aec-0aebd1b92d70 365s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 365s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 365s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 365s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 365s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 365s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 365s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 365s DEBUG (session:517) REQ: curl -g -i -X GET https://glance.ps6.canonical.com:9292/v2/images/28ecccfc-4cb0-4cc6-a280-209e2d140e10 -H "Accept: application/json" -H "OpenStack-API-Version: compute 2.87" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}caf18d3000135ed69b265e2fc83bc573b13d844491672d62f9508972b7006d14" -H "X-OpenStack-Nova-API-Version: 2.87" 365s DEBUG (connectionpool:962) Starting new HTTPS connection (1): glance.ps6.canonical.com:9292 365s DEBUG (connectionpool:429) https://glance.ps6.canonical.com:9292 "GET /v2/images/28ecccfc-4cb0-4cc6-a280-209e2d140e10 HTTP/1.1" 200 1935 365s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1935 Content-Type: application/json Date: Fri, 22 Mar 2024 14:01:43 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) X-Openstack-Request-Id: req-3520c19c-1b38-41ed-aefb-b87296749598 365s DEBUG (session:580) RESP BODY: {"base_image_ref": "09c3944a-cd0d-425d-b22f-cde7ec51d155", "boot_roles": "reader,member", "hw_cdrom_bus": "scsi", "hw_disk_bus": "virtio", "hw_machine_type": "virt", "hw_video_model": "virtio", "hw_vif_model": "virtio", "image_location": "snapshot", "image_state": "available", "image_type": "snapshot", "instance_uuid": "543499e0-aeb9-4922-8880-c51a4fc18bf8", "owner_id": "bd8b3df3f03d43a0a9303b7c0434fdab", "owner_project_name": "prod-proposed-migration-arm64_project", "owner_specified.openstack.md5": "087a26f2222dab8516c553374a9d1b4d", "owner_specified.openstack.object": "images/adt/ubuntu-noble-arm64-server-20240201.img", "owner_specified.openstack.sha256": "095b278df09de76f01843de514daf3f8eb0a0cc67fee4b3491161913153619db", "owner_user_name": "prod-proposed-migration-arm64", "user_id": "369f50a481564a2c9433776a4ebd224d", "name": "adt/ubuntu-noble-arm64-server-20240321.img", "disk_format": "qcow2", "container_format": "bare", "visibility": "private", "size": 2306342912, "virtual_size": 21474836480, "status": "active", "checksum": "8198422d2c7534f56b5a2a46874755ab", "protected": false, "min_ram": 0, "min_disk": 20, "owner": "bd8b3df3f03d43a0a9303b7c0434fdab", "os_hidden": false, "os_hash_algo": "sha512", "os_hash_value": "c59ccc5319301a5ec5077e547fd66aac380403815cc5c00e980d9dce3efa9cc417db45604d4bf4c4e1913c2a5af61917b84fdf003c36adeb77990adb487af4ed", "id": "28ecccfc-4cb0-4cc6-a280-209e2d140e10", "created_at": "2024-03-21T11:24:35Z", "updated_at": "2024-03-21T11:25:04Z", "locations": [{"url": "rbd://eea9d068-c18c-11ed-8dc0-013aacb71b80/glance/28ecccfc-4cb0-4cc6-a280-209e2d140e10/snap", "metadata": {"store": "ceph"}}], "direct_url": "rbd://eea9d068-c18c-11ed-8dc0-013aacb71b80/glance/28ecccfc-4cb0-4cc6-a280-209e2d140e10/snap", "tags": [], "self": "/v2/images/28ecccfc-4cb0-4cc6-a280-209e2d140e10", "file": "/v2/images/28ecccfc-4cb0-4cc6-a280-209e2d140e10/file", "schema": "/v2/schemas/image", "stores": "ceph"} 365s DEBUG (session:936) GET call to image for https://glance.ps6.canonical.com:9292/v2/images/28ecccfc-4cb0-4cc6-a280-209e2d140e10 used request id req-3520c19c-1b38-41ed-aefb-b87296749598 365s DEBUG (session:517) REQ: curl -g -i -X GET https://nova.ps6.canonical.com:8774/v2.1/flavors/autopkgtest -H "Accept: application/json" -H "OpenStack-API-Version: compute 2.87" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}caf18d3000135ed69b265e2fc83bc573b13d844491672d62f9508972b7006d14" -H "X-OpenStack-Nova-API-Version: 2.87" 365s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/autopkgtest HTTP/1.1" 404 84 365s DEBUG (session:548) RESP: [404] Connection: Keep-Alive Content-Length: 84 Content-Type: application/json; charset=UTF-8 Date: Fri, 22 Mar 2024 14:01:43 GMT Keep-Alive: timeout=75, max=998 OpenStack-API-Version: compute 2.87 Server: Apache/2.4.52 (Ubuntu) Vary: OpenStack-API-Version,X-OpenStack-Nova-API-Version X-OpenStack-Nova-API-Version: 2.87 x-compute-request-id: req-0f81f087-10ce-4251-9686-3de8655f4d9d x-openstack-request-id: req-0f81f087-10ce-4251-9686-3de8655f4d9d 365s DEBUG (session:580) RESP BODY: {"itemNotFound": {"code": 404, "message": "Flavor autopkgtest could not be found."}} 365s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors/autopkgtest used request id req-0f81f087-10ce-4251-9686-3de8655f4d9d 365s DEBUG (session:517) REQ: curl -g -i -X GET https://nova.ps6.canonical.com:8774/v2.1/flavors?is_public=None -H "Accept: application/json" -H "OpenStack-API-Version: compute 2.87" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}caf18d3000135ed69b265e2fc83bc573b13d844491672d62f9508972b7006d14" -H "X-OpenStack-Nova-API-Version: 2.87" 365s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors?is_public=None HTTP/1.1" 200 1739 365s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1739 Content-Type: application/json Date: Fri, 22 Mar 2024 14:01:43 GMT Keep-Alive: timeout=75, max=997 OpenStack-API-Version: compute 2.87 Server: Apache/2.4.52 (Ubuntu) Vary: OpenStack-API-Version,X-OpenStack-Nova-API-Version X-OpenStack-Nova-API-Version: 2.87 x-compute-request-id: req-ea93116c-f399-4bd3-899a-82ee97784b8e x-openstack-request-id: req-ea93116c-f399-4bd3-899a-82ee97784b8e 365s DEBUG (session:580) RESP BODY: {"flavors": [{"id": "062428d9-35a1-461f-a33a-38436ed516b4", "name": "autopkgtest-cpu8-ram16-disk160-arm64", "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/flavors/062428d9-35a1-461f-a33a-38436ed516b4"}, {"rel": "bookmark", "href": "https://nova.ps6.canonical.com:8774/flavors/062428d9-35a1-461f-a33a-38436ed516b4"}], "description": null}, {"id": "8d27c5f0-65c7-4018-b3f7-50463875ab09", "name": "autopkgtest", "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09"}, {"rel": "bookmark", "href": "https://nova.ps6.canonical.com:8774/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09"}], "description": null}, {"id": "8ebe34fb-1390-4cc7-bbe5-0d38c80f2fb4", "name": "autopkgtest-cpu2-ram4-disk20-arm64", "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/flavors/8ebe34fb-1390-4cc7-bbe5-0d38c80f2fb4"}, {"rel": "bookmark", "href": "https://nova.ps6.canonical.com:8774/flavors/8ebe34fb-1390-4cc7-bbe5-0d38c80f2fb4"}], "description": null}, {"id": "a8256f9e-53ee-4584-ad7f-60e088825b83", "name": "autopkgtest-big", "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/flavors/a8256f9e-53ee-4584-ad7f-60e088825b83"}, {"rel": "bookmark", "href": "https://nova.ps6.canonical.com:8774/flavors/a8256f9e-53ee-4584-ad7f-60e088825b83"}], "description": null}, {"id": "cfc564ac-9f6e-4477-91c4-a89ccb4b744e", "name": "autopkgtest-cpu4-ram8-disk100-arm64", "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/flavors/cfc564ac-9f6e-4477-91c4-a89ccb4b744e"}, {"rel": "bookmark", "href": "https://nova.ps6.canonical.com:8774/flavors/cfc564ac-9f6e-4477-91c4-a89ccb4b744e"}], "description": null}]} 365s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors?is_public=None used request id req-ea93116c-f399-4bd3-899a-82ee97784b8e 365s DEBUG (session:517) REQ: curl -g -i -X GET https://nova.ps6.canonical.com:8774/v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09 -H "Accept: application/json" -H "OpenStack-API-Version: compute 2.87" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}caf18d3000135ed69b265e2fc83bc573b13d844491672d62f9508972b7006d14" -H "X-OpenStack-Nova-API-Version: 2.87" 365s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09 HTTP/1.1" 200 613 365s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 613 Content-Type: application/json Date: Fri, 22 Mar 2024 14:01:43 GMT Keep-Alive: timeout=75, max=996 OpenStack-API-Version: compute 2.87 Server: Apache/2.4.52 (Ubuntu) Vary: OpenStack-API-Version,X-OpenStack-Nova-API-Version X-OpenStack-Nova-API-Version: 2.87 x-compute-request-id: req-e39c4ba2-b942-4af2-80a9-07015d630e0e x-openstack-request-id: req-e39c4ba2-b942-4af2-80a9-07015d630e0e 365s DEBUG (session:580) RESP BODY: {"flavor": {"id": "8d27c5f0-65c7-4018-b3f7-50463875ab09", "name": "autopkgtest", "ram": 4096, "disk": 20, "swap": 0, "OS-FLV-EXT-DATA:ephemeral": 0, "OS-FLV-DISABLED:disabled": false, "vcpus": 2, "os-flavor-access:is_public": false, "rxtx_factor": 1.0, "links": [{"rel": "self", "href": "https://nova.ps6.canonical.com:8774/v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09"}, {"rel": "bookmark", "href": "https://nova.ps6.canonical.com:8774/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09"}], "description": null, "extra_specs": {"aggregate_instance_extra_specs:commit": "builder-arm64", "hw_rng:allowed": "True"}}} 365s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09 used request id req-e39c4ba2-b942-4af2-80a9-07015d630e0e 365s DEBUG (session:517) REQ: curl -g -i -X POST https://nova.ps6.canonical.com:8774/v2.1/servers -H "Accept: application/json" -H "Content-Type: application/json" -H "OpenStack-API-Version: compute 2.87" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}caf18d3000135ed69b265e2fc83bc573b13d844491672d62f9508972b7006d14" -H "X-OpenStack-Nova-API-Version: 2.87" -d '{"server": {"name": "adt-noble-arm64-bibtexparser-20240322-140119-juju-7f2275-prod-proposed-migration-environment-2", "imageRef": "28ecccfc-4cb0-4cc6-a280-209e2d140e10", "flavorRef": "8d27c5f0-65c7-4018-b3f7-50463875ab09", "user_data": "I2Nsb3VkLWNvbmZpZwpob3N0bmFtZTogYXV0b3BrZ3Rlc3QKbWFuYWdlX2V0Y19ob3N0czogdHJ1ZQphcHRfdXBkYXRlOiB0cnVlCmFwdF91cGdyYWRlOiBmYWxzZQphcHRfbWlycm9yOiBodHRwOi8vZnRwbWFzdGVyLmludGVybmFsL3VidW50dS8KCnJ1bmNtZDoKIC0gZWNobyAnQWNxdWlyZTo6TGFuZ3VhZ2VzICJub25lIjsnID4gL2V0Yy9hcHQvYXB0LmNvbmYuZC85MG5vbGFuZ3VhZ2VzCiAtIGVjaG8gJ2ZvcmNlLXVuc2FmZS1pbycgPiAvZXRjL2Rwa2cvZHBrZy5jZmcuZC9hdXRvcGtndGVzdAogLSBwcmludGYgJ1xuVEVSTT1saW51eFxuJ2h0dHBfcHJveHk9aHR0cDovL3NxdWlkLmludGVybmFsOjMxMjgnXG4naHR0cHNfcHJveHk9aHR0cDovL3NxdWlkLmludGVybmFsOjMxMjgnXG4nbm9fcHJveHk9MTI3LjAuMC4xLDEyNy4wLjEuMSxsb2dpbi51YnVudHUuY29tLGxvY2FsaG9zdCxsb2NhbGRvbWFpbixub3ZhbG9jYWwsaW50ZXJuYWwsYXJjaGl2ZS51YnVudHUuY29tLHBvcnRzLnVidW50dS5jb20sc2VjdXJpdHkudWJ1bnR1LmNvbSxkZGVicy51YnVudHUuY29tLGNoYW5nZWxvZ3MudWJ1bnR1LmNvbSxsYXVuY2hwYWRsaWJyYXJpYW4ubmV0LGxhdW5jaHBhZGNvbnRlbnQubmV0LGxhdW5jaHBhZC5uZXQsMTAuMjQuMC4wLzI0LGtleXN0b25lLnBzNS5jYW5vbmljYWwuY29tLG9iamVjdHN0b3JhZ2UucHJvZHN0YWNrNS5jYW5vbmljYWwuY29tJ1xuJyA+PiAvZXRjL2Vudmlyb25tZW50CiAtIHNlZCAtaSAtciAnL14xMjcuMC4xLjEvIHMvYXV0b3BrZ3Rlc3QtW14gXStcLi9hdXRvcGtndGVzdFwuLycgL2V0Yy9ob3N0cwo=", "key_name": "testbed-juju-7f2275-prod-proposed-migration-environment-2", "min_count": 1, "max_count": 1, "security_groups": [{"name": "autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-11.secgroup"}], "networks": [{"uuid": "6ea4839c-9760-4b54-ab7d-70a6312667d1"}]}}' 365s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "POST /v2.1/servers HTTP/1.1" 403 115 365s DEBUG (session:548) RESP: [403] Connection: Keep-Alive Content-Length: 115 Content-Type: application/json; charset=UTF-8 Date: Fri, 22 Mar 2024 14:01:43 GMT Keep-Alive: timeout=75, max=995 OpenStack-API-Version: compute 2.87 Server: Apache/2.4.52 (Ubuntu) Vary: OpenStack-API-Version,X-OpenStack-Nova-API-Version X-OpenStack-Nova-API-Version: 2.87 x-compute-request-id: req-e0308a1b-fa16-48ae-a904-bd2481d52d63 x-openstack-request-id: req-e0308a1b-fa16-48ae-a904-bd2481d52d63 365s DEBUG (session:580) RESP BODY: {"forbidden": {"code": 403, "message": "Quota exceeded for cores: Requested 2, but already used 140 of 140 cores"}} 365s DEBUG (session:936) POST call to compute for https://nova.ps6.canonical.com:8774/v2.1/servers used request id req-e0308a1b-fa16-48ae-a904-bd2481d52d63 365s DEBUG (shell:822) Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-e0308a1b-fa16-48ae-a904-bd2481d52d63) 365s Traceback (most recent call last): 365s File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 820, in main 365s OpenStackComputeShell().main(argv) 365s File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 742, in main 365s args.func(self.cs, args) 365s File "/usr/lib/python3/dist-packages/novaclient/v2/shell.py", line 971, in do_boot 365s server = cs.servers.create(*boot_args, **boot_kwargs) 365s File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 1477, in create 365s return self._boot(response_key, *boot_args, **boot_kwargs) 365s File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 836, in _boot 365s return self._create('/servers', body, response_key, 365s File "/usr/lib/python3/dist-packages/novaclient/base.py", line 363, in _create 365s resp, body = self.api.client.post(url, body=body) 365s File "/usr/lib/python3/dist-packages/keystoneauth1/adapter.py", line 392, in post 365s return self.request(url, 'POST', **kwargs) 365s File "/usr/lib/python3/dist-packages/novaclient/client.py", line 78, in request 365s raise exceptions.from_response(resp, body, url, method) 365s novaclient.exceptions.Forbidden: Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-e0308a1b-fa16-48ae-a904-bd2481d52d63) 365s ERROR (Forbidden): Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-e0308a1b-fa16-48ae-a904-bd2481d52d63) 367s autopkgtest [14:07:26]: testbed dpkg architecture: arm64 367s autopkgtest [14:07:26]: testbed apt version: 2.7.12 367s autopkgtest [14:07:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup 368s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 368s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [54.0 kB] 368s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 368s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3759 kB] 368s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [497 kB] 368s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [680 kB] 368s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 368s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.7 kB] 368s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 368s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4188 kB] 369s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 369s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [67.3 kB] 369s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 370s Fetched 9414 kB in 2s (5697 kB/s) 370s Reading package lists... 373s Reading package lists... 373s Building dependency tree... 373s Reading state information... 374s Calculating upgrade... 374s The following packages will be upgraded: 374s cloud-init fonts-ubuntu-console python3-markupsafe 374s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 374s Need to get 629 kB of archives. 374s After this operation, 65.5 kB disk space will be freed. 374s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 fonts-ubuntu-console all 0.869+git20240321-0ubuntu1 [18.7 kB] 374s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 python3-markupsafe arm64 2.1.5-1build1 [12.5 kB] 374s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 cloud-init all 24.1.2-0ubuntu1 [597 kB] 375s Preconfiguring packages ... 375s Fetched 629 kB in 1s (1192 kB/s) 375s (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 ... 74820 files and directories currently installed.) 375s Preparing to unpack .../fonts-ubuntu-console_0.869+git20240321-0ubuntu1_all.deb ... 375s Unpacking fonts-ubuntu-console (0.869+git20240321-0ubuntu1) over (0.869-0ubuntu1) ... 375s Preparing to unpack .../python3-markupsafe_2.1.5-1build1_arm64.deb ... 376s Unpacking python3-markupsafe (2.1.5-1build1) over (2.1.5-1) ... 376s Preparing to unpack .../cloud-init_24.1.2-0ubuntu1_all.deb ... 376s Unpacking cloud-init (24.1.2-0ubuntu1) over (24.1.1-0ubuntu1) ... 376s Setting up fonts-ubuntu-console (0.869+git20240321-0ubuntu1) ... 376s Setting up cloud-init (24.1.2-0ubuntu1) ... 377s Setting up python3-markupsafe (2.1.5-1build1) ... 377s Processing triggers for man-db (2.12.0-3) ... 378s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 378s Reading package lists... 378s Building dependency tree... 378s Reading state information... 379s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 380s sh: Attempting to set up Debian/Ubuntu apt sources automatically 380s sh: Distribution appears to be Ubuntu 381s Reading package lists... 381s Building dependency tree... 381s Reading state information... 382s eatmydata is already the newest version (131-1). 382s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 382s Reading package lists... 382s Building dependency tree... 382s Reading state information... 383s dbus is already the newest version (1.14.10-4ubuntu1). 383s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 383s Reading package lists... 383s Building dependency tree... 383s Reading state information... 383s rng-tools-debian is already the newest version (2.4). 383s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 384s Reading package lists... 384s Building dependency tree... 384s Reading state information... 384s The following packages will be REMOVED: 384s cloud-init* python3-configobj* python3-debconf* 385s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 385s After this operation, 3256 kB disk space will be freed. 385s (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 ... 74819 files and directories currently installed.) 385s Removing cloud-init (24.1.2-0ubuntu1) ... 385s Removing python3-configobj (5.0.8-3) ... 385s Removing python3-debconf (1.5.86) ... 385s Processing triggers for man-db (2.12.0-3) ... 386s (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 ... 74430 files and directories currently installed.) 386s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 386s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 386s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 386s invoke-rc.d: policy-rc.d denied execution of try-restart. 386s Reading package lists... 387s Building dependency tree... 387s Reading state information... 387s linux-generic is already the newest version (6.8.0-11.11+1). 387s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 387s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 387s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 388s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 389s Reading package lists... 389s Reading package lists... 390s Building dependency tree... 390s Reading state information... 390s Calculating upgrade... 390s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 391s Reading package lists... 391s Building dependency tree... 391s Reading state information... 391s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 392s autopkgtest [14:07:51]: rebooting testbed after setup commands that affected boot 419s autopkgtest [14:08:18]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024 422s autopkgtest [14:08:21]: @@@@@@@@@@@@@@@@@@@@ apt-source bibtexparser 424s Get:1 http://ftpmaster.internal/ubuntu noble/universe bibtexparser 2.0.0b5+really1.4.1-1 (dsc) [2417 B] 424s Get:2 http://ftpmaster.internal/ubuntu noble/universe bibtexparser 2.0.0b5+really1.4.1-1 (tar) [97.1 kB] 424s Get:3 http://ftpmaster.internal/ubuntu noble/universe bibtexparser 2.0.0b5+really1.4.1-1 (diff) [4660 B] 425s gpgv: Signature made Sun Jan 28 18:53:59 2024 UTC 425s gpgv: using RSA key F1F007320A035541F0A663CA578A0494D1C646D1 425s gpgv: issuer "tille@debian.org" 425s gpgv: Can't check signature: No public key 425s dpkg-source: warning: cannot verify inline signature for ./bibtexparser_2.0.0b5+really1.4.1-1.dsc: no acceptable signature found 425s autopkgtest [14:08:24]: testing package bibtexparser version 2.0.0b5+really1.4.1-1 425s autopkgtest [14:08:24]: build not needed 425s autopkgtest [14:08:24]: test python3-bibtexparser: preparing testbed 427s Reading package lists... 427s Building dependency tree... 427s Reading state information... 428s Starting pkgProblemResolver with broken count: 0 428s Starting 2 pkgProblemResolver with broken count: 0 428s Done 428s The following additional packages will be installed: 428s libjs-jquery libjs-sphinxdoc libjs-underscore python-bibtexparser-doc 428s python3-all python3-bibtexparser python3-distutils python3-lib2to3 428s Recommended packages: 428s javascript-common 428s The following NEW packages will be installed: 428s autopkgtest-satdep libjs-jquery libjs-sphinxdoc libjs-underscore 428s python-bibtexparser-doc python3-all python3-bibtexparser python3-distutils 428s python3-lib2to3 428s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 428s Need to get 895 kB/896 kB of archives. 428s After this operation, 3077 kB of additional disk space will be used. 428s Get:1 /tmp/autopkgtest.DTBw4I/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [732 B] 429s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 429s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 429s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-sphinxdoc all 7.2.6-4 [149 kB] 429s Get:5 http://ftpmaster.internal/ubuntu noble/universe arm64 python-bibtexparser-doc all 2.0.0b5+really1.4.1-1 [54.8 kB] 429s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 python3-lib2to3 all 3.11.5-1 [79.0 kB] 429s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 python3-distutils all 3.11.5-1 [131 kB] 429s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 python3-all arm64 3.12.1-0ubuntu2 [906 B] 429s Get:9 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-bibtexparser all 2.0.0b5+really1.4.1-1 [34.5 kB] 430s Fetched 895 kB in 1s (1471 kB/s) 430s Selecting previously unselected package libjs-jquery. 430s (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 ... 74375 files and directories currently installed.) 430s Preparing to unpack .../0-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 430s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 430s Selecting previously unselected package libjs-underscore. 430s Preparing to unpack .../1-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 430s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 430s Selecting previously unselected package libjs-sphinxdoc. 430s Preparing to unpack .../2-libjs-sphinxdoc_7.2.6-4_all.deb ... 430s Unpacking libjs-sphinxdoc (7.2.6-4) ... 430s Selecting previously unselected package python-bibtexparser-doc. 430s Preparing to unpack .../3-python-bibtexparser-doc_2.0.0b5+really1.4.1-1_all.deb ... 430s Unpacking python-bibtexparser-doc (2.0.0b5+really1.4.1-1) ... 430s Selecting previously unselected package python3-lib2to3. 430s Preparing to unpack .../4-python3-lib2to3_3.11.5-1_all.deb ... 430s Unpacking python3-lib2to3 (3.11.5-1) ... 430s Selecting previously unselected package python3-distutils. 430s Preparing to unpack .../5-python3-distutils_3.11.5-1_all.deb ... 430s Unpacking python3-distutils (3.11.5-1) ... 430s Selecting previously unselected package python3-all. 430s Preparing to unpack .../6-python3-all_3.12.1-0ubuntu2_arm64.deb ... 430s Unpacking python3-all (3.12.1-0ubuntu2) ... 430s Selecting previously unselected package python3-bibtexparser. 430s Preparing to unpack .../7-python3-bibtexparser_2.0.0b5+really1.4.1-1_all.deb ... 430s Unpacking python3-bibtexparser (2.0.0b5+really1.4.1-1) ... 430s Selecting previously unselected package autopkgtest-satdep. 430s Preparing to unpack .../8-1-autopkgtest-satdep.deb ... 430s Unpacking autopkgtest-satdep (0) ... 430s Setting up python3-bibtexparser (2.0.0b5+really1.4.1-1) ... 430s /usr/lib/python3/dist-packages/bibtexparser/latexenc.py:93: SyntaxWarning: invalid escape sequence '\g' 430s string = re.sub('([^{]|^)([A-Z])([^}]|$)', '\g<1>{\g<2>}\g<3>', string) 430s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 430s Setting up python3-lib2to3 (3.11.5-1) ... 430s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 430s Setting up python3-distutils (3.11.5-1) ... 430s python3.12: can't get files for byte-compilation 430s Setting up python3-all (3.12.1-0ubuntu2) ... 430s Setting up libjs-sphinxdoc (7.2.6-4) ... 430s Setting up python-bibtexparser-doc (2.0.0b5+really1.4.1-1) ... 430s Setting up autopkgtest-satdep (0) ... 434s (Reading database ... 74696 files and directories currently installed.) 434s Removing autopkgtest-satdep (0) ... 434s autopkgtest [14:08:33]: test python3-bibtexparser: [----------------------- 435s + cp -r bibtexparser/tests/ /tmp/autopkgtest.DTBw4I/autopkgtest_tmp 435s + cd /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/ 435s + perl -i -pe s{bibtexparser/tests/(data/?)}{$1}xmsg test_bibdatabase.py test_bibtex_strings.py test_bibtexexpression.py test_bibtexparser.py test_bibtexwriter.py test_bparser.py test_bwriter.py test_comments.py test_crossref_resolving.py test_customization.py test_homogenise_fields.py test_latexenc.py test_preambles.py test_splitname.py 435s + py3versions -s 435s + LC_ALL=C.UTF-8 python3.12 -m unittest discover --verbose 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_customization.py:28: SyntaxWarning: invalid escape sequence '\{' 435s 'Tom {de \{Geus}', 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_customization.py:29: SyntaxWarning: invalid escape sequence '\{' 435s 'Tom \{de Geus\}', 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_customization.py:30: SyntaxWarning: invalid escape sequence '\{' 435s 'Tom de {G\{eus}', 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_customization.py:50: SyntaxWarning: invalid escape sequence '\{' 435s '{de \{Geus}, Tom', 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_customization.py:51: SyntaxWarning: invalid escape sequence '\}' 435s 'Geus\}, Tom \{de', 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_customization.py:52: SyntaxWarning: invalid escape sequence '\{' 435s 'de {G\{eus}, Tom', 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_latexenc.py:30: SyntaxWarning: invalid escape sequence '\`' 435s expected = "{\`a} {\\\'e} {\`e} {\\\"o}" 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_latexenc.py:36: SyntaxWarning: invalid escape sequence '\c' 435s expected = '{\c c}' 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_latexenc.py:76: SyntaxWarning: invalid escape sequence '\`' 435s string = "{\`a} {\\\'e} {\`e} {\\\"o}" 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_latexenc.py:88: SyntaxWarning: invalid escape sequence '\c' 435s string = '{\c c}' 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_splitname.py:301: SyntaxWarning: invalid escape sequence '\l' 435s {'first': ['Bogus{\l}aw'], 'von': [], 'last': ['Jackowski'], 'jr': []}), 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_splitname.py:353: SyntaxWarning: invalid escape sequence '\s' 435s {'first': ['Herbert'], 'von': [], 'last': ['Vo{\ss}'], 'jr': []}), 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_splitname.py:499: SyntaxWarning: invalid escape sequence '\s' 435s {'first': ['TUG', '{\sltt DVI}', 'Driver', 'Standards'], 'von': [], 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_splitname.py:503: SyntaxWarning: invalid escape sequence '\s' 435s {'first': ['TUG'], 'von': ['{\sltt xDVIx}'], 435s /tmp/autopkgtest.DTBw4I/autopkgtest_tmp/tests/test_splitname.py:531: SyntaxWarning: invalid escape sequence '\o' 435s {'first': [], 'von': [], 'last': ['{Kristoffer H\o{}gsbro Rose}'], 'jr': []}), 435s test_expand_string (test_bibdatabase.TestBibDataString.test_expand_string) ... ok 435s test_get_value (test_bibdatabase.TestBibDataString.test_get_value) ... ok 435s test_get_value_string_is_defined_by_expression (test_bibdatabase.TestBibDataString.test_get_value_string_is_defined_by_expression) ... ok 435s test_name_is_lower (test_bibdatabase.TestBibDataString.test_name_is_lower) ... ok 435s test_raises_KeyError (test_bibdatabase.TestBibDataString.test_raises_KeyError) ... ok 435s test_strings_are_equal_iif_name_is_equal (test_bibdatabase.TestBibDataString.test_strings_are_equal_iif_name_is_equal) ... ok 435s test_equations_are_equal_iif_same (test_bibdatabase.TestBibDataStringExpression.test_equations_are_equal_iif_same) ... ok 435s test_get_value (test_bibdatabase.TestBibDataStringExpression.test_get_value) ... ok 435s test_raises_KeyError (test_bibdatabase.TestBibDataStringExpression.test_raises_KeyError) ... ok 435s test_entries_dict_prop (test_bibdatabase.TestBibDatabase.test_entries_dict_prop) ... ok 435s test_entries_list_method (test_bibdatabase.TestBibDatabase.test_entries_list_method) ... ok 435s test_multiple_string_parse (test_bibtex_strings.TestStringParse.test_multiple_string_parse) ... ok 435s test_multiple_string_parse_count (test_bibtex_strings.TestStringParse.test_multiple_string_parse_count) ... ok 435s test_single_string_parse (test_bibtex_strings.TestStringParse.test_single_string_parse) ... ok 435s test_single_string_parse_count (test_bibtex_strings.TestStringParse.test_single_string_parse_count) ... ok 435s test_string_braces (test_bibtex_strings.TestStringParse.test_string_braces) ... ok 435s test_string_parse_accept_chars (test_bibtex_strings.TestStringParse.test_string_parse_accept_chars) ... ok 435s test_ignore_common_strings (test_bibtex_strings.TestStringWrite.test_ignore_common_strings) ... ok 435s test_ignore_common_strings_only_if_not_overloaded (test_bibtex_strings.TestStringWrite.test_ignore_common_strings_only_if_not_overloaded) ... ok 435s test_multiple_string_write (test_bibtex_strings.TestStringWrite.test_multiple_string_write) ... ok 435s test_single_string_write (test_bibtex_strings.TestStringWrite.test_single_string_write) ... ok 435s test_write_common_strings (test_bibtex_strings.TestStringWrite.test_write_common_strings) ... ok 435s test_write_dependent_strings (test_bibtex_strings.TestStringWrite.test_write_dependent_strings) ... ok 435s test_braced (test_bibtexexpression.TestBibtexExpression.test_braced) ... ok 435s test_braced_unicode (test_bibtexexpression.TestBibtexExpression.test_braced_unicode) ... ok 435s test_braced_with_new_line (test_bibtexexpression.TestBibtexExpression.test_braced_with_new_line) ... ok 435s test_capital_key (test_bibtexexpression.TestBibtexExpression.test_capital_key) ... ok 435s test_capital_type (test_bibtexexpression.TestBibtexExpression.test_capital_type) ... ok 435s test_declaration_after_space (test_bibtexexpression.TestBibtexExpression.test_declaration_after_space) ... ok 435s test_declaration_after_space_and_comment (test_bibtexexpression.TestBibtexExpression.test_declaration_after_space_and_comment) ... ok 435s test_entry_declaration_after_space (test_bibtexexpression.TestBibtexExpression.test_entry_declaration_after_space) ... ok 435s test_entry_declaration_key_with_whitespace (test_bibtexexpression.TestBibtexExpression.test_entry_declaration_key_with_whitespace) ... ok 435s test_entry_declaration_no_key (test_bibtexexpression.TestBibtexExpression.test_entry_declaration_no_key) ... ok 435s test_entry_declaration_no_key_comma (test_bibtexexpression.TestBibtexExpression.test_entry_declaration_no_key_comma) ... ok 435s test_entry_declaration_no_key_keyvalue_without_space (test_bibtexexpression.TestBibtexExpression.test_entry_declaration_no_key_keyvalue_without_space) ... ok 435s test_entry_declaration_no_key_new_line (test_bibtexexpression.TestBibtexExpression.test_entry_declaration_no_key_new_line) ... ok 435s test_minimal (test_bibtexexpression.TestBibtexExpression.test_minimal) ... ok 435s test_preamble_declaration_after_space (test_bibtexexpression.TestBibtexExpression.test_preamble_declaration_after_space) ... ok 435s test_quoted (test_bibtexexpression.TestBibtexExpression.test_quoted) ... ok 435s test_quoted_with_new_line (test_bibtexexpression.TestBibtexExpression.test_quoted_with_new_line) ... ok 435s test_quoted_with_unicode (test_bibtexexpression.TestBibtexExpression.test_quoted_with_unicode) ... ok 435s test_string_declaration_after_space (test_bibtexexpression.TestBibtexExpression.test_string_declaration_after_space) ... ok 435s test_parse_bom_bytes (test_bibtexparser.TestBibtexParserParserMethods.test_parse_bom_bytes) ... ok 435s test_parse_bom_str (test_bibtexparser.TestBibtexParserParserMethods.test_parse_bom_str) ... ok 435s test_parse_empty (test_bibtexparser.TestBibtexParserParserMethods.test_parse_empty) ... /usr/lib/python3/dist-packages/bibtexparser/bparser.py:184: UserWarning: The parser has been called more than once. Subsequent parse calls lead to a combined BibTeX library. 435s To avoid the warning, set property `parser.expect_multiple_parse` to `True`. 435s return self.parse(file.read(), partial=partial) 435s ok 435s test_parse_file (test_bibtexparser.TestBibtexParserParserMethods.test_parse_file) ... ok 435s test_parse_file_module (test_bibtexparser.TestBibtexParserParserMethods.test_parse_file_module) ... ok 435s test_parse_immediately (test_bibtexparser.TestBibtexParserParserMethods.test_parse_immediately) ... ok 435s test_parse_str (test_bibtexparser.TestBibtexParserParserMethods.test_parse_str) ... ok 435s test_parse_str_module (test_bibtexparser.TestBibtexParserParserMethods.test_parse_str_module) ... ok 435s test_parse_immediately (test_bibtexparser.TestBibtexparserFieldNames.test_parse_immediately) ... ok 435s test_write_file (test_bibtexparser.TestBibtexparserWriteMethods.test_write_file) ... ok 435s test_write_str (test_bibtexparser.TestBibtexparserWriteMethods.test_write_str) ... ok 435s test_align_bool (test_bibtexwriter.TestBibTexWriter.test_align_bool) ... ok 435s test_align_int (test_bibtexwriter.TestBibTexWriter.test_align_int) ... ok 435s test_align_multiline_values (test_bibtexwriter.TestBibTexWriter.test_align_multiline_values) ... ok 435s test_align_multiline_values_with_align (test_bibtexwriter.TestBibTexWriter.test_align_multiline_values_with_align) ... ok 435s test_align_multiline_values_with_align_with_indent (test_bibtexwriter.TestBibTexWriter.test_align_multiline_values_with_align_with_indent) ... ok 435s test_align_multiline_values_with_indent (test_bibtexwriter.TestBibTexWriter.test_align_multiline_values_with_indent) ... ok 435s test_content_comment_only (test_bibtexwriter.TestBibTexWriter.test_content_comment_only) ... ok 435s test_content_entries_only (test_bibtexwriter.TestBibTexWriter.test_content_entries_only) ... ok 435s test_display_order (test_bibtexwriter.TestBibTexWriter.test_display_order) ... ok 435s test_display_order_sorting (test_bibtexwriter.TestBibTexWriter.test_display_order_sorting) ... ok 435s test_entry_separator (test_bibtexwriter.TestBibTexWriter.test_entry_separator) ... ok 435s test_indent (test_bibtexwriter.TestBibTexWriter.test_indent) ... ok 435s test_sort_default (test_bibtexwriter.TestEntrySorting.test_sort_default) ... ok 435s test_sort_id (test_bibtexwriter.TestEntrySorting.test_sort_id) ... ok 435s test_sort_missing_field (test_bibtexwriter.TestEntrySorting.test_sort_missing_field) ... ok 435s test_sort_none (test_bibtexwriter.TestEntrySorting.test_sort_none) ... ok 435s test_sort_type (test_bibtexwriter.TestEntrySorting.test_sort_type) ... ok 435s test_sort_type_id (test_bibtexwriter.TestEntrySorting.test_sort_type_id) ... ok 435s test_unicode_problems (test_bibtexwriter.TestEntrySorting.test_unicode_problems) ... ok 435s test_article (test_bparser.TestBibtexParserList.test_article) ... ok 435s test_article_annotation (test_bparser.TestBibtexParserList.test_article_annotation) ... ok 435s test_article_comma_first (test_bparser.TestBibtexParserList.test_article_comma_first) ... ok 435s test_article_cust_latex (test_bparser.TestBibtexParserList.test_article_cust_latex) ... ok 435s test_article_cust_order (test_bparser.TestBibtexParserList.test_article_cust_order) ... ok 435s test_article_cust_unicode (test_bparser.TestBibtexParserList.test_article_cust_unicode) ... ok 435s test_article_missing_coma (test_bparser.TestBibtexParserList.test_article_missing_coma) ... ok 435s test_article_no_braces (test_bparser.TestBibtexParserList.test_article_no_braces) ... ok 435s test_article_protection_braces (test_bparser.TestBibtexParserList.test_article_protection_braces) ... ok 435s test_article_special_characters (test_bparser.TestBibtexParserList.test_article_special_characters) ... ok 435s test_article_start_bom (test_bparser.TestBibtexParserList.test_article_start_bom) ... ok 435s test_article_start_with_whitespace (test_bparser.TestBibtexParserList.test_article_start_with_whitespace) ... ok 435s test_book (test_bparser.TestBibtexParserList.test_book) ... ok 435s test_book_cust_latex (test_bparser.TestBibtexParserList.test_book_cust_latex) ... ok 435s test_book_cust_unicode (test_bparser.TestBibtexParserList.test_book_cust_unicode) ... ok 435s test_comments_spaces_and_declarations (test_bparser.TestBibtexParserList.test_comments_spaces_and_declarations) ... ok 435s test_does_not_fail_on_non_bibtex_with_partial (test_bparser.TestBibtexParserList.test_does_not_fail_on_non_bibtex_with_partial) ... ok 435s test_empty_string (test_bparser.TestBibtexParserList.test_empty_string) ... ok 435s test_encoding (test_bparser.TestBibtexParserList.test_encoding) ... ok 435s test_encoding_with_homogenize (test_bparser.TestBibtexParserList.test_encoding_with_homogenize) ... ok 435s test_features (test_bparser.TestBibtexParserList.test_features) ... ok 435s test_features2 (test_bparser.TestBibtexParserList.test_features2) ... ok 435s test_field_name_with_dash_underscore (test_bparser.TestBibtexParserList.test_field_name_with_dash_underscore) ... ok 435s test_no_citekey_parsed_as_comment (test_bparser.TestBibtexParserList.test_no_citekey_parsed_as_comment) ... ok 435s test_nonstandard_ignored (test_bparser.TestBibtexParserList.test_nonstandard_ignored) ... Entry type wrong not standard. Not considered. 435s ok 435s test_nonstandard_not_ignored (test_bparser.TestBibtexParserList.test_nonstandard_not_ignored) ... ok 435s test_oneline (test_bparser.TestBibtexParserList.test_oneline) ... ok 435s test_parsing_just_once_not_raising_warnings_with_default_settings (test_bparser.TestBibtexParserList.test_parsing_just_once_not_raising_warnings_with_default_settings) ... ok 435s test_parsing_three_times_not_raising_a_warning_if_expect_multiple_parse_is_true (test_bparser.TestBibtexParserList.test_parsing_three_times_not_raising_a_warning_if_expect_multiple_parse_is_true) ... ok 435s test_parsing_three_times_raise_warnings_only_once_with_default_settings (test_bparser.TestBibtexParserList.test_parsing_three_times_raise_warnings_only_once_with_default_settings) ... ok 435s test_parsing_twice_raise_warnings_with_default_settings (test_bparser.TestBibtexParserList.test_parsing_twice_raise_warnings_with_default_settings) ... ok 435s test_string_definitions (test_bparser.TestBibtexParserList.test_string_definitions) ... ok 435s test_string_is_interpolated (test_bparser.TestBibtexParserList.test_string_is_interpolated) ... ok 435s test_string_is_not_interpolated (test_bparser.TestBibtexParserList.test_string_is_not_interpolated) ... ok 435s test_traps (test_bparser.TestBibtexParserList.test_traps) ... ok 436s test_article (test_bwriter.TestBibtexWriterList.test_article) ... ok 436s test_article_with_annotation (test_bwriter.TestBibtexWriterList.test_article_with_annotation) ... ok 436s test_book (test_bwriter.TestBibtexWriterList.test_book) ... ok 436s test_comma_first (test_bwriter.TestBibtexWriterList.test_comma_first) ... ok 436s test_comma_first_and_trailing_comma (test_bwriter.TestBibtexWriterList.test_comma_first_and_trailing_comma) ... ok 436s test_exception_typeerror (test_bwriter.TestBibtexWriterList.test_exception_typeerror) ... ok 436s test_multiple (test_bwriter.TestBibtexWriterList.test_multiple) ... ok 436s test_trailing_comma (test_bwriter.TestBibtexWriterList.test_trailing_comma) ... ok 436s test_with_strings (test_bwriter.TestBibtexWriterList.test_with_strings) ... ok 436s test_43 (test_comments.TestParseComment.test_43) ... ok 436s test_43_bis (test_comments.TestParseComment.test_43_bis) ... ok 436s test_comment_count (test_comments.TestParseComment.test_comment_count) ... ok 436s test_comment_list (test_comments.TestParseComment.test_comment_list) ... ok 436s test_comments_percentage (test_comments.TestParseComment.test_comments_percentage) ... ok 436s test_comments_percentage_nocoma (test_comments.TestParseComment.test_comments_percentage_nocoma) ... ok 436s test_multiline_comments (test_comments.TestParseComment.test_multiline_comments) ... ok 436s test_multiple_entries (test_comments.TestParseComment.test_multiple_entries) ... ok 436s test_no_newline (test_comments.TestParseComment.test_no_newline) ... ok 436s test_comment_write (test_comments.TestWriteComment.test_comment_write) ... ok 436s test_multiline_comment_write (test_comments.TestWriteComment.test_multiline_comment_write) ... ok 436s test_multiple_entries (test_comments.TestWriteComment.test_multiple_entries) ... ok 436s test_crossref (test_crossref_resolving.TestCrossRef.test_crossref) ... ok 436s test_crossref_cascading (test_crossref_resolving.TestCrossRef.test_crossref_cascading) ... ok 436s test_crossref_cascading_cycle (test_crossref_resolving.TestCrossRef.test_crossref_cascading_cycle) ... ok 436s test_crossref_missing_entries (test_crossref_resolving.TestCrossRef.test_crossref_missing_entries) ... ok 436s test_add_plaintext_fields (test_customization.TestBibtexParserMethod.test_add_plaintext_fields) ... ok 436s test_convert_to_unicode (test_customization.TestBibtexParserMethod.test_convert_to_unicode) ... ok 436s test_getnames (test_customization.TestBibtexParserMethod.test_getnames) ... ok 436s test_homogenize (test_customization.TestBibtexParserMethod.test_homogenize) ... ok 436s test_keywords (test_customization.TestBibtexParserMethod.test_keywords) ... ok 436s test_page_double_hyphen_alreadyOK (test_customization.TestBibtexParserMethod.test_page_double_hyphen_alreadyOK) ... ok 436s test_page_double_hyphen_nothing (test_customization.TestBibtexParserMethod.test_page_double_hyphen_nothing) ... ok 436s test_page_double_hyphen_simple (test_customization.TestBibtexParserMethod.test_page_double_hyphen_simple) ... ok 436s test_page_double_hyphen_space (test_customization.TestBibtexParserMethod.test_page_double_hyphen_space) ... ok 436s test_homogenize_default (test_homogenise_fields.TestHomogenizeFields.test_homogenize_default) ... ok 436s test_homogenize_off (test_homogenise_fields.TestHomogenizeFields.test_homogenize_off) ... ok 436s test_homogenize_on (test_homogenise_fields.TestHomogenizeFields.test_homogenize_on) ... ok 436s test_homogenizes_fields (test_homogenise_fields.TestHomogenizeFields.test_homogenizes_fields) ... ok 436s test_accent (test_latexenc.TestLatexConverter.test_accent) ... ok 436s test_special_caracter (test_latexenc.TestLatexConverter.test_special_caracter) ... ok 436s test_accents (test_latexenc.TestUnicodeConversion.test_accents) ... ok 436s test_does_not_modify_existing_combining (test_latexenc.TestUnicodeConversion.test_does_not_modify_existing_combining) ... ok 436s test_does_not_modify_two_existing_combining (test_latexenc.TestUnicodeConversion.test_does_not_modify_two_existing_combining) ... ok 436s test_ignores_trailing_modifier (test_latexenc.TestUnicodeConversion.test_ignores_trailing_modifier) ... ok 436s test_special_caracter (test_latexenc.TestUnicodeConversion.test_special_caracter) ... ok 436s test_alreadyprotected (test_latexenc.TestUppercaseProtection.test_alreadyprotected) ... ok 436s test_lowercase (test_latexenc.TestUppercaseProtection.test_lowercase) ... ok 436s test_traps (test_latexenc.TestUppercaseProtection.test_traps) ... ok 436s test_traps2 (test_latexenc.TestUppercaseProtection.test_traps2) ... ok 436s test_uppercase (test_latexenc.TestUppercaseProtection.test_uppercase) ... ok 436s test_multiple_preamble_parse (test_preambles.TestPreambleParse.test_multiple_preamble_parse) ... ok 436s test_multiple_preamble_parse_count (test_preambles.TestPreambleParse.test_multiple_preamble_parse_count) ... ok 436s test_single_preamble_parse (test_preambles.TestPreambleParse.test_single_preamble_parse) ... ok 436s test_single_preamble_parse_count (test_preambles.TestPreambleParse.test_single_preamble_parse_count) ... ok 436s test_multiple_string_write (test_preambles.TestPreambleWrite.test_multiple_string_write) ... ok 436s test_single_preamble_write (test_preambles.TestPreambleWrite.test_single_preamble_write) ... ok 436s test_splitname_basic (test_splitname.TestSplitnameMethod.test_splitname_basic) 436s Basic tests of customization.splitname() ... ok 436s test_splitname_cases (test_splitname.TestSplitnameMethod.test_splitname_cases) 436s Test customization.splitname() vs output from BibTeX ... ok 436s 436s ---------------------------------------------------------------------- 436s Ran 165 tests in 0.715s 436s 436s OK 436s autopkgtest [14:08:35]: test python3-bibtexparser: -----------------------] 437s autopkgtest [14:08:36]: test python3-bibtexparser: - - - - - - - - - - results - - - - - - - - - - 437s python3-bibtexparser PASS 437s autopkgtest [14:08:36]: @@@@@@@@@@@@@@@@@@@@ summary 437s python3-bibtexparser PASS