0s autopkgtest [19:12:59]: starting date and time: 2024-07-12 19:12:59+0000 0s autopkgtest [19:12:59]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [19:12:59]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ey361j2v/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade rsyslog --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.39-3.1ubuntu3 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@lcy02-78.secgroup --name adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 --image adt/ubuntu-oracular-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 136s autopkgtest [19:15:15]: testbed dpkg architecture: amd64 136s autopkgtest [19:15:15]: testbed apt version: 2.9.6 136s autopkgtest [19:15:15]: @@@@@@@@@@@@@@@@@@@@ test bed setup 138s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 138s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [48.0 kB] 138s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [327 kB] 138s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 138s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2576 B] 138s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [99.8 kB] 138s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [71.2 kB] 138s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 c-n-f Metadata [2104 B] 138s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [34.9 kB] 138s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [6244 B] 138s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 c-n-f Metadata [368 B] 138s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [361 kB] 138s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [218 kB] 138s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 c-n-f Metadata [9228 B] 138s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [7644 B] 138s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [3052 B] 138s Get:17 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 c-n-f Metadata [276 B] 140s Fetched 1325 kB in 0s (5808 kB/s) 140s Reading package lists... 168s Reading package lists... 168s Building dependency tree... 168s Reading state information... 169s Calculating upgrade... 169s The following packages will be upgraded: 169s libc-bin libc-dev-bin libc-devtools libc6 libc6-dev locales 169s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 169s Need to get 10.3 MB of archives. 169s After this operation, 34.8 kB of additional disk space will be used. 169s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-devtools amd64 2.39-3.1ubuntu3 [29.3 kB] 169s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6-dev amd64 2.39-3.1ubuntu3 [2120 kB] 169s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-dev-bin amd64 2.39-3.1ubuntu3 [20.4 kB] 169s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6 amd64 2.39-3.1ubuntu3 [3262 kB] 169s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-bin amd64 2.39-3.1ubuntu3 [680 kB] 169s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 locales all 2.39-3.1ubuntu3 [4220 kB] 169s Preconfiguring packages ... 169s Fetched 10.3 MB in 0s (91.4 MB/s) 170s (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 ... 74486 files and directories currently installed.) 170s Preparing to unpack .../libc-devtools_2.39-3.1ubuntu3_amd64.deb ... 170s Unpacking libc-devtools (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 170s Preparing to unpack .../libc6-dev_2.39-3.1ubuntu3_amd64.deb ... 170s Unpacking libc6-dev:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 170s Preparing to unpack .../libc-dev-bin_2.39-3.1ubuntu3_amd64.deb ... 170s Unpacking libc-dev-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 170s Preparing to unpack .../libc6_2.39-3.1ubuntu3_amd64.deb ... 170s Unpacking libc6:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 170s Setting up libc6:amd64 (2.39-3.1ubuntu3) ... 170s Error: Could not restart systemd, systemd binary not working 171s (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 ... 74486 files and directories currently installed.) 171s Preparing to unpack .../libc-bin_2.39-3.1ubuntu3_amd64.deb ... 171s Unpacking libc-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 171s Setting up libc-bin (2.39-3.1ubuntu3) ... 171s (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 ... 74486 files and directories currently installed.) 171s Preparing to unpack .../locales_2.39-3.1ubuntu3_all.deb ... 171s Unpacking locales (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 171s Setting up locales (2.39-3.1ubuntu3) ... 172s Generating locales (this might take a while)... 173s en_US.UTF-8... done 173s Generation complete. 173s Setting up libc-dev-bin (2.39-3.1ubuntu3) ... 173s Setting up libc-devtools (2.39-3.1ubuntu3) ... 173s Setting up libc6-dev:amd64 (2.39-3.1ubuntu3) ... 173s Processing triggers for man-db (2.12.1-2) ... 174s Processing triggers for systemd (256-1ubuntu1) ... 175s Reading package lists... 175s Building dependency tree... 175s Reading state information... 176s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 181s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 181s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 181s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 181s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 183s Reading package lists... 183s Reading package lists... 183s Building dependency tree... 183s Reading state information... 183s Calculating upgrade... 183s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 183s Reading package lists... 184s Building dependency tree... 184s Reading state information... 184s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 190s autopkgtest [19:16:09]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 00:40:06 UTC 2024 191s autopkgtest [19:16:10]: @@@@@@@@@@@@@@@@@@@@ apt-source rsyslog 219s Get:1 http://ftpmaster.internal/ubuntu oracular/main rsyslog 8.2312.0-3ubuntu9 (dsc) [3525 B] 219s Get:2 http://ftpmaster.internal/ubuntu oracular/main rsyslog 8.2312.0-3ubuntu9 (tar) [3358 kB] 219s Get:3 http://ftpmaster.internal/ubuntu oracular/main rsyslog 8.2312.0-3ubuntu9 (diff) [48.7 kB] 220s gpgv: Signature made Mon Apr 8 14:50:15 2024 UTC 220s gpgv: using RSA key 4FB588A84C2DDE79A74C77876FA458DD1DB03F71 220s gpgv: issuer "juliank@ubuntu.com" 220s gpgv: Can't check signature: No public key 220s dpkg-source: warning: cannot verify inline signature for ./rsyslog_8.2312.0-3ubuntu9.dsc: no acceptable signature found 220s autopkgtest [19:16:39]: testing package rsyslog version 8.2312.0-3ubuntu9 220s autopkgtest [19:16:39]: build not needed 224s autopkgtest [19:16:43]: test logcheck: preparing testbed 226s Reading package lists... 227s Building dependency tree... 227s Reading state information... 227s Starting pkgProblemResolver with broken count: 0 227s Starting 2 pkgProblemResolver with broken count: 0 227s Done 228s The following additional packages will be installed: 228s libipc-signal-perl liblockfile-bin liblockfile1 libmime-types-perl libnsl2 228s libproc-waitstat-perl lockfile-progs logcheck logtail mime-construct postfix 228s ssl-cert 228s Suggested packages: 228s libmojolicious-perl mail-reader postfix-cdb postfix-doc postfix-ldap 228s postfix-lmdb postfix-mta-sts-resolver postfix-mongodb postfix-mysql 228s postfix-pcre postfix-pgsql postfix-sqlite procmail sasl2-bin 228s | dovecot-common 228s Recommended packages: 228s logcheck-database 228s The following NEW packages will be installed: 228s autopkgtest-satdep libipc-signal-perl liblockfile-bin liblockfile1 228s libmime-types-perl libnsl2 libproc-waitstat-perl lockfile-progs logcheck 228s logtail mime-construct postfix ssl-cert 228s 0 upgraded, 13 newly installed, 0 to remove and 0 not upgraded. 228s Need to get 1479 kB/1480 kB of archives. 228s After this operation, 4985 kB of additional disk space will be used. 228s Get:1 /tmp/autopkgtest.dP0lQp/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [716 B] 228s Get:2 http://ftpmaster.internal/ubuntu oracular/main amd64 ssl-cert all 1.1.2ubuntu2 [18.0 kB] 228s Get:3 http://ftpmaster.internal/ubuntu oracular/main amd64 libnsl2 amd64 1.3.0-3build3 [41.4 kB] 228s Get:4 http://ftpmaster.internal/ubuntu oracular/main amd64 postfix amd64 3.9.0-2 [1263 kB] 228s Get:5 http://ftpmaster.internal/ubuntu oracular/main amd64 libipc-signal-perl all 1.00-10 [5326 B] 228s Get:6 http://ftpmaster.internal/ubuntu oracular/main amd64 liblockfile-bin amd64 1.17-1build3 [11.2 kB] 228s Get:7 http://ftpmaster.internal/ubuntu oracular/main amd64 liblockfile1 amd64 1.17-1build3 [6840 B] 228s Get:8 http://ftpmaster.internal/ubuntu oracular/main amd64 libmime-types-perl all 2.26-1 [63.3 kB] 228s Get:9 http://ftpmaster.internal/ubuntu oracular/main amd64 libproc-waitstat-perl all 1.00-7 [6148 B] 228s Get:10 http://ftpmaster.internal/ubuntu oracular/main amd64 lockfile-progs amd64 0.1.19+nmu1 [8854 B] 228s Get:11 http://ftpmaster.internal/ubuntu oracular/main amd64 mime-construct all 1.12+really1.11-1 [18.4 kB] 228s Get:12 http://ftpmaster.internal/ubuntu oracular/main amd64 logtail all 1.4.3 [11.3 kB] 228s Get:13 http://ftpmaster.internal/ubuntu oracular/main amd64 logcheck all 1.4.3 [25.8 kB] 228s Preconfiguring packages ... 228s Fetched 1479 kB in 0s (9247 kB/s) 228s Selecting previously unselected package ssl-cert. 228s (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 ... 74486 files and directories currently installed.) 228s Preparing to unpack .../00-ssl-cert_1.1.2ubuntu2_all.deb ... 228s Unpacking ssl-cert (1.1.2ubuntu2) ... 228s Selecting previously unselected package libnsl2:amd64. 228s Preparing to unpack .../01-libnsl2_1.3.0-3build3_amd64.deb ... 228s Unpacking libnsl2:amd64 (1.3.0-3build3) ... 228s Selecting previously unselected package postfix. 228s Preparing to unpack .../02-postfix_3.9.0-2_amd64.deb ... 229s Unpacking postfix (3.9.0-2) ... 229s Selecting previously unselected package libipc-signal-perl. 229s Preparing to unpack .../03-libipc-signal-perl_1.00-10_all.deb ... 229s Unpacking libipc-signal-perl (1.00-10) ... 229s Selecting previously unselected package liblockfile-bin. 229s Preparing to unpack .../04-liblockfile-bin_1.17-1build3_amd64.deb ... 229s Unpacking liblockfile-bin (1.17-1build3) ... 229s Selecting previously unselected package liblockfile1:amd64. 229s Preparing to unpack .../05-liblockfile1_1.17-1build3_amd64.deb ... 229s Unpacking liblockfile1:amd64 (1.17-1build3) ... 229s Selecting previously unselected package libmime-types-perl. 229s Preparing to unpack .../06-libmime-types-perl_2.26-1_all.deb ... 229s Unpacking libmime-types-perl (2.26-1) ... 229s Selecting previously unselected package libproc-waitstat-perl. 229s Preparing to unpack .../07-libproc-waitstat-perl_1.00-7_all.deb ... 229s Unpacking libproc-waitstat-perl (1.00-7) ... 229s Selecting previously unselected package lockfile-progs. 229s Preparing to unpack .../08-lockfile-progs_0.1.19+nmu1_amd64.deb ... 229s Unpacking lockfile-progs (0.1.19+nmu1) ... 229s Selecting previously unselected package mime-construct. 229s Preparing to unpack .../09-mime-construct_1.12+really1.11-1_all.deb ... 229s Unpacking mime-construct (1.12+really1.11-1) ... 229s Selecting previously unselected package logtail. 229s Preparing to unpack .../10-logtail_1.4.3_all.deb ... 229s Unpacking logtail (1.4.3) ... 229s Selecting previously unselected package logcheck. 229s Preparing to unpack .../11-logcheck_1.4.3_all.deb ... 229s Unpacking logcheck (1.4.3) ... 229s Selecting previously unselected package autopkgtest-satdep. 229s Preparing to unpack .../12-1-autopkgtest-satdep.deb ... 229s Unpacking autopkgtest-satdep (0) ... 229s Setting up liblockfile-bin (1.17-1build3) ... 229s Setting up libmime-types-perl (2.26-1) ... 229s Setting up logtail (1.4.3) ... 229s Setting up libipc-signal-perl (1.00-10) ... 229s Setting up ssl-cert (1.1.2ubuntu2) ... 229s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 231s Setting up libnsl2:amd64 (1.3.0-3build3) ... 231s Setting up liblockfile1:amd64 (1.17-1build3) ... 231s Setting up libproc-waitstat-perl (1.00-7) ... 231s Setting up lockfile-progs (0.1.19+nmu1) ... 231s Setting up postfix (3.9.0-2) ... 231s info: Selecting GID from range 100 to 999 ... 231s info: Adding group `postfix' (GID 112) ... 231s info: Selecting UID from range 100 to 999 ... 231s 231s info: Adding system user `postfix' (UID 108) ... 231s info: Adding new user `postfix' (UID 108) with group `postfix' ... 231s info: Not creating home directory `/var/spool/postfix'. 231s Creating /etc/postfix/dynamicmaps.cf 231s info: Selecting GID from range 100 to 999 ... 231s info: Adding group `postdrop' (GID 113) ... 231s setting myhostname: autopkgtest.local 231s setting alias maps 231s setting alias database 231s changing /etc/mailname to autopkgtest.local 231s setting myorigin 231s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost 231s setting relayhost: 231s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 231s setting mailbox_size_limit: 0 231s setting recipient_delimiter: + 233s setting inet_interfaces: all 235s setting inet_protocols: all 235s /etc/aliases does not exist, creating it. 235s WARNING: /etc/aliases exists, but does not have a root alias. 235s 235s Postfix (main.cf) is now set up with a default configuration. If you need to 235s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 235s Postfix configuration values, see postconf(1). 235s 235s After modifying main.cf, be sure to run 'systemctl reload postfix'. 235s 237s Running newaliases 238s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 239s Setting up mime-construct (1.12+really1.11-1) ... 239s Setting up logcheck (1.4.3) ... 239s Setting up autopkgtest-satdep (0) ... 239s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 239s Processing triggers for ufw (0.36.2-6) ... 239s Processing triggers for man-db (2.12.1-2) ... 251s Processing triggers for libc-bin (2.39-3.1ubuntu3) ... 256s (Reading database ... 74813 files and directories currently installed.) 256s Removing autopkgtest-satdep (0) ... 271s autopkgtest [19:17:30]: test logcheck: [----------------------- 272s Stopping 'rsyslog.service', but its triggering units are still active: 272s syslog.socket 275s * Checking logcheck rules 275s ** Starting and stopping rsyslog 276s Stopping 'rsyslog.service', but its triggering units are still active: 276s syslog.socket 279s ** rsyslog generated the following lines in syslog: 279s 2024-07-12T19:17:35.001784+00:00 autopkgtest rsyslogd: [origin software="rsyslogd" swVersion="8.2312.0" x-pid="4130" x-info="https://www.rsyslog.com"] exiting on signal 15. 279s 2024-07-12T19:17:35.139585+00:00 autopkgtest rsyslogd: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd. [v8.2312.0] 279s 2024-07-12T19:17:35.139984+00:00 autopkgtest rsyslogd: rsyslogd's groupid changed to 102 279s 2024-07-12T19:17:35.140028+00:00 autopkgtest rsyslogd: rsyslogd's userid changed to 102 279s 2024-07-12T19:17:35.140058+00:00 autopkgtest rsyslogd: [origin software="rsyslogd" swVersion="8.2312.0" x-pid="4147" x-info="https://www.rsyslog.com"] start 279s ** rsyslog generated the following lines in the systemd journal: 279s Jul 12 19:17:35 autopkgtest rsyslogd[4130]: [origin software="rsyslogd" swVersion="8.2312.0" x-pid="4130" x-info="https://www.rsyslog.com"] exiting on signal 15. 279s Jul 12 19:17:35 autopkgtest rsyslogd[4147]: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd. [v8.2312.0] 279s Jul 12 19:17:35 autopkgtest rsyslogd[4147]: rsyslogd's groupid changed to 102 279s Jul 12 19:17:35 autopkgtest rsyslogd[4147]: rsyslogd's userid changed to 102 279s Jul 12 19:17:35 autopkgtest rsyslogd[4147]: [origin software="rsyslogd" swVersion="8.2312.0" x-pid="4147" x-info="https://www.rsyslog.com"] start 279s ** Running logcheck 279s * OK: no unmatched lines 279s autopkgtest [19:17:38]: test logcheck: -----------------------] 280s autopkgtest [19:17:39]: test logcheck: - - - - - - - - - - results - - - - - - - - - - 280s logcheck PASS 281s autopkgtest [19:17:40]: test apparmor-include-mechanism: preparing testbed 1568s nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "url": "https://nova-internal.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "ebb570ffacb64d188008169beff10c7d", "interface": "admin", "region_id": "prodstack5", "url": "https://nova-admin.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}], "id": "239a7e347ea145ba8900922319abfe0c"nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 1568s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 1568s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 1568s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 1568s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 1568s nova [E] nova boot failed (attempt #0): 1568s nova [E] DEBUG (extension:189) found extension EntryPoint.parse('v1password = swiftclient.authv1:PasswordLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('noauth = cinderclient.contrib.noauth:CinderNoAuthLoader') 1568s DEBUG (extension:189) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('none = keystoneauth1.loading._plugins.noauth:NoAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3adfspassword = keystoneauth1.extras._saml2._loading:ADFSPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3applicationcredential = keystoneauth1.loading._plugins.identity.v3:ApplicationCredential') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3fedkerb = keystoneauth1.extras.kerberos._loading:MappedKerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3kerberos = keystoneauth1.extras.kerberos._loading:Kerberos') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3multifactor = keystoneauth1.loading._plugins.identity.v3:MultiFactor') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oauth1 = keystoneauth1.extras.oauth1._loading:V3OAuth1') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcaccesstoken = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAccessToken') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcclientcredentials = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectClientCredentials') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3samlpassword = keystoneauth1.extras._saml2._loading:Saml2Password') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3tokenlessauth = keystoneauth1.loading._plugins.identity.v3:TokenlessAuth') 1568s DEBUG (extension:189) found extension EntryPoint.parse('v3totp = keystoneauth1.loading._plugins.identity.v3:TOTP') 1568s DEBUG (session:517) REQ: curl -g -i -X GET https://keystone.ps5.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" 1568s DEBUG (connectionpool:962) Starting new HTTPS connection (1): keystone.ps5.canonical.com:5000 1568s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "GET /v3 HTTP/1.1" 200 267 1568s DEBUG (session:548) RESP: [200] Connection: Keep-Alive Content-Length: 267 Content-Type: application/json Date: Fri, 12 Jul 2024 19:21:20 GMT Keep-Alive: timeout=5, max=100 Server: Apache/2.4.41 (Ubuntu) Vary: X-Auth-Token x-openstack-request-id: req-e284988a-064d-481a-a551-0dfa0a32a6a1 1576s DEBUG (session:580) RESP BODY: {"version": {"id": "v3.14", "status": "stable", "updated": "2020-04-07T00:00:00Z", "links": [{"rel": "self", "href": "https://keystone.ps5.canonautopkgtest [19:39:15]: testbed dpkg architecture: amd64 1576s autopkgtest [19:39:15]: testbed apt version: 2.9.6 1576s autopkgtest [19:39:15]: @@@@@@@@@@@@@@@@@@@@ test bed setup 1576s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 1576s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [3288 B] 1576s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [48.0 kB] 1576s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [371 kB] 1576s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 1576s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [99.8 kB] 1576s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [71.2 kB] 1576s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 c-n-f Metadata [2104 B] 1576s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [34.9 kB] 1576s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [6244 B] 1576s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 c-n-f Metadata [368 B] 1576s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [393 kB] 1576s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [236 kB] 1576s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 c-n-f Metadata [9228 B] 1576s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [7976 B] 1576s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [3052 B] 1576s Get:17 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 c-n-f Metadata [276 B] 1578s Fetched 1422 kB in 0s (5931 kB/s) 1578s Reading package lists... 1587s Reading package lists... 1587s Building dependency tree... 1587s Reading state information... 1587s Calculating upgrade... 1587s The following packages will be upgraded: 1587s libc-bin libc-dev-bin libc-devtools libc6 libc6-dev locales 1587s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 1587s Need to get 10.3 MB of archives. 1587s After this operation, 34.8 kB of additional disk space will be used. 1587s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-devtools amd64 2.39-3.1ubuntu3 [29.3 kB] 1587s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6-dev amd64 2.39-3.1ubuntu3 [2120 kB] 1587s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-dev-bin amd64 2.39-3.1ubuntu3 [20.4 kB] 1587s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6 amd64 2.39-3.1ubuntu3 [3262 kB] 1588s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-bin amd64 2.39-3.1ubuntu3 [680 kB] 1588s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 locales all 2.39-3.1ubuntu3 [4220 kB] 1588s Preconfiguring packages ... 1588s Fetched 10.3 MB in 0s (60.2 MB/s) 1588s (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 ... 74486 files and directories currently installed.) 1588s Preparing to unpack .../libc-devtools_2.39-3.1ubuntu3_amd64.deb ... 1588s Unpacking libc-devtools (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 1588s Preparing to unpack .../libc6-dev_2.39-3.1ubuntu3_amd64.deb ... 1588s Unpacking libc6-dev:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 1589s Preparing to unpack .../libc-dev-bin_2.39-3.1ubuntu3_amd64.deb ... 1589s Unpacking libc-dev-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 1589s Preparing to unpack .../libc6_2.39-3.1ubuntu3_amd64.deb ... 1589s Unpacking libc6:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 1589s Setting up libc6:amd64 (2.39-3.1ubuntu3) ... 1589s Error: Could not restart systemd, systemd binary not working 1589s (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 ... 74486 files and directories currently installed.) 1589s Preparing to unpack .../libc-bin_2.39-3.1ubuntu3_amd64.deb ... 1589s Unpacking libc-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 1589s Setting up libc-bin (2.39-3.1ubuntu3) ... 1589s (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 ... 74486 files and directories currently installed.) 1589s Preparing to unpack .../locales_2.39-3.1ubuntu3_all.deb ... 1589s Unpacking locales (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 1590s Setting up locales (2.39-3.1ubuntu3) ... 1590s Generating locales (this might take a while)... 1592s en_US.UTF-8... done 1592s Generation complete. 1592s Setting up libc-dev-bin (2.39-3.1ubuntu3) ... 1592s Setting up libc-devtools (2.39-3.1ubuntu3) ... 1592s Setting up libc6-dev:amd64 (2.39-3.1ubuntu3) ... 1592s Processing triggers for man-db (2.12.1-2) ... 1593s Processing triggers for systemd (256-1ubuntu1) ... 1594s Reading package lists... 1594s Building dependency tree... 1594s Reading state information... 1594s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 1595s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 1595s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 1595s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 1595s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 1596s Reading package lists... 1596s Reading package lists... 1596s Building dependency tree... 1596s Reading state information... 1597s Calculating upgrade... 1597s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 1597s Reading package lists... 1597s Building dependency tree... 1597s Reading state information... 1598s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 1638s Reading package lists... 1638s Building dependency tree... 1638s Reading state information... 1639s Starting pkgProblemResolver with broken count: 0 1639s Starting 2 pkgProblemResolver with broken count: 0 1639s Done 1639s The following NEW packages will be installed: 1639s autopkgtest-satdep 1639s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 1639s Need to get 0 B/712 B of archives. 1639s After this operation, 0 B of additional disk space will be used. 1639s Get:1 /tmp/autopkgtest.dP0lQp/2-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [712 B] 1640s Selecting previously unselected package autopkgtest-satdep. 1640s (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 ... 74486 files and directories currently installed.) 1640s Preparing to unpack .../2-autopkgtest-satdep.deb ... 1640s Unpacking autopkgtest-satdep (0) ... 1640s Setting up autopkgtest-satdep (0) ... 1644s (Reading database ... 74486 files and directories currently installed.) 1644s Removing autopkgtest-satdep (0) ... 1687s autopkgtest [19:41:06]: test apparmor-include-mechanism: [----------------------- 1688s 1688s ## Files with known backup extensions, that start with a dot, and a README file, are not included. Testing with: 1688s README .somedotfile do-not-include.dpkg-new do-not-include.dpkg-old do-not-include.dpkg-dist do-not-include.dpkg-bak do-not-include.dpkg-remove do-not-include.pacsave do-not-include.pacnew do-not-include.rpmnew do-not-include.rpmsave do-not-include.orig do-not-include.rej do-not-include~ 1688s 1688s ## These, however, should be included: pkg1.apparmor randomfile 1688s ## Generated test files: 1688s total 80 1688s drwxr-xr-x 2 root root 4096 Jul 12 19:41 . 1688s drwxr-xr-x 9 root root 12288 Jul 5 16:08 .. 1688s -rw-r--r-- 1 root root 48 Jul 12 19:41 .somedotfile 1688s -rw-r--r-- 1 root root 42 Jul 12 19:41 README 1688s -rw-r--r-- 1 root root 59 Jul 12 19:41 do-not-include.dpkg-bak 1688s -rw-r--r-- 1 root root 60 Jul 12 19:41 do-not-include.dpkg-dist 1688s -rw-r--r-- 1 root root 59 Jul 12 19:41 do-not-include.dpkg-new 1688s -rw-r--r-- 1 root root 59 Jul 12 19:41 do-not-include.dpkg-old 1688s -rw-r--r-- 1 root root 62 Jul 12 19:41 do-not-include.dpkg-remove 1688s -rw-r--r-- 1 root root 55 Jul 12 19:41 do-not-include.orig 1688s -rw-r--r-- 1 root root 57 Jul 12 19:41 do-not-include.pacnew 1688s -rw-r--r-- 1 root root 58 Jul 12 19:41 do-not-include.pacsave 1688s -rw-r--r-- 1 root root 54 Jul 12 19:41 do-not-include.rej 1688s -rw-r--r-- 1 root root 57 Jul 12 19:41 do-not-include.rpmnew 1688s -rw-r--r-- 1 root root 58 Jul 12 19:41 do-not-include.rpmsave 1688s -rw-r--r-- 1 root root 51 Jul 12 19:41 do-not-include~ 1688s -rw-r--r-- 1 root root 34 Jul 12 19:41 pkg1.apparmor 1688s -rw-r--r-- 1 root root 31 Jul 12 19:41 randomfile 1688s Ignoring: '/etc/apparmor.d/rsyslog.d/do-not-include.orig' 1688s Ignoring: '/etc/apparmor.d/rsyslog.d/do-not-include.rej' 1688s Ignoring: '/etc/apparmor.d/rsyslog.d/do-not-include.rpmnew' 1688s Ignoring: '/etc/apparmor.d/rsyslog.d/do-not-include.rpmsave' 1688s Ignoring: '/etc/apparmor.d/rsyslog.d/do-not-include~' 1688s ## Verifying that none of the excluded files were included in the apparmor profile: 1688s ## OK 1688s ## Verifying that all the allowed files were included: 1688s ## OK 1688s 1689s autopkgtest [19:41:08]: test apparmor-include-mechanism: -----------------------] 1690s autopkgtest [19:41:09]: test apparmor-include-mechanism: - - - - - - - - - - results - - - - - - - - - - 1690s apparmor-include-mechanism PASS 1690s autopkgtest [19:41:09]: test simple-logger: preparing testbed 1950s autopkgtest [19:45:29]: testbed dpkg architecture: amd64 1950s autopkgtest [19:45:29]: testbed apt version: 2.9.6 1950s autopkgtest [19:45:29]: @@@@@@@@@@@@@@@@@@@@ test bed setup 1950s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 1950s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [3288 B] 1950s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [371 kB] 1950s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [48.0 kB] 1950s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 1950s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [99.8 kB] 1951s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [71.2 kB] 1951s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 c-n-f Metadata [2104 B] 1951s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [34.9 kB] 1951s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [6244 B] 1951s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 c-n-f Metadata [368 B] 1951s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [236 kB] 1951s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [393 kB] 1951s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 c-n-f Metadata [9228 B] 1951s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [3052 B] 1951s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [7976 B] 1951s Get:17 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 c-n-f Metadata [276 B] 1952s Fetched 1422 kB in 0s (5377 kB/s) 1952s Reading package lists... 2001s Reading package lists... 2001s Building dependency tree... 2001s Reading state information... 2001s Calculating upgrade... 2002s The following packages will be upgraded: 2002s libc-bin libc-dev-bin libc-devtools libc6 libc6-dev locales 2002s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2002s Need to get 10.3 MB of archives. 2002s After this operation, 34.8 kB of additional disk space will be used. 2002s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-devtools amd64 2.39-3.1ubuntu3 [29.3 kB] 2002s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6-dev amd64 2.39-3.1ubuntu3 [2120 kB] 2002s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-dev-bin amd64 2.39-3.1ubuntu3 [20.4 kB] 2002s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6 amd64 2.39-3.1ubuntu3 [3262 kB] 2002s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-bin amd64 2.39-3.1ubuntu3 [680 kB] 2002s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 locales all 2.39-3.1ubuntu3 [4220 kB] 2002s Preconfiguring packages ... 2002s Fetched 10.3 MB in 0s (57.7 MB/s) 2003s (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 ... 74486 files and directories currently installed.) 2003s Preparing to unpack .../libc-devtools_2.39-3.1ubuntu3_amd64.deb ... 2003s Unpacking libc-devtools (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2003s Preparing to unpack .../libc6-dev_2.39-3.1ubuntu3_amd64.deb ... 2003s Unpacking libc6-dev:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2003s Preparing to unpack .../libc-dev-bin_2.39-3.1ubuntu3_amd64.deb ... 2003s Unpacking libc-dev-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2003s Preparing to unpack .../libc6_2.39-3.1ubuntu3_amd64.deb ... 2003s Unpacking libc6:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2003s Setting up libc6:amd64 (2.39-3.1ubuntu3) ... 2004s Error: Could not restart systemd, systemd binary not working 2004s (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 ... 74486 files and directories currently installed.) 2004s Preparing to unpack .../libc-bin_2.39-3.1ubuntu3_amd64.deb ... 2004s Unpacking libc-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2004s Setting up libc-bin (2.39-3.1ubuntu3) ... 2004s (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 ... 74486 files and directories currently installed.) 2004s Preparing to unpack .../locales_2.39-3.1ubuntu3_all.deb ... 2004s Unpacking locales (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2004s Setting up locales (2.39-3.1ubuntu3) ... 2005s Generating locales (this might take a while)... 2007s en_US.UTF-8... done 2007s Generation complete. 2007s Setting up libc-dev-bin (2.39-3.1ubuntu3) ... 2007s Setting up libc-devtools (2.39-3.1ubuntu3) ... 2007s Setting up libc6-dev:amd64 (2.39-3.1ubuntu3) ... 2007s Processing triggers for man-db (2.12.1-2) ... 2008s Processing triggers for systemd (256-1ubuntu1) ... 2009s Reading package lists... 2009s Building dependency tree... 2009s Reading state information... 2010s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2011s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 2011s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 2011s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 2011s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 2012s Reading package lists... 2012s Reading package lists... 2013s Building dependency tree... 2013s Reading state information... 2013s Calculating upgrade... 2014s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2014s Reading package lists... 2014s Building dependency tree... 2014s Reading state information... 2015s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2092s Reading package lists... 2092s Building dependency tree... 2092s Reading state information... 2093s Starting pkgProblemResolver with broken count: 0 2093s Starting 2 pkgProblemResolver with broken count: 0 2093s Done 2093s The following additional packages will be installed: 2093s apparmor-utils python3-apparmor python3-libapparmor 2093s Suggested packages: 2093s vim-addon-manager 2093s The following NEW packages will be installed: 2093s apparmor-utils autopkgtest-satdep python3-apparmor python3-libapparmor 2093s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 2093s Need to get 161 kB/162 kB of archives. 2093s After this operation, 1040 kB of additional disk space will be used. 2093s Get:1 /tmp/autopkgtest.dP0lQp/3-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [728 B] 2093s Get:2 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-libapparmor amd64 4.0.1-0ubuntu1 [30.1 kB] 2093s Get:3 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-apparmor all 4.0.1-0ubuntu1 [84.5 kB] 2093s Get:4 http://ftpmaster.internal/ubuntu oracular/main amd64 apparmor-utils all 4.0.1-0ubuntu1 [46.5 kB] 2094s Fetched 161 kB in 0s (4132 kB/s) 2094s Selecting previously unselected package python3-libapparmor. 2094s (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 ... 74486 files and directories currently installed.) 2094s Preparing to unpack .../python3-libapparmor_4.0.1-0ubuntu1_amd64.deb ... 2094s Unpacking python3-libapparmor (4.0.1-0ubuntu1) ... 2094s Selecting previously unselected package python3-apparmor. 2094s Preparing to unpack .../python3-apparmor_4.0.1-0ubuntu1_all.deb ... 2094s Unpacking python3-apparmor (4.0.1-0ubuntu1) ... 2094s Selecting previously unselected package apparmor-utils. 2094s Preparing to unpack .../apparmor-utils_4.0.1-0ubuntu1_all.deb ... 2094s Unpacking apparmor-utils (4.0.1-0ubuntu1) ... 2094s Selecting previously unselected package autopkgtest-satdep. 2094s Preparing to unpack .../3-autopkgtest-satdep.deb ... 2094s Unpacking autopkgtest-satdep (0) ... 2094s Setting up python3-libapparmor (4.0.1-0ubuntu1) ... 2094s Setting up python3-apparmor (4.0.1-0ubuntu1) ... 2094s Setting up apparmor-utils (4.0.1-0ubuntu1) ... 2094s Setting up autopkgtest-satdep (0) ... 2094s Processing triggers for man-db (2.12.1-2) ... 2098s (Reading database ... 74590 files and directories currently installed.) 2098s Removing autopkgtest-satdep (0) ... 2128s autopkgtest [19:48:27]: test simple-logger: [----------------------- 2128s Enforcing the /etc/apparmor.d/usr.sbin.rsyslogd apparmor profile 2129s Setting /etc/apparmor.d/usr.sbin.rsyslogd to enforce mode. 2129s Logging message: logger-test-value=34603b5a-bf88-4717-9ece-4075db56be5b 2129s Message correctly found in system logs 2129s autopkgtest [19:48:28]: test simple-logger: -----------------------] 2129s autopkgtest [19:48:28]: test simple-logger: - - - - - - - - - - results - - - - - - - - - - 2129s simple-logger PASS 2131s autopkgtest [19:48:30]: test simple-mysql: preparing testbed 2284s autopkgtest [19:51:03]: testbed dpkg architecture: amd64 2284s autopkgtest [19:51:03]: testbed apt version: 2.9.6 2284s autopkgtest [19:51:03]: @@@@@@@@@@@@@@@@@@@@ test bed setup 2285s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 2285s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [371 kB] 2285s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 2285s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [48.0 kB] 2285s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [3288 B] 2285s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [99.8 kB] 2285s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [71.2 kB] 2285s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 c-n-f Metadata [2104 B] 2285s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [34.9 kB] 2285s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [6244 B] 2285s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 c-n-f Metadata [368 B] 2285s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [393 kB] 2285s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [236 kB] 2285s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 c-n-f Metadata [9228 B] 2285s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [7976 B] 2285s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [3052 B] 2285s Get:17 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 c-n-f Metadata [276 B] 2286s Fetched 1422 kB in 0s (5704 kB/s) 2286s Reading package lists... 2288s Reading package lists... 2288s Building dependency tree... 2288s Reading state information... 2288s Calculating upgrade... 2288s The following packages will be upgraded: 2288s libc-bin libc-dev-bin libc-devtools libc6 libc6-dev locales 2288s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2288s Need to get 10.3 MB of archives. 2288s After this operation, 34.8 kB of additional disk space will be used. 2288s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-devtools amd64 2.39-3.1ubuntu3 [29.3 kB] 2288s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6-dev amd64 2.39-3.1ubuntu3 [2120 kB] 2288s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-dev-bin amd64 2.39-3.1ubuntu3 [20.4 kB] 2288s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6 amd64 2.39-3.1ubuntu3 [3262 kB] 2289s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-bin amd64 2.39-3.1ubuntu3 [680 kB] 2289s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 locales all 2.39-3.1ubuntu3 [4220 kB] 2289s Preconfiguring packages ... 2289s Fetched 10.3 MB in 0s (46.4 MB/s) 2289s (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 ... 74486 files and directories currently installed.) 2289s Preparing to unpack .../libc-devtools_2.39-3.1ubuntu3_amd64.deb ... 2289s Unpacking libc-devtools (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2289s Preparing to unpack .../libc6-dev_2.39-3.1ubuntu3_amd64.deb ... 2289s Unpacking libc6-dev:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2289s Preparing to unpack .../libc-dev-bin_2.39-3.1ubuntu3_amd64.deb ... 2289s Unpacking libc-dev-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2289s Preparing to unpack .../libc6_2.39-3.1ubuntu3_amd64.deb ... 2290s Unpacking libc6:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2290s Setting up libc6:amd64 (2.39-3.1ubuntu3) ... 2290s Error: Could not restart systemd, systemd binary not working 2290s (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 ... 74486 files and directories currently installed.) 2290s Preparing to unpack .../libc-bin_2.39-3.1ubuntu3_amd64.deb ... 2290s Unpacking libc-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2290s Setting up libc-bin (2.39-3.1ubuntu3) ... 2290s (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 ... 74486 files and directories currently installed.) 2290s Preparing to unpack .../locales_2.39-3.1ubuntu3_all.deb ... 2290s Unpacking locales (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2290s Setting up locales (2.39-3.1ubuntu3) ... 2291s Generating locales (this might take a while)... 2292s en_US.UTF-8... done 2292s Generation complete. 2292s Setting up libc-dev-bin (2.39-3.1ubuntu3) ... 2292s Setting up libc-devtools (2.39-3.1ubuntu3) ... 2292s Setting up libc6-dev:amd64 (2.39-3.1ubuntu3) ... 2292s Processing triggers for man-db (2.12.1-2) ... 2294s Processing triggers for systemd (256-1ubuntu1) ... 2295s Reading package lists... 2295s Building dependency tree... 2295s Reading state information... 2295s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2296s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 2296s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 2296s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 2296s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 2297s Reading package lists... 2297s Reading package lists... 2297s Building dependency tree... 2297s Reading state information... 2298s Calculating upgrade... 2298s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2298s Reading package lists... 2298s Building dependency tree... 2298s Reading state information... 2299s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2362s Reading package lists... 2362s Building dependency tree... 2362s Reading state information... 2362s Starting pkgProblemResolver with broken count: 0 2362s Starting 2 pkgProblemResolver with broken count: 0 2362s Done 2363s The following additional packages will be installed: 2363s apparmor-utils libevent-pthreads-2.1-7t64 libmecab2 libprotobuf-lite32t64 2363s mysql-client-8.0 mysql-client-core-8.0 mysql-common mysql-server 2363s mysql-server-8.0 mysql-server-core-8.0 python3-apparmor python3-libapparmor 2363s Suggested packages: 2363s vim-addon-manager mailx tinyca 2363s Recommended packages: 2363s libhtml-template-perl mecab-ipadic-utf8 2363s The following NEW packages will be installed: 2363s apparmor-utils autopkgtest-satdep libevent-pthreads-2.1-7t64 libmecab2 2363s libprotobuf-lite32t64 mysql-client-8.0 mysql-client-core-8.0 mysql-common 2363s mysql-server mysql-server-8.0 mysql-server-core-8.0 python3-apparmor 2363s python3-libapparmor 2363s 0 upgraded, 13 newly installed, 0 to remove and 0 not upgraded. 2363s Need to get 22.2 MB/22.2 MB of archives. 2363s After this operation, 187 MB of additional disk space will be used. 2363s Get:1 /tmp/autopkgtest.dP0lQp/4-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [736 B] 2363s Get:2 http://ftpmaster.internal/ubuntu oracular/main amd64 mysql-common all 5.8+1.1.0build1 [6746 B] 2363s Get:3 http://ftpmaster.internal/ubuntu oracular/main amd64 mysql-client-core-8.0 amd64 8.0.37-1 [2728 kB] 2363s Get:4 http://ftpmaster.internal/ubuntu oracular/main amd64 mysql-client-8.0 amd64 8.0.37-1 [22.4 kB] 2363s Get:5 http://ftpmaster.internal/ubuntu oracular/main amd64 libevent-pthreads-2.1-7t64 amd64 2.1.12-stable-10 [7966 B] 2363s Get:6 http://ftpmaster.internal/ubuntu oracular/main amd64 libmecab2 amd64 0.996-14ubuntu4 [201 kB] 2363s Get:7 http://ftpmaster.internal/ubuntu oracular/main amd64 libprotobuf-lite32t64 amd64 3.21.12-8.2build1 [238 kB] 2363s Get:8 http://ftpmaster.internal/ubuntu oracular/main amd64 mysql-server-core-8.0 amd64 8.0.37-1 [17.4 MB] 2363s Get:9 http://ftpmaster.internal/ubuntu oracular/main amd64 mysql-server-8.0 amd64 8.0.37-1 [1428 kB] 2363s Get:10 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-libapparmor amd64 4.0.1-0ubuntu1 [30.1 kB] 2363s Get:11 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-apparmor all 4.0.1-0ubuntu1 [84.5 kB] 2363s Get:12 http://ftpmaster.internal/ubuntu oracular/main amd64 apparmor-utils all 4.0.1-0ubuntu1 [46.5 kB] 2363s Get:13 http://ftpmaster.internal/ubuntu oracular/main amd64 mysql-server all 8.0.37-1 [9506 B] 2363s Preconfiguring packages ... 2363s Fetched 22.2 MB in 0s (66.1 MB/s) 2364s Selecting previously unselected package mysql-common. 2364s (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 ... 74486 files and directories currently installed.) 2364s Preparing to unpack .../0-mysql-common_5.8+1.1.0build1_all.deb ... 2364s Unpacking mysql-common (5.8+1.1.0build1) ... 2364s Selecting previously unselected package mysql-client-core-8.0. 2364s Preparing to unpack .../1-mysql-client-core-8.0_8.0.37-1_amd64.deb ... 2364s Unpacking mysql-client-core-8.0 (8.0.37-1) ... 2364s Selecting previously unselected package mysql-client-8.0. 2364s Preparing to unpack .../2-mysql-client-8.0_8.0.37-1_amd64.deb ... 2364s Unpacking mysql-client-8.0 (8.0.37-1) ... 2364s Selecting previously unselected package libevent-pthreads-2.1-7t64:amd64. 2364s Preparing to unpack .../3-libevent-pthreads-2.1-7t64_2.1.12-stable-10_amd64.deb ... 2364s Unpacking libevent-pthreads-2.1-7t64:amd64 (2.1.12-stable-10) ... 2364s Selecting previously unselected package libmecab2:amd64. 2364s Preparing to unpack .../4-libmecab2_0.996-14ubuntu4_amd64.deb ... 2364s Unpacking libmecab2:amd64 (0.996-14ubuntu4) ... 2364s Selecting previously unselected package libprotobuf-lite32t64:amd64. 2364s Preparing to unpack .../5-libprotobuf-lite32t64_3.21.12-8.2build1_amd64.deb ... 2364s Unpacking libprotobuf-lite32t64:amd64 (3.21.12-8.2build1) ... 2364s Selecting previously unselected package mysql-server-core-8.0. 2364s Preparing to unpack .../6-mysql-server-core-8.0_8.0.37-1_amd64.deb ... 2364s Unpacking mysql-server-core-8.0 (8.0.37-1) ... 2364s Setting up mysql-common (5.8+1.1.0build1) ... 2364s update-alternatives: using /etc/mysql/my.cnf.fallback to provide /etc/mysql/my.cnf (my.cnf) in auto mode 2365s Selecting previously unselected package mysql-server-8.0. 2365s (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 ... 74705 files and directories currently installed.) 2365s Preparing to unpack .../0-mysql-server-8.0_8.0.37-1_amd64.deb ... 2365s Unpacking mysql-server-8.0 (8.0.37-1) ... 2365s Selecting previously unselected package python3-libapparmor. 2365s Preparing to unpack .../1-python3-libapparmor_4.0.1-0ubuntu1_amd64.deb ... 2365s Unpacking python3-libapparmor (4.0.1-0ubuntu1) ... 2365s Selecting previously unselected package python3-apparmor. 2365s Preparing to unpack .../2-python3-apparmor_4.0.1-0ubuntu1_all.deb ... 2365s Unpacking python3-apparmor (4.0.1-0ubuntu1) ... 2365s Selecting previously unselected package apparmor-utils. 2365s Preparing to unpack .../3-apparmor-utils_4.0.1-0ubuntu1_all.deb ... 2365s Unpacking apparmor-utils (4.0.1-0ubuntu1) ... 2365s Selecting previously unselected package mysql-server. 2365s Preparing to unpack .../4-mysql-server_8.0.37-1_all.deb ... 2365s Unpacking mysql-server (8.0.37-1) ... 2365s Selecting previously unselected package autopkgtest-satdep. 2365s Preparing to unpack .../5-4-autopkgtest-satdep.deb ... 2365s Unpacking autopkgtest-satdep (0) ... 2365s Setting up libprotobuf-lite32t64:amd64 (3.21.12-8.2build1) ... 2365s Setting up python3-libapparmor (4.0.1-0ubuntu1) ... 2365s Setting up libmecab2:amd64 (0.996-14ubuntu4) ... 2365s Setting up mysql-client-core-8.0 (8.0.37-1) ... 2365s Setting up libevent-pthreads-2.1-7t64:amd64 (2.1.12-stable-10) ... 2365s Setting up mysql-server-core-8.0 (8.0.37-1) ... 2365s Setting up python3-apparmor (4.0.1-0ubuntu1) ... 2365s Setting up mysql-client-8.0 (8.0.37-1) ... 2365s Setting up mysql-server-8.0 (8.0.37-1) ... 2365s update-alternatives: using /etc/mysql/mysql.cnf to provide /etc/mysql/my.cnf (my.cnf) in auto mode 2365s Renaming removed key_buffer and myisam-recover options (if present) 2369s mysqld will log errors to /var/log/mysql/error.log 2369s mysqld is running as pid 2868 2374s Created symlink '/etc/systemd/system/multi-user.target.wants/mysql.service' → '/usr/lib/systemd/system/mysql.service'. 2375s Setting up apparmor-utils (4.0.1-0ubuntu1) ... 2375s Setting up mysql-server (8.0.37-1) ... 2375s Setting up autopkgtest-satdep (0) ... 2375s Processing triggers for man-db (2.12.1-2) ... 2376s Processing triggers for libc-bin (2.39-3.1ubuntu3) ... 2385s (Reading database ... 74847 files and directories currently installed.) 2385s Removing autopkgtest-satdep (0) ... 2423s autopkgtest [19:53:22]: test simple-mysql: [----------------------- 2424s Enforcing the /etc/apparmor.d/usr.sbin.rsyslogd apparmor profile 2424s Setting /etc/apparmor.d/usr.sbin.rsyslogd to enforce mode. 2424s Reading package lists... 2424s Building dependency tree... 2424s Reading state information... 2425s The following additional packages will be installed: 2425s dbconfig-common libmysqlclient21 2425s Suggested packages: 2425s dbconfig-mysql | dbconfig-pgsql | dbconfig-sqlite3 | dbconfig-no-thanks 2425s The following NEW packages will be installed: 2425s dbconfig-common libmysqlclient21 rsyslog-mysql 2425s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 2425s Need to get 1861 kB of archives. 2425s After this operation, 8457 kB of additional disk space will be used. 2425s Get:1 http://ftpmaster.internal/ubuntu oracular/universe amd64 dbconfig-common all 2.0.24 [596 kB] 2425s Get:2 http://ftpmaster.internal/ubuntu oracular/main amd64 libmysqlclient21 amd64 8.0.37-1 [1254 kB] 2425s Get:3 http://ftpmaster.internal/ubuntu oracular/universe amd64 rsyslog-mysql amd64 8.2312.0-3ubuntu9 [11.8 kB] 2425s Preconfiguring packages ... 2425s Fetched 1861 kB in 0s (27.2 MB/s) 2425s Selecting previously unselected package dbconfig-common. 2425s (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 ... 74847 files and directories currently installed.) 2425s Preparing to unpack .../dbconfig-common_2.0.24_all.deb ... 2425s Unpacking dbconfig-common (2.0.24) ... 2425s Selecting previously unselected package libmysqlclient21:amd64. 2425s Preparing to unpack .../libmysqlclient21_8.0.37-1_amd64.deb ... 2425s Unpacking libmysqlclient21:amd64 (8.0.37-1) ... 2425s Selecting previously unselected package rsyslog-mysql. 2425s Preparing to unpack .../rsyslog-mysql_8.2312.0-3ubuntu9_amd64.deb ... 2425s Unpacking rsyslog-mysql (8.2312.0-3ubuntu9) ... 2425s Setting up libmysqlclient21:amd64 (8.0.37-1) ... 2425s Setting up dbconfig-common (2.0.24) ... 2426s 2426s Creating config file /etc/dbconfig-common/config with new version 2426s Setting up rsyslog-mysql (8.2312.0-3ubuntu9) ... 2426s Determining localhost credentials from /etc/mysql/debian.cnf: succeeded. 2426s dbconfig-common: writing config to /etc/dbconfig-common/rsyslog-mysql.conf 2426s 2426s Creating config file /etc/dbconfig-common/rsyslog-mysql.conf with new version 2426s 2426s Creating config file /etc/rsyslog.d/mysql.conf with new version 2426s checking privileges on database Syslog for rsyslog@localhost: user creation needed. 2426s granting access to database Syslog for rsyslog@localhost: success. 2426s verifying access for rsyslog@localhost: success. 2427s creating database Syslog: success. 2427s verifying database Syslog exists: success. 2427s populating database via sql... done. 2427s dbconfig-common: flushing administrative password 2427s Processing triggers for man-db (2.12.1-2) ... 2427s Processing triggers for libc-bin (2.39-3.1ubuntu3) ... 2428s Logging message: logger-test-value=37a989d3-964c-4a65-8f0a-31febb1fccbe 2428s Checking mysql for the message (10 attempts): 2428s Message correctly found in the mysql Syslog.SystemEvents table 2428s autopkgtest [19:53:27]: test simple-mysql: -----------------------] 2428s autopkgtest [19:53:27]: test simple-mysql: - - - - - - - - - - results - - - - - - - - - - 2428s simple-mysql PASS 2429s autopkgtest [19:53:28]: test simple-pgsql: preparing testbed 2561s autopkgtest [19:55:40]: testbed dpkg architecture: amd64 2564s autopkgtest [19:55:43]: testbed apt version: 2.9.6 2564s autopkgtest [19:55:43]: @@@@@@@@@@@@@@@@@@@@ test bed setup 2587s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 2587s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [371 kB] 2587s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [3288 B] 2587s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [48.0 kB] 2587s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 2587s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [71.2 kB] 2587s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [99.8 kB] 2587s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 c-n-f Metadata [2104 B] 2587s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [6244 B] 2587s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [34.9 kB] 2587s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 c-n-f Metadata [368 B] 2587s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [393 kB] 2587s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [236 kB] 2587s Get:14 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 c-n-f Metadata [9228 B] 2587s Get:15 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [7976 B] 2587s Get:16 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [3052 B] 2587s Get:17 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 c-n-f Metadata [276 B] 2589s Fetched 1422 kB in 0s (5316 kB/s) 2589s Reading package lists... 2612s Reading package lists... 2613s Building dependency tree... 2613s Reading state information... 2613s Calculating upgrade... 2613s The following packages will be upgraded: 2613s libc-bin libc-dev-bin libc-devtools libc6 libc6-dev locales 2613s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2613s Need to get 10.3 MB of archives. 2613s After this operation, 34.8 kB of additional disk space will be used. 2613s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-devtools amd64 2.39-3.1ubuntu3 [29.3 kB] 2613s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6-dev amd64 2.39-3.1ubuntu3 [2120 kB] 2613s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-dev-bin amd64 2.39-3.1ubuntu3 [20.4 kB] 2613s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc6 amd64 2.39-3.1ubuntu3 [3262 kB] 2613s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libc-bin amd64 2.39-3.1ubuntu3 [680 kB] 2613s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 locales all 2.39-3.1ubuntu3 [4220 kB] 2614s Preconfiguring packages ... 2614s Fetched 10.3 MB in 0s (63.8 MB/s) 2614s (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 ... 74486 files and directories currently installed.) 2614s Preparing to unpack .../libc-devtools_2.39-3.1ubuntu3_amd64.deb ... 2614s Unpacking libc-devtools (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2614s Preparing to unpack .../libc6-dev_2.39-3.1ubuntu3_amd64.deb ... 2614s Unpacking libc6-dev:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2614s Preparing to unpack .../libc-dev-bin_2.39-3.1ubuntu3_amd64.deb ... 2614s Unpacking libc-dev-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2614s Preparing to unpack .../libc6_2.39-3.1ubuntu3_amd64.deb ... 2615s Unpacking libc6:amd64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2615s Setting up libc6:amd64 (2.39-3.1ubuntu3) ... 2615s Error: Could not restart systemd, systemd binary not working 2615s (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 ... 74486 files and directories currently installed.) 2615s Preparing to unpack .../libc-bin_2.39-3.1ubuntu3_amd64.deb ... 2615s Unpacking libc-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2615s Setting up libc-bin (2.39-3.1ubuntu3) ... 2615s (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 ... 74486 files and directories currently installed.) 2615s Preparing to unpack .../locales_2.39-3.1ubuntu3_all.deb ... 2615s Unpacking locales (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 2615s Setting up locales (2.39-3.1ubuntu3) ... 2616s Generating locales (this might take a while)... 2617s en_US.UTF-8... done 2617s Generation complete. 2617s Setting up libc-dev-bin (2.39-3.1ubuntu3) ... 2617s Setting up libc-devtools (2.39-3.1ubuntu3) ... 2617s Setting up libc6-dev:amd64 (2.39-3.1ubuntu3) ... 2617s Processing triggers for man-db (2.12.1-2) ... 2619s Processing triggers for systemd (256-1ubuntu1) ... 2620s Reading package lists... 2620s Building dependency tree... 2620s Reading state information... 2620s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2620s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 2620s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 2620s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 2620s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 2622s Reading package lists... 2622s Reading package lists... 2622s Building dependency tree... 2622s Reading state information... 2622s Calculating upgrade... 2623s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2623s Reading package lists... 2623s Building dependency tree... 2623s Reading state information... 2623s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2651s Reading package lists... 2651s Building dependency tree... 2651s Reading state information... 2651s Starting pkgProblemResolver with broken count: 0 2651s Starting 2 pkgProblemResolver with broken count: 0 2651s Done 2652s The following additional packages will be installed: 2652s apparmor-utils libjson-perl libpq5 libxslt1.1 postgresql postgresql-16 2652s postgresql-client-16 postgresql-client-common postgresql-common 2652s python3-apparmor python3-libapparmor ssl-cert 2652s Suggested packages: 2652s vim-addon-manager postgresql-doc postgresql-doc-16 2652s Recommended packages: 2652s libjson-xs-perl 2652s The following NEW packages will be installed: 2652s apparmor-utils autopkgtest-satdep libjson-perl libpq5 libxslt1.1 postgresql 2652s postgresql-16 postgresql-client-16 postgresql-client-common 2652s postgresql-common python3-apparmor python3-libapparmor ssl-cert 2652s 0 upgraded, 13 newly installed, 0 to remove and 0 not upgraded. 2652s Need to get 17.6 MB/17.6 MB of archives. 2652s After this operation, 52.2 MB of additional disk space will be used. 2652s Get:1 /tmp/autopkgtest.dP0lQp/5-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [740 B] 2652s Get:2 http://ftpmaster.internal/ubuntu oracular/main amd64 libjson-perl all 4.10000-1 [81.9 kB] 2652s Get:3 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-client-common all 261 [36.6 kB] 2652s Get:4 http://ftpmaster.internal/ubuntu oracular/main amd64 ssl-cert all 1.1.2ubuntu2 [18.0 kB] 2652s Get:5 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-common all 261 [162 kB] 2652s Get:6 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-libapparmor amd64 4.0.1-0ubuntu1 [30.1 kB] 2652s Get:7 http://ftpmaster.internal/ubuntu oracular/main amd64 python3-apparmor all 4.0.1-0ubuntu1 [84.5 kB] 2652s Get:8 http://ftpmaster.internal/ubuntu oracular/main amd64 apparmor-utils all 4.0.1-0ubuntu1 [46.5 kB] 2652s Get:9 http://ftpmaster.internal/ubuntu oracular/main amd64 libpq5 amd64 16.3-1 [140 kB] 2652s Get:10 http://ftpmaster.internal/ubuntu oracular/main amd64 libxslt1.1 amd64 1.1.39-0exp1build1 [167 kB] 2652s Get:11 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-client-16 amd64 16.3-1 [1269 kB] 2652s Get:12 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-16 amd64 16.3-1 [15.5 MB] 2652s Get:13 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql all 16+261 [11.7 kB] 2652s Preconfiguring packages ... 2653s Fetched 17.6 MB in 0s (78.1 MB/s) 2653s Selecting previously unselected package libjson-perl. 2653s (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 ... 74486 files and directories currently installed.) 2653s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 2653s Unpacking libjson-perl (4.10000-1) ... 2653s Selecting previously unselected package postgresql-client-common. 2653s Preparing to unpack .../01-postgresql-client-common_261_all.deb ... 2653s Unpacking postgresql-client-common (261) ... 2653s Selecting previously unselected package ssl-cert. 2653s Preparing to unpack .../02-ssl-cert_1.1.2ubuntu2_all.deb ... 2653s Unpacking ssl-cert (1.1.2ubuntu2) ... 2653s Selecting previously unselected package postgresql-common. 2653s Preparing to unpack .../03-postgresql-common_261_all.deb ... 2653s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 2653s Unpacking postgresql-common (261) ... 2653s Selecting previously unselected package python3-libapparmor. 2653s Preparing to unpack .../04-python3-libapparmor_4.0.1-0ubuntu1_amd64.deb ... 2653s Unpacking python3-libapparmor (4.0.1-0ubuntu1) ... 2653s Selecting previously unselected package python3-apparmor. 2653s Preparing to unpack .../05-python3-apparmor_4.0.1-0ubuntu1_all.deb ... 2653s Unpacking python3-apparmor (4.0.1-0ubuntu1) ... 2653s Selecting previously unselected package apparmor-utils. 2653s Preparing to unpack .../06-apparmor-utils_4.0.1-0ubuntu1_all.deb ... 2653s Unpacking apparmor-utils (4.0.1-0ubuntu1) ... 2653s Selecting previously unselected package libpq5:amd64. 2653s Preparing to unpack .../07-libpq5_16.3-1_amd64.deb ... 2653s Unpacking libpq5:amd64 (16.3-1) ... 2653s Selecting previously unselected package libxslt1.1:amd64. 2653s Preparing to unpack .../08-libxslt1.1_1.1.39-0exp1build1_amd64.deb ... 2653s Unpacking libxslt1.1:amd64 (1.1.39-0exp1build1) ... 2653s Selecting previously unselected package postgresql-client-16. 2653s Preparing to unpack .../09-postgresql-client-16_16.3-1_amd64.deb ... 2653s Unpacking postgresql-client-16 (16.3-1) ... 2653s Selecting previously unselected package postgresql-16. 2653s Preparing to unpack .../10-postgresql-16_16.3-1_amd64.deb ... 2653s Unpacking postgresql-16 (16.3-1) ... 2653s Selecting previously unselected package postgresql. 2653s Preparing to unpack .../11-postgresql_16+261_all.deb ... 2653s Unpacking postgresql (16+261) ... 2653s Selecting previously unselected package autopkgtest-satdep. 2653s Preparing to unpack .../12-5-autopkgtest-satdep.deb ... 2653s Unpacking autopkgtest-satdep (0) ... 2653s Setting up python3-libapparmor (4.0.1-0ubuntu1) ... 2654s Setting up postgresql-client-common (261) ... 2654s Setting up libpq5:amd64 (16.3-1) ... 2654s Setting up ssl-cert (1.1.2ubuntu2) ... 2654s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 2654s Setting up python3-apparmor (4.0.1-0ubuntu1) ... 2655s Setting up libjson-perl (4.10000-1) ... 2655s Setting up libxslt1.1:amd64 (1.1.39-0exp1build1) ... 2655s Setting up postgresql-client-16 (16.3-1) ... 2655s update-alternatives: using /usr/share/postgresql/16/man/man1/psql.1.gz to provide /usr/share/man/man1/psql.1.gz (psql.1.gz) in auto mode 2655s Setting up postgresql-common (261) ... 2656s 2656s Creating config file /etc/postgresql-common/createcluster.conf with new version 2656s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 2656s Removing obsolete dictionary files: 2657s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 2657s Setting up apparmor-utils (4.0.1-0ubuntu1) ... 2657s Setting up postgresql-16 (16.3-1) ... 2657s Creating new PostgreSQL cluster 16/main ... 2657s /usr/lib/postgresql/16/bin/initdb -D /var/lib/postgresql/16/main --auth-local peer --auth-host scram-sha-256 --no-instructions 2657s The files belonging to this database system will be owned by user "postgres". 2657s This user must also own the server process. 2657s 2657s The database cluster will be initialized with locale "C.UTF-8". 2657s The default database encoding has accordingly been set to "UTF8". 2657s The default text search configuration will be set to "english". 2657s 2657s Data page checksums are disabled. 2657s 2657s fixing permissions on existing directory /var/lib/postgresql/16/main ... ok 2657s creating subdirectories ... ok 2657s selecting dynamic shared memory implementation ... posix 2657s selecting default max_connections ... 100 2657s selecting default shared_buffers ... 128MB 2657s selecting default time zone ... Etc/UTC 2657s creating configuration files ... ok 2658s running bootstrap script ... ok 2658s performing post-bootstrap initialization ... ok 2658s syncing data to disk ... ok 2662s Setting up postgresql (16+261) ... 2662s Setting up autopkgtest-satdep (0) ... 2662s Processing triggers for man-db (2.12.1-2) ... 2663s Processing triggers for libc-bin (2.39-3.1ubuntu3) ... 2665s (Reading database ... 76531 files and directories currently installed.) 2665s Removing autopkgtest-satdep (0) ... 2696s autopkgtest [19:57:55]: test simple-pgsql: [----------------------- 2705s Enforcing the /etc/apparmor.d/usr.sbin.rsyslogd apparmor profile 2705s Setting /etc/apparmor.d/usr.sbin.rsyslogd to enforce mode. 2705s Reading package lists... 2706s Building dependency tree... 2706s Reading state information... 2706s The following additional packages will be installed: 2706s dbconfig-common 2706s Suggested packages: 2706s dbconfig-mysql | dbconfig-pgsql | dbconfig-sqlite3 | dbconfig-no-thanks 2706s The following NEW packages will be installed: 2706s dbconfig-common rsyslog-pgsql 2706s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 2706s Need to get 607 kB of archives. 2706s After this operation, 1606 kB of additional disk space will be used. 2706s Get:1 http://ftpmaster.internal/ubuntu oracular/universe amd64 dbconfig-common all 2.0.24 [596 kB] 2706s Get:2 http://ftpmaster.internal/ubuntu oracular/universe amd64 rsyslog-pgsql amd64 8.2312.0-3ubuntu9 [11.0 kB] 2706s Preconfiguring packages ... 2706s Fetched 607 kB in 0s (16.8 MB/s) 2707s Selecting previously unselected package dbconfig-common. 2707s (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 ... 76531 files and directories currently installed.) 2707s Preparing to unpack .../dbconfig-common_2.0.24_all.deb ... 2707s Unpacking dbconfig-common (2.0.24) ... 2707s Selecting previously unselected package rsyslog-pgsql. 2707s Preparing to unpack .../rsyslog-pgsql_8.2312.0-3ubuntu9_amd64.deb ... 2707s Unpacking rsyslog-pgsql (8.2312.0-3ubuntu9) ... 2707s Setting up dbconfig-common (2.0.24) ... 2707s 2707s Creating config file /etc/dbconfig-common/config with new version 2707s Setting up rsyslog-pgsql (8.2312.0-3ubuntu9) ... 2707s dbconfig-common: writing config to /etc/dbconfig-common/rsyslog-pgsql.conf 2707s 2707s Creating config file /etc/dbconfig-common/rsyslog-pgsql.conf with new version 2708s 2708s Creating config file /etc/rsyslog.d/pgsql.conf with new version 2708s creating postgres user rsyslog: success. 2708s verifying creation of user: success. 2708s creating database Syslog: success. 2708s verifying database Syslog exists: success. 2708s populating database via sql... done. 2708s dbconfig-common: flushing administrative password 2709s Processing triggers for man-db (2.12.1-2) ... 2709s Logging message: logger-test-value=f63ed4c5-d048-47da-8769-4784203e88a6 2709s Checking postgresql for the message (10 attempts): 2709s Message correctly found in the postgresql Syslog.systemevents table 2710s autopkgtest [19:58:09]: test simple-pgsql: -----------------------] 2726s autopkgtest [19:58:25]: test simple-pgsql: - - - - - - - - - - results - - - - - - - - - - 2726s simple-pgsql PASS 2730s autopkgtest [19:58:29]: @@@@@@@@@@@@@@@@@@@@ summary 2730s logcheck PASS 2730s apparmor-include-mechanism PASS 2730s simple-logger PASS 2730s simple-mysql PASS 2730s simple-pgsql PASS 2847s ical.com:5000/v3/"}], "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v3+json"}]}} 2847s DEBUG (session:946) GET call to https://keystone.ps5.canonical.com:5000/v3 used request id req-e284988a-064d-481a-a551-0dfa0a32a6a1 2847s DEBUG (base:182) Making authentication request to https://keystone.ps5.canonical.com:5000/v3/auth/tokens 2847s DEBUG (connectionpool:429) https://keystone.ps5.canonical.com:5000 "POST /v3/auth/tokens HTTP/1.1" 201 11701 2847s DEBUG (base:187) {"token": {"methods": ["password"], "user": {"domain": {"id": "default", "name": "Default"}, "id": "c01f0e5a065246f2a090a7d191029fce", "name": "prod-proposed-migration", "password_expires_at": null}, "audit_ids": ["npsunP7kRxK_w2OF0xuuBg"], "expires_at": "2024-07-13T19:21:20.000000Z", "issued_at": "2024-07-12T19:21:20.000000Z", "project": {"domain": {"id": "default", "name": "Default"}, "id": "a77cf7d04cc348e3b9aad5180306c3dd", "name": "prod-proposed-migration_project"}, "is_domain": false, "roles": [{"id": "f84069c3d10e4eebaea55b7499d804ac", "name": "reader"}, {"id": "3c78c6ccb7a24b77a91e24246ff0896e", "name": "member"}], "is_admin_project": false, "catalog": [{"endpoints": [{"id": "381f92a8b48942dfbfdf1f2569df8e5a", "interface": "internal", "region_id": "prodstack5", "url": "https://heat-internal.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "57c801b8efae427bb38d127888ec39c7", "interface": "admin", "region_id": "prodstack5", "url": "https://heat-admin.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "edae1b88012c46b892b6ca4d670e78e6", "interface": "public", "region_id": "prodstack5", "url": "https://heat.ps5.canonical.com:8004/v1/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c32215c880f45ebb55fa813d2c01a05", "type": "orchestration", "name": "heat"}, {"endpoints": [{"id": "3f327f9d25044e4dae537bc2aa694117", "interface": "internal", "region_id": "prodstack5", "url": "https://cinder-internal.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "be9b6d7a63fd4c2cbec3d3945d67da23", "interface": "admin", "region_id": "prodstack5", "url": "https://cinder-admin.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}, {"id": "f79fd684be71400084dd1871bf1ceed8", "interface": "public", "region_id": "prodstack5", "url": "https://cinder.ps5.canonical.com:8776/v3/a77cf7d04cc348e3b9aad5180306c3dd", "region": "prodstack5"}], "id": "0c799399b02f4d468844fac80cf78763", "type": "volumev3", "name": "cinderv3"}, {"endpoints": [{"id": "32d4ab1d59314991b616622f958c55a3", "interface": "admin", "region_id": "prodstack5", "url": "https://glance-admin.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "c0023fe925774a949a611bafa775b1dd", "interface": "public", "region_id": "prodstack5", "url": "https://glance.ps5.canonical.com:9292", "region": "prodstack5"}, {"id": "efdeffa94ac54e8485318b673fe00a62", "interface": "internal", "region_id": "prodstack5", "url": "https://glance-internal.ps5.canonical.com:9292", "region": "prodstack5"}], "id": "12a1596e978446df9f49adedf0281be4", "type": "image", "name": "glance"}, {"endpoints": [{"id": "35a1da84ece8457796097bbb42a7c48b", "interface": "public", "region_id": "prodstack5", "url": "https://neutron.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "76f58d33070d4716b6ace61da0cf5fab", "interface": "internal", "region_id": "prodstack5", "url": "https://neutron-internal.ps5.canonical.com:9696", "region": "prodstack5"}, {"id": "fa63ae5cd82345128c1e06d795bd5c5c", "interface": "admin", "region_id": "prodstack5", "url": "https://neutron-admin.ps5.canonical.com:9696", "region": "prodstack5"}], "id": "166ad5679b9e4430b00903524f1aa2e2", "type": "network", "name": "neutron"}, {"endpoints": [{"id": "51b3369f6bcb44d39d927fed38dfcb1d", "interface": "public", "region_id": "prodstack5", "url": "https://nova.ps5.canonical.com:8774/v2.1", "region": "prodstack5"}, {"id": "bde75440fd044085a599523fa768b3e0", "interface": "internal", "region_id": "prodstack5", "nova [W] Skipping flock for amd64 2847s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 2847s nova [W] Skipping flock for amd64 2847s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)... 2847s nova [W] Skipping flock for amd64 2847s Creating nova instance adt-oracular-amd64-rsyslog-20240712-191258-juju-7f2275-prod-proposed-migration-environment-2-43b37a9a-acfd-43f7-9fa5-3490bca2ebb7 from image adt/ubuntu-oracular-amd64-server-20240712.img (UUID 9132249a-6053-4497-bc26-981612ca03ad)...