0s autopkgtest [17:13:35]: starting date and time: 2024-03-23 17:13:35+0000
  0s autopkgtest [17:13:35]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
  0s autopkgtest [17:13:35]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.cy53njzw/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:multipath-tools --apt-upgrade freedom-maker --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=multipath-tools/0.9.4-5ubuntu6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-10.secgroup --name adt-noble-arm64-freedom-maker-20240323-164605-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/
666s Creating nova instance adt-noble-arm64-freedom-maker-20240323-164605-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240321.img (UUID 28ecccfc-4cb0-4cc6-a280-209e2d140e10)...
666s nova boot failed (attempt #1):
666s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP')
666s 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"
666s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps6.canonical.com:5000
666s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Sat, 23 Mar 2024 17:13:57 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-3b1d2184-9b2a-4e53-85bd-14ee93c608f2
666s 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"}]}}
666s DEBUG (session:946) GET call to https://keystone.ps6.canonical.com:5000/v3 used request id req-3b1d2184-9b2a-4e53-85bd-14ee93c608f2
666s DEBUG (base:182) Making authentication request to https://keystone.ps6.canonical.com:5000/v3/auth/tokens
666s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 12445
666s 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": ["wvOed9zUSJ6tZ_H_2___Iw"], "expires_at": "2024-03-24T17:13:58.000000Z", "issued_at": "2024-03-23T17:13:58.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"}]}}
666s 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}5fb088ae18d3e833160a592e236e2c127d55b4f1093abc17d737da6db8f33d2d"
666s 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}5fb088ae18d3e833160a592e236e2c127d55b4f1093abc17d737da6db8f33d2d"
666s DEBUG (connectionpool:962) Starting new HTTPS connection (1): nova.ps6.canonical.com:8774
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1 HTTP/1.1" 302 0
666s RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Sat, 23 Mar 2024 17:13:58 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-f9072958-7df9-4c4d-99de-b9a8a48d7472 x-openstack-request-id: req-f9072958-7df9-4c4d-99de-b9a8a48d7472
666s DEBUG (session:548) RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Sat, 23 Mar 2024 17:13:58 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-f9072958-7df9-4c4d-99de-b9a8a48d7472 x-openstack-request-id: req-f9072958-7df9-4c4d-99de-b9a8a48d7472
666s RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged.
666s DEBUG (session:580) RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged.
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/ HTTP/1.1" 200 397
666s RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Sat, 23 Mar 2024 17:13:58 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-d2187b1f-62bc-4eb0-acf0-ae693be845b4 x-openstack-request-id: req-d2187b1f-62bc-4eb0-acf0-ae693be845b4
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Sat, 23 Mar 2024 17:13:58 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-d2187b1f-62bc-4eb0-acf0-ae693be845b4 x-openstack-request-id: req-d2187b1f-62bc-4eb0-acf0-ae693be845b4
666s 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"}]}}
666s 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"}]}}
666s GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-d2187b1f-62bc-4eb0-acf0-ae693be845b4
666s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-d2187b1f-62bc-4eb0-acf0-ae693be845b4
666s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP')
666s 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}5fb088ae18d3e833160a592e236e2c127d55b4f1093abc17d737da6db8f33d2d" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:962) Starting new HTTPS connection (1): glance.ps6.canonical.com:9292
666s DEBUG (connectionpool:429) https://glance.ps6.canonical.com:9292 "GET /v2/images/28ecccfc-4cb0-4cc6-a280-209e2d140e10 HTTP/1.1" 200 1935
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1935 Content-Type: application/json Date: Sat, 23 Mar 2024 17:13:58 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) X-Openstack-Request-Id: req-db0b519b-5b0d-4ad5-ae53-07ab559b76f4
666s 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"}
666s 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-db0b519b-5b0d-4ad5-ae53-07ab559b76f4
666s 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}5fb088ae18d3e833160a592e236e2c127d55b4f1093abc17d737da6db8f33d2d" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/autopkgtest HTTP/1.1" 404 84
666s DEBUG (session:548) RESP: [404] Connection: Keep-Alive Content-Length: 84 Content-Type: application/json; charset=UTF-8 Date: Sat, 23 Mar 2024 17:13:58 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-9764e5cc-eb9f-49c7-ad06-7e6c72d6eacd x-openstack-request-id: req-9764e5cc-eb9f-49c7-ad06-7e6c72d6eacd
666s DEBUG (session:580) RESP BODY: {"itemNotFound": {"code": 404, "message": "Flavor autopkgtest could not be found."}}
666s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors/autopkgtest used request id req-9764e5cc-eb9f-49c7-ad06-7e6c72d6eacd
666s 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}5fb088ae18d3e833160a592e236e2c127d55b4f1093abc17d737da6db8f33d2d" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors?is_public=None HTTP/1.1" 200 1739
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1739 Content-Type: application/json Date: Sat, 23 Mar 2024 17:13:58 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-314e1182-d763-43a2-b5ec-18811aed1e93 x-openstack-request-id: req-314e1182-d763-43a2-b5ec-18811aed1e93
666s 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}]}
666s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors?is_public=None used request id req-314e1182-d763-43a2-b5ec-18811aed1e93
666s 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}5fb088ae18d3e833160a592e236e2c127d55b4f1093abc17d737da6db8f33d2d" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09 HTTP/1.1" 200 613
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 613 Content-Type: application/json Date: Sat, 23 Mar 2024 17:13:59 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-452d555f-24ba-4f6f-9dc9-ada8955136b9 x-openstack-request-id: req-452d555f-24ba-4f6f-9dc9-ada8955136b9
666s 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"}}}
666s 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-452d555f-24ba-4f6f-9dc9-ada8955136b9
666s 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}5fb088ae18d3e833160a592e236e2c127d55b4f1093abc17d737da6db8f33d2d" -H "X-OpenStack-Nova-API-Version: 2.87" -d '{"server": {"name": "adt-noble-arm64-freedom-maker-20240323-164605-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-10.secgroup"}], "networks": [{"uuid": "6ea4839c-9760-4b54-ab7d-70a6312667d1"}]}}'
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "POST /v2.1/servers HTTP/1.1" 403 115
666s DEBUG (session:548) RESP: [403] Connection: Keep-Alive Content-Length: 115 Content-Type: application/json; charset=UTF-8 Date: Sat, 23 Mar 2024 17:13:59 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-50cf12a7-bb3d-46d5-b396-a142dd9ba10f x-openstack-request-id: req-50cf12a7-bb3d-46d5-b396-a142dd9ba10f
666s DEBUG (session:580) RESP BODY: {"forbidden": {"code": 403, "message": "Quota exceeded for cores: Requested 2, but already used 140 of 140 cores"}}
666s DEBUG (session:936) POST call to compute for https://nova.ps6.canonical.com:8774/v2.1/servers used request id req-50cf12a7-bb3d-46d5-b396-a142dd9ba10f
666s DEBUG (shell:822) Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-50cf12a7-bb3d-46d5-b396-a142dd9ba10f)
666s Traceback (most recent call last):
666s   File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 820, in main
666s     OpenStackComputeShell().main(argv)
666s   File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 742, in main
666s     args.func(self.cs, args)
666s   File "/usr/lib/python3/dist-packages/novaclient/v2/shell.py", line 971, in do_boot
666s     server = cs.servers.create(*boot_args, **boot_kwargs)
666s   File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 1477, in create
666s     return self._boot(response_key, *boot_args, **boot_kwargs)
666s   File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 836, in _boot
666s     return self._create('/servers', body, response_key,
666s   File "/usr/lib/python3/dist-packages/novaclient/base.py", line 363, in _create
666s     resp, body = self.api.client.post(url, body=body)
666s   File "/usr/lib/python3/dist-packages/keystoneauth1/adapter.py", line 392, in post
666s     return self.request(url, 'POST', **kwargs)
666s   File "/usr/lib/python3/dist-packages/novaclient/client.py", line 78, in request
666s     raise exceptions.from_response(resp, body, url, method)
666s novaclient.exceptions.Forbidden: Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-50cf12a7-bb3d-46d5-b396-a142dd9ba10f)
666s ERROR (Forbidden): Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-50cf12a7-bb3d-46d5-b396-a142dd9ba10f)
666s nova boot failed (attempt #2):
666s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP')
666s 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"
666s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps6.canonical.com:5000
666s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Sat, 23 Mar 2024 17:19:00 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-b1be18f7-c769-45db-9ad6-1f0ba01479e1
666s 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"}]}}
666s DEBUG (session:946) GET call to https://keystone.ps6.canonical.com:5000/v3 used request id req-b1be18f7-c769-45db-9ad6-1f0ba01479e1
666s DEBUG (base:182) Making authentication request to https://keystone.ps6.canonical.com:5000/v3/auth/tokens
666s DEBUG (connectionpool:429) https://keystone.ps6.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 12445
666s 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": ["b6ip-VNHQEWaYQaDzW2LEw"], "expires_at": "2024-03-24T17:19:00.000000Z", "issued_at": "2024-03-23T17:19:00.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"}]}}
666s 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}4d15216f5b8f0d9f6bd347b2cc171084254e397081d9ac969b3b3742159968aa"
666s 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}4d15216f5b8f0d9f6bd347b2cc171084254e397081d9ac969b3b3742159968aa"
666s DEBUG (connectionpool:962) Starting new HTTPS connection (1): nova.ps6.canonical.com:8774
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1 HTTP/1.1" 302 0
666s RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Sat, 23 Mar 2024 17:19:01 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-d5814669-e0e7-4666-b96b-6e7eb0236cca x-openstack-request-id: req-d5814669-e0e7-4666-b96b-6e7eb0236cca
666s DEBUG (session:548) RESP: [302] Connection: Keep-Alive Content-Length: 0 Content-Type: text/plain; charset=utf8 Date: Sat, 23 Mar 2024 17:19:01 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-d5814669-e0e7-4666-b96b-6e7eb0236cca x-openstack-request-id: req-d5814669-e0e7-4666-b96b-6e7eb0236cca
666s RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged.
666s DEBUG (session:580) RESP BODY: Omitted, Content-Type is set to text/plain; charset=utf8. Only application/json responses have their bodies logged.
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/ HTTP/1.1" 200 397
666s RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Sat, 23 Mar 2024 17:19:01 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-29265492-7acb-4c86-b8d1-48790c0ef5cc x-openstack-request-id: req-29265492-7acb-4c86-b8d1-48790c0ef5cc
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 397 Content-Type: application/json Date: Sat, 23 Mar 2024 17:19:01 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-29265492-7acb-4c86-b8d1-48790c0ef5cc x-openstack-request-id: req-29265492-7acb-4c86-b8d1-48790c0ef5cc
666s 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"}]}}
666s 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"}]}}
666s GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-29265492-7acb-4c86-b8d1-48790c0ef5cc
666s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/ used request id req-29265492-7acb-4c86-b8d1-48790c0ef5cc
666s DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader')
666s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth')
666s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP')
666s 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}4d15216f5b8f0d9f6bd347b2cc171084254e397081d9ac969b3b3742159968aa" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:962) Starting new HTTPS connection (1): glance.ps6.canonical.com:9292
666s DEBUG (connectionpool:429) https://glance.ps6.canonical.com:9292 "GET /v2/images/28ecccfc-4cb0-4cc6-a280-209e2d140e10 HTTP/1.1" 200 1935
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1935 Content-Type: application/json Date: Sat, 23 Mar 2024 17:19:01 GMT Keep-Alive: timeout=75, max=1000 Server: Apache/2.4.52 (Ubuntu) X-Openstack-Request-Id: req-63470e52-d605-48a7-9a1a-f9b4ff14d20f
666s 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"}
666s 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-63470e52-d605-48a7-9a1a-f9b4ff14d20f
666s 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}4d15216f5b8f0d9f6bd347b2cc171084254e397081d9ac969b3b3742159968aa" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/autopkgtest HTTP/1.1" 404 84
666s DEBUG (session:548) RESP: [404] Connection: Keep-Alive Content-Length: 84 Content-Type: application/json; charset=UTF-8 Date: Sat, 23 Mar 2024 17:19:01 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-c2b5f71f-113b-4172-9de6-09c4d6e74bb1 x-openstack-request-id: req-c2b5f71f-113b-4172-9de6-09c4d6e74bb1
666s DEBUG (session:580) RESP BODY: {"itemNotFound": {"code": 404, "message": "Flavor autopkgtest could not be found."}}
666s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors/autopkgtest used request id req-c2b5f71f-113b-4172-9de6-09c4d6e74bb1
666s 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}4d15216f5b8f0d9f6bd347b2cc171084254e397081d9ac969b3b3742159968aa" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors?is_public=None HTTP/1.1" 200 1739
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 1739 Content-Type: application/json Date: Sat, 23 Mar 2024 17:19:01 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-470b3b98-4269-49be-a5b0-ce6be80a233a x-openstack-request-id: req-470b3b98-4269-49be-a5b0-ce6be80a233a
666s 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}]}
666s DEBUG (session:936) GET call to compute for https://nova.ps6.canonical.com:8774/v2.1/flavors?is_public=None used request id req-470b3b98-4269-49be-a5b0-ce6be80a233a
666s 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}4d15216f5b8f0d9f6bd347b2cc171084254e397081d9ac969b3b3742159968aa" -H "X-OpenStack-Nova-API-Version: 2.87"
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "GET /v2.1/flavors/8d27c5f0-65c7-4018-b3f7-50463875ab09 HTTP/1.1" 200 613
666s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 613 Content-Type: application/json Date: Sat, 23 Mar 2024 17:19:02 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-fa5a14a1-4856-48b2-8938-a11f62f5c9a8 x-openstack-request-id: req-fa5a14a1-4856-48b2-8938-a11f62f5c9a8
666s 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"}}}
666s 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-fa5a14a1-4856-48b2-8938-a11f62f5c9a8
666s 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}4d15216f5b8f0d9f6bd347b2cc171084254e397081d9ac969b3b3742159968aa" -H "X-OpenStack-Nova-API-Version: 2.87" -d '{"server": {"name": "adt-noble-arm64-freedom-maker-20240323-164605-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-10.secgroup"}], "networks": [{"uuid": "6ea4839c-9760-4b54-ab7d-70a6312667d1"}]}}'
666s DEBUG (connectionpool:429) https://nova.ps6.canonical.com:8774 "POST /v2.1/servers HTTP/1.1" 403 115
666s DEBUG (session:548) RESP: [403] Connection: Keep-Alive Content-Length: 115 Content-Type: application/json; charset=UTF-8 Date: Sat, 23 Mar 2024 17:19:02 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-7bbb9705-9076-4f6a-b66f-a8ef51ad8645 x-openstack-request-id: req-7bbb9705-9076-4f6a-b66f-a8ef51ad8645
666s DEBUG (session:580) RESP BODY: {"forbidden": {"code": 403, "message": "Quota exceeded for cores: Requested 2, but already used 140 of 140 cores"}}
666s DEBUG (session:936) POST call to compute for https://nova.ps6.canonical.com:8774/v2.1/servers used request id req-7bbb9705-9076-4f6a-b66f-a8ef51ad8645
666s DEBUG (shell:822) Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-7bbb9705-9076-4f6a-b66f-a8ef51ad8645)
666s Traceback (most recent call last):
666s   File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 820, in main
666s     OpenStackComputeShell().main(argv)
666s   File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 742, in main
666s     args.func(self.cs, args)
666s   File "/usr/lib/python3/dist-packages/novaclient/v2/shell.py", line 971, in do_boot
666s     server = cs.servers.create(*boot_args, **boot_kwargs)
666s   File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 1477, in create
666s     return self._boot(response_key, *boot_args, **boot_kwargs)
666s   File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 836, in _boot
666s     return self._create('/servers', body, response_key,
666s   File "/usr/lib/python3/dist-packages/novaclient/base.py", line 363, in _create
666s     resp, body = self.api.client.post(url, body=body)
666s   File "/usr/lib/python3/dist-packages/keystoneauth1/adapter.py", line 392, in post
666s     return self.request(url, 'POST', **kwargs)
666s   File "/usr/lib/python3/dist-packages/novaclient/client.py", line 78, in request
666s     raise exceptions.from_response(resp, body, url, method)
666s novaclient.exceptions.Forbidden: Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-7bbb9705-9076-4f6a-b66f-a8ef51ad8645)
666s ERROR (Forbidden): Quota exceeded for cores: Requested 2, but already used 140 of 140 cores (HTTP 403) (Request-ID: req-7bbb9705-9076-4f6a-b66f-a8ef51ad8645)
671s autopkgtest [17:24:46]: testbed dpkg architecture: arm64
671s autopkgtest [17:24:46]: testbed apt version: 2.7.12
671s autopkgtest [17:24:46]: @@@@@@@@@@@@@@@@@@@@ test bed setup
672s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
672s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB]
672s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [493 kB]
672s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
672s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3969 kB]
672s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [667 kB]
672s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B]
672s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.7 kB]
672s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B]
672s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4345 kB]
673s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B]
673s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [69.8 kB]
673s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B]
675s Fetched 9770 kB in 2s (5555 kB/s)
675s Reading package lists...
678s Reading package lists...
678s Building dependency tree...
678s Reading state information...
679s Calculating upgrade...
680s The following package was automatically installed and is no longer required:
680s   libaio1
680s Use 'sudo apt autoremove' to remove it.
680s The following packages will be REMOVED:
680s   liburcu8
680s The following NEW packages will be installed:
680s   libaio1t64 liburcu8t64
680s The following packages will be upgraded:
680s   cloud-init fonts-ubuntu-console kpartx libbsd0 libc-bin libc6 locales
680s   multipath-tools python3-markupsafe
680s 9 upgraded, 2 newly installed, 1 to remove and 0 not upgraded.
680s Need to get 8673 kB of archives.
680s After this operation, 30.7 kB of additional disk space will be used.
680s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 libc6 arm64 2.39-0ubuntu6 [2776 kB]
680s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libc-bin arm64 2.39-0ubuntu6 [591 kB]
680s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 multipath-tools arm64 0.9.4-5ubuntu6 [303 kB]
680s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 liburcu8t64 arm64 0.14.0-3.1 [63.1 kB]
680s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libbsd0 arm64 0.12.1-1 [41.0 kB]
680s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 locales all 2.39-0ubuntu6 [4232 kB]
680s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 fonts-ubuntu-console all 0.869+git20240321-0ubuntu1 [18.7 kB]
680s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 libaio1t64 arm64 0.3.113-6 [7312 B]
680s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 python3-markupsafe arm64 2.1.5-1build1 [12.5 kB]
680s Get:10 http://ftpmaster.internal/ubuntu noble/main arm64 cloud-init all 24.1.2-0ubuntu1 [597 kB]
680s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 kpartx arm64 0.9.4-5ubuntu6 [31.3 kB]
681s Preconfiguring packages ...
681s Fetched 8673 kB in 1s (9065 kB/s)
681s (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.)
681s Preparing to unpack .../libc6_2.39-0ubuntu6_arm64.deb ...
682s Unpacking libc6:arm64 (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
682s Setting up libc6:arm64 (2.39-0ubuntu6) ...
683s (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.)
683s Preparing to unpack .../libc-bin_2.39-0ubuntu6_arm64.deb ...
683s Unpacking libc-bin (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
683s Setting up libc-bin (2.39-0ubuntu6) ...
683s (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.)
683s Preparing to unpack .../multipath-tools_0.9.4-5ubuntu6_arm64.deb ...
683s Unpacking multipath-tools (0.9.4-5ubuntu6) over (0.9.4-5ubuntu3) ...
683s dpkg: liburcu8:arm64: dependency problems, but removing anyway as you requested:
683s  xfsprogs depends on liburcu8 (>= 0.13.0).
683s 
683s (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.)
683s Removing liburcu8:arm64 (0.14.0-3) ...
683s Selecting previously unselected package liburcu8t64:arm64.
683s (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 ... 74800 files and directories currently installed.)
683s Preparing to unpack .../0-liburcu8t64_0.14.0-3.1_arm64.deb ...
683s Unpacking liburcu8t64:arm64 (0.14.0-3.1) ...
683s Preparing to unpack .../1-libbsd0_0.12.1-1_arm64.deb ...
683s Unpacking libbsd0:arm64 (0.12.1-1) over (0.11.8-1) ...
683s Preparing to unpack .../2-locales_2.39-0ubuntu6_all.deb ...
683s Unpacking locales (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
683s Preparing to unpack .../3-fonts-ubuntu-console_0.869+git20240321-0ubuntu1_all.deb ...
683s Unpacking fonts-ubuntu-console (0.869+git20240321-0ubuntu1) over (0.869-0ubuntu1) ...
683s Selecting previously unselected package libaio1t64:arm64.
683s Preparing to unpack .../4-libaio1t64_0.3.113-6_arm64.deb ...
683s Unpacking libaio1t64:arm64 (0.3.113-6) ...
683s Preparing to unpack .../5-python3-markupsafe_2.1.5-1build1_arm64.deb ...
683s Unpacking python3-markupsafe (2.1.5-1build1) over (2.1.5-1) ...
683s Preparing to unpack .../6-cloud-init_24.1.2-0ubuntu1_all.deb ...
684s Unpacking cloud-init (24.1.2-0ubuntu1) over (24.1.1-0ubuntu1) ...
684s Preparing to unpack .../7-kpartx_0.9.4-5ubuntu6_arm64.deb ...
684s Unpacking kpartx (0.9.4-5ubuntu6) over (0.9.4-5ubuntu3) ...
684s Setting up fonts-ubuntu-console (0.869+git20240321-0ubuntu1) ...
684s Setting up liburcu8t64:arm64 (0.14.0-3.1) ...
684s Setting up cloud-init (24.1.2-0ubuntu1) ...
685s Setting up locales (2.39-0ubuntu6) ...
686s Generating locales (this might take a while)...
688s   en_US.UTF-8... done
688s Generation complete.
688s Setting up python3-markupsafe (2.1.5-1build1) ...
688s Setting up libaio1t64:arm64 (0.3.113-6) ...
688s Setting up kpartx (0.9.4-5ubuntu6) ...
688s Setting up libbsd0:arm64 (0.12.1-1) ...
688s Setting up multipath-tools (0.9.4-5ubuntu6) ...
689s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
689s Processing triggers for man-db (2.12.0-3) ...
690s Processing triggers for libc-bin (2.39-0ubuntu6) ...
690s Reading package lists...
690s Building dependency tree...
690s Reading state information...
691s The following packages will be REMOVED:
691s   libaio1*
691s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded.
691s After this operation, 90.1 kB disk space will be freed.
691s (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 ... 74823 files and directories currently installed.)
691s Removing libaio1:arm64 (0.3.113-5) ...
691s Processing triggers for libc-bin (2.39-0ubuntu6) ...
692s sh: Attempting to set up Debian/Ubuntu apt sources automatically
692s sh: Distribution appears to be Ubuntu
693s Reading package lists...
693s Building dependency tree...
693s Reading state information...
694s eatmydata is already the newest version (131-1).
694s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
694s Reading package lists...
694s Building dependency tree...
694s Reading state information...
695s dbus is already the newest version (1.14.10-4ubuntu1).
695s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
695s Reading package lists...
695s Building dependency tree...
695s Reading state information...
696s rng-tools-debian is already the newest version (2.4).
696s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
696s Reading package lists...
696s Building dependency tree...
696s Reading state information...
697s The following packages will be REMOVED:
697s   cloud-init* python3-configobj* python3-debconf*
697s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded.
697s After this operation, 3256 kB disk space will be freed.
697s (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 ... 74818 files and directories currently installed.)
697s Removing cloud-init (24.1.2-0ubuntu1) ...
698s Removing python3-configobj (5.0.8-3) ...
698s Removing python3-debconf (1.5.86) ...
698s Processing triggers for man-db (2.12.0-3) ...
698s (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 ... 74429 files and directories currently installed.)
698s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ...
699s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed
699s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
699s invoke-rc.d: policy-rc.d denied execution of try-restart.
699s Reading package lists...
699s Building dependency tree...
699s Reading state information...
700s linux-generic is already the newest version (6.8.0-11.11+1).
700s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
700s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease
701s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease
701s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease
703s Reading package lists...
703s Reading package lists...
703s Building dependency tree...
703s Reading state information...
703s Calculating upgrade...
704s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
704s Reading package lists...
704s Building dependency tree...
704s Reading state information...
705s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
705s autopkgtest [17:25:20]: rebooting testbed after setup commands that affected boot
733s autopkgtest [17:25:48]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024
736s autopkgtest [17:25:51]: @@@@@@@@@@@@@@@@@@@@ apt-source freedom-maker
738s Get:1 http://ftpmaster.internal/ubuntu noble/universe freedom-maker 0.33 (dsc) [2015 B]
738s Get:2 http://ftpmaster.internal/ubuntu noble/universe freedom-maker 0.33 (tar) [45.6 kB]
738s gpgv: Signature made Fri Feb  9 17:46:29 2024 UTC
738s gpgv:                using RSA key 7D6ADB750F91085589484BE677C0C75E7B650808
738s gpgv:                issuer "jvalleroy@mailbox.org"
738s gpgv: Can't check signature: No public key
738s dpkg-source: warning: cannot verify inline signature for ./freedom-maker_0.33.dsc: no acceptable signature found
738s autopkgtest [17:25:53]: testing package freedom-maker version 0.33
739s autopkgtest [17:25:54]: build not needed
739s autopkgtest [17:25:54]: test command1: preparing testbed
742s Reading package lists...
742s Building dependency tree...
742s Reading state information...
743s Starting pkgProblemResolver with broken count: 0
743s Starting 2 pkgProblemResolver with broken count: 0
743s Done
744s The following additional packages will be installed:
744s   debootstrap freedom-maker git git-man libaio1 liberror-perl liburing2
744s   python3-all python3-distutils python3-lib2to3 qemu-user-static qemu-utils
744s   sshpass
744s Suggested packages:
744s   squid-deb-proxy-client debian-archive-keyring arch-test virtualbox
744s   git-daemon-run | git-daemon-sysvinit git-doc git-email git-gui gitk gitweb
744s   git-cvs git-mediawiki git-svn
744s Recommended packages:
744s   qemu-block-extra
744s The following NEW packages will be installed:
744s   autopkgtest-satdep debootstrap freedom-maker git git-man libaio1
744s   liberror-perl liburing2 python3-all python3-distutils python3-lib2to3
744s   qemu-user-static qemu-utils sshpass
744s 0 upgraded, 14 newly installed, 0 to remove and 0 not upgraded.
744s Need to get 24.1 MB/24.1 MB of archives.
744s After this operation, 205 MB of additional disk space will be used.
744s Get:1 /tmp/autopkgtest.mpRncR/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [724 B]
744s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 liberror-perl all 0.17029-2 [25.6 kB]
744s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 git-man all 1:2.43.0-1ubuntu1 [1100 kB]
744s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 git arm64 1:2.43.0-1ubuntu1 [3786 kB]
745s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libaio1 arm64 0.3.113-5 [6278 B]
745s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 liburing2 arm64 2.5-1 [21.5 kB]
745s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 python3-lib2to3 all 3.11.5-1 [79.0 kB]
745s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 python3-distutils all 3.11.5-1 [131 kB]
745s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 python3-all arm64 3.12.1-0ubuntu2 [906 B]
745s Get:10 http://ftpmaster.internal/ubuntu noble/universe arm64 qemu-user-static arm64 1:8.2.1+ds-1ubuntu1 [16.8 MB]
745s Get:11 http://ftpmaster.internal/ubuntu noble/main arm64 qemu-utils arm64 1:8.2.1+ds-1ubuntu1 [2041 kB]
745s Get:12 http://ftpmaster.internal/ubuntu noble/main arm64 debootstrap all 1.0.134ubuntu1 [48.0 kB]
745s Get:13 http://ftpmaster.internal/ubuntu noble/universe arm64 sshpass arm64 1.09-1 [11.5 kB]
745s Get:14 http://ftpmaster.internal/ubuntu noble/universe arm64 freedom-maker all 0.33 [54.2 kB]
746s Fetched 24.1 MB in 1s (19.3 MB/s)
746s Selecting previously unselected package liberror-perl.
746s (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 ... 74374 files and directories currently installed.)
746s Preparing to unpack .../00-liberror-perl_0.17029-2_all.deb ...
746s Unpacking liberror-perl (0.17029-2) ...
746s Selecting previously unselected package git-man.
746s Preparing to unpack .../01-git-man_1%3a2.43.0-1ubuntu1_all.deb ...
746s Unpacking git-man (1:2.43.0-1ubuntu1) ...
746s Selecting previously unselected package git.
746s Preparing to unpack .../02-git_1%3a2.43.0-1ubuntu1_arm64.deb ...
746s Unpacking git (1:2.43.0-1ubuntu1) ...
746s Selecting previously unselected package libaio1:arm64.
746s Preparing to unpack .../03-libaio1_0.3.113-5_arm64.deb ...
746s Unpacking libaio1:arm64 (0.3.113-5) ...
746s Selecting previously unselected package liburing2:arm64.
746s Preparing to unpack .../04-liburing2_2.5-1_arm64.deb ...
746s Unpacking liburing2:arm64 (2.5-1) ...
746s Selecting previously unselected package python3-lib2to3.
746s Preparing to unpack .../05-python3-lib2to3_3.11.5-1_all.deb ...
746s Unpacking python3-lib2to3 (3.11.5-1) ...
746s Selecting previously unselected package python3-distutils.
746s Preparing to unpack .../06-python3-distutils_3.11.5-1_all.deb ...
746s Unpacking python3-distutils (3.11.5-1) ...
746s Selecting previously unselected package python3-all.
746s Preparing to unpack .../07-python3-all_3.12.1-0ubuntu2_arm64.deb ...
746s Unpacking python3-all (3.12.1-0ubuntu2) ...
746s Selecting previously unselected package qemu-user-static.
746s Preparing to unpack .../08-qemu-user-static_1%3a8.2.1+ds-1ubuntu1_arm64.deb ...
746s Unpacking qemu-user-static (1:8.2.1+ds-1ubuntu1) ...
747s Selecting previously unselected package qemu-utils.
747s Preparing to unpack .../09-qemu-utils_1%3a8.2.1+ds-1ubuntu1_arm64.deb ...
747s Unpacking qemu-utils (1:8.2.1+ds-1ubuntu1) ...
747s Selecting previously unselected package debootstrap.
747s Preparing to unpack .../10-debootstrap_1.0.134ubuntu1_all.deb ...
747s Unpacking debootstrap (1.0.134ubuntu1) ...
747s Selecting previously unselected package sshpass.
747s Preparing to unpack .../11-sshpass_1.09-1_arm64.deb ...
747s Unpacking sshpass (1.09-1) ...
747s Selecting previously unselected package freedom-maker.
747s Preparing to unpack .../12-freedom-maker_0.33_all.deb ...
747s Unpacking freedom-maker (0.33) ...
747s Selecting previously unselected package autopkgtest-satdep.
747s Preparing to unpack .../13-1-autopkgtest-satdep.deb ...
747s Unpacking autopkgtest-satdep (0) ...
747s Setting up debootstrap (1.0.134ubuntu1) ...
747s Setting up qemu-user-static (1:8.2.1+ds-1ubuntu1) ...
747s Setting up sshpass (1.09-1) ...
747s Setting up liberror-perl (0.17029-2) ...
747s Setting up git-man (1:2.43.0-1ubuntu1) ...
747s Setting up liburing2:arm64 (2.5-1) ...
747s Setting up libaio1:arm64 (0.3.113-5) ...
747s Setting up python3-lib2to3 (3.11.5-1) ...
747s Setting up python3-distutils (3.11.5-1) ...
747s python3.12: can't get files for byte-compilation
747s Setting up python3-all (3.12.1-0ubuntu2) ...
747s Setting up git (1:2.43.0-1ubuntu1) ...
747s Setting up qemu-utils (1:8.2.1+ds-1ubuntu1) ...
747s Setting up freedom-maker (0.33) ...
748s Setting up autopkgtest-satdep (0) ...
748s Processing triggers for systemd (255.2-3ubuntu2) ...
748s Processing triggers for man-db (2.12.0-3) ...
749s Processing triggers for libc-bin (2.39-0ubuntu6) ...
752s (Reading database ... 76008 files and directories currently installed.)
752s Removing autopkgtest-satdep (0) ...
753s autopkgtest [17:26:08]: test command1: set -e ; for py in $(py3versions -r 2>/dev/null) ; do cd "$AUTOPKGTEST_TMP" ; echo "Testing with $py:" ; $py -c "import freedommaker; print(freedommaker)" ; done
753s autopkgtest [17:26:08]: test command1: [-----------------------
753s Testing with python3.12:
753s <module 'freedommaker' from '/usr/lib/python3/dist-packages/freedommaker/__init__.py'>
754s autopkgtest [17:26:09]: test command1: -----------------------]
754s autopkgtest [17:26:09]: test command1:  - - - - - - - - - - results - - - - - - - - - -
754s command1             PASS
754s autopkgtest [17:26:09]: test command2: preparing testbed
825s autopkgtest [17:27:20]: testbed dpkg architecture: arm64
825s autopkgtest [17:27:20]: testbed apt version: 2.7.12
825s autopkgtest [17:27:20]: @@@@@@@@@@@@@@@@@@@@ test bed setup
825s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
826s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB]
826s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3969 kB]
826s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
826s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [493 kB]
826s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [667 kB]
826s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B]
826s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.7 kB]
826s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B]
826s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4345 kB]
826s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B]
826s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [69.8 kB]
826s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B]
828s Fetched 9770 kB in 2s (5456 kB/s)
829s Reading package lists...
831s Reading package lists...
831s Building dependency tree...
831s Reading state information...
832s Calculating upgrade...
835s The following package was automatically installed and is no longer required:
835s   libaio1
835s Use 'sudo apt autoremove' to remove it.
835s The following packages will be REMOVED:
835s   liburcu8
835s The following NEW packages will be installed:
835s   libaio1t64 liburcu8t64
835s The following packages will be upgraded:
836s   cloud-init fonts-ubuntu-console kpartx libbsd0 libc-bin libc6 locales
836s   multipath-tools python3-markupsafe
836s 9 upgraded, 2 newly installed, 1 to remove and 0 not upgraded.
836s Need to get 8673 kB of archives.
836s After this operation, 30.7 kB of additional disk space will be used.
836s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 libc6 arm64 2.39-0ubuntu6 [2776 kB]
836s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libc-bin arm64 2.39-0ubuntu6 [591 kB]
836s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 multipath-tools arm64 0.9.4-5ubuntu6 [303 kB]
836s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 liburcu8t64 arm64 0.14.0-3.1 [63.1 kB]
836s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libbsd0 arm64 0.12.1-1 [41.0 kB]
836s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 locales all 2.39-0ubuntu6 [4232 kB]
836s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 fonts-ubuntu-console all 0.869+git20240321-0ubuntu1 [18.7 kB]
836s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 libaio1t64 arm64 0.3.113-6 [7312 B]
836s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 python3-markupsafe arm64 2.1.5-1build1 [12.5 kB]
836s Get:10 http://ftpmaster.internal/ubuntu noble/main arm64 cloud-init all 24.1.2-0ubuntu1 [597 kB]
836s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 kpartx arm64 0.9.4-5ubuntu6 [31.3 kB]
836s Preconfiguring packages ...
836s Fetched 8673 kB in 1s (10.5 MB/s)
836s (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.)
836s Preparing to unpack .../libc6_2.39-0ubuntu6_arm64.deb ...
836s Unpacking libc6:arm64 (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
836s Setting up libc6:arm64 (2.39-0ubuntu6) ...
836s (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.)
836s Preparing to unpack .../libc-bin_2.39-0ubuntu6_arm64.deb ...
836s Unpacking libc-bin (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
836s Setting up libc-bin (2.39-0ubuntu6) ...
836s (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.)
836s Preparing to unpack .../multipath-tools_0.9.4-5ubuntu6_arm64.deb ...
836s Unpacking multipath-tools (0.9.4-5ubuntu6) over (0.9.4-5ubuntu3) ...
836s dpkg: liburcu8:arm64: dependency problems, but removing anyway as you requested:
836s  xfsprogs depends on liburcu8 (>= 0.13.0).
836s 
836s (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.)
836s Removing liburcu8:arm64 (0.14.0-3) ...
836s Selecting previously unselected package liburcu8t64:arm64.
836s (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 ... 74800 files and directories currently installed.)
836s Preparing to unpack .../0-liburcu8t64_0.14.0-3.1_arm64.deb ...
836s Unpacking liburcu8t64:arm64 (0.14.0-3.1) ...
836s Preparing to unpack .../1-libbsd0_0.12.1-1_arm64.deb ...
836s Unpacking libbsd0:arm64 (0.12.1-1) over (0.11.8-1) ...
836s Preparing to unpack .../2-locales_2.39-0ubuntu6_all.deb ...
836s Unpacking locales (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
836s Preparing to unpack .../3-fonts-ubuntu-console_0.869+git20240321-0ubuntu1_all.deb ...
836s Unpacking fonts-ubuntu-console (0.869+git20240321-0ubuntu1) over (0.869-0ubuntu1) ...
836s Selecting previously unselected package libaio1t64:arm64.
836s Preparing to unpack .../4-libaio1t64_0.3.113-6_arm64.deb ...
836s Unpacking libaio1t64:arm64 (0.3.113-6) ...
836s Preparing to unpack .../5-python3-markupsafe_2.1.5-1build1_arm64.deb ...
836s Unpacking python3-markupsafe (2.1.5-1build1) over (2.1.5-1) ...
836s Preparing to unpack .../6-cloud-init_24.1.2-0ubuntu1_all.deb ...
836s Unpacking cloud-init (24.1.2-0ubuntu1) over (24.1.1-0ubuntu1) ...
836s Preparing to unpack .../7-kpartx_0.9.4-5ubuntu6_arm64.deb ...
836s Unpacking kpartx (0.9.4-5ubuntu6) over (0.9.4-5ubuntu3) ...
836s Setting up fonts-ubuntu-console (0.869+git20240321-0ubuntu1) ...
836s Setting up liburcu8t64:arm64 (0.14.0-3.1) ...
836s Setting up cloud-init (24.1.2-0ubuntu1) ...
838s Setting up locales (2.39-0ubuntu6) ...
838s Generating locales (this might take a while)...
841s   en_US.UTF-8... done
841s Generation complete.
841s Setting up python3-markupsafe (2.1.5-1build1) ...
841s Setting up libaio1t64:arm64 (0.3.113-6) ...
841s Setting up kpartx (0.9.4-5ubuntu6) ...
841s Setting up libbsd0:arm64 (0.12.1-1) ...
841s Setting up multipath-tools (0.9.4-5ubuntu6) ...
842s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
842s Processing triggers for man-db (2.12.0-3) ...
843s Processing triggers for libc-bin (2.39-0ubuntu6) ...
843s Reading package lists...
844s Building dependency tree...
844s Reading state information...
844s The following packages will be REMOVED:
844s   libaio1*
845s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded.
845s After this operation, 90.1 kB disk space will be freed.
845s (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 ... 74823 files and directories currently installed.)
845s Removing libaio1:arm64 (0.3.113-5) ...
845s Processing triggers for libc-bin (2.39-0ubuntu6) ...
846s sh: Attempting to set up Debian/Ubuntu apt sources automatically
846s sh: Distribution appears to be Ubuntu
846s Reading package lists...
847s Building dependency tree...
847s Reading state information...
847s eatmydata is already the newest version (131-1).
847s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
847s Reading package lists...
847s Building dependency tree...
847s Reading state information...
848s dbus is already the newest version (1.14.10-4ubuntu1).
848s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
848s Reading package lists...
848s Building dependency tree...
848s Reading state information...
849s rng-tools-debian is already the newest version (2.4).
849s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
849s Reading package lists...
849s Building dependency tree...
849s Reading state information...
850s The following packages will be REMOVED:
850s   cloud-init* python3-configobj* python3-debconf*
850s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded.
850s After this operation, 3256 kB disk space will be freed.
850s (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 ... 74818 files and directories currently installed.)
850s Removing cloud-init (24.1.2-0ubuntu1) ...
851s Removing python3-configobj (5.0.8-3) ...
851s Removing python3-debconf (1.5.86) ...
851s Processing triggers for man-db (2.12.0-3) ...
851s (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 ... 74429 files and directories currently installed.)
851s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ...
852s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed
852s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
852s invoke-rc.d: policy-rc.d denied execution of try-restart.
852s Reading package lists...
853s Building dependency tree...
853s Reading state information...
853s linux-generic is already the newest version (6.8.0-11.11+1).
853s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
854s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease
854s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease
854s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease
856s Reading package lists...
856s Reading package lists...
856s Building dependency tree...
856s Reading state information...
856s Calculating upgrade...
857s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
857s Reading package lists...
857s Building dependency tree...
857s Reading state information...
858s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
858s autopkgtest [17:27:53]: rebooting testbed after setup commands that affected boot
1022s Reading package lists...
1022s Building dependency tree...
1022s Reading state information...
1023s Starting pkgProblemResolver with broken count: 0
1023s Starting 2 pkgProblemResolver with broken count: 0
1023s Done
1023s The following additional packages will be installed:
1023s   debootstrap freedom-maker git git-man libaio1 liberror-perl liburing2
1023s   qemu-user-static qemu-utils sshpass
1023s Suggested packages:
1023s   squid-deb-proxy-client debian-archive-keyring arch-test virtualbox
1023s   git-daemon-run | git-daemon-sysvinit git-doc git-email git-gui gitk gitweb
1023s   git-cvs git-mediawiki git-svn
1023s Recommended packages:
1023s   qemu-block-extra
1024s The following NEW packages will be installed:
1024s   autopkgtest-satdep debootstrap freedom-maker git git-man libaio1
1024s   liberror-perl liburing2 qemu-user-static qemu-utils sshpass
1024s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded.
1024s Need to get 23.9 MB/23.9 MB of archives.
1024s After this operation, 204 MB of additional disk space will be used.
1024s Get:1 /tmp/autopkgtest.mpRncR/2-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [724 B]
1024s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 liberror-perl all 0.17029-2 [25.6 kB]
1024s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 git-man all 1:2.43.0-1ubuntu1 [1100 kB]
1024s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 git arm64 1:2.43.0-1ubuntu1 [3786 kB]
1024s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libaio1 arm64 0.3.113-5 [6278 B]
1024s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 liburing2 arm64 2.5-1 [21.5 kB]
1024s Get:7 http://ftpmaster.internal/ubuntu noble/universe arm64 qemu-user-static arm64 1:8.2.1+ds-1ubuntu1 [16.8 MB]
1025s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 qemu-utils arm64 1:8.2.1+ds-1ubuntu1 [2041 kB]
1025s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 debootstrap all 1.0.134ubuntu1 [48.0 kB]
1025s Get:10 http://ftpmaster.internal/ubuntu noble/universe arm64 sshpass arm64 1.09-1 [11.5 kB]
1025s Get:11 http://ftpmaster.internal/ubuntu noble/universe arm64 freedom-maker all 0.33 [54.2 kB]
1029s Fetched 23.9 MB in 1s (17.0 MB/s)
1029s Selecting previously unselected package liberror-perl.
1029s (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 ... 74374 files and directories currently installed.)
1029s Preparing to unpack .../00-liberror-perl_0.17029-2_all.deb ...
1029s Unpacking liberror-perl (0.17029-2) ...
1029s Selecting previously unselected package git-man.
1029s Preparing to unpack .../01-git-man_1%3a2.43.0-1ubuntu1_all.deb ...
1029s Unpacking git-man (1:2.43.0-1ubuntu1) ...
1029s Selecting previously unselected package git.
1029s Preparing to unpack .../02-git_1%3a2.43.0-1ubuntu1_arm64.deb ...
1029s Unpacking git (1:2.43.0-1ubuntu1) ...
1029s Selecting previously unselected package libaio1:arm64.
1029s Preparing to unpack .../03-libaio1_0.3.113-5_arm64.deb ...
1029s Unpacking libaio1:arm64 (0.3.113-5) ...
1029s Selecting previously unselected package liburing2:arm64.
1029s Preparing to unpack .../04-liburing2_2.5-1_arm64.deb ...
1029s Unpacking liburing2:arm64 (2.5-1) ...
1029s Selecting previously unselected package qemu-user-static.
1029s Preparing to unpack .../05-qemu-user-static_1%3a8.2.1+ds-1ubuntu1_arm64.deb ...
1029s Unpacking qemu-user-static (1:8.2.1+ds-1ubuntu1) ...
1029s Selecting previously unselected package qemu-utils.
1029s Preparing to unpack .../06-qemu-utils_1%3a8.2.1+ds-1ubuntu1_arm64.deb ...
1029s Unpacking qemu-utils (1:8.2.1+ds-1ubuntu1) ...
1029s Selecting previously unselected package debootstrap.
1029s Preparing to unpack .../07-debootstrap_1.0.134ubuntu1_all.deb ...
1029s Unpacking debootstrap (1.0.134ubuntu1) ...
1029s Selecting previously unselected package sshpass.
1029s Preparing to unpack .../08-sshpass_1.09-1_arm64.deb ...
1029s Unpacking sshpass (1.09-1) ...
1029s Selecting previously unselected package freedom-maker.
1029s Preparing to unpack .../09-freedom-maker_0.33_all.deb ...
1029s Unpacking freedom-maker (0.33) ...
1029s Selecting previously unselected package autopkgtest-satdep.
1029s Preparing to unpack .../10-2-autopkgtest-satdep.deb ...
1029s Unpacking autopkgtest-satdep (0) ...
1029s Setting up debootstrap (1.0.134ubuntu1) ...
1029s Setting up qemu-user-static (1:8.2.1+ds-1ubuntu1) ...
1029s Setting up sshpass (1.09-1) ...
1029s Setting up liberror-perl (0.17029-2) ...
1029s Setting up git-man (1:2.43.0-1ubuntu1) ...
1029s Setting up liburing2:arm64 (2.5-1) ...
1029s Setting up libaio1:arm64 (0.3.113-5) ...
1029s Setting up git (1:2.43.0-1ubuntu1) ...
1029s Setting up qemu-utils (1:8.2.1+ds-1ubuntu1) ...
1029s Setting up freedom-maker (0.33) ...
1029s Setting up autopkgtest-satdep (0) ...
1029s Processing triggers for systemd (255.2-3ubuntu2) ...
1029s Processing triggers for man-db (2.12.0-3) ...
1029s Processing triggers for libc-bin (2.39-0ubuntu6) ...
1033s (Reading database ... 75791 files and directories currently installed.)
1033s Removing autopkgtest-satdep (0) ...
1035s autopkgtest [17:30:50]: test command2: set -e ; freedom-maker --help
1035s autopkgtest [17:30:50]: test command2: [-----------------------
1035s usage: freedom-maker [-h] [--build-stamp BUILD_STAMP]
1035s                      [--image-size IMAGE_SIZE] [--build-mirror BUILD_MIRROR]
1035s                      [--mirror MIRROR] [--distribution DISTRIBUTION]
1035s                      [--add-release-component RELEASE_COMPONENT]
1035s                      [--package PACKAGE] [--custom-package CUSTOM_PACKAGE]
1035s                      [--enable-backports] [--disable-backports]
1035s                      [--build-dir BUILD_DIR]
1035s                      [--log-level {critical,error,warn,info,debug}]
1035s                      [--hostname HOSTNAME] [--sign] [--force] [--build-in-ram]
1035s                      [--skip-compression] [--with-build-dep]
1035s                      targets [targets ...]
1035s 
1035s FreedomMaker - Script to build FreedomBox images
1035s 
1035s positional arguments:
1035s   targets               Image targets to build
1035s 
1035s options:
1035s   -h, --help            show this help message and exit
1035s   --build-stamp BUILD_STAMP
1035s                         Build stamp to use on image file names (default:
1035s                         2024-03-23)
1035s   --image-size IMAGE_SIZE
1035s                         Size of the image to build (default: 3800M)
1035s   --build-mirror BUILD_MIRROR
1035s                         Debian mirror to use for building (default:
1035s                         http://deb.debian.org/debian)
1035s   --mirror MIRROR       Debian mirror to use in built image (default:
1035s                         http://deb.debian.org/debian)
1035s   --distribution DISTRIBUTION
1035s                         Debian release to use in built image (default:
1035s                         unstable)
1035s   --add-release-component RELEASE_COMPONENT
1035s                         Add an extra Debian release component (other than
1035s                         main) (default: None)
1035s   --package PACKAGE     Install additional packages in the image (default:
1035s                         None)
1035s   --custom-package CUSTOM_PACKAGE
1035s                         Install package from DEB file into the image (default:
1035s                         None)
1035s   --enable-backports    Deprecated: Backports are now enabled for stable
1035s                         images by default (default: False)
1035s   --disable-backports   Disable backports in the image (default: False)
1035s   --build-dir BUILD_DIR
1035s                         Directory to build images and create log file
1035s                         (default: build)
1035s   --log-level {critical,error,warn,info,debug}
1035s                         Log level (default: debug)
1035s   --hostname HOSTNAME   Hostname to set inside the built images (default:
1035s                         freedombox)
1035s   --sign                Sign the images with default GPG key after building
1035s                         (default: False)
1035s   --force               Force rebuild of images even when required image
1035s                         exists (default: False)
1035s   --build-in-ram        Build the image in RAM so that it is faster, requires
1035s                         free RAM about the size of disk image (default: False)
1035s   --skip-compression    Do not compress the generated image (default: False)
1035s   --with-build-dep      Include build dependencies in the image (default:
1035s                         False)
1035s autopkgtest [17:30:50]: test command2: -----------------------]
1037s command2             PASS
1037s autopkgtest [17:30:52]: test command2:  - - - - - - - - - - results - - - - - - - - - -
1037s autopkgtest [17:30:52]: test command3: preparing testbed
1109s autopkgtest [17:32:04]: testbed dpkg architecture: arm64
1109s autopkgtest [17:32:04]: testbed apt version: 2.7.12
1109s autopkgtest [17:32:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup
1109s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
1110s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
1110s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3969 kB]
1110s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [493 kB]
1111s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB]
1111s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [667 kB]
1111s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B]
1111s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.7 kB]
1111s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B]
1111s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4345 kB]
1111s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B]
1111s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [69.8 kB]
1111s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B]
1113s Fetched 9770 kB in 2s (4727 kB/s)
1113s Reading package lists...
1116s Reading package lists...
1116s Building dependency tree...
1116s Reading state information...
1119s Calculating upgrade...
1119s The following package was automatically installed and is no longer required:
1119s   libaio1
1119s Use 'sudo apt autoremove' to remove it.
1119s The following packages will be REMOVED:
1119s   liburcu8
1119s The following NEW packages will be installed:
1119s   libaio1t64 liburcu8t64
1119s The following packages will be upgraded:
1119s   cloud-init fonts-ubuntu-console kpartx libbsd0 libc-bin libc6 locales
1119s   multipath-tools python3-markupsafe
1119s 9 upgraded, 2 newly installed, 1 to remove and 0 not upgraded.
1119s Need to get 8673 kB of archives.
1119s After this operation, 30.7 kB of additional disk space will be used.
1119s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 libc6 arm64 2.39-0ubuntu6 [2776 kB]
1119s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 libc-bin arm64 2.39-0ubuntu6 [591 kB]
1119s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 multipath-tools arm64 0.9.4-5ubuntu6 [303 kB]
1119s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 liburcu8t64 arm64 0.14.0-3.1 [63.1 kB]
1119s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libbsd0 arm64 0.12.1-1 [41.0 kB]
1119s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 locales all 2.39-0ubuntu6 [4232 kB]
1119s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 fonts-ubuntu-console all 0.869+git20240321-0ubuntu1 [18.7 kB]
1119s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 libaio1t64 arm64 0.3.113-6 [7312 B]
1119s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 python3-markupsafe arm64 2.1.5-1build1 [12.5 kB]
1119s Get:10 http://ftpmaster.internal/ubuntu noble/main arm64 cloud-init all 24.1.2-0ubuntu1 [597 kB]
1119s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 kpartx arm64 0.9.4-5ubuntu6 [31.3 kB]
1119s Preconfiguring packages ...
1120s Fetched 8673 kB in 1s (8651 kB/s)
1120s (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.)
1120s Preparing to unpack .../libc6_2.39-0ubuntu6_arm64.deb ...
1120s Unpacking libc6:arm64 (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
1121s Setting up libc6:arm64 (2.39-0ubuntu6) ...
1122s (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.)
1122s Preparing to unpack .../libc-bin_2.39-0ubuntu6_arm64.deb ...
1122s Unpacking libc-bin (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
1122s Setting up libc-bin (2.39-0ubuntu6) ...
1122s (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.)
1122s Preparing to unpack .../multipath-tools_0.9.4-5ubuntu6_arm64.deb ...
1122s Unpacking multipath-tools (0.9.4-5ubuntu6) over (0.9.4-5ubuntu3) ...
1123s dpkg: liburcu8:arm64: dependency problems, but removing anyway as you requested:
1123s  xfsprogs depends on liburcu8 (>= 0.13.0).
1123s 
1123s (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.)
1123s Removing liburcu8:arm64 (0.14.0-3) ...
1123s Selecting previously unselected package liburcu8t64:arm64.
1123s (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 ... 74800 files and directories currently installed.)
1123s Preparing to unpack .../0-liburcu8t64_0.14.0-3.1_arm64.deb ...
1123s Unpacking liburcu8t64:arm64 (0.14.0-3.1) ...
1123s Preparing to unpack .../1-libbsd0_0.12.1-1_arm64.deb ...
1123s Unpacking libbsd0:arm64 (0.12.1-1) over (0.11.8-1) ...
1124s Preparing to unpack .../2-locales_2.39-0ubuntu6_all.deb ...
1124s Unpacking locales (2.39-0ubuntu6) over (2.39-0ubuntu2) ...
1124s Preparing to unpack .../3-fonts-ubuntu-console_0.869+git20240321-0ubuntu1_all.deb ...
1124s Unpacking fonts-ubuntu-console (0.869+git20240321-0ubuntu1) over (0.869-0ubuntu1) ...
1124s Selecting previously unselected package libaio1t64:arm64.
1124s Preparing to unpack .../4-libaio1t64_0.3.113-6_arm64.deb ...
1124s Unpacking libaio1t64:arm64 (0.3.113-6) ...
1125s Preparing to unpack .../5-python3-markupsafe_2.1.5-1build1_arm64.deb ...
1125s Unpacking python3-markupsafe (2.1.5-1build1) over (2.1.5-1) ...
1125s Preparing to unpack .../6-cloud-init_24.1.2-0ubuntu1_all.deb ...
1126s Unpacking cloud-init (24.1.2-0ubuntu1) over (24.1.1-0ubuntu1) ...
1127s Preparing to unpack .../7-kpartx_0.9.4-5ubuntu6_arm64.deb ...
1127s Unpacking kpartx (0.9.4-5ubuntu6) over (0.9.4-5ubuntu3) ...
1127s Setting up fonts-ubuntu-console (0.869+git20240321-0ubuntu1) ...
1127s Setting up liburcu8t64:arm64 (0.14.0-3.1) ...
1127s Setting up cloud-init (24.1.2-0ubuntu1) ...
1131s Setting up locales (2.39-0ubuntu6) ...
1135s Generating locales (this might take a while)...
1143s   en_US.UTF-8... done
1143s Generation complete.
1143s Setting up python3-markupsafe (2.1.5-1build1) ...
1143s Setting up libaio1t64:arm64 (0.3.113-6) ...
1143s Setting up kpartx (0.9.4-5ubuntu6) ...
1143s Setting up libbsd0:arm64 (0.12.1-1) ...
1143s Setting up multipath-tools (0.9.4-5ubuntu6) ...
1145s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
1146s Processing triggers for man-db (2.12.0-3) ...
1147s Processing triggers for libc-bin (2.39-0ubuntu6) ...
1149s Reading package lists...
1149s Building dependency tree...
1149s Reading state information...
1151s The following packages will be REMOVED:
1151s   libaio1*
1151s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded.
1151s After this operation, 90.1 kB disk space will be freed.
1151s (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 ... 74823 files and directories currently installed.)
1151s Removing libaio1:arm64 (0.3.113-5) ...
1151s Processing triggers for libc-bin (2.39-0ubuntu6) ...
1155s sh: Attempting to set up Debian/Ubuntu apt sources automatically
1155s sh: Distribution appears to be Ubuntu
1156s Reading package lists...
1157s Building dependency tree...
1157s Reading state information...
1158s eatmydata is already the newest version (131-1).
1158s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1158s Reading package lists...
1158s Building dependency tree...
1158s Reading state information...
1159s dbus is already the newest version (1.14.10-4ubuntu1).
1159s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1159s Reading package lists...
1162s Building dependency tree...
1162s Reading state information...
1162s rng-tools-debian is already the newest version (2.4).
1162s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1162s Reading package lists...
1162s Building dependency tree...
1162s Reading state information...
1162s The following packages will be REMOVED:
1162s   cloud-init* python3-configobj* python3-debconf*
1163s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded.
1163s After this operation, 3256 kB disk space will be freed.
1163s (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 ... 74818 files and directories currently installed.)
1163s Removing cloud-init (24.1.2-0ubuntu1) ...
1165s Removing python3-configobj (5.0.8-3) ...
1165s Removing python3-debconf (1.5.86) ...
1166s Processing triggers for man-db (2.12.0-3) ...
1167s (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 ... 74429 files and directories currently installed.)
1167s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ...
1171s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed
1172s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ...
1172s invoke-rc.d: policy-rc.d denied execution of try-restart.
1172s Reading package lists...
1173s Building dependency tree...
1173s Reading state information...
1173s linux-generic is already the newest version (6.8.0-11.11+1).
1173s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1174s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease
1174s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease
1174s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease
1179s Reading package lists...
1179s Reading package lists...
1179s Building dependency tree...
1179s Reading state information...
1180s Calculating upgrade...
1180s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1180s Reading package lists...
1180s Building dependency tree...
1180s Reading state information...
1181s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1182s autopkgtest [17:33:17]: rebooting testbed after setup commands that affected boot
1350s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
1368s Reading package lists...
1368s Building dependency tree...
1368s Reading state information...
1368s Starting pkgProblemResolver with broken count: 0
1368s Starting 2 pkgProblemResolver with broken count: 0
1368s Done
1369s The following additional packages will be installed:
1369s   debootstrap freedom-maker git git-man libaio1 liberror-perl liburing2
1369s   qemu-user-static qemu-utils sshpass
1369s Suggested packages:
1369s   squid-deb-proxy-client debian-archive-keyring arch-test virtualbox
1369s   git-daemon-run | git-daemon-sysvinit git-doc git-email git-gui gitk gitweb
1369s   git-cvs git-mediawiki git-svn
1369s Recommended packages:
1369s   qemu-block-extra
1369s The following NEW packages will be installed:
1369s   autopkgtest-satdep debootstrap freedom-maker git git-man libaio1
1369s   liberror-perl liburing2 qemu-user-static qemu-utils sshpass
1369s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded.
1369s Need to get 23.9 MB/23.9 MB of archives.
1369s After this operation, 204 MB of additional disk space will be used.
1369s Get:1 /tmp/autopkgtest.mpRncR/3-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [704 B]
1369s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 liberror-perl all 0.17029-2 [25.6 kB]
1369s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 git-man all 1:2.43.0-1ubuntu1 [1100 kB]
1370s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 git arm64 1:2.43.0-1ubuntu1 [3786 kB]
1370s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 libaio1 arm64 0.3.113-5 [6278 B]
1370s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 liburing2 arm64 2.5-1 [21.5 kB]
1370s Get:7 http://ftpmaster.internal/ubuntu noble/universe arm64 qemu-user-static arm64 1:8.2.1+ds-1ubuntu1 [16.8 MB]
1370s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 qemu-utils arm64 1:8.2.1+ds-1ubuntu1 [2041 kB]
1370s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 debootstrap all 1.0.134ubuntu1 [48.0 kB]
1370s Get:10 http://ftpmaster.internal/ubuntu noble/universe arm64 sshpass arm64 1.09-1 [11.5 kB]
1370s Get:11 http://ftpmaster.internal/ubuntu noble/universe arm64 freedom-maker all 0.33 [54.2 kB]
1371s Fetched 23.9 MB in 1s (20.2 MB/s)
1371s Selecting previously unselected package liberror-perl.
1371s (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 ... 74374 files and directories currently installed.)
1371s Preparing to unpack .../00-liberror-perl_0.17029-2_all.deb ...
1371s Unpacking liberror-perl (0.17029-2) ...
1371s Selecting previously unselected package git-man.
1371s Preparing to unpack .../01-git-man_1%3a2.43.0-1ubuntu1_all.deb ...
1371s Unpacking git-man (1:2.43.0-1ubuntu1) ...
1371s Selecting previously unselected package git.
1371s Preparing to unpack .../02-git_1%3a2.43.0-1ubuntu1_arm64.deb ...
1371s Unpacking git (1:2.43.0-1ubuntu1) ...
1371s Selecting previously unselected package libaio1:arm64.
1371s Preparing to unpack .../03-libaio1_0.3.113-5_arm64.deb ...
1371s Unpacking libaio1:arm64 (0.3.113-5) ...
1371s Selecting previously unselected package liburing2:arm64.
1371s Preparing to unpack .../04-liburing2_2.5-1_arm64.deb ...
1371s Unpacking liburing2:arm64 (2.5-1) ...
1371s Selecting previously unselected package qemu-user-static.
1371s Preparing to unpack .../05-qemu-user-static_1%3a8.2.1+ds-1ubuntu1_arm64.deb ...
1371s Unpacking qemu-user-static (1:8.2.1+ds-1ubuntu1) ...
1372s Selecting previously unselected package qemu-utils.
1372s Preparing to unpack .../06-qemu-utils_1%3a8.2.1+ds-1ubuntu1_arm64.deb ...
1372s Unpacking qemu-utils (1:8.2.1+ds-1ubuntu1) ...
1373s Selecting previously unselected package debootstrap.
1373s Preparing to unpack .../07-debootstrap_1.0.134ubuntu1_all.deb ...
1373s Unpacking debootstrap (1.0.134ubuntu1) ...
1373s Selecting previously unselected package sshpass.
1373s Preparing to unpack .../08-sshpass_1.09-1_arm64.deb ...
1373s Unpacking sshpass (1.09-1) ...
1373s Selecting previously unselected package freedom-maker.
1373s Preparing to unpack .../09-freedom-maker_0.33_all.deb ...
1373s Unpacking freedom-maker (0.33) ...
1373s Selecting previously unselected package autopkgtest-satdep.
1373s Preparing to unpack .../10-3-autopkgtest-satdep.deb ...
1373s Unpacking autopkgtest-satdep (0) ...
1373s Setting up debootstrap (1.0.134ubuntu1) ...
1373s Setting up qemu-user-static (1:8.2.1+ds-1ubuntu1) ...
1373s Setting up sshpass (1.09-1) ...
1373s Setting up liberror-perl (0.17029-2) ...
1373s Setting up git-man (1:2.43.0-1ubuntu1) ...
1373s Setting up liburing2:arm64 (2.5-1) ...
1373s Setting up libaio1:arm64 (0.3.113-5) ...
1373s Setting up git (1:2.43.0-1ubuntu1) ...
1373s Setting up qemu-utils (1:8.2.1+ds-1ubuntu1) ...
1373s Setting up freedom-maker (0.33) ...
1373s Setting up autopkgtest-satdep (0) ...
1373s Processing triggers for systemd (255.2-3ubuntu2) ...
1373s Processing triggers for man-db (2.12.0-3) ...
1374s Processing triggers for libc-bin (2.39-0ubuntu6) ...
1378s (Reading database ... 75791 files and directories currently installed.)
1378s Removing autopkgtest-satdep (0) ...
1379s autopkgtest [17:36:34]: test command3: set -e ; passwd-in-image --help
1379s autopkgtest [17:36:34]: test command3: [-----------------------
1380s usage: passwd-in-image [-h] [--password PASSWORD] image user
1380s 
1380s Change password of a user inside a disk image file
1380s 
1380s positional arguments:
1380s   image                Disk image file (.img or .vdi) inside which user
1380s                        manipulation is sought
1380s   user                 User account to change password for
1380s 
1380s options:
1380s   -h, --help           show this help message and exit
1380s   --password PASSWORD  New password for user
1380s autopkgtest [17:36:35]: test command3: -----------------------]
1381s autopkgtest [17:36:36]: test command3:  - - - - - - - - - - results - - - - - - - - - -
1381s command3             PASS
1381s autopkgtest [17:36:36]: test command4: preparing testbed
1389s Reading package lists...
1390s Building dependency tree...
1390s Reading state information...
1390s Starting pkgProblemResolver with broken count: 0
1390s Starting 2 pkgProblemResolver with broken count: 0
1390s Done
1390s The following NEW packages will be installed:
1390s   autopkgtest-satdep
1390s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
1390s Need to get 0 B/708 B of archives.
1390s After this operation, 0 B of additional disk space will be used.
1390s Get:1 /tmp/autopkgtest.mpRncR/4-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [708 B]
1391s Selecting previously unselected package autopkgtest-satdep.
1391s (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 ... 75791 files and directories currently installed.)
1391s Preparing to unpack .../4-autopkgtest-satdep.deb ...
1391s Unpacking autopkgtest-satdep (0) ...
1391s Setting up autopkgtest-satdep (0) ...
1397s (Reading database ... 75791 files and directories currently installed.)
1397s Removing autopkgtest-satdep (0) ...
1400s autopkgtest [17:36:55]: test command4: set -e ; vagrant-package --help
1400s autopkgtest [17:36:55]: test command4: [-----------------------
1401s usage: vagrant-package [-h] [--distribution DISTRIBUTION]
1401s                        [--release-components RELEASE_COMPONENTS [RELEASE_COMPONENTS ...]]
1401s                        [--output OUTPUT]
1401s                        image
1401s 
1401s Convert VirtualBox disk image into Vagrant box
1401s 
1401s positional arguments:
1401s   image                 Disk image file (.vdi) to be converted
1401s 
1401s options:
1401s   -h, --help            show this help message and exit
1401s   --distribution DISTRIBUTION
1401s                         Debian release used in built image
1401s   --release-components RELEASE_COMPONENTS [RELEASE_COMPONENTS ...]
1401s                         Release components used in apt sources list
1401s   --output OUTPUT       Path of the output vagrant box file (default:
1401s                         package.box)
1401s autopkgtest [17:36:56]: test command4: -----------------------]
1401s autopkgtest [17:36:56]: test command4:  - - - - - - - - - - results - - - - - - - - - -
1401s command4             PASS
1402s autopkgtest [17:36:57]: test command5: preparing testbed
1411s Reading package lists...
1412s Building dependency tree...
1412s Reading state information...
1412s Starting pkgProblemResolver with broken count: 0
1412s Starting 2 pkgProblemResolver with broken count: 0
1412s Done
1413s The following additional packages will be installed:
1413s   python3-iniconfig python3-packaging python3-pluggy python3-pytest
1413s The following NEW packages will be installed:
1413s   autopkgtest-satdep python3-iniconfig python3-packaging python3-pluggy
1413s   python3-pytest
1413s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded.
1413s Need to get 372 kB/373 kB of archives.
1413s After this operation, 1523 kB of additional disk space will be used.
1413s Get:1 /tmp/autopkgtest.mpRncR/5-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [720 B]
1413s Get:2 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-iniconfig all 1.1.1-2 [6024 B]
1413s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 python3-packaging all 23.2-1 [40.6 kB]
1413s Get:4 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-pluggy all 1.4.0-1 [20.4 kB]
1413s Get:5 http://ftpmaster.internal/ubuntu noble/universe arm64 python3-pytest all 7.4.4-1 [305 kB]
1414s Fetched 372 kB in 1s (740 kB/s)
1414s Selecting previously unselected package python3-iniconfig.
1414s (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 ... 75791 files and directories currently installed.)
1414s Preparing to unpack .../python3-iniconfig_1.1.1-2_all.deb ...
1414s Unpacking python3-iniconfig (1.1.1-2) ...
1414s Selecting previously unselected package python3-packaging.
1414s Preparing to unpack .../python3-packaging_23.2-1_all.deb ...
1414s Unpacking python3-packaging (23.2-1) ...
1414s Selecting previously unselected package python3-pluggy.
1414s Preparing to unpack .../python3-pluggy_1.4.0-1_all.deb ...
1414s Unpacking python3-pluggy (1.4.0-1) ...
1414s Selecting previously unselected package python3-pytest.
1415s Preparing to unpack .../python3-pytest_7.4.4-1_all.deb ...
1415s Unpacking python3-pytest (7.4.4-1) ...
1415s Selecting previously unselected package autopkgtest-satdep.
1415s Preparing to unpack .../5-autopkgtest-satdep.deb ...
1415s Unpacking autopkgtest-satdep (0) ...
1415s Setting up python3-iniconfig (1.1.1-2) ...
1415s Setting up python3-packaging (23.2-1) ...
1415s Setting up python3-pluggy (1.4.0-1) ...
1415s Setting up python3-pytest (7.4.4-1) ...
1416s Setting up autopkgtest-satdep (0) ...
1416s Processing triggers for man-db (2.12.0-3) ...
1420s (Reading database ... 75955 files and directories currently installed.)
1420s Removing autopkgtest-satdep (0) ...
1421s autopkgtest [17:37:16]: test command5: py.test-3 -p no:cacheprovider /usr/lib/python3/dist-packages/freedommaker/
1421s autopkgtest [17:37:16]: test command5: [-----------------------
1422s ============================= test session starts ==============================
1422s platform linux -- Python 3.12.2, pytest-7.4.4, pluggy-1.4.0
1422s rootdir: /usr/lib/python3/dist-packages/freedommaker
1422s collected 46 items
1422s 
1422s ../../../../usr/lib/python3/dist-packages/freedommaker/tests/test_library.py . [  2%]
1422s ........................................                                 [ 89%]
1422s ../../../../usr/lib/python3/dist-packages/freedommaker/tests/test_utils.py . [ 91%]
1422s ...                                                                      [ 97%]
1422s ../../../../usr/lib/python3/dist-packages/freedommaker/tests/test_virtualbox.py s [100%]
1422s 
1422s ======================== 45 passed, 1 skipped in 0.28s =========================
1423s autopkgtest [17:37:18]: test command5: -----------------------]
1423s command5             PASS
1423s autopkgtest [17:37:18]: test command5:  - - - - - - - - - - results - - - - - - - - - -
1424s autopkgtest [17:37:19]: @@@@@@@@@@@@@@@@@@@@ summary
1424s command1             PASS
1424s command2             PASS
1424s command3             PASS
1424s command4             PASS
1424s command5             PASS
1436s Creating nova instance adt-noble-arm64-freedom-maker-20240323-164605-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240321.img (UUID 28ecccfc-4cb0-4cc6-a280-209e2d140e10)...
1436s Creating nova instance adt-noble-arm64-freedom-maker-20240323-164605-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240321.img (UUID 28ecccfc-4cb0-4cc6-a280-209e2d140e10)...