0s autopkgtest [05:31:58]: starting date and time: 2024-03-24 05:31:58+0000 0s autopkgtest [05:31:58]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [05:31:58]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.wjhhkkjn/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 sqlalchemy-i18n --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-3.secgroup --name adt-noble-arm64-sqlalchemy-i18n-20240324-053158-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/ 455s Creating nova instance adt-noble-arm64-sqlalchemy-i18n-20240324-053158-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240324.img (UUID 943dd583-2042-4622-b4ce-bdf10ad153ac)... 455s nova boot failed (attempt #1): 455s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 455s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 455s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 455s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 455s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 455s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 455s 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" 455s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps6.canonical.com:5000 455s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 455s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Sun, 24 Mar 2024 05:33:41 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-282a7f2a-c43d-400d-b75c-bf6c1635c0f9 455s 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"}]}} 455s DEBUG (session:946) GET call to https://keystone.ps6.canonical.com:5000/v3 used request id req-282a7f2a-c43d-400d-b75c-bf6c1635c0f9 455s DEBUG (base:182) Making authentication request to https://keystone.ps6.canonical.com:5000/v3/auth/tokens 455s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 12445 455s 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": ["7L4iS2K1QMSmFGiRj4Eg1Q"], "expires_at": "2024-03-25T05:33:41.000000Z", "issued_at": "2024-03-24T05:33:41.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"}]}} 455s 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}4c5a1040e0384d45150e138a9ae775f7bab42ecbd424d1aa0974bfc60bd9bea5" 455s 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}4c5a1040e0384d45150e138a9ae775f7bab42ecbd424d1aa0974bfc60bd9bea5" 455s DEBUG (connectionpool:962) Starting new HTTPS connection (1): nova.ps6.canonical.com:8774 455s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1 HTTP/1.1" 302 0 455s RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Sun, 24 Mar 2024 05:33:41 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-b7cc0d24-8e88-4400-8319-f6dd3b1902ce x-openstack-request-id: req-b7cc0d24-8e88-4400-8319-f6dd3b1902ce 455s DEBUG (session:548) RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Sun, 24 Mar 2024 05:33:41 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-b7cc0d24-8e88-4400-8319-f6dd3b1902ce x-openstack-request-id: req-b7cc0d24-8e88-4400-8319-f6dd3b1902ce 455s RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged. 455s DEBUG (session:580) RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged. 455s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/ HTTP/1.1" 200 397 455s RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Sun, 24 Mar 2024 05:33:41 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-473a97a2-743c-4ff8-919a-9c6697c1c6b6 x-openstack-request-id: req-473a97a2-743c-4ff8-919a-9c6697c1c6b6 455s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Sun, 24 Mar 2024 05:33:41 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-473a97a2-743c-4ff8-919a-9c6697c1c6b6 x-openstack-request-id: req-473a97a2-743c-4ff8-919a-9c6697c1c6b6 455s 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"}]}} 455s 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"}]}} 455s GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-473a97a2-743c-4ff8-919a-9c6697c1c6b6 455s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-473a97a2-743c-4ff8-919a-9c6697c1c6b6 455s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 455s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 455s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 455s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 455s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 455s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 455s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 455s DEBUG (session:517) REQ: curl -g -i -X GET https://glance.ps6.canonical.com:9292/v2/images/943dd583-2042-4622-b4ce-bdf10ad153ac -H "Accept: application/json" -H "OpenStack-API-Version: compute 2.87" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA256}4c5a1040e0384d45150e138a9ae775f7bab42ecbd424d1aa0974bfc60bd9bea5" -H "X-OpenStack-Nova-API-Version: 2.87" 455s DEBUG (connectionpool:962) Starting new HTTPS connection (1): glance.ps6.canonical.com:9292 455s DEBUG (connectionpool:429) https://glance.ps6.canonical.com:9292 "GET /v2/images/943dd583-2042-4622-b4ce-bdf10ad153ac HTTP/1.1" 200 1935 455s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1935 Content-Type: application/json Date: Sun, 24 Mar 2024 05:33:42 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) X-Openstack-Request-Id: req-177ceff3-455a-4f2b-a926-bf311937646c 455s DEBUG (session:580) RESP BODY: {"base_image_ref": "09c3944a-cd0d-425d-b22f-cde7ec51d155", "boot_roles": "member,reader", "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": "bc4d8474-2306-4932-a029-eb05e6aa0070", "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-20240324.img", "disk_format": "qcow2", "container_format": "bare", "visibility": "private", "size": 2340683776, "virtual_size": 21474836480, "status": "active", "checksum": "02217aaa63f3d49965efbdca847c5c0e", "protected": false, "min_ram": 0, "min_disk": 20, "owner": "bd8b3df3f03d43a0a9303b7c0434fdab", "os_hidden": false, "os_hash_algo": "sha512", "os_hash_value": "fe5802fc52ec80a7347f29b260d672bc687386dd19d42565cf2df8da873e45471382efffbf170f29d30990636735cf90a3d2d75240f91e8b686c49ccc9dc9b83", "id": "943dd583-2042-4622-b4ce-bdf10ad153ac", "created_at": "2024-03-24T04:06:45Z", "updated_at": "2024-03-24T04:07:10Z", "locations": [{"url": "rbd://eea9d068-c18c-11ed-8dc0-013aacb71b80/glance/943dd583-2042-4622-b4ce-bdf10ad153ac/snap", "metadata": {"store": "ceph"}}], "direct_url": "rbd://eea9d068-c18c-11ed-8dc0-013aacb71b80/glance/943dd583-2042-4622-b4ce-bdf10ad153ac/snap", "tags": [], "self": "/v2/images/943dd583-2042-4622-b4ce-bdf10ad153ac", "file": "/v2/images/943dd583-2042-4622-b4ce-bdf10ad153ac/file", "schema": "/v2/schemas/image", "stores": "ceph"} 455s DEBUG (session:936) GET call to image for https://glance.ps6.canonical.com:9292/v2/images/943dd583-2042-4622-b4ce-bdf10ad153ac used request id req-177ceff3-455a-4f2b-a926-bf311937646c 455s 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}4c5a1040e0384d45150e138a9ae775f7bab42ecbd424d1aa0974bfc60bd9bea5" -H "X-OpenStack-Nova-API-Version: 2.87" 455s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/autopkgtest HTTP/1.1" 404 84 455s DEBUG (session:548) RESP: [404] Connection: Keep-Alive Content-Length: 84 Content-Type: application/json; charset=UTF-8 Date: Sun, 24 Mar 2024 05:33:42 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-e60e45c0-512a-4eb5-9dd5-90acae46eaf3 x-openstack-request-id: req-e60e45c0-512a-4eb5-9dd5-90acae46eaf3 455s DEBUG (session:580) RESP BODY: {"itemNotFound": {"code": 404, "message": "Flavor autopkgtest could not be found."}} 455s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors/autopkgtest used request id req-e60e45c0-512a-4eb5-9dd5-90acae46eaf3 455s 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}4c5a1040e0384d45150e138a9ae775f7bab42ecbd424d1aa0974bfc60bd9bea5" -H "X-OpenStack-Nova-API-Version: 2.87" 455s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors?is_public=None HTTP/1.1" 200 1739 455s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1739 Content-Type: application/json Date: Sun, 24 Mar 2024 05:33:42 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-72f24c97-5512-4614-ab97-5ce9e68bcc9b x-openstack-request-id: req-72f24c97-5512-4614-ab97-5ce9e68bcc9b 455s 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}]} 455s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors?is_public=None used request id req-72f24c97-5512-4614-ab97-5ce9e68bcc9b 455s 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}4c5a1040e0384d45150e138a9ae775f7bab42ecbd424d1aa0974bfc60bd9bea5" -H "X-OpenStack-Nova-API-Version: 2.87" 455s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09 HTTP/1.1" 200 613 455s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 613 Content-Type: application/json Date: Sun, 24 Mar 2024 05:33:42 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-77e85ca4-2b63-4099-b87c-5043d31d2cb1 x-openstack-request-id: req-77e85ca4-2b63-4099-b87c-5043d31d2cb1 455s 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"}}} 455s 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-77e85ca4-2b63-4099-b87c-5043d31d2cb1 455s 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}4c5a1040e0384d45150e138a9ae775f7bab42ecbd424d1aa0974bfc60bd9bea5" -H "X-OpenStack-Nova-API-Version: 2.87" -d '{"server": {"name": "adt-noble-arm64-sqlalchemy-i18n-20240324-053158-juju-7f2275-prod-proposed-migration-environment-2", "imageRef": "943dd583-2042-4622-b4ce-bdf10ad153ac", "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-3.secgroup"}], "networks": [{"uuid": "6ea4839c-9760-4b54-ab7d-70a6312667d1"}]}}' 455s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "POST /v2.1/servers HTTP/1.1" 403 115 455s DEBUG (session:548) RESP: [403] Connection: Keep-Alive Content-Length: 115 Content-Type: application/json; charset=UTF-8 Date: Sun, 24 Mar 2024 05:33:45 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-5deb7d40-be54-41c6-9a39-33ce7bbc8da0 x-openstack-request-id: req-5deb7d40-be54-41c6-9a39-33ce7bbc8da0 455s DEBUG (session:580) RESP BODY: {"forbidden": {"code": 403, "message": "Quota exceeded for cores: Requested 2, but already used 140 of 140 cores"}} 455s DEBUG (session:936) POST call to compute for https://nova.ps6.canonical.com:8774/v2.1/servers used request id req-5deb7d40-be54-41c6-9a39-33ce7bbc8da0 455s DEBUG (shell:822) Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-5deb7d40-be54-41c6-9a39-33ce7bbc8da0) 455s Traceback (most recent call last): 455s File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 820, in main 455s OpenStackComputeShell().main(argv) 455s File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 742, in main 455s args.func(self.cs, args) 455s File "/usr/lib/python3/dist-packages/novaclient/v2/shell.py", line 971, in do_boot 455s server = cs.servers.create(*boot_args, **boot_kwargs) 455s File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 1477, in create 455s return self._boot(response_key, *boot_args, **boot_kwargs) 455s File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 836, in _boot 455s return self._create('/servers', body, response_key, 455s File "/usr/lib/python3/dist-packages/novaclient/base.py", line 363, in _create 455s resp, body = self.api.client.post(url, body=body) 455s File "/usr/lib/python3/dist-packages/keystoneauth1/adapter.py", line 392, in post 455s return self.request(url, 'POST', **kwargs) 455s File "/usr/lib/python3/dist-packages/novaclient/client.py", line 78, in request 455s raise exceptions.from_response(resp, body, url, method) 455s novaclient.exceptions.Forbidden: Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-5deb7d40-be54-41c6-9a39-33ce7bbc8da0) 455s ERROR (Forbidden): Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-5deb7d40-be54-41c6-9a39-33ce7bbc8da0) 460s autopkgtest [05:39:38]: testbed dpkg architecture: arm64 460s autopkgtest [05:39:38]: testbed apt version: 2.7.12 460s autopkgtest [05:39:38]: @@@@@@@@@@@@@@@@@@@@ test bed setup 460s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 461s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 461s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3984 kB] 464s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB] 464s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [494 kB] 464s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [707 kB] 464s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 464s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.7 kB] 464s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 464s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4359 kB] 464s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 464s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [69.8 kB] 464s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 464s Fetched 9840 kB in 2s (5583 kB/s) 464s Reading package lists... 467s Reading package lists... 467s Building dependency tree... 467s Reading state information... 467s Calculating upgrade... 472s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 472s sh: Attempting to set up Debian/Ubuntu apt sources automatically 472s sh: Distribution appears to be Ubuntu 472s Reading package lists... 472s Building dependency tree... 472s Reading state information... 472s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 472s Reading package lists... 472s Building dependency tree... 472s Reading state information... 472s eatmydata is already the newest version (131-1). 472s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 472s Reading package lists... 472s Building dependency tree... 472s Reading state information... 472s dbus is already the newest version (1.14.10-4ubuntu1). 472s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 472s Reading package lists... 472s Building dependency tree... 472s Reading state information... 472s rng-tools-debian is already the newest version (2.4). 472s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 472s Reading package lists... 472s Building dependency tree... 472s Reading state information... 473s The following packages will be REMOVED: 473s cloud-init* python3-configobj* python3-debconf* 473s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 473s After this operation, 3256 kB disk space will be freed. 473s (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.) 473s Removing cloud-init (24.1.2-0ubuntu1) ... 474s Removing python3-configobj (5.0.8-3) ... 474s Removing python3-debconf (1.5.86) ... 474s Processing triggers for man-db (2.12.0-3) ... 474s (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.) 474s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 475s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 475s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 475s invoke-rc.d: policy-rc.d denied execution of try-restart. 475s Reading package lists... 475s Building dependency tree... 475s Reading state information... 476s linux-generic is already the newest version (6.8.0-11.11+1). 476s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 476s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 476s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 476s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 482s Reading package lists... 482s Reading package lists... 482s Building dependency tree... 482s Reading state information... 482s Calculating upgrade... 482s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 482s Reading package lists... 482s Building dependency tree... 482s Reading state information... 482s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 482s autopkgtest [05:39:58]: rebooting testbed after setup commands that affected boot 508s autopkgtest [05:40:26]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024 515s autopkgtest [05:40:33]: @@@@@@@@@@@@@@@@@@@@ apt-source sqlalchemy-i18n 517s Get:1 http://ftpmaster.internal/ubuntu noble/universe sqlalchemy-i18n 1.1.0-1build1 (dsc) [2462 B] 517s Get:2 http://ftpmaster.internal/ubuntu noble/universe sqlalchemy-i18n 1.1.0-1build1 (tar) [28.2 kB] 517s Get:3 http://ftpmaster.internal/ubuntu noble/universe sqlalchemy-i18n 1.1.0-1build1 (diff) [4212 B] 517s gpgv: Signature made Wed Jan 18 23:54:36 2023 UTC 517s gpgv: using RSA key 439884E6862A429C290DF63B033C4CA276024834 517s gpgv: issuer "athos.ribeiro@canonical.com" 517s gpgv: Can't check signature: No public key 517s dpkg-source: warning: cannot verify inline signature for ./sqlalchemy-i18n_1.1.0-1build1.dsc: no acceptable signature found 518s autopkgtest [05:40:36]: testing package sqlalchemy-i18n version 1.1.0-1build1 518s autopkgtest [05:40:36]: build not needed 518s autopkgtest [05:40:36]: test setup-db-and-run-tests.py: preparing testbed 528s Reading package lists... 528s Building dependency tree... 528s Reading state information... 528s Starting pkgProblemResolver with broken count: 0 528s Starting 2 pkgProblemResolver with broken count: 0 528s Done 529s The following additional packages will be installed: 529s libjs-jquery libjs-sphinxdoc libjs-underscore libjson-perl libllvm17 libpq5 529s libxslt1.1 postgresql postgresql-16 postgresql-client-16 529s postgresql-client-common postgresql-common python3-arrow python3-dateutil 529s python3-greenlet python3-iniconfig python3-packaging python3-pluggy 529s python3-psycopg2 python3-pytest python3-sqlalchemy python3-sqlalchemy-i18n 529s python3-sqlalchemy-utils ssl-cert 529s Suggested packages: 529s postgresql-doc postgresql-doc-16 python-arrow-doc python-greenlet-dev 529s python-greenlet-doc python-psycopg2-doc python-sqlalchemy-doc python3-fdb 529s python3-pymssql python3-mysqldb python3-asyncpg python3-aiosqlite 529s python-sqlalchemy-utils-doc python3-infinity python3-intervals 529s python3-psycopg2cffi 529s Recommended packages: 529s javascript-common libjson-xs-perl python3-sqlalchemy-ext 529s The following NEW packages will be installed: 529s autopkgtest-satdep libjs-jquery libjs-sphinxdoc libjs-underscore 529s libjson-perl libllvm17 libpq5 libxslt1.1 postgresql postgresql-16 529s postgresql-client-16 postgresql-client-common postgresql-common 529s python3-arrow python3-dateutil python3-greenlet python3-iniconfig 529s python3-packaging python3-pluggy python3-psycopg2 python3-pytest 529s python3-sqlalchemy python3-sqlalchemy-i18n python3-sqlalchemy-utils ssl-cert 529s 0 upgraded, 25 newly installed, 0 to remove and 0 not upgraded. 529s Need to get 44.7 MB/44.7 MB of archives. 529s After this operation, 187 MB of additional disk space will be used. 529s Get:1 /tmp/autopkgtest.wKP0tI/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [740 B] 529s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libjson-perl all 4.10000-1 [81.9 kB] 529s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 postgresql-client-common all 257 [36.2 kB] 529s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 ssl-cert all 1.1.2ubuntu1 [17.8 kB] 529s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 postgresql-common all 257 [162 kB] 529s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 529s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 529s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 libjs-sphinxdoc all 7.2.6-4 [149 kB] 529s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 libllvm17 arm64 1:17.0.6-5build1 [25.0 MB] 530s Get:10 http://ftpmaster.internal/ubuntu noble/main arm64 libpq5 arm64 16.2-1 [136 kB] 530s Get:11 http://ftpmaster.internal/ubuntu noble/main arm64 libxslt1.1 arm64 1.1.39-0exp1 [166 kB] 530s Get:12 http://ftpmaster.internal/ubuntu noble/main arm64 postgresql-client-16 arm64 16.2-1 [1260 kB] 530s Get:13 http://ftpmaster.internal/ubuntu noble/main arm64 postgresql-16 arm64 16.2-1 [15.2 MB] 530s Get:14 http://ftpmaster.internal/ubuntu noble/main arm64 postgresql all 16+257 [11.4 kB] 530s Get:15 http://ftpmaster.internal/ubuntu noble/main arm64 python3-dateutil all 2.8.2-3 [79.2 kB] 530s Get:16 http://ftpmaster.internal/ubuntu noble/main arm64 python3-arrow all 1.2.3-1 [55.7 kB] 530s Get:17 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-iniconfig all 1.1.1-2 [6024 B] 530s Get:18 http://ftpmaster.internal/ubuntu noble/main arm64 python3-packaging all 23.2-1 [40.6 kB] 530s Get:19 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-pluggy all 1.4.0-1 [20.4 kB] 530s Get:20 http://ftpmaster.internal/ubuntu noble/main arm64 python3-psycopg2 arm64 2.9.9-1 [177 kB] 530s Get:21 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-pytest all 7.4.4-1 [305 kB] 530s Get:22 http://ftpmaster.internal/ubuntu noble/main arm64 python3-greenlet arm64 3.0.1-2 [168 kB] 531s Get:23 http://ftpmaster.internal/ubuntu noble/main arm64 python3-sqlalchemy all 1.4.50+ds1-1 [1020 kB] 531s Get:24 http://ftpmaster.internal/ubuntu noble/main arm64 python3-sqlalchemy-utils all 0.41.1-0ubuntu1 [59.4 kB] 531s Get:25 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-sqlalchemy-i18n all 1.1.0-1build1 [26.7 kB] 531s Preconfiguring packages ... 531s Fetched 44.7 MB in 2s (24.4 MB/s) 531s Selecting previously unselected package libjson-perl. 531s (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.) 531s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 531s Unpacking libjson-perl (4.10000-1) ... 531s Selecting previously unselected package postgresql-client-common. 531s Preparing to unpack .../01-postgresql-client-common_257_all.deb ... 531s Unpacking postgresql-client-common (257) ... 531s Selecting previously unselected package ssl-cert. 531s Preparing to unpack .../02-ssl-cert_1.1.2ubuntu1_all.deb ... 531s Unpacking ssl-cert (1.1.2ubuntu1) ... 531s Selecting previously unselected package postgresql-common. 531s Preparing to unpack .../03-postgresql-common_257_all.deb ... 531s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 531s Unpacking postgresql-common (257) ... 531s Selecting previously unselected package libjs-jquery. 531s Preparing to unpack .../04-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 531s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 531s Selecting previously unselected package libjs-underscore. 531s Preparing to unpack .../05-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 531s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 532s Selecting previously unselected package libjs-sphinxdoc. 532s Preparing to unpack .../06-libjs-sphinxdoc_7.2.6-4_all.deb ... 532s Unpacking libjs-sphinxdoc (7.2.6-4) ... 532s Selecting previously unselected package libllvm17:arm64. 532s Preparing to unpack .../07-libllvm17_1%3a17.0.6-5build1_arm64.deb ... 532s Unpacking libllvm17:arm64 (1:17.0.6-5build1) ... 532s Selecting previously unselected package libpq5:arm64. 532s Preparing to unpack .../08-libpq5_16.2-1_arm64.deb ... 532s Unpacking libpq5:arm64 (16.2-1) ... 532s Selecting previously unselected package libxslt1.1:arm64. 532s Preparing to unpack .../09-libxslt1.1_1.1.39-0exp1_arm64.deb ... 532s Unpacking libxslt1.1:arm64 (1.1.39-0exp1) ... 532s Selecting previously unselected package postgresql-client-16. 532s Preparing to unpack .../10-postgresql-client-16_16.2-1_arm64.deb ... 532s Unpacking postgresql-client-16 (16.2-1) ... 532s Selecting previously unselected package postgresql-16. 532s Preparing to unpack .../11-postgresql-16_16.2-1_arm64.deb ... 532s Unpacking postgresql-16 (16.2-1) ... 533s Selecting previously unselected package postgresql. 533s Preparing to unpack .../12-postgresql_16+257_all.deb ... 533s Unpacking postgresql (16+257) ... 533s Selecting previously unselected package python3-dateutil. 533s Preparing to unpack .../13-python3-dateutil_2.8.2-3_all.deb ... 533s Unpacking python3-dateutil (2.8.2-3) ... 533s Selecting previously unselected package python3-arrow. 533s Preparing to unpack .../14-python3-arrow_1.2.3-1_all.deb ... 533s Unpacking python3-arrow (1.2.3-1) ... 533s Selecting previously unselected package python3-iniconfig. 533s Preparing to unpack .../15-python3-iniconfig_1.1.1-2_all.deb ... 533s Unpacking python3-iniconfig (1.1.1-2) ... 533s Selecting previously unselected package python3-packaging. 533s Preparing to unpack .../16-python3-packaging_23.2-1_all.deb ... 533s Unpacking python3-packaging (23.2-1) ... 533s Selecting previously unselected package python3-pluggy. 533s Preparing to unpack .../17-python3-pluggy_1.4.0-1_all.deb ... 533s Unpacking python3-pluggy (1.4.0-1) ... 533s Selecting previously unselected package python3-psycopg2. 533s Preparing to unpack .../18-python3-psycopg2_2.9.9-1_arm64.deb ... 533s Unpacking python3-psycopg2 (2.9.9-1) ... 533s Selecting previously unselected package python3-pytest. 533s Preparing to unpack .../19-python3-pytest_7.4.4-1_all.deb ... 533s Unpacking python3-pytest (7.4.4-1) ... 533s Selecting previously unselected package python3-greenlet. 533s Preparing to unpack .../20-python3-greenlet_3.0.1-2_arm64.deb ... 533s Unpacking python3-greenlet (3.0.1-2) ... 533s Selecting previously unselected package python3-sqlalchemy. 533s Preparing to unpack .../21-python3-sqlalchemy_1.4.50+ds1-1_all.deb ... 533s Unpacking python3-sqlalchemy (1.4.50+ds1-1) ... 533s Selecting previously unselected package python3-sqlalchemy-utils. 533s Preparing to unpack .../22-python3-sqlalchemy-utils_0.41.1-0ubuntu1_all.deb ... 533s Unpacking python3-sqlalchemy-utils (0.41.1-0ubuntu1) ... 533s Selecting previously unselected package python3-sqlalchemy-i18n. 533s Preparing to unpack .../23-python3-sqlalchemy-i18n_1.1.0-1build1_all.deb ... 533s Unpacking python3-sqlalchemy-i18n (1.1.0-1build1) ... 533s Selecting previously unselected package autopkgtest-satdep. 533s Preparing to unpack .../24-1-autopkgtest-satdep.deb ... 533s Unpacking autopkgtest-satdep (0) ... 533s Setting up postgresql-client-common (257) ... 533s Setting up python3-iniconfig (1.1.1-2) ... 533s Setting up libpq5:arm64 (16.2-1) ... 533s Setting up python3-packaging (23.2-1) ... 533s Setting up ssl-cert (1.1.2ubuntu1) ... 543s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 543s Setting up python3-greenlet (3.0.1-2) ... 543s Setting up python3-psycopg2 (2.9.9-1) ... 543s Setting up python3-pluggy (1.4.0-1) ... 543s Setting up libjson-perl (4.10000-1) ... 543s Setting up libxslt1.1:arm64 (1.1.39-0exp1) ... 543s Setting up python3-dateutil (2.8.2-3) ... 543s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 543s Setting up libllvm17:arm64 (1:17.0.6-5build1) ... 543s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 543s Setting up python3-arrow (1.2.3-1) ... 543s Setting up python3-pytest (7.4.4-1) ... 543s Setting up postgresql-client-16 (16.2-1) ... 543s update-alternatives: using /usr/share/postgresql/16/man/man1/psql.1.gz to provide /usr/share/man/man1/psql.1.gz (psql.1.gz) in auto mode 543s Setting up python3-sqlalchemy (1.4.50+ds1-1) ... 543s Setting up postgresql-common (257) ... 543s 543s Creating config file /etc/postgresql-common/createcluster.conf with new version 543s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 543s Removing obsolete dictionary files: 543s Created symlink /etc/systemd/system/multi-user.target.wants/postgresql.service → /usr/lib/systemd/system/postgresql.service. 543s Setting up libjs-sphinxdoc (7.2.6-4) ... 543s Setting up python3-sqlalchemy-utils (0.41.1-0ubuntu1) ... 543s Setting up python3-sqlalchemy-i18n (1.1.0-1build1) ... 543s Setting up postgresql-16 (16.2-1) ... 543s Creating new PostgreSQL cluster 16/main ... 543s /usr/lib/postgresql/16/bin/initdb -D /var/lib/postgresql/16/main --auth-local peer --auth-host scram-sha-256 --no-instructions 543s The files belonging to this database system will be owned by user "postgres". 543s This user must also own the server process. 543s 543s The database cluster will be initialized with locale "C.UTF-8". 543s The default database encoding has accordingly been set to "UTF8". 543s The default text search configuration will be set to "english". 543s 543s Data page checksums are disabled. 543s 543s fixing permissions on existing directory /var/lib/postgresql/16/main ... ok 543s creating subdirectories ... ok 543s selecting dynamic shared memory implementation ... posix 543s selecting default max_connections ... 100 543s selecting default shared_buffers ... 128MB 543s selecting default time zone ... Etc/UTC 543s creating configuration files ... ok 543s running bootstrap script ... ok 543s performing post-bootstrap initialization ... ok 543s syncing data to disk ... ok 543s Setting up postgresql (16+257) ... 543s Setting up autopkgtest-satdep (0) ... 543s Processing triggers for man-db (2.12.0-3) ... 544s Processing triggers for libc-bin (2.39-0ubuntu6) ... 547s (Reading database ... 77118 files and directories currently installed.) 547s Removing autopkgtest-satdep (0) ... 547s autopkgtest [05:41:05]: test setup-db-and-run-tests.py: [----------------------- 548s The files belonging to this database system will be owned by user "ubuntu". 548s This user must also own the server process. 548s 548s The database cluster will be initialized with this locale configuration: 548s provider: libc 548s LC_COLLATE: C.UTF-8 548s LC_CTYPE: C.UTF-8 548s LC_MESSAGES: C 548s LC_MONETARY: C.UTF-8 548s LC_NUMERIC: C.UTF-8 548s LC_TIME: C.UTF-8 548s The default database encoding has accordingly been set to "UTF8". 548s The default text search configuration will be set to "english". 548s 548s Data page checksums are disabled. 548s 548s creating directory /tmp/tmpexw6d15s/data ... ok 548s creating subdirectories ... ok 548s selecting dynamic shared memory implementation ... posix 548s selecting default max_connections ... 100 548s selecting default shared_buffers ... 128MB 548s selecting default time zone ... Etc/UTC 548s creating configuration files ... ok 548s running bootstrap script ... ok 548s performing post-bootstrap initialization ... ok 549s syncing data to disk ... ok 549s 549s Success. You can now start the database server using: 549s 549s /usr/lib/postgresql/16/bin/pg_ctl -D /tmp/tmpexw6d15s/data -l logfile start 549s 549s 2024-03-24 05:41:07.034 UTC [3489] LOG: starting PostgreSQL 16.2 (Ubuntu 16.2-1) on aarch64-unknown-linux-gnu, compiled by gcc (Ubuntu 13.2.0-13ubuntu1) 13.2.0, 64-bit 549s 2024-03-24 05:41:07.035 UTC [3489] LOG: listening on IPv6 address "::1", port 43825 549s 2024-03-24 05:41:07.035 UTC [3489] LOG: listening on IPv4 address "127.0.0.1", port 43825 549s 2024-03-24 05:41:07.035 UTC [3489] LOG: listening on Unix socket "/tmp/tmpexw6d15s/tmp/.s.PGSQL.43825" 549s 2024-03-24 05:41:07.037 UTC [3492] LOG: database system was shut down at 2024-03-24 05:41:06 UTC 549s 2024-03-24 05:41:07.040 UTC [3489] LOG: database system is ready to accept connections 549s running initdb 550s starting server 550s ============================= test session starts ============================== 550s platform linux -- Python 3.12.2, pytest-7.4.4, pluggy-1.4.0 550s rootdir: /tmp/autopkgtest.wKP0tI/build.LmD/src 550s collected 119 items 550s 550s tests/test_common_base_class.py .. [ 1%] 550s tests/test_comparator.py .... [ 5%] 550s tests/test_composite_primary_key.py .. [ 6%] 550s tests/test_configuration.py .. [ 8%] 550s tests/test_current_translation_property.py ...... [ 13%] 550s tests/test_current_translation_property_with_locale.py .. [ 15%] 550s tests/test_custom_base_class.py . [ 15%] 550s tests/test_expressions.py . [ 16%] 550s tests/test_fallback_locale_as_callable.py .... [ 20%] 550s tests/test_fallback_locale_without_class_default.py .... [ 23%] 550s tests/test_fallback_translation.py ...... [ 28%] 551s tests/test_find_translations.py .... [ 31%] 551s tests/test_hybrid_property_as_dynamic_source_locale.py .. [ 33%] 551s tests/test_hybrid_property_exclusion.py .. [ 35%] 551s tests/test_join_expressions.py ........ [ 42%] 551s tests/test_joined_loading.py .......... [ 50%] 552s tests/test_joined_table_inheritance.py ................ [ 63%] 552s tests/test_property_collision.py . [ 64%] 552s tests/test_relationships.py .. [ 66%] 552s tests/test_translatable.py ................ [ 79%] 552s tests/test_translation_auto_creation.py .. [ 81%] 553s tests/test_translation_auto_creation_with_non_nullables.py .. [ 83%] 553s tests/test_translation_mapping.py .................... [100%]2024-03-24 05:41:11.853 UTC [3489] LOG: received smart shutdown request 553s 2024-03-24 05:41:11.858 UTC [3489] LOG: background worker "logical replication launcher" (PID 3495) exited with exit code 1 553s 2024-03-24 05:41:11.858 UTC [3490] LOG: shutting down 553s 2024-03-24 05:41:11.859 UTC [3490] LOG: checkpoint starting: shutdown immediate 553s 2024-03-24 05:41:11.877 UTC [3490] LOG: checkpoint complete: wrote 1111 buffers (6.8%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.010 s, sync=0.001 s, total=0.019 s; sync files=0, longest=0.000 s, average=0.000 s; distance=10200 kB, estimate=10200 kB; lsn=0/1EE6110, redo lsn=0/1EE6110 553s 2024-03-24 05:41:11.885 UTC [3489] LOG: database system is shut down 554s 554s 554s =============================== warnings summary =============================== 554s ../../../../usr/lib/python3/dist-packages/dateutil/tz/tz.py:37 554s /usr/lib/python3/dist-packages/dateutil/tz/tz.py:37: DeprecationWarning: datetime.datetime.utcfromtimestamp() is deprecated and scheduled for removal in a future version. Use timezone-aware objects to represent datetimes in UTC: datetime.datetime.fromtimestamp(timestamp, datetime.UTC). 554s EPOCH = datetime.datetime.utcfromtimestamp(0) 554s 554s tests/test_common_base_class.py::TestDeclarative::test_translatable_dict_copied_to_each_child_class 554s /tmp/autopkgtest.wKP0tI/build.LmD/src/tests/__init__.py:52: MovedIn20Warning: Deprecated API features detected! These feature(s) are not compatible with SQLAlchemy 2.0. To prevent incompatible upgrades prior to updating applications, ensure requirements files are pinned to "sqlalchemy<2.0". Set environment variable SQLALCHEMY_WARN_20=1 to show all deprecation warnings. Set environment variable SQLALCHEMY_SILENCE_UBER_WARNING=1 to silence this message. (Background on SQLAlchemy 2.0 at: https://sqlalche.me/e/b8d9) 554s self.Model = declarative_base() 554s 554s tests/test_find_translations.py::TestDeclarative::test_with_full_confidence 554s tests/test_find_translations.py::TestDeclarative::test_with_varying_confidence 554s tests/test_find_translations.py::TestClassic::test_with_full_confidence 554s tests/test_find_translations.py::TestClassic::test_with_varying_confidence 554s /tmp/autopkgtest.wKP0tI/build.LmD/src/sqlalchemy_i18n/__init__.py:85: SAWarning: implicitly coercing SELECT object to scalar subquery; please use the .scalar_subquery() method to produce a scalar subquery. 554s (sa.func.cast(sa.func.count('1'), sa.Numeric) / total_count) 554s 554s -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 554s ======================= 119 passed, 6 warnings in 4.64s ======================== 554s stopping server 554s clean up 554s autopkgtest [05:41:12]: test setup-db-and-run-tests.py: -----------------------] 555s setup-db-and-run-tests.py PASS 555s autopkgtest [05:41:13]: test setup-db-and-run-tests.py: - - - - - - - - - - results - - - - - - - - - - 555s autopkgtest [05:41:13]: @@@@@@@@@@@@@@@@@@@@ summary 555s setup-db-and-run-tests.py PASS