0s autopkgtest [09:03:36]: starting date and time: 2025-07-04 09:03:36+0000 0s autopkgtest [09:03:36]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [09:03:36]: host juju-7f2275-prod-proposed-migration-environment-23; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.k0hvzqvk/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glib2.0 --apt-upgrade cluster-glue --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glib2.0/2.72.4-0ubuntu2.6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-23@sto01-ppc64el-23.secgroup --name adt-jammy-ppc64el-cluster-glue-20250704-082254-juju-7f2275-prod-proposed-migration-environment-23-f1468759-0849-492b-a844-847c05ab948f --image adt/ubuntu-jammy-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-23 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-jammy-ppc64el-cluster-glue-20250704-082254-juju-7f2275-prod-proposed-migration-environment-23-f1468759-0849-492b-a844-847c05ab948f from image adt/ubuntu-jammy-ppc64el-server-20250704.img (UUID 823b13fa-663c-4fce-ab34-09a1dfb61e0a)... 44s autopkgtest [09:04:20]: testbed dpkg architecture: ppc64el 44s autopkgtest [09:04:20]: testbed apt version: 2.4.14 44s autopkgtest [09:04:20]: @@@@@@@@@@@@@@@@@@@@ test bed setup 44s autopkgtest [09:04:20]: testbed release detected to be: None 45s autopkgtest [09:04:21]: updating testbed package index (apt update) 45s Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 46s Get:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease [128 kB] 46s Get:3 http://ftpmaster.internal/ubuntu jammy-security InRelease [129 kB] 46s Get:4 http://ftpmaster.internal/ubuntu jammy-proposed InRelease [279 kB] 47s Get:5 http://ftpmaster.internal/ubuntu jammy-proposed/universe Sources [28.8 kB] 47s Get:6 http://ftpmaster.internal/ubuntu jammy-proposed/restricted Sources [25.1 kB] 47s Get:7 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse Sources [3112 B] 47s Get:8 http://ftpmaster.internal/ubuntu jammy-proposed/main Sources [90.7 kB] 47s Get:9 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el Packages [159 kB] 47s Get:10 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el c-n-f Metadata [2476 B] 47s Get:11 http://ftpmaster.internal/ubuntu jammy-proposed/restricted ppc64el Packages [2536 B] 48s Get:12 http://ftpmaster.internal/ubuntu jammy-proposed/restricted ppc64el c-n-f Metadata [116 B] 48s Get:13 http://ftpmaster.internal/ubuntu jammy-proposed/universe ppc64el Packages [49.0 kB] 48s Get:14 http://ftpmaster.internal/ubuntu jammy-proposed/universe ppc64el c-n-f Metadata [2064 B] 48s Get:15 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse ppc64el c-n-f Metadata [116 B] 54s Fetched 899 kB in 2s (367 kB/s) 55s Reading package lists... 55s autopkgtest [09:04:31]: upgrading testbed (apt dist-upgrade and autopurge) 55s Reading package lists... 55s Building dependency tree... 55s Reading state information... 56s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 56s Starting 2 pkgProblemResolver with broken count: 0 56s Done 56s Entering ResolveByKeep 56s 56s The following packages will be upgraded: 56s libglib2.0-0 libglib2.0-bin libglib2.0-data 56s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 56s Need to get 1746 kB of archives. 56s After this operation, 0 B of additional disk space will be used. 56s Get:1 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el libglib2.0-data all 2.72.4-0ubuntu2.6 [4698 B] 56s Get:2 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el libglib2.0-bin ppc64el 2.72.4-0ubuntu2.6 [89.1 kB] 56s Get:3 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el libglib2.0-0 ppc64el 2.72.4-0ubuntu2.6 [1652 kB] 60s Fetched 1746 kB in 4s (482 kB/s) 60s (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 ... 66651 files and directories currently installed.) 60s Preparing to unpack .../libglib2.0-data_2.72.4-0ubuntu2.6_all.deb ... 60s Unpacking libglib2.0-data (2.72.4-0ubuntu2.6) over (2.72.4-0ubuntu2.5) ... 60s Preparing to unpack .../libglib2.0-bin_2.72.4-0ubuntu2.6_ppc64el.deb ... 60s Unpacking libglib2.0-bin (2.72.4-0ubuntu2.6) over (2.72.4-0ubuntu2.5) ... 60s Preparing to unpack .../libglib2.0-0_2.72.4-0ubuntu2.6_ppc64el.deb ... 60s Unpacking libglib2.0-0:ppc64el (2.72.4-0ubuntu2.6) over (2.72.4-0ubuntu2.5) ... 60s Setting up libglib2.0-0:ppc64el (2.72.4-0ubuntu2.6) ... 60s No schema files found: doing nothing. 60s Setting up libglib2.0-data (2.72.4-0ubuntu2.6) ... 60s Setting up libglib2.0-bin (2.72.4-0ubuntu2.6) ... 60s Processing triggers for libc-bin (2.35-0ubuntu3.10) ... 60s Processing triggers for man-db (2.10.2-1) ... 61s Reading package lists... 61s Building dependency tree... 61s Reading state information... 61s Starting pkgProblemResolver with broken count: 0 61s Starting 2 pkgProblemResolver with broken count: 0 61s Done 61s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 63s autopkgtest [09:04:39]: testbed running kernel: Linux 5.15.0-143-generic #153-Ubuntu SMP Fri Jun 13 19:14:40 UTC 2025 64s autopkgtest [09:04:40]: @@@@@@@@@@@@@@@@@@@@ apt-source cluster-glue 72s Get:1 http://ftpmaster.internal/ubuntu jammy/main cluster-glue 1.0.12-20ubuntu3 (dsc) [3300 B] 72s Get:2 http://ftpmaster.internal/ubuntu jammy/main cluster-glue 1.0.12-20ubuntu3 (tar) [491 kB] 72s Get:3 http://ftpmaster.internal/ubuntu jammy/main cluster-glue 1.0.12-20ubuntu3 (diff) [55.6 kB] 72s gpgv: Signature made Thu Mar 17 14:57:10 2022 UTC 72s gpgv: using RSA key D56571B88A8BBAF140BF63D6BD7EAA60778FA6F5 72s gpgv: issuer "doko@ubuntu.com" 72s gpgv: Can't check signature: No public key 72s dpkg-source: warning: cannot verify signature ./cluster-glue_1.0.12-20ubuntu3.dsc 72s dpkg-source: warning: diff 'src/debian/patches/ubuntu/lp1895355-b7bed186-Dev-update-permissions-for-ec2.patch' doesn't contain any patch 72s autopkgtest [09:04:48]: testing package cluster-glue version 1.0.12-20ubuntu3 75s autopkgtest [09:04:51]: build not needed 78s autopkgtest [09:04:54]: test user: preparing testbed 78s Reading package lists... 78s Building dependency tree... 78s Reading state information... 79s Starting pkgProblemResolver with broken count: 0 79s Starting 2 pkgProblemResolver with broken count: 0 79s Done 79s The following NEW packages will be installed: 79s cluster-glue liblrm2 libltdl7 libopenhpi3 libopenipmi0 libpils2 libplumb2 79s libplumbgpl2 libsensors-config libsensors5 libsnmp-base libsnmp40 79s libstonith1 libtimedate-perl 79s 0 upgraded, 14 newly installed, 0 to remove and 0 not upgraded. 79s Need to get 2694 kB of archives. 79s After this operation, 14.0 MB of additional disk space will be used. 79s Get:1 http://ftpmaster.internal/ubuntu jammy/main ppc64el libltdl7 ppc64el 2.4.6-15build2 [46.9 kB] 79s Get:2 http://ftpmaster.internal/ubuntu jammy/main ppc64el libpils2 ppc64el 1.0.12-20ubuntu3 [21.9 kB] 79s Get:3 http://ftpmaster.internal/ubuntu jammy/main ppc64el libplumb2 ppc64el 1.0.12-20ubuntu3 [94.6 kB] 79s Get:4 http://ftpmaster.internal/ubuntu jammy/main ppc64el liblrm2 ppc64el 1.0.12-20ubuntu3 [18.8 kB] 79s Get:5 http://ftpmaster.internal/ubuntu jammy/universe ppc64el libopenhpi3 ppc64el 3.8.0-2.1build5 [155 kB] 79s Get:6 http://ftpmaster.internal/ubuntu jammy/main ppc64el libopenipmi0 ppc64el 2.0.29-0.1ubuntu6 [606 kB] 80s Get:7 http://ftpmaster.internal/ubuntu jammy/main ppc64el libplumbgpl2 ppc64el 1.0.12-20ubuntu3 [8706 B] 80s Get:8 http://ftpmaster.internal/ubuntu jammy/main ppc64el libsensors-config all 1:3.6.0-7ubuntu1 [5274 B] 80s Get:9 http://ftpmaster.internal/ubuntu jammy/main ppc64el libsensors5 ppc64el 1:3.6.0-7ubuntu1 [32.3 kB] 80s Get:10 http://ftpmaster.internal/ubuntu jammy-updates/main ppc64el libsnmp-base all 5.9.1+dfsg-1ubuntu2.8 [201 kB] 80s Get:11 http://ftpmaster.internal/ubuntu jammy-updates/main ppc64el libsnmp40 ppc64el 5.9.1+dfsg-1ubuntu2.8 [1163 kB] 83s Get:12 http://ftpmaster.internal/ubuntu jammy/main ppc64el libstonith1 ppc64el 1.0.12-20ubuntu3 [16.0 kB] 83s Get:13 http://ftpmaster.internal/ubuntu jammy/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB] 83s Get:14 http://ftpmaster.internal/ubuntu jammy/universe ppc64el cluster-glue ppc64el 1.0.12-20ubuntu3 [290 kB] 83s Fetched 2694 kB in 4s (716 kB/s) 83s Selecting previously unselected package libltdl7:ppc64el. 83s (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 ... 66651 files and directories currently installed.) 83s Preparing to unpack .../00-libltdl7_2.4.6-15build2_ppc64el.deb ... 83s Unpacking libltdl7:ppc64el (2.4.6-15build2) ... 83s Selecting previously unselected package libpils2. 83s Preparing to unpack .../01-libpils2_1.0.12-20ubuntu3_ppc64el.deb ... 83s Unpacking libpils2 (1.0.12-20ubuntu3) ... 83s Selecting previously unselected package libplumb2. 83s Preparing to unpack .../02-libplumb2_1.0.12-20ubuntu3_ppc64el.deb ... 83s Unpacking libplumb2 (1.0.12-20ubuntu3) ... 83s Selecting previously unselected package liblrm2. 83s Preparing to unpack .../03-liblrm2_1.0.12-20ubuntu3_ppc64el.deb ... 83s Unpacking liblrm2 (1.0.12-20ubuntu3) ... 83s Selecting previously unselected package libopenhpi3. 83s Preparing to unpack .../04-libopenhpi3_3.8.0-2.1build5_ppc64el.deb ... 83s Unpacking libopenhpi3 (3.8.0-2.1build5) ... 83s Selecting previously unselected package libopenipmi0. 83s Preparing to unpack .../05-libopenipmi0_2.0.29-0.1ubuntu6_ppc64el.deb ... 83s Unpacking libopenipmi0 (2.0.29-0.1ubuntu6) ... 83s Selecting previously unselected package libplumbgpl2. 83s Preparing to unpack .../06-libplumbgpl2_1.0.12-20ubuntu3_ppc64el.deb ... 83s Unpacking libplumbgpl2 (1.0.12-20ubuntu3) ... 83s Selecting previously unselected package libsensors-config. 83s Preparing to unpack .../07-libsensors-config_1%3a3.6.0-7ubuntu1_all.deb ... 83s Unpacking libsensors-config (1:3.6.0-7ubuntu1) ... 83s Selecting previously unselected package libsensors5:ppc64el. 83s Preparing to unpack .../08-libsensors5_1%3a3.6.0-7ubuntu1_ppc64el.deb ... 83s Unpacking libsensors5:ppc64el (1:3.6.0-7ubuntu1) ... 83s Selecting previously unselected package libsnmp-base. 83s Preparing to unpack .../09-libsnmp-base_5.9.1+dfsg-1ubuntu2.8_all.deb ... 83s Unpacking libsnmp-base (5.9.1+dfsg-1ubuntu2.8) ... 83s Selecting previously unselected package libsnmp40:ppc64el. 83s Preparing to unpack .../10-libsnmp40_5.9.1+dfsg-1ubuntu2.8_ppc64el.deb ... 83s Unpacking libsnmp40:ppc64el (5.9.1+dfsg-1ubuntu2.8) ... 83s Selecting previously unselected package libstonith1. 83s Preparing to unpack .../11-libstonith1_1.0.12-20ubuntu3_ppc64el.deb ... 83s Unpacking libstonith1 (1.0.12-20ubuntu3) ... 83s Selecting previously unselected package libtimedate-perl. 83s Preparing to unpack .../12-libtimedate-perl_2.3300-2_all.deb ... 83s Unpacking libtimedate-perl (2.3300-2) ... 83s Selecting previously unselected package cluster-glue. 83s Preparing to unpack .../13-cluster-glue_1.0.12-20ubuntu3_ppc64el.deb ... 83s Unpacking cluster-glue (1.0.12-20ubuntu3) ... 83s Setting up libsnmp-base (5.9.1+dfsg-1ubuntu2.8) ... 83s Setting up libsensors-config (1:3.6.0-7ubuntu1) ... 83s Setting up libplumbgpl2 (1.0.12-20ubuntu3) ... 83s Setting up libsensors5:ppc64el (1:3.6.0-7ubuntu1) ... 83s Setting up libltdl7:ppc64el (2.4.6-15build2) ... 83s Setting up libtimedate-perl (2.3300-2) ... 83s Setting up libopenipmi0 (2.0.29-0.1ubuntu6) ... 83s Setting up libopenhpi3 (3.8.0-2.1build5) ... 83s Setting up libpils2 (1.0.12-20ubuntu3) ... 83s Setting up libsnmp40:ppc64el (5.9.1+dfsg-1ubuntu2.8) ... 83s Setting up libplumb2 (1.0.12-20ubuntu3) ... 83s Setting up libstonith1 (1.0.12-20ubuntu3) ... 83s Setting up liblrm2 (1.0.12-20ubuntu3) ... 83s Setting up cluster-glue (1.0.12-20ubuntu3) ... 83s Adding group `haclient' (GID 116) ... 83s Done. 83s Warning: The home dir /var/lib/pacemaker you specified can't be accessed: No such file or directory 83s Adding system user `hacluster' (UID 111) ... 83s Adding new user `hacluster' (UID 111) with group `haclient' ... 83s ERROR: ld.so: object 'libeatmydata.so' from LD_PRELOAD cannot be preloaded (cannot open shared object file): ignored. 83s Not creating home directory `/var/lib/pacemaker'. 84s Created symlink /etc/systemd/system/multi-user.target.wants/logd.service → /lib/systemd/system/logd.service. 84s Processing triggers for man-db (2.10.2-1) ... 84s Processing triggers for libc-bin (2.35-0ubuntu3.10) ... 85s autopkgtest [09:05:01]: test user: [----------------------- 86s uid=111(hacluster) gid=116(haclient) groups=116(haclient) 86s autopkgtest [09:05:02]: test user: -----------------------] 86s autopkgtest [09:05:02]: test user: - - - - - - - - - - results - - - - - - - - - - 86s user PASS 86s autopkgtest [09:05:02]: test ipctest: preparing testbed 87s Reading package lists... 87s Building dependency tree... 87s Reading state information... 87s Starting pkgProblemResolver with broken count: 0 87s Starting 2 pkgProblemResolver with broken count: 0 87s Done 87s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 88s autopkgtest [09:05:04]: test ipctest: [----------------------- 88s Jul 04 09:05:03 autopkgtest ipctest: [2690]: info: Echo server: 10000 reps pid 2690. 88s Jul 04 09:05:03 autopkgtest ipctest: [2691]: info: Echo client: 10000 reps pid 2691. 88s Jul 04 09:05:03 autopkgtest ipctest: [2691]: info: echoclient: 0 errors 89s Jul 04 09:05:04 autopkgtest ipctest: [2690]: info: echoserver: 0 errors 89s Jul 04 09:05:04 autopkgtest ipctest: [2692]: info: Asyn echo server: 10000 reps pid 2692. 89s Jul 04 09:05:04 autopkgtest ipctest: [2693]: info: Async Echo client: 10000 reps pid 2693. 89s Jul 04 09:05:05 autopkgtest ipctest: [2693]: info: Async echoclient: 0 errors, 10000 reads, 10000 writes 89s Jul 04 09:05:05 autopkgtest ipctest: [2692]: info: asyn_echoserver: 0 errors 89s Jul 04 09:05:05 autopkgtest ipctest: [2694]: info: Mainloop echo server: 10000 reps pid 2694. 89s Jul 04 09:05:05 autopkgtest ipctest: [2695]: info: Mainloop echo client: 10000 reps pid 2695. 90s Jul 04 09:05:05 autopkgtest ipctest: [2695]: info: Mainloop echo client: 0 errors, 10000 read 10000 written 90s 90s (process:2694): GLib-CRITICAL **: 09:05:05.378: Source ID 1 was not found when attempting to remove it 90s Jul 04 09:05:05 autopkgtest ipctest: [2694]: info: Mainloop echo server: 0 errors 90s Jul 04 09:05:05 autopkgtest ipctest: [2694]: info: TOTAL errors: 0 90s autopkgtest [09:05:06]: test ipctest: -----------------------] 90s ipctest PASS 90s autopkgtest [09:05:06]: test ipctest: - - - - - - - - - - results - - - - - - - - - - 91s autopkgtest [09:05:07]: test logd: preparing testbed 91s Reading package lists... 91s Building dependency tree... 91s Reading state information... 91s Starting pkgProblemResolver with broken count: 0 91s Starting 2 pkgProblemResolver with broken count: 0 91s Done 91s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 92s autopkgtest [09:05:08]: test logd: [----------------------- 92s === service === 92s ● logd.service - ha_logd logging daemon 92s Loaded: loaded (/lib/systemd/system/logd.service; enabled; vendor preset: enabled) 92s Active: active (running) since Fri 2025-07-04 09:05:07 UTC; 8ms ago 92s Docs: man:ha_logd(8) 92s Process: 2843 ExecStartPre=/bin/rm -f /run/logd.pid (code=exited, status=0/SUCCESS) 92s Main PID: 2844 (ha_logd) 92s Tasks: 2 (limit: 4675) 92s Memory: 3.0M 92s CPU: 2ms 92s CGroup: /system.slice/logd.service 92s ├─2844 "ha_logd: read process" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" 92s └─2845 "ha_logd: write process" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" "" 92s 92s Jul 04 09:05:07 autopkgtest systemd[1]: Starting ha_logd logging daemon... 92s Jul 04 09:05:07 autopkgtest systemd[1]: Started ha_logd logging daemon. 92s Jul 04 09:05:07 autopkgtest logd[2844]: [2844]: info: logd started with /etc/logd.cf. 92s === ha_logger === 92s Jul 04 09:05:07 autopkgtest cluster[2845]: [2849]: autopkgtest-message 92s === logtest === 92s sending Message 0 92s sending Message 1 92s sending Message 2 92s sending Message 3 92s sending Message 4 92s sending Message 5 92s sending Message 6 92s sending Message 7 92s sending Message 8 92s sending Message 9 92s Jul 04 09:05:07 autopkgtest logtest[2845]: [2851]: info: total message dropped: 0 93s autopkgtest [09:05:09]: test logd: -----------------------] 93s autopkgtest [09:05:09]: test logd: - - - - - - - - - - results - - - - - - - - - - 93s logd PASS 93s autopkgtest [09:05:09]: test stonith-null: preparing testbed 100s Creating nova instance adt-jammy-ppc64el-cluster-glue-20250704-082254-juju-7f2275-prod-proposed-migration-environment-23-f1468759-0849-492b-a844-847c05ab948f from image adt/ubuntu-jammy-ppc64el-server-20250704.img (UUID 823b13fa-663c-4fce-ab34-09a1dfb61e0a)... 141s autopkgtest [09:05:57]: testbed dpkg architecture: ppc64el 141s autopkgtest [09:05:57]: testbed apt version: 2.4.14 142s autopkgtest [09:05:58]: @@@@@@@@@@@@@@@@@@@@ test bed setup 142s autopkgtest [09:05:58]: testbed release detected to be: jammy 143s autopkgtest [09:05:59]: updating testbed package index (apt update) 143s Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 143s Hit:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease 143s Hit:3 http://ftpmaster.internal/ubuntu jammy-security InRelease 143s Get:4 http://ftpmaster.internal/ubuntu jammy-proposed InRelease [279 kB] 144s Get:5 http://ftpmaster.internal/ubuntu jammy-proposed/main Sources [90.7 kB] 144s Get:6 http://ftpmaster.internal/ubuntu jammy-proposed/universe Sources [28.8 kB] 144s Get:7 http://ftpmaster.internal/ubuntu jammy-proposed/restricted Sources [25.1 kB] 144s Get:8 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse Sources [3112 B] 144s Get:9 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el Packages [159 kB] 144s Get:10 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el c-n-f Metadata [2476 B] 144s Get:11 http://ftpmaster.internal/ubuntu jammy-proposed/restricted ppc64el Packages [2536 B] 144s Get:12 http://ftpmaster.internal/ubuntu jammy-proposed/restricted ppc64el c-n-f Metadata [116 B] 144s Get:13 http://ftpmaster.internal/ubuntu jammy-proposed/universe ppc64el Packages [49.0 kB] 144s Get:14 http://ftpmaster.internal/ubuntu jammy-proposed/universe ppc64el c-n-f Metadata [2064 B] 144s Get:15 http://ftpmaster.internal/ubuntu jammy-proposed/multiverse ppc64el c-n-f Metadata [116 B] 150s Fetched 642 kB in 1s (469 kB/s) 151s Reading package lists... 151s autopkgtest [09:06:07]: upgrading testbed (apt dist-upgrade and autopurge) 151s Reading package lists... 151s Building dependency tree... 151s Reading state information... 152s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 152s Starting 2 pkgProblemResolver with broken count: 0 152s Done 152s Entering ResolveByKeep 152s 152s The following packages will be upgraded: 152s libglib2.0-0 libglib2.0-bin libglib2.0-data 152s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 152s Need to get 1746 kB of archives. 152s After this operation, 0 B of additional disk space will be used. 152s Get:1 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el libglib2.0-data all 2.72.4-0ubuntu2.6 [4698 B] 152s Get:2 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el libglib2.0-bin ppc64el 2.72.4-0ubuntu2.6 [89.1 kB] 152s Get:3 http://ftpmaster.internal/ubuntu jammy-proposed/main ppc64el libglib2.0-0 ppc64el 2.72.4-0ubuntu2.6 [1652 kB] 158s Fetched 1746 kB in 5s (338 kB/s) 159s (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 ... 66651 files and directories currently installed.) 159s Preparing to unpack .../libglib2.0-data_2.72.4-0ubuntu2.6_all.deb ... 159s Unpacking libglib2.0-data (2.72.4-0ubuntu2.6) over (2.72.4-0ubuntu2.5) ... 159s Preparing to unpack .../libglib2.0-bin_2.72.4-0ubuntu2.6_ppc64el.deb ... 159s Unpacking libglib2.0-bin (2.72.4-0ubuntu2.6) over (2.72.4-0ubuntu2.5) ... 159s Preparing to unpack .../libglib2.0-0_2.72.4-0ubuntu2.6_ppc64el.deb ... 159s Unpacking libglib2.0-0:ppc64el (2.72.4-0ubuntu2.6) over (2.72.4-0ubuntu2.5) ... 159s Setting up libglib2.0-0:ppc64el (2.72.4-0ubuntu2.6) ... 159s No schema files found: doing nothing. 159s Setting up libglib2.0-data (2.72.4-0ubuntu2.6) ... 159s Setting up libglib2.0-bin (2.72.4-0ubuntu2.6) ... 159s Processing triggers for libc-bin (2.35-0ubuntu3.10) ... 159s Processing triggers for man-db (2.10.2-1) ... 160s Reading package lists... 160s Building dependency tree... 160s Reading state information... 160s Starting pkgProblemResolver with broken count: 0 160s Starting 2 pkgProblemResolver with broken count: 0 160s Done 160s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 163s Reading package lists... 163s Building dependency tree... 163s Reading state information... 163s Starting pkgProblemResolver with broken count: 0 163s Starting 2 pkgProblemResolver with broken count: 0 163s Done 163s The following NEW packages will be installed: 163s cluster-glue liblrm2 libltdl7 libopenhpi3 libopenipmi0 libpils2 libplumb2 163s libplumbgpl2 libsensors-config libsensors5 libsnmp-base libsnmp40 163s libstonith1 libtimedate-perl 163s 0 upgraded, 14 newly installed, 0 to remove and 0 not upgraded. 163s Need to get 2694 kB of archives. 163s After this operation, 14.0 MB of additional disk space will be used. 163s Get:1 http://ftpmaster.internal/ubuntu jammy/main ppc64el libltdl7 ppc64el 2.4.6-15build2 [46.9 kB] 163s Get:2 http://ftpmaster.internal/ubuntu jammy/main ppc64el libpils2 ppc64el 1.0.12-20ubuntu3 [21.9 kB] 163s Get:3 http://ftpmaster.internal/ubuntu jammy/main ppc64el libplumb2 ppc64el 1.0.12-20ubuntu3 [94.6 kB] 163s Get:4 http://ftpmaster.internal/ubuntu jammy/main ppc64el liblrm2 ppc64el 1.0.12-20ubuntu3 [18.8 kB] 163s Get:5 http://ftpmaster.internal/ubuntu jammy/universe ppc64el libopenhpi3 ppc64el 3.8.0-2.1build5 [155 kB] 163s Get:6 http://ftpmaster.internal/ubuntu jammy/main ppc64el libopenipmi0 ppc64el 2.0.29-0.1ubuntu6 [606 kB] 165s Get:7 http://ftpmaster.internal/ubuntu jammy/main ppc64el libplumbgpl2 ppc64el 1.0.12-20ubuntu3 [8706 B] 165s Get:8 http://ftpmaster.internal/ubuntu jammy/main ppc64el libsensors-config all 1:3.6.0-7ubuntu1 [5274 B] 165s Get:9 http://ftpmaster.internal/ubuntu jammy/main ppc64el libsensors5 ppc64el 1:3.6.0-7ubuntu1 [32.3 kB] 165s Get:10 http://ftpmaster.internal/ubuntu jammy-updates/main ppc64el libsnmp-base all 5.9.1+dfsg-1ubuntu2.8 [201 kB] 165s Get:11 http://ftpmaster.internal/ubuntu jammy-updates/main ppc64el libsnmp40 ppc64el 5.9.1+dfsg-1ubuntu2.8 [1163 kB] 168s Get:12 http://ftpmaster.internal/ubuntu jammy/main ppc64el libstonith1 ppc64el 1.0.12-20ubuntu3 [16.0 kB] 168s Get:13 http://ftpmaster.internal/ubuntu jammy/main ppc64el libtimedate-perl all 2.3300-2 [34.0 kB] 168s Get:14 http://ftpmaster.internal/ubuntu jammy/universe ppc64el cluster-glue ppc64el 1.0.12-20ubuntu3 [290 kB] 169s Fetched 2694 kB in 5s (550 kB/s) 169s Selecting previously unselected package libltdl7:ppc64el. 169s (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 ... 66651 files and directories currently installed.) 169s Preparing to unpack .../00-libltdl7_2.4.6-15build2_ppc64el.deb ... 169s Unpacking libltdl7:ppc64el (2.4.6-15build2) ... 169s Selecting previously unselected package libpils2. 169s Preparing to unpack .../01-libpils2_1.0.12-20ubuntu3_ppc64el.deb ... 169s Unpacking libpils2 (1.0.12-20ubuntu3) ... 169s Selecting previously unselected package libplumb2. 169s Preparing to unpack .../02-libplumb2_1.0.12-20ubuntu3_ppc64el.deb ... 169s Unpacking libplumb2 (1.0.12-20ubuntu3) ... 169s Selecting previously unselected package liblrm2. 169s Preparing to unpack .../03-liblrm2_1.0.12-20ubuntu3_ppc64el.deb ... 169s Unpacking liblrm2 (1.0.12-20ubuntu3) ... 169s Selecting previously unselected package libopenhpi3. 169s Preparing to unpack .../04-libopenhpi3_3.8.0-2.1build5_ppc64el.deb ... 169s Unpacking libopenhpi3 (3.8.0-2.1build5) ... 169s Selecting previously unselected package libopenipmi0. 169s Preparing to unpack .../05-libopenipmi0_2.0.29-0.1ubuntu6_ppc64el.deb ... 169s Unpacking libopenipmi0 (2.0.29-0.1ubuntu6) ... 169s Selecting previously unselected package libplumbgpl2. 169s Preparing to unpack .../06-libplumbgpl2_1.0.12-20ubuntu3_ppc64el.deb ... 169s Unpacking libplumbgpl2 (1.0.12-20ubuntu3) ... 169s Selecting previously unselected package libsensors-config. 169s Preparing to unpack .../07-libsensors-config_1%3a3.6.0-7ubuntu1_all.deb ... 169s Unpacking libsensors-config (1:3.6.0-7ubuntu1) ... 169s Selecting previously unselected package libsensors5:ppc64el. 169s Preparing to unpack .../08-libsensors5_1%3a3.6.0-7ubuntu1_ppc64el.deb ... 169s Unpacking libsensors5:ppc64el (1:3.6.0-7ubuntu1) ... 169s Selecting previously unselected package libsnmp-base. 169s Preparing to unpack .../09-libsnmp-base_5.9.1+dfsg-1ubuntu2.8_all.deb ... 169s Unpacking libsnmp-base (5.9.1+dfsg-1ubuntu2.8) ... 169s Selecting previously unselected package libsnmp40:ppc64el. 169s Preparing to unpack .../10-libsnmp40_5.9.1+dfsg-1ubuntu2.8_ppc64el.deb ... 169s Unpacking libsnmp40:ppc64el (5.9.1+dfsg-1ubuntu2.8) ... 169s Selecting previously unselected package libstonith1. 169s Preparing to unpack .../11-libstonith1_1.0.12-20ubuntu3_ppc64el.deb ... 169s Unpacking libstonith1 (1.0.12-20ubuntu3) ... 169s Selecting previously unselected package libtimedate-perl. 169s Preparing to unpack .../12-libtimedate-perl_2.3300-2_all.deb ... 169s Unpacking libtimedate-perl (2.3300-2) ... 169s Selecting previously unselected package cluster-glue. 169s Preparing to unpack .../13-cluster-glue_1.0.12-20ubuntu3_ppc64el.deb ... 169s Unpacking cluster-glue (1.0.12-20ubuntu3) ... 169s Setting up libsnmp-base (5.9.1+dfsg-1ubuntu2.8) ... 169s Setting up libsensors-config (1:3.6.0-7ubuntu1) ... 169s Setting up libplumbgpl2 (1.0.12-20ubuntu3) ... 169s Setting up libsensors5:ppc64el (1:3.6.0-7ubuntu1) ... 169s Setting up libltdl7:ppc64el (2.4.6-15build2) ... 169s Setting up libtimedate-perl (2.3300-2) ... 169s Setting up libopenipmi0 (2.0.29-0.1ubuntu6) ... 169s Setting up libopenhpi3 (3.8.0-2.1build5) ... 169s Setting up libpils2 (1.0.12-20ubuntu3) ... 169s Setting up libsnmp40:ppc64el (5.9.1+dfsg-1ubuntu2.8) ... 169s Setting up libplumb2 (1.0.12-20ubuntu3) ... 169s Setting up libstonith1 (1.0.12-20ubuntu3) ... 169s Setting up liblrm2 (1.0.12-20ubuntu3) ... 169s Setting up cluster-glue (1.0.12-20ubuntu3) ... 169s Adding group `haclient' (GID 116) ... 169s Done. 169s Warning: The home dir /var/lib/pacemaker you specified can't be accessed: No such file or directory 169s Adding system user `hacluster' (UID 111) ... 169s Adding new user `hacluster' (UID 111) with group `haclient' ... 169s ERROR: ld.so: object 'libeatmydata.so' from LD_PRELOAD cannot be preloaded (cannot open shared object file): ignored. 169s Not creating home directory `/var/lib/pacemaker'. 170s Created symlink /etc/systemd/system/multi-user.target.wants/logd.service → /lib/systemd/system/logd.service. 170s Processing triggers for man-db (2.10.2-1) ... 170s Processing triggers for libc-bin (2.35-0ubuntu3.10) ... 173s autopkgtest [09:06:29]: test stonith-null: [----------------------- 173s === list === 173s apcmaster 173s apcmastersnmp 173s apcsmart 173s baytech 173s bladehpi 173s cyclades 173s drac3 173s external/drac5 173s external/dracmc-telnet 173s external/ec2 173s external/hetzner 173s external/hmchttp 173s external/ibmrsa 173s external/ibmrsa-telnet 173s external/ipmi 173s external/ippower9258 173s external/kdumpcheck 173s external/libvirt 173s external/nut 173s external/rackpdu 173s external/riloe 173s external/ssh 173s external/vcenter 173s external/vmware 173s external/xen0 173s external/xen0-ha 173s ibmhmc 173s ipmilan 173s meatware 173s null 173s nw_rpc100s 173s rcd_serial 173s rps10 173s ssh 173s suicide 173s wti_mpc 173s wti_nps 173s 173s === metadata === 173s 173s 173s 173s 1.0 173s 173s Dummy (do-nothing) STONITH device 173s FOR TESTING ONLY! 173s 173s NULL STONITH device 173s 173s 173s Hostlist 173s 173s The list of hosts that the STONITH device controls 173s 173s 173s 173s 173s 173s 173s 173s 173s 173s 173s 2.0 173s 173s 173s 173s === status === 173s Jul 04 09:06:29 autopkgtest stonith: [2141]: debug: null device OK. 173s autopkgtest 173s 173s === reset === 173s Jul 04 09:06:29 autopkgtest stonith: [2142]: info: Host null-reset: autopkgtest 173s autopkgtest [09:06:29]: test stonith-null: -----------------------] 173s stonith-null PASS 173s autopkgtest [09:06:29]: test stonith-null: - - - - - - - - - - results - - - - - - - - - - 174s autopkgtest [09:06:30]: test stonith-suicide: preparing testbed 174s Reading package lists... 174s Building dependency tree... 174s Reading state information... 174s Starting pkgProblemResolver with broken count: 0 174s Starting 2 pkgProblemResolver with broken count: 0 174s Done 174s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 175s autopkgtest [09:06:31]: test stonith-suicide: [----------------------- 175s === list === 175s apcmaster 175s apcmastersnmp 175s apcsmart 175s baytech 175s bladehpi 175s cyclades 175s drac3 175s external/drac5 175s external/dracmc-telnet 175s external/ec2 175s external/hetzner 175s external/hmchttp 175s external/ibmrsa 175s external/ibmrsa-telnet 175s external/ipmi 175s external/ippower9258 175s external/kdumpcheck 175s external/libvirt 175s external/nut 175s external/rackpdu 175s external/riloe 175s external/ssh 175s external/vcenter 175s external/vmware 175s external/xen0 175s external/xen0-ha 175s ibmhmc 175s ipmilan 175s meatware 175s null 175s nw_rpc100s 175s rcd_serial 175s rps10 175s ssh 175s suicide 175s wti_mpc 175s wti_nps 175s 175s === metadata === 175s 175s 175s 175s 1.0 175s 175s Virtual device to reboot/powerdown itself. 175s 175s 175s Suicide STONITH device 175s 175s 175s 175s 175s 175s 175s 175s 175s 175s 2.0 175s 175s 175s 175s === status === 175s Jul 04 09:06:31 autopkgtest stonith: [2288]: debug: suicide device OK. 175s autopkgtest 175s 175s === reset === 175s Killed 176s autopkgtest [09:06:32]: test process requested preparation for reboot with marker fenced 176s autopkgtest-virt-ssh [09:06:32]: state saved, waiting for testbed to reboot... 970s ------- nova console-log 7eed045d-c3b4-4cb7-9c32-171965bc4d71 (adt-jammy-ppc64el-cluster-glue-20250704-082254-juju-7f2275-prod-proposed-migration-environment-23-f1468759-0849-492b-a844-847c05ab948f) ------ 986s 986s 986s SLOF[0m[?25l ********************************************************************** 986s [1mQEMU Starting 986s [0m Build Date = Mar 5 2025 10:48:26 986s FW Version = release 20210711 986s Press "s" to enter Open Firmware. 986s 986s [0m[?25hC0000C0100C0120C0140C0200C0240C0260C02E0C0300C0320C0340C0360C0370C0380C0371C0373C0374C03F0C0400C0480C04C0C04D0C0500Populating /vdevice methods 986s Populating /vdevice/v-scsi@2000 986s SCSI: Looking for devices 986s 8000000000000000 CD-ROM : "QEMU QEMU CD-ROM 2.5+" 986s Populating /vdevice/vty@30000000 986s Populating /vdevice/nvram@71000000 986s C05A0Populating /pci@800000020000000 986s 00 0800 (D) : 1af4 1000 virtio [ net ] 986s 00 1000 (D) : 1b36 000d serial bus [ usb-xhci ] 986s 00 1800 (D) : 1af4 1003 virtio [ serial ] 986s 00 2000 (D) : 1af4 1001 virtio [ block ] 986s 00 2800 (D) : 1af4 1002 legacy-device* 986s 00 3000 (D) : 1af4 1005 legacy-device* 986s 00 3800 (D) : 1234 1111 qemu vga 986s C0600C06C0C0700C0800C0880No NVRAM common partition, re-initializing... 986s C0890C08A0C08A8Installing QEMU fb 986s 986s 986s 986s C08B0Scanning USB 986s XHCI: Initializing 986s USB Keyboard 986s USB mouse 986s C08C0C08D0No console specified using screen & keyboard 986s C08E0C08E8C08FF 986s Welcome to Open Firmware 986s 986s Copyright (c) 2004, 2017 IBM Corporation All rights reserved. 986s This program and the accompanying materials are made available 986s under the terms of the BSD License available at 986s http://www.opensource.org/licenses/bsd-license.php 986s 986s 986s Trying to load: from: /pci@800000020000000/scsi@4 ... Successfully loaded 986s Linux ppc64le 986s #153-Ubuntu SMP [ 0.000000] radix-mmu: Page sizes from device-tree: 986s [ 0.000000] radix-mmu: Page size shift = 12 AP=0x0 986s [ 0.000000] radix-mmu: Page size shift = 16 AP=0x5 986s [ 0.000000] radix-mmu: Page size shift = 21 AP=0x1 986s [ 0.000000] radix-mmu: Page size shift = 30 AP=0x2 986s [ 0.000000] Activating Kernel Userspace Execution Prevention 986s [ 0.000000] Activating Kernel Userspace Access Prevention 986s [ 0.000000] radix-mmu: Mapped 0x0000000000000000-0x0000000002800000 with 2.00 MiB pages (exec) 986s [ 0.000000] radix-mmu: Mapped 0x0000000002800000-0x0000000100000000 with 2.00 MiB pages 986s [ 0.000000] lpar: Using radix MMU under hypervisor 986s [ 0.000000] Linux version 5.15.0-143-generic (buildd@bos03-ppc64el-012) (gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #153-Ubuntu SMP Fri Jun 13 19:14:40 UTC 2025 (Ubuntu 5.15.0-143.153-generic 5.15.180) 986s [ 0.000000] Secure boot mode disabled 986s [ 0.000000] Found initrd at 0xc000000004f00000:0xc000000008bfed2f 986s [ 0.000000] Using pSeries machine description 986s [ 0.000000] Partition configured for 2 cpus. 986s [ 0.000000] CPU maps initialized for 1 thread per core 986s [ 0.000000] numa: Partition configured for 1 NUMA nodes. 986s [ 0.000000] ----------------------------------------------------- 986s [ 0.000000] phys_mem_size = 0x100000000 986s [ 0.000000] dcache_bsize = 0x80 986s [ 0.000000] icache_bsize = 0x80 986s [ 0.000000] cpu_features = 0x0001c06b8f4f9187 986s [ 0.000000] possible = 0x000ffbfbcf5fb187 986s [ 0.000000] always = 0x0000000380008181 986s [ 0.000000] cpu_user_features = 0xdc0065c2 0xaef00000 986s [ 0.000000] mmu_features = 0x3c007641 986s [ 0.000000] firmware_features = 0x00000285455a445f 986s [ 0.000000] vmalloc start = 0xc008000000000000 986s [ 0.000000] IO start = 0xc00a000000000000 986s [ 0.000000] vmemmap start = 0xc00c000000000000 986s [ 0.000000] ----------------------------------------------------- 986s [ 0.000000] numa: NODE_DATA [mem 0xfff68900-0xfff6ffff] 986s [ 0.000000] rfi-flush: fallback displacement flush available 986s [ 0.000000] rfi-flush: ori type flush available 986s [ 0.000000] rfi-flush: mttrig type flush available 986s [ 0.000000] count-cache-flush: hardware flush enabled. 986s [ 0.000000] link-stack-flush: software flush enabled. 986s [ 0.000000] stf-barrier: eieio barrier available 986s [ 0.000000] PPC64 nvram contains 65536 bytes 986s [ 0.000000] barrier-nospec: using ORI speculation barrier 986s [ 0.000000] Zone ranges: 986s [ 0.000000] Normal [mem 0x0000000000000000-0x00000000ffffffff] 986s [ 0.000000] Device empty 986s [ 0.000000] Movable zone start for each node 986s [ 0.000000] Early memory node ranges 986s [ 0.000000] node 0: [mem 0x0000000000000000-0x00000000ffffffff] 986s [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffffffff] 986s [ 0.000000] percpu: Embedded 10 pages/cpu s604184 r0 d51176 u655360 986s [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 65472 986s [ 0.000000] Policy zone: Normal 986s [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinux-5.15.0-143-generic root=UUID=2615bd81-81c5-435c-83db-9c1ce09297e4 ro console=hvc0 earlyprintk 986s [ 0.000000] Unknown kernel command line parameters "earlyprintk BOOT_IMAGE=/boot/vmlinux-5.15.0-143-generic", will be passed to user space. 986s [ 0.000000] Dentry cache hash table entries: 524288 (order: 6, 4194304 bytes, linear) 986s [ 0.000000] Inode-cache hash table entries: 262144 (order: 5, 2097152 bytes, linear) 986s [ 0.000000] mem auto-init: stack:off, heap alloc:on, heap free:off 986s [ 0.000000] Memory: 3989888K/4194304K available (19392K kernel code, 3904K rwdata, 10304K rodata, 7424K init, 2040K bss, 204416K reserved, 0K cma-reserved) 986s [ 0.000000] SLUB: HWalign=128, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 986s [ 0.000000] ftrace: allocating 45165 entries in 17 pages 986s [ 0.000000] ftrace: allocated 17 pages with 2 groups 986s [ 0.000000] trace event string verifier disabled 986s [ 0.000000] rcu: Hierarchical RCU implementation. 986s [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=2048 to nr_cpu_ids=2. 986s [ 0.000000] Rude variant of Tasks RCU enabled. 986s [ 0.000000] Tracing variant of Tasks RCU enabled. 986s [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. 986s [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 986s [ 0.000000] NR_IRQS: 512, nr_irqs: 512, preallocated irqs: 16 986s [ 0.000000] xive: Using IRQ range [0-1] 986s [ 0.000000] xive: Interrupt handling initialized with spapr backend 986s [ 0.000000] xive: Using priority 6 for all interrupts 986s [ 0.000000] xive: Using 64kB queues 986s [ 0.000000] time_init: 56 bit decrementer (max: 7fffffffffffff) 986s [ 0.000003] clocksource: timebase: mask: 0xffffffffffffffff max_cycles: 0x761537d007, max_idle_ns: 440795202126 ns 986s [ 0.000006] clocksource: timebase mult[1f40000] shift[24] registered 986s [ 0.000070] Console: colour dummy device 80x25 986s [ 0.000110] pid_max: default: 32768 minimum: 301 986s [ 0.000190] LSM: Security Framework initializing 986s [ 0.000223] landlock: Up and running. 986s [ 0.000224] Yama: becoming mindful. 986s [ 0.000248] AppArmor: AppArmor initialized 986s [ 0.000309] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) 986s [ 0.000315] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) 986s [ 0.001031] POWER9 performance monitor hardware support registered 986s [ 0.001053] rcu: Hierarchical SRCU implementation. 986s [ 0.002026] smp: Bringing up secondary CPUs ... 986s [ 0.002593] smp: Brought up 1 node, 2 CPUs 986s [ 0.002600] numa: Node 0 CPUs: 0-1 986s [ 0.002979] devtmpfs: initialized 986s [ 0.006291] PCI host bridge /pci@800000020000000 ranges: 986s [ 0.006299] IO 0x0000200000000000..0x000020000000ffff -> 0x0000000000000000 986s [ 0.006303] MEM 0x0000200080000000..0x00002000ffffffff -> 0x0000000080000000 986s [ 0.006306] MEM 0x0000210000000000..0x000021ffffffffff -> 0x0000210000000000 986s [ 0.006327] PCI: OF: PROBE_ONLY disabled 986s [ 0.006359] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns 986s [ 0.006379] futex hash table entries: 512 (order: 0, 65536 bytes, linear) 986s [ 0.006462] pinctrl core: initialized pinctrl subsystem 986s [ 0.006770] NET: Registered PF_NETLINK/PF_ROUTE protocol family 986s [ 0.006866] audit: initializing netlink subsys (disabled) 986s [ 0.006971] audit: type=2000 audit(1751619934.004:1): state=initialized audit_enabled=0 res=1 986s [ 0.007086] thermal_sys: Registered thermal governor 'fair_share' 986s [ 0.007089] thermal_sys: Registered thermal governor 'bang_bang' 986s [ 0.007091] thermal_sys: Registered thermal governor 'step_wise' 986s [ 0.007092] thermal_sys: Registered thermal governor 'user_space' 986s [ 0.007094] thermal_sys: Registered thermal governor 'power_allocator' 986s [ 0.007110] cpuidle: using governor ladder 986s [ 0.007115] cpuidle: using governor menu 986s [ 0.007226] pstore: Registered nvram as persistent store backend 986s [ 0.008130] EEH: pSeries platform initialized 986s [ 0.009779] software IO TLB: tearing down default memory pool 986s [ 0.009901] PCI: Probing PCI hardware 986s [ 0.010057] PCI host bridge to bus 0000:00 986s [ 0.010061] pci_bus 0000:00: root bus resource [io 0x10000-0x1ffff] (bus address [0x0000-0xffff]) 986s [ 0.010065] pci_bus 0000:00: root bus resource [mem 0x200080000000-0x2000ffffffff] (bus address [0x80000000-0xffffffff]) 986s [ 0.010069] pci_bus 0000:00: root bus resource [bus 00-ff] 986s [ 0.010072] pci_bus 0000:00: root bus resource [mem 0x210000000000-0x21ffffffffff 64bit] 986s [ 0.010186] pci 0000:00:01.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled. 986s [ 0.010601] pci 0000:00:02.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled. 986s [ 0.010852] pci 0000:00:03.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled. 986s [ 0.011279] pci 0000:00:04.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled. 986s [ 0.011696] pci 0000:00:05.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled. 986s [ 0.012088] pci 0000:00:06.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled. 986s [ 0.012432] pci 0000:00:07.0: No hypervisor support for SR-IOV on this device, IOV BARs disabled. 986s [ 0.015046] IOMMU table initialized, virtual merging enabled 986s [ 0.015404] pci_bus 0000:00: resource 4 [io 0x10000-0x1ffff] 986s [ 0.015407] pci_bus 0000:00: resource 5 [mem 0x200080000000-0x2000ffffffff] 986s [ 0.015410] pci_bus 0000:00: resource 6 [mem 0x210000000000-0x21ffffffffff 64bit] 986s [ 0.015416] pci 0000:00:01.0: Adding to iommu group 0 986s [ 0.015617] pci 0000:00:02.0: Adding to iommu group 0 986s [ 0.015701] pci 0000:00:03.0: Adding to iommu group 0 986s [ 0.015895] pci 0000:00:04.0: Adding to iommu group 0 986s [ 0.016079] pci 0000:00:05.0: Adding to iommu group 0 986s [ 0.016269] pci 0000:00:06.0: Adding to iommu group 0 986s [ 0.016413] pci 0000:00:07.0: Adding to iommu group 0 986s [ 0.016444] EEH: No capable adapters found: recovery disabled. 986s [ 0.017946] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. 986s [ 0.018679] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages 986s [ 0.018682] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages 986s [ 0.024763] iommu: Default domain type: Translated 986s [ 0.024766] iommu: DMA domain TLB invalidation policy: strict mode 986s [ 0.024958] SCSI subsystem initialized 986s [ 0.025134] pci 0000:00:07.0: vgaarb: VGA device added: decodes=io+mem,owns=mem,locks=none 986s [ 0.025138] pci 0000:00:07.0: vgaarb: bridge control possible 986s [ 0.025146] pci 0000:00:07.0: vgaarb: setting as boot device (VGA legacy resources not available) 986s [ 0.025148] vgaarb: loaded 986s [ 0.025182] usbcore: registered new interface driver usbfs 986s [ 0.025191] usbcore: registered new interface driver hub 986s [ 0.025198] usbcore: registered new device driver usb 986s [ 0.025219] pps_core: LinuxPPS API ver. 1 registered 986s [ 0.025221] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 986s [ 0.025225] PTP clock support registered 986s [ 0.025308] EDAC MC: Ver: 3.0.0 986s [ 0.025729] NetLabel: Initializing 986s [ 0.025731] NetLabel: domain hash size = 128 986s [ 0.025732] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO 986s [ 0.025747] NetLabel: unlabeled traffic allowed by default 986s [ 0.025906] clocksource: Switched to clocksource timebase 986s [ 0.045148] VFS: Disk quotas dquot_6.6.0 986s [ 0.045174] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes) 986s [ 0.045316] AppArmor: AppArmor Filesystem Enabled 986s [ 0.048431] NET: Registered PF_INET protocol family 986s [ 0.048494] IP idents hash table entries: 65536 (order: 3, 524288 bytes, linear) 986s [ 0.049303] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear) 986s [ 0.049326] Table-perturb hash table entries: 65536 (order: 2, 262144 bytes, linear) 986s [ 0.049345] TCP established hash table entries: 32768 (order: 2, 262144 bytes, linear) 986s [ 0.049432] TCP bind hash table entries: 32768 (order: 3, 524288 bytes, linear) 986s [ 0.049462] TCP: Hash tables configured (established 32768 bind 32768) 986s [ 0.049512] MPTCP token hash table entries: 4096 (order: 0, 98304 bytes, linear) 986s [ 0.049531] UDP hash table entries: 2048 (order: 0, 65536 bytes, linear) 986s [ 0.049543] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes, linear) 986s [ 0.049579] NET: Registered PF_UNIX/PF_LOCAL protocol family 986s [ 0.049585] NET: Registered PF_XDP protocol family 986s [ 0.049877] PCI: CLS 0 bytes, default 128 986s [ 0.049932] Trying to unpack rootfs image as initramfs... 986s [ 0.054855] vas: HCALL(398) error -2, query_type 0, result buffer 0x3fc7000 986s [ 0.055180] Initialise system trusted keyrings 986s [ 0.055218] Key type blacklist registered 986s [ 0.055591] workingset: timestamp_bits=38 max_order=16 bucket_order=0 986s [ 0.056967] zbud: loaded 986s [ 0.057422] squashfs: version 4.0 (2009/01/31) Phillip Lougher 986s [ 0.057643] fuse: init (API version 7.34) 986s [ 0.057803] integrity: Platform Keyring initialized 986s [ 0.079643] Key type asymmetric registered 986s [ 0.079650] Asymmetric key parser 'x509' registered 986s [ 0.079681] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) 986s [ 0.079725] io scheduler mq-deadline registered 986s [ 0.080381] Using unsupported 800x600 (null) at 200081000000, depth=32, pitch=3200 986s [ 0.080425] fbcon: Deferring console take-over 986s [ 0.080426] fb0: Open Firmware frame buffer device on /pci@800000020000000/vga@7 986s [ 0.080479] virtio-pci 0000:00:01.0: enabling device (0100 -> 0103) 986s [ 0.081255] virtio-pci 0000:00:01.0: ibm,query-pe-dma-windows(2026) 800 8000000 20000000 returned 0 986s [ 0.081523] virtio-pci 0000:00:01.0: ibm,create-pe-dma-window(2027) 800 8000000 20000000 18 20 returned 0 (liobn = 0x80000001 starting addr = 8000000 0) 986s [ 0.082301] virtio-pci 0000:00:03.0: enabling device (0100 -> 0103) 986s [ 0.083563] virtio-pci 0000:00:04.0: enabling device (0100 -> 0103) 986s [ 0.084879] virtio-pci 0000:00:05.0: enabling device (0100 -> 0103) 986s [ 0.086038] virtio-pci 0000:00:06.0: enabling device (0100 -> 0103) 986s [ 0.094106] printk: console [hvc0] enabled 986s [ 0.094161] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled 986s [ 0.240110] Non-volatile memory driver v1.3 986s [ 0.240162] Linux agpgart interface v0.103 986s [ 0.241724] loop: module loaded 986s [ 0.242041] tun: Universal TUN/TAP device driver, 1.6 986s [ 0.242115] PPP generic driver version 2.4.2 986s [ 0.242179] VFIO - User Level meta-driver version: 0.3 986s [ 0.242271] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver 986s [ 0.242307] ehci-pci: EHCI PCI platform driver 986s [ 0.242335] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver 986s [ 0.242363] ohci-pci: OHCI PCI platform driver 986s [ 0.242391] uhci_hcd: USB Universal Host Controller Interface driver 986s [ 0.242494] mousedev: PS/2 mouse device common for all mice 986s [ 0.242596] rtc-generic rtc-generic: registered as rtc0 986s [ 0.242630] rtc-generic rtc-generic: setting system clock to 2025-07-04T09:05:35 UTC (1751619935) 986s [ 0.242676] i2c_dev: i2c /dev entries driver 986s [ 0.242750] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. 986s [ 0.242821] device-mapper: uevent: version 1.0.3 986s [ 0.242883] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com 986s [ 0.243137] ledtrig-cpu: registered to indicate activity on CPUs 986s [ 0.243193] drop_monitor: Initializing network drop monitor service 986s [ 0.243364] NET: Registered PF_INET6 protocol family 986s [ 0.459655] Freeing initrd memory: 62400K 986s [ 0.463642] Segment Routing with IPv6 986s [ 0.463690] In-situ OAM (IOAM) with IPv6 986s [ 0.463732] NET: Registered PF_PACKET protocol family 986s [ 0.463819] Key type dns_resolver registered 986s [ 0.463867] secvar-sysfs: secvar: failed to retrieve secvar operations. 986s [ 0.463898] drmem: No dynamic reconfiguration memory found 986s [ 0.464135] registered taskstats version 1 986s [ 0.464233] Loading compiled-in X.509 certificates 986s [ 0.464979] Loaded X.509 cert 'Build time autogenerated kernel key: 947b354868022ab50808553ad9c19753f39d5eb2' 986s [ 0.465615] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing 2025 Kmod: d541cef61dc7e793b7eb7e899970a2eef0b5dc8c' 986s [ 0.466285] Loaded X.509 cert 'Canonical Ltd. Live Patch Signing: 14df34d1a87cf37625abec039ef2bf521249b969' 986s [ 0.466935] Loaded X.509 cert 'Canonical Ltd. Kernel Module Signing: 88f752e560a1e0737e31163a466ad7b70a850c19' 986s [ 0.466980] blacklist: Loading compiled-in revocation X.509 certificates 986s [ 0.467023] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing: 61482aa2830d0ab2ad5af10b7250da9033ddcef0' 986s [ 0.467080] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2017): 242ade75ac4a15e50d50c84b0d45ff3eae707a03' 986s [ 0.467137] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (ESM 2018): 365188c1d374d6b07c3c8f240f8ef722433d6a8b' 986s [ 0.467204] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2019): c0746fd6c5da3ae827864651ad66ae47fe24b3e8' 986s [ 0.467265] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v1): a8d54bbb3825cfb94fa13c9f8a594a195c107b8d' 986s [ 0.467323] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v2): 4cf046892d6fd3c9a5b03f98d845f90851dc6a8c' 986s [ 0.467379] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (2021 v3): 100437bb6de6e469b581e61cd66bce3ef4ed53af' 986s [ 0.467435] Loaded X.509 cert 'Canonical Ltd. Secure Boot Signing (Ubuntu Core 2019): c1d57b8f6b743f23ee41f4f7ee292f06eecadfb9' 986s [ 0.467575] zswap: loaded using pool lzo/zbud 986s [ 0.467809] Key type .fscrypt registered 986s [ 0.467829] Key type fscrypt-provisioning registered 986s [ 0.467909] pstore: Using crash dump compression: deflate 986s [ 0.469528] Key type encrypted registered 986s [ 0.469551] AppArmor: AppArmor sha1 policy hashing enabled 986s [ 0.469588] Secure boot mode disabled 986s [ 0.469606] ima: No TPM chip found, activating TPM-bypass! 986s [ 0.469631] Loading compiled-in module X.509 certificates 986s [ 0.470288] Loaded X.509 cert 'Build time autogenerated kernel key: 947b354868022ab50808553ad9c19753f39d5eb2' 986s [ 0.470335] ima: Allocated hash algorithm: sha256 986s [ 0.470374] Secure boot mode disabled 986s [ 0.470397] Trusted boot mode disabled 986s [ 0.470414] ima: No architecture policies found 986s [ 0.470446] evm: Initialising EVM extended attributes: 986s [ 0.470468] evm: security.selinux 986s [ 0.470485] evm: security.SMACK64 986s [ 0.470502] evm: security.SMACK64EXEC 986s [ 0.470519] evm: security.SMACK64TRANSMUTE 986s [ 0.470535] evm: security.SMACK64MMAP 986s [ 0.470552] evm: security.apparmor 986s [ 0.470568] evm: security.ima 986s [ 0.470585] evm: security.capability 986s [ 0.470602] evm: HMAC attrs: 0x1 986s [ 0.471061] clk: Disabling unused clocks 986s [ 0.471139] integrity: Unable to open file: /etc/keys/x509_evm.der (-2) 986s [ 0.472589] Freeing unused kernel image (initmem) memory: 7424K 986s [ 0.473282] Checked W+X mappings: passed, no W+X pages found 986s [ 0.473314] Run /init as init process 986s Loading, please wait... 986s Starting version 249.11-0ubuntu3.16 986s [ 0.590975] virtio_blk virtio2: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB) 986s [ 0.605071] xhci_hcd 0000:00:02.0: xHCI Host Controller 986s [ 0.605109] xhci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 1 986s [ 0.605490] xhci_hcd 0000:00:02.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 986s [ 0.611461] xhci_hcd 0000:00:02.0: xHCI Host Controller 986s [ 0.611503] xhci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 2 986s [ 0.611553] xhci_hcd 0000:00:02.0: Host supports USB 3.0 SuperSpeed 986s [ 0.611736] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 986s [ 0.611790] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 986s [ 0.611835] usb usb1: Product: xHCI Host Controller 986s [ 0.611867] usb usb1: Manufacturer: Linux 5.15.0-143-generic xhci-hcd 986s [ 0.611905] usb usb1: SerialNumber: 0000:00:02.0 986s [ 0.613675] hub 1-0:1.0: USB hub found 986s [ 0.613840] hub 1-0:1.0: 4 ports detected 986s [ 0.617062] random: crng init done 986s [ 0.624271] vda: vda1 vda2 986s [ 0.626326] ibmvscsi 2000: SRP_VERSION: 16.a 986s [ 0.626414] ibmvscsi 2000: Maximum ID: 64 Maximum LUN: 32 Maximum Channel: 3 986s [ 0.626451] scsi host0: IBM POWER Virtual SCSI Adapter 1.5.9 986s [ 0.626615] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. 986s [ 0.626680] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.15 986s [ 0.626715] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 986s [ 0.626748] usb usb2: Product: xHCI Host Controller 986s [ 0.626771] usb usb2: Manufacturer: Linux 5.15.0-143-generic xhci-hcd 986s [ 0.626799] usb usb2: SerialNumber: 0000:00:02.0 986s [ 0.626826] ibmvscsi 2000: partner initialization complete 986s [ 0.626878] ibmvscsi 2000: host srp version: 16.a, host partition qemu (0), OS 2, max io 2097152 986s [ 0.626923] ibmvscsi 2000: sent SRP login 986s [ 0.626941] ibmvscsi 2000: SRP_LOGIN succeeded 986s [ 0.627032] hub 2-0:1.0: USB hub found 986s [ 0.627071] scsi 0:0:0:0: CD-ROM QEMU QEMU CD-ROM 2.5+ PQ: 0 ANSI: 5 986s [ 0.627106] hub 2-0:1.0: 4 ports detected 986s [ 0.680201] sr 0:0:0:0: Power-on or device reset occurred 986s [ 0.680313] sr 0:0:0:0: [sr0] scsi3-mmc drive: 16x/50x cd/rw xa/form2 cdda tray 986s [ 0.680352] cdrom: Uniform CD-ROM driver Revision: 3.20 986s [ 0.680892] sr 0:0:0:0: Attached scsi generic sg0 type 5 986s [ 0.682105] virtio_net virtio0 enp0s1: renamed from eth0 986s Begin: Loading essential drivers ... done. 986s Begin: Running /scripts/init-premount ... done. 986s Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. 986s Begin: Running /scripts/local-premount ... [ 0.833920] raid6: vpermxor8 gen() 21878 MB/s 986s [ 0.901918] raid6: vpermxor4 gen() 18955 MB/s 986s [ 0.961927] usb 1-1: new high-speed USB device number 2 using xhci_hcd 986s [ 0.969936] raid6: vpermxor2 gen() 15146 MB/s 986s [ 1.037927] raid6: vpermxor1 gen() 12949 MB/s 986s [ 1.105920] raid6: altivecx8 gen() 13863 MB/s 986s [ 1.110313] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 986s [ 1.110358] usb 1-1: New USB device strings: Mfr=1, Product=4, SerialNumber=11 986s [ 1.110392] usb 1-1: Product: QEMU USB Keyboard 986s [ 1.110414] usb 1-1: Manufacturer: QEMU 986s [ 1.110432] usb 1-1: SerialNumber: 68284-pci@800000020000000:02.0-1 986s [ 1.124436] hid: raw HID events driver (C) Jiri Kosina 986s [ 1.133467] usbcore: registered new interface driver usbhid 986s [ 1.133497] usbhid: USB HID core driver 986s [ 1.135899] input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:02.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input0 986s [ 1.173937] raid6: altivecx4 gen() 11724 MB/s 986s [ 1.194152] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:02.0-1/input0 986s [ 1.241944] raid6: altivecx2 gen() 10886 MB/s 986s [ 1.249932] usb 1-2: new high-speed USB device number 3 using xhci_hcd 986s [ 1.309971] raid6: altivecx1 gen() 8431 MB/s 986s [ 1.377971] raid6: int64x8 gen() 7371 MB/s 986s [ 1.398326] usb 1-2: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 986s [ 1.398370] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=9 986s [ 1.398404] usb 1-2: Product: QEMU USB Mouse 986s [ 1.398427] usb 1-2: Manufacturer: QEMU 986s [ 1.398444] usb 1-2: SerialNumber: 89126-pci@800000020000000:02.0-2 986s [ 1.399157] input: QEMU QEMU USB Mouse as /devices/pci0000:00/0000:00:02.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input1 986s [ 1.399277] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Mouse] on usb-0000:00:02.0-2/input0 986s [ 1.445964] raid6: int64x8 xor() 4400 MB/s 986s [ 1.513970] raid6: int64x4 gen() 8460 MB/s 986s [ 1.581958] raid6: int64x4 xor() 4127 MB/s 986s [ 1.649974] raid6: int64x2 gen() 6316 MB/s 986s [ 1.717983] raid6: int64x2 xor() 3046 MB/s 986s [ 1.785950] raid6: int64x1 gen() 4962 MB/s 986s [ 1.853931] raid6: int64x1 xor() 2528 MB/s 986s [ 1.853971] raid6: using algorithm vpermxor8 gen() 21878 MB/s 986s [ 1.853998] raid6: using intx1 recovery algorithm 986s [ 1.864837] xor: measuring software checksum speed 986s [ 1.865046] 8regs : 18312 MB/sec 986s [ 1.865271] 8regs_prefetch : 16400 MB/sec 986s [ 1.865473] 32regs : 18479 MB/sec 986s [ 1.865727] 32regs_prefetch : 14245 MB/sec 986s [ 1.865901] altivec : 21932 MB/sec 986s [ 1.865929] xor: using function: altivec (21932 MB/sec) 986s [ 2.021578] Btrfs loaded, crc32c=crc32c-vpmsum, zoned=yes, fsverity=yes 986s Scanning for Btrfs filesystems 986s done. 986s Begin: Will now check root file system ... fsck from util-linux 2.37.2 986s [/usr/sbin/fsck.ext4 (1) -- /dev/vda1] fsck.ext4 -a -C0 /dev/vda1 986s cloudimg-rootfs: clean, 73632/2552320 files, 877482/5240560 blocks 986s done. 986s [ 2.085384] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. 986s done. 986s Begin: Running /scripts/local-bottom ... done. 986s Begin: Running /scripts/init-bottom ... done. 986s [ 2.262246] systemd[1]: Inserted module 'autofs4' 986s [ 2.292255] systemd[1]: systemd 249.11-0ubuntu3.16 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) 986s [ 2.292452] systemd[1]: Detected virtualization kvm. 986s [ 2.292486] systemd[1]: Detected architecture ppc64-le. 986s 986s Welcome to [1mUbuntu 22.04.5 LTS[0m! 986s 986s [ 2.295056] systemd[1]: Hostname set to . 986s [ 2.414876] systemd[1]: Configuration file /run/systemd/system/netplan-ovs-cleanup.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway. 986s [ 2.617101] systemd[1]: Queued start job for default target Graphical Interface. 986s [ 2.618105] systemd[1]: Created slice Slice /system/autopkgtest. 986s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/autopkgtest[0m. 986s [ 2.618685] systemd[1]: Created slice Slice /system/modprobe. 986s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/modprobe[0m. 986s [ 2.619155] systemd[1]: Created slice Slice /system/serial-getty. 986s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/serial-getty[0m. 986s [ 2.619563] systemd[1]: Created slice User and Session Slice. 986s [[0;32m OK [0m] Created slice [0;1;39mUser and Session Slice[0m. 986s [ 2.619852] systemd[1]: Started Forward Password Requests to Wall Directory Watch. 986s [[0;32m OK [0m] Started [0;1;39mForward Password R���uests to Wall Directory Watch[0m. 986s [ 2.620206] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. 986s [[0;32m OK [0m] Set up automount [0;1;39mArbitrary���s File System Automount Point[0m. 986s [ 2.620440] systemd[1]: Reached target Remote File Systems. 986s [[0;32m OK [0m] Reached target [0;1;39mRemote File Systems[0m. 986s [ 2.620597] systemd[1]: Reached target Slice Units. 986s [[0;32m OK [0m] Reached target [0;1;39mSlice Units[0m. 986s [ 2.620767] systemd[1]: Reached target Swaps. 986s [[0;32m OK [0m] Reached target [0;1;39mSwaps[0m. 986s [ 2.620918] systemd[1]: Reached target Local Verity Protected Volumes. 986s [[0;32m OK [0m] Reached target [0;1;39mLocal Verity Protected Volumes[0m. 986s [ 2.621219] systemd[1]: Listening on multipathd control socket. 986s [[0;32m OK [0m] Listening on [0;1;39mmultipathd control socket[0m. 986s [ 2.621485] systemd[1]: Listening on Syslog Socket. 986s [[0;32m OK [0m] Listening on [0;1;39mSyslog Socket[0m. 986s [ 2.621726] systemd[1]: Listening on fsck to fsckd communication Socket. 986s [[0;32m OK [0m] Listening on [0;1;39mfsck to fsckd communication Socket[0m. 986s [ 2.621930] systemd[1]: Listening on initctl Compatibility Named Pipe. 986s [[0;32m OK [0m] Listening on [0;1;39minitctl Compatibility Named Pipe[0m. 986s [ 2.622310] systemd[1]: Listening on Journal Audit Socket. 986s [[0;32m OK [0m] Listening on [0;1;39mJournal Audit Socket[0m. 986s [ 2.622564] systemd[1]: Listening on Journal Socket (/dev/log). 986s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket (/dev/log)[0m. 986s [ 2.622853] systemd[1]: Listening on Journal Socket. 986s [[0;32m OK [0m] Listening on [0;1;39mJournal Socket[0m. 986s [ 2.623118] systemd[1]: Listening on Network Service Netlink Socket. 986s [[0;32m OK [0m] Listening on [0;1;39mNetwork Service Netlink Socket[0m. 986s [ 2.623416] systemd[1]: Listening on udev Control Socket. 986s [[0;32m OK [0m] Listening on [0;1;39mudev Control Socket[0m. 986s [ 2.623706] systemd[1]: Listening on udev Kernel Socket. 986s [[0;32m OK [0m] Listening on [0;1;39mudev Kernel Socket[0m. 986s [ 2.624552] systemd[1]: Mounting Huge Pages File System... 986s Mounting [0;1;39mHuge Pages File System[0m... 986s [ 2.625380] systemd[1]: Mounting POSIX Message Queue File System... 986s Mounting [0;1;39mPOSIX Message Queue File System[0m... 986s [ 2.626485] systemd[1]: Mounting Kernel Debug File System... 986s Mounting [0;1;39mKernel Debug File System[0m... 986s [ 2.627315] systemd[1]: Mounting Kernel Trace File System... 986s Mounting [0;1;39mKernel Trace File System[0m... 986s [ 2.628889] systemd[1]: Starting Journal Service... 986s Starting [0;1;39mJournal Service[0m... 986s [ 2.632452] systemd[1]: Starting Set the console keyboard layout... 986s Starting [0;1;39mSet the console keyboard layout[0m... 986s [ 2.633585] systemd[1]: Starting Create List of Static Device Nodes... 986s Starting [0;1;39mCreate List of Static Device Nodes[0m... 986s [ 2.633811] systemd[1]: Condition check resulted in LXD - agent being skipped. 986s [ 2.634707] systemd[1]: Starting Load Kernel Module configfs... 986s Starting [0;1;39mLoad Kernel Module configfs[0m... 986s [ 2.635786] systemd[1]: Starting Load Kernel Module drm... 986s Starting [0;1;39mLoad Kernel Module drm[0m... 986s [ 2.636725] systemd[1]: Starting Load Kernel Module efi_pstore... 986s Starting [0;1;39mLoad Kernel Module efi_pstore[0m... 986s [ 2.638724] systemd[1]: Starting Load Kernel Module fuse... 986s Starting [0;1;39mLoad Kernel Module fuse[0m... 986s [ 2.640393] systemd[1]: Condition check resulted in OpenVSwitch configuration for cleanup being skipped. 986s [ 2.640556] systemd[1]: Condition check resulted in File System Check on Root Device being skipped. 986s [ 2.662100] systemd[1]: Starting Load Kernel Modules... 986s Starting [0;1;39mLoad Kernel Modules[0m... 986s [ 2.663277] systemd[1]: Starting Remount Root and Kernel File Systems... 986s Starting [0;1;39mRemount Root and Kernel File Systems[0m... 986s [ 2.664254] systemd[1]: Starting Coldplug All udev Devices... 986s Starting [0;1;39mColdplug All udev Devices[0m... 986s [ 2.665889] systemd[1]: Mounted Huge Pages File System. 986s [[0;32m OK [0m] Mounted [0;1;39mHuge Pages File System[0m. 986s [ 2.666271] systemd[1]: Mounted POSIX Message Queue File System. 986s [[0;32m OK [0m] Mounted [0;1;39mPOSIX Message Queue File System[0m. 986s [ 2.666553] systemd[1]: Mounted Kernel Debug File System. 986s [[0;32m OK [0m] Mounted [0;1;39mKernel Debug File System[0m. 986s [ 2.666800] systemd[1]: Mounted Kernel Trace File System. 986s [[0;32m OK [0m] Mounted [0;1;39mKernel Trace File System[0m. 986s [ 2.667259] systemd[1]: Finished Create List of Static Device Nodes. 986s [[0;32m OK [0m] Finished [0;1;39mCreate List of Static Device Nodes[0m. 986s [ 2.667748] systemd[1]: modprobe@configfs.service: Deactivated successfully. 986s [ 2.668067] systemd[1]: Finished Load Kernel Module configfs. 986s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module configfs[0m. 986s [ 2.668584] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. 986s [ 2.668874] systemd[1]: Finished Load Kernel Module efi_pstore. 986s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module efi_pstore[0m. 986s [ 2.669375] systemd[1]: modprobe@fuse.service: Deactivated successfully. 986s [ 2.669662] systemd[1]: Finished Load Kernel Module fuse. 986s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module fuse[0m. 986s [ 2.670640] systemd[1]: Mounting FUSE Control File System... 986s Mounting [0;1;39mFUSE Control File System[0m... 986s [ 2.671496] systemd[1]: Mounting Kernel Configuration File System... 986s Mounting [0;1;39mKernel Configuration File System[0m... 986s [ 2.672335] systemd[1]: Mounted FUSE Control File System. 986s [[0;32m OK [0m] Mounted [0;1;39mFUSE Control File System[0m. 986s [ 2.673267] systemd[1]: Mounted Kernel Configuration File System. 986s [[0;32m OK [0m] Mounted [0;1;39mKernel Configuration File System[0m. 986s [ 2.698633] systemd[1]: Finished Load Kernel Modules. 986s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Modules[0m. 986s [ 2.706117] systemd[1]: Starting Apply Kernel Variables... 986s Starting [0;1;39mApply Kernel Variables[0m... 986s [ 2.729784] systemd[1]: Started Journal Service. 986s [[0;32m OK [0m] Started [0;1;39mJournal Service[0m. 986s [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module drm[0m. 986s [ 2.750061] EXT4-fs (vda1): re-mounted. Opts: discard,errors=remount-ro. Quota mode: none. 986s [[0;32m OK [0m] Finished [0;1;39mRemount Root and Kernel File Systems[0m. 986s Starting [0;1;39mCloud-init: Local Stage (pre-network)[0m... 986s Starting [0;1;39mDevice-Mapper Multipath Device Controller[0m... 986s Starting [0;1;39mFlush Journal to Persistent Storage[0m... 986s Starting [0;1;39mLoad/Save Random Seed[0m... 986s Starting [0;1;39mCreate System Users[0m... 986s [[0;32m OK [0m] Finished [0;1;39mSet the console keyboard layout[0m. 986s [ 2.825305] alua: device handler registered 986s [ 2.827588] emc: device handler registered 986s [[0;32m OK [0m] Finished [0;1;39mApply Kernel Variables[0m. 986s [[0;32m OK [0m] Finished [0;1;39mCreate System Users[0m. 986s Starting [0;1;39mCreate Static Device Nodes in /dev[0m... 986s [[0;32m OK [0m] Finished [0;1;39mColdplug All udev Devices[0m. 986s [[0;32m OK [0m] Finished [0;1;39mCreate Static Device Nodes in /dev[0m. 986s Starting [0;1;39mRule-based Manage���for Device Events and Files[0m... 986s [[0;32m OK [0m] Finished [0;1;39mLoad/Save Random Seed[0m. 986s [[0;32m OK [0m] Finished [0;1;39mFlush Journal to Persistent Storage[0m. 986s [[0;32m OK [0m] Started [0;1;39mDevice-Mapper Multipath Device Controller[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mPreparation for Local File Systems[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. 986s Starting [0;1;39mLoad AppArmor profiles[0m... 986s Starting [0;1;39mSet console font and keymap[0m... 986s Starting [0;1;39mTell Plymouth To Write Out Runtime Data[0m... 986s Starting [0;1;39mSet Up Additional Binary Formats[0m... 986s Starting [0;1;39mCreate Volatile Files and Directories[0m... 986s Starting [0;1;39mUncomplicated firewall[0m... 986s [[0;32m OK [0m] Finished [0;1;39mSet console font and keymap[0m. 986s [[0;32m OK [0m] Finished [0;1;39mUncomplicated firewall[0m. 986s [[0;32m OK [0m] Started [0;1;39mRule-based Manager for Device Events and Files[0m. 986s [[0;32m OK [0m] Finished [0;1;39mTell Plymouth To Write Out Runtime Data[0m. 986s Mounting [0;1;39mArbitrary Executable File Formats File System[0m... 986s [[0;32m OK [0m] Started [0;1;39mDispatch Password ���ts to Console Directory Watch[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mLocal Encrypted Volumes[0m. 986s [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. 986s Starting [0;1;39mNetwork Time Synchronization[0m... 986s Starting [0;1;39mRecord System Boot/Shutdown in UTMP[0m... 986s [[0;32m OK [0m] Finished [0;1;39mRecord System Boot/Shutdown in UTMP[0m. 986s [[0;32m OK [0m] Mounted [0;1;39mArbitrary Executable File Formats File System[0m. 986s [[0;32m OK [0m] Finished [0;1;39mSet Up Additional Binary Formats[0m. 986s [[0;32m OK [0m] Finished [0;1;39mLoad AppArmor profiles[0m. 986s [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. 986s [[0;32m OK [0m] Listening on [0;1;39mLoad/Save RF ���itch Status /dev/rfkill Watch[0m. 986s [[0;32m OK [0m] Found device [0;1;39m/dev/hvc0[0m. 986s [ 3.817501] cloud-init[527]: Cloud-init v. 25.1.2-0ubuntu0~22.04.2 running 'init-local' at Fri, 04 Jul 2025 09:05:39 +0000. Up 3.78 seconds. 986s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Local Stage (pre-network)[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mPreparation for Network[0m. 986s Starting [0;1;39mNetwork Configuration[0m... 986s [[0;32m OK [0m] Started [0;1;39mNetwork Configuration[0m. 986s Starting [0;1;39mWait for Network to be Configured[0m... 986s Starting [0;1;39mNetwork Name Resolution[0m... 986s [[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. 986s [[0;32m OK [0m] Finished [0;1;39mWait for Network to be Configured[0m. 986s Starting [0;1;39mCloud-init: Network Stage[0m... 986s [ 6.513270] cloud-init[561]: Cloud-init v. 25.1.2-0ubuntu0~22.04.2 running 'init' at Fri, 04 Jul 2025 09:05:41 +0000. Up 6.48 seconds. 986s [ 6.520580] cloud-init[561]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++ 986s [ 6.520787] cloud-init[561]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 986s [ 6.520940] cloud-init[561]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | 986s [ 6.521088] cloud-init[561]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 986s [ 6.521237] cloud-init[561]: ci-info: | enp0s1 | True | 10.151.39.192 | 255.255.255.0 | global | fa:16:3e:4d:3a:64 | 986s [ 6.521393] cloud-init[561]: ci-info: | enp0s1 | True | fe80::f816:3eff:fe4d:3a64/64 | . | link | fa:16:3e:4d:3a:64 | 986s [ 6.521554] cloud-init[561]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | 986s [ 6.521702] cloud-init[561]: ci-info: | lo | True | ::1/128 | . | host | . | 986s [ 6.521849] cloud-init[561]: ci-info: +--------+------+------------------------------+---------------+--------+-------------------+ 986s [ 6.521993] cloud-init[561]: ci-info: ++++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++++ 986s [ 6.522139] cloud-init[561]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 986s [ 6.522283] cloud-init[561]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | 986s [ 6.522427] cloud-init[561]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 986s [ 6.522575] cloud-init[561]: ci-info: | 0 | 0.0.0.0 | 10.151.39.1 | 0.0.0.0 | enp0s1 | UG | 986s [ 6.522720] cloud-init[561]: ci-info: | 1 | 10.151.11.5 | 10.151.39.1 | 255.255.255.255 | enp0s1 | UGH | 986s [ 6.522864] cloud-init[561]: ci-info: | 2 | 10.151.11.6 | 10.151.39.1 | 255.255.255.255 | enp0s1 | UGH | 986s [ 6.523019] cloud-init[561]: ci-info: | 3 | 10.151.11.7 | 10.151.39.1 | 255.255.255.255 | enp0s1 | UGH | 986s [ 6.523168] cloud-init[561]: ci-info: | 4 | 10.151.39.0 | 0.0.0.0 | 255.255.255.0 | enp0s1 | U | 986s [ 6.523327] cloud-init[561]: ci-info: | 5 | 10.151.39.1 | 0.0.0.0 | 255.255.255.255 | enp0s1 | UH | 986s [ 6.523470] cloud-init[561]: ci-info: | 6 | 10.151.39.2 | 0.0.0.0 | 255.255.255.255 | enp0s1 | UH | 986s [ 6.523613] cloud-init[561]: ci-info: | 7 | 169.254.169.254 | 10.151.39.2 | 255.255.255.255 | enp0s1 | UGH | 986s [ 6.523769] cloud-init[561]: ci-info: +-------+-----------------+-------------+-----------------+-----------+-------+ 986s [ 6.523910] cloud-init[561]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ 986s [ 6.524033] cloud-init[561]: ci-info: +-------+-------------+---------+-----------+-------+ 986s [ 6.524159] cloud-init[561]: ci-info: | Route | Destination | Gateway | Interface | Flags | 986s [ 6.524354] cloud-init[561]: ci-info: +-------+-------------+---------+-----------+-------+ 986s [ 6.524515] cloud-init[561]: ci-info: | 1 | fe80::/64 | :: | enp0s1 | U | 986s [ 6.524676] cloud-init[561]: ci-info: | 3 | local | :: | enp0s1 | U | 986s [ 6.524833] cloud-init[561]: ci-info: | 4 | multicast | :: | enp0s1 | U | 986s [ 6.524998] cloud-init[561]: ci-info: +-------+-------------+---------+-----------+-------+ 986s [ 6.611460] cloud-init[561]: 2025-07-04 09:05:41,870 - schema.py[WARNING]: cloud-config failed schema validation! You may run 'sudo cloud-init schema --system' to check the details. 986s [ 7.434245] cloud-init[561]: Generating public/private rsa key pair. 986s [ 7.434505] cloud-init[561]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key 986s [ 7.434641] cloud-init[561]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub 986s [ 7.434773] cloud-init[561]: The key fingerprint is: 986s [ 7.434884] cloud-init[561]: SHA256:WfKiAgd/5IashQ4daT2lshf+a6kGScGyMf0EmGE5/eA root@autopkgtest 986s [ 7.435013] cloud-init[561]: The key's randomart image is: 986s [ 7.435121] cloud-init[561]: +---[RSA 3072]----+ 986s [ 7.435236] cloud-init[561]: |.B+. . | 986s [ 7.435357] cloud-init[561]: |Bo+=.o | 986s [ 7.435461] cloud-init[561]: | =O+B . . . | 986s [ 7.435563] cloud-init[561]: |.o.E.B = | 986s [ 7.435666] cloud-init[561]: |..=.O + S . | 986s [ 7.435768] cloud-init[561]: | oo* + . . | 986s [ 7.435870] cloud-init[561]: | o.. o. | 986s [ 7.435972] cloud-init[561]: | ..o. | 986s [ 7.436074] cloud-init[561]: | ..o. | 986s [ 7.436216] cloud-init[561]: +----[SHA256]-----+ 986s [ 7.436329] cloud-init[561]: Generating public/private ecdsa key pair. 986s [ 7.436448] cloud-init[561]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key 986s [ 7.436575] cloud-init[561]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub 986s [ 7.436723] cloud-init[561]: The key fingerprint is: 986s [ 7.436832] cloud-init[561]: SHA256:AsKH2GOkQ8SqP3RxNUAaNjJzea7/ogDLLAyOkmooJSE root@autopkgtest 986s [ 7.436991] cloud-init[561]: The key's randomart image is: 986s [ 7.437101] cloud-init[561]: +---[ECDSA 256]---+ 986s [ 7.437203] cloud-init[561]: |oo= =oo. | 986s [ 7.437304] cloud-init[561]: |.B B.+. o | 986s [ 7.437406] cloud-init[561]: |= B +o . . | 986s [ 7.437508] cloud-init[561]: |Eo +..o | 986s [ 7.437610] cloud-init[561]: |=. +. S | 986s [ 7.437723] cloud-init[561]: |X+o o . | 986s [ 7.437826] cloud-init[561]: |BX.. . | 986s [ 7.437950] cloud-init[561]: |*.o. o | 986s [ 7.438053] cloud-init[561]: |+ ... o. | 986s [ 7.438155] cloud-init[561]: +----[SHA256]-----+ 986s [ 7.438256] cloud-init[561]: Generating public/private ed25519 key pair. 986s [ 7.438373] cloud-init[561]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key 986s [ 7.438573] cloud-init[561]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub 986s [ 7.438725] cloud-init[561]: The key fingerprint is: 986s [ 7.438836] cloud-init[561]: SHA256:KCkYt4PQEhoZypf25a+QnUq42VzoVDoq7aAoEVo+n7c root@autopkgtest 986s [ 7.438963] cloud-init[561]: The key's randomart image is: 986s [ 7.439069] cloud-init[561]: +--[ED25519 256]--+ 986s [ 7.439172] cloud-init[561]: |+o | 986s [ 7.439275] cloud-init[561]: |=+ . | 986s [ 7.439386] cloud-init[561]: |*.o+ . | 986s [ 7.439488] cloud-init[561]: |o*+...o. | 986s [ 7.439597] cloud-init[561]: |+++ o..oS | 986s [ 7.439699] cloud-init[561]: |o oo..* o | 986s [ 7.439800] cloud-init[561]: | o.+ X + . | 986s [ 7.439927] cloud-init[561]: |+...% * . | 986s [ 7.440030] cloud-init[561]: |+ o= *Eo | 986s [ 7.440132] cloud-init[561]: +----[SHA256]-----+ 986s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Network Stage[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mCloud-config availability[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mNetwork is Online[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. 986s [[0;32m OK [0m] Started [0;1;39mDaily apt download activities[0m. 986s [[0;32m OK [0m] Started [0;1;39mDaily apt upgrade and clean activities[0m. 986s [[0;32m OK [0m] Started [0;1;39mDaily dpkg database backup timer[0m. 986s [[0;32m OK [0m] Started [0;1;39mPeriodic ext4 Onli���ata Check for All Filesystems[0m. 986s [[0;32m OK [0m] Started [0;1;39mDiscard unused blocks once a week[0m. 986s [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. 986s [[0;32m OK [0m] Started [0;1;39mDaily man-db regeneration[0m. 986s [[0;32m OK [0m] Started [0;1;39mMessage of the Day[0m. 986s [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mPath Units[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mTimer Units[0m. 986s [[0;32m OK [0m] Listening on [0;1;39mcloud-init hotplug hook socket[0m. 986s [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. 986s [[0;32m OK [0m] Listening on [0;1;39mUUID daemon activation socket[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mSocket Units[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. 986s Starting [0;1;39mLSB: automatic crash report generation[0m... 986s [[0;32m OK [0m] Started [0;1;39mautopkgtest root shell on hvc1[0m. 986s [[0;32m OK [0m] Started [0;1;39mautopkgtest root shell on ttyS1[0m. 986s Starting [0;1;39mCloud-init: Config Stage[0m... 986s [[0;32m OK [0m] Started [0;1;39mRegular background program processing daemon[0m. 986s [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. 986s [[0;32m OK [0m] Started [0;1;39mSave initial kernel messages after boot[0m. 986s Starting [0;1;39mRemove Stale Onli���t4 Metadata Check Snapshots[0m... 986s Starting [0;1;39mRecord successful boot for GRUB[0m... 986s Starting [0;1;39mIBM Power Raid dump daemon[0m... 986s [[0;32m OK [0m] Started [0;1;39mirqbalance daemon[0m. 986s Starting [0;1;39mDispatcher daemon for systemd-networkd[0m... 986s Starting [0;1;39mPollinate to seed���udo random number generator[0m... 986s Starting [0;1;39mLSB: rng-tools (Debian variant)[0m... 986s Starting [0;1;39mSystem Logging Service[0m... 986s Starting [0;1;39mppc64-diag rtas_e���orm error handling) Service[0m... 986s Starting [0;1;39mUser Login Management[0m... 986s Starting [0;1;39mPermit User Sessions[0m... 986s [[0;32m OK [0m] Finished [0;1;39mRemove Stale Onli���ext4 Metadata Check Snapshots[0m. 986s [[0;32m OK [0m] Started [0;1;39mIBM Power Raid dump daemon[0m. 986s [[0;32m OK [0m] Finished [0;1;39mPermit User Sessions[0m. 986s [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. 986s [[0;32m OK [0m] Started [0;1;39mLSB: automatic crash report generation[0m. 986s [[0;32m OK [0m] Started [0;1;39mLSB: rng-tools (Debian variant)[0m. 986s [[0;32m OK [0m] Started [0;1;39mppc64-diag rtas_er���tform error handling) Service[0m. 986s [[0;32m OK [0m] Finished [0;1;39mRecord successful boot for GRUB[0m. 986s Starting [0;1;39mGRUB failed boot detection[0m... 986s Starting [0;1;39mIBM Power Raid init daemon[0m... 986s Starting [0;1;39mIBM Power Raid update daemon[0m... 986s Starting [0;1;39mHold until boot process finishes up[0m... 986s Starting [0;1;39mTerminate Plymouth Boot Screen[0m... 986s [[0;32m OK [0m] Started [0;1;39mIBM Power Raid init daemon[0m. 986s [[0;32m OK [0m] Started [0;1;39mIBM Power Raid update daemon[0m. 986s [[0;32m OK [0m] Finished [0;1;39mHold until boot process finishes up[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mIBM Power Raid utilities[0m. 986s [[0;32m OK [0m] Started [0;1;39mSerial Getty on hvc0[0m. 986s Starting [0;1;39mSet console scheme[0m... 986s [[0;32m OK [0m] Finished [0;1;39mTerminate Plymouth Boot Screen[0m. 986s [[0;32m OK [0m] Finished [0;1;39mGRUB failed boot detection[0m. 986s [[0;32m OK [0m] Finished [0;1;39mSet console scheme[0m. 986s [[0;32m OK [0m] Created slice [0;1;39mSlice /system/getty[0m. 986s [[0;32m OK [0m] Started [0;1;39mGetty on tty1[0m. 986s [[0;32m OK [0m] Reached target [0;1;39mLogin Prompts[0m. 986s [[0;32m OK [0m] Started [0;1;39mUser Login Management[0m. 986s [[0;32m OK [0m] Started [0;1;39mDispatcher daemon for systemd-networkd[0m. 986s [ 7.941719] cloud-init[714]: Cloud-init v. 25.1.2-0ubuntu0~22.04.2 running 'modules:config' at Fri, 04 Jul 2025 09:05:43 +0000. Up 7.88 seconds. 986s [ 8.238131] cloud-init[714]: 2025-07-04 09:05:43,497 - lifecycle.py[DEPRECATED]: The following config key(s): ['apt_mirror', 'apt_preserve_sources_list'] is deprecated in 22.1 and scheduled to be removed in 27.1. 986s [ 8.238844] cloud-init[714]: 2025-07-04 09:05:43,497 - lifecycle.py[DEPRECATED]: Support for combined old and new apt module keys is deprecated in 22.1 and scheduled to be removed in 27.1. 986s [[0;32m OK [0m] Finished [0;1;39mCloud-init: Config Stage[0m. 986s 986s Ubuntu 22.04.5 LTS autopkgtest hvc0 986s 986s autopkgtest login: [ 16.870651] cloud-init[775]: Cloud-init v. 25.1.2-0ubuntu0~22.04.2 running 'modules:final' at Fri, 04 Jul 2025 09:05:52 +0000. Up 16.80 seconds. 986s [ 17.197896] cloud-init[775]: Hit:1 http://ftpmaster.internal/ubuntu jammy InRelease 986s [ 17.231113] cloud-init[775]: Get:2 http://ftpmaster.internal/ubuntu jammy-updates InRelease [128 kB] 986s [ 17.276853] cloud-init[775]: Get:3 http://ftpmaster.internal/ubuntu jammy-security InRelease [129 kB] 986s [ 17.611688] cloud-init[775]: Fetched 257 kB in 0s (634 kB/s) 986s [ 18.432334] cloud-init[775]: Reading package lists... 986s ci-info: ++++++++++++++++++++++++++++++++++++++++++++++++++++++Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu+++++++++++++++++++++++++++++++++++++++++++++++++++++++ 986s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 986s ci-info: | Keytype | Fingerprint (sha256) | Options | Comment | 986s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 986s ci-info: | ssh-rsa | e8:35:e0:40:84:e9:20:46:36:c3:0d:24:8f:f7:02:62:a2:c6:f7:f5:5c:ed:3f:df:2b:54:8b:69:97:eb:98:5e | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-15 | 986s ci-info: | ssh-rsa | 91:43:c5:c0:08:13:e1:4c:d2:84:a3:93:cc:b6:92:94:24:03:c7:0a:60:b3:34:9d:7f:63:f7:38:37:6f:9d:18 | - | ubuntu@juju-7f2275-prod-proposed-migration-environment-23 | 986s ci-info: +---------+-------------------------------------------------------------------------------------------------+---------+-----------------------------------------------------------+ 986s <14>Jul 4 09:05:53 cloud-init: ############################################################# 986s <14>Jul 4 09:05:53 cloud-init: -----BEGIN SSH HOST KEY FINGERPRINTS----- 986s <14>Jul 4 09:05:53 cloud-init: 256 SHA256:AsKH2GOkQ8SqP3RxNUAaNjJzea7/ogDLLAyOkmooJSE root@autopkgtest (ECDSA) 986s <14>Jul 4 09:05:53 cloud-init: 256 SHA256:KCkYt4PQEhoZypf25a+QnUq42VzoVDoq7aAoEVo+n7c root@autopkgtest (ED25519) 986s <14>Jul 4 09:05:53 cloud-init: 3072 SHA256:WfKiAgd/5IashQ4daT2lshf+a6kGScGyMf0EmGE5/eA root@autopkgtest (RSA) 986s <14>Jul 4 09:05:53 cloud-init: -----END SSH HOST KEY FINGERPRINTS----- 986s <14>Jul 4 09:05:53 cloud-init: ############################################################# 986s -----BEGIN SSH HOST KEY KEYS----- 986s ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBJV6RjYTsRRD9aQrRSCJBybvUi1KDnydUiVUNbejQlRPk0ZurwU/KSCKwIp6AEzkQwhGbrlimqNN1EBGhV8kGEU= root@autopkgtest 986s ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIMtOrYug5XyctbFCuxXKQs7QSE0NWJXzAwqpDRn5q4IH root@autopkgtest 986s ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCyIfDy0JmXWnGW9pXD8MXbn5aVQwp9R4gY/tsHlNhYEe5HEtlF4LxKlJ4GDbD/VLREMNCPnd/ekYGKeo3DmRZO0YhQI/FjcFr2SLzy1+8JgkPbgoaYRIokHe2x2hytFVVjB1VQGRCuomWNEAfBOqXRjBsZQRRQYcGte4OU/Hka5Huak/ZmX1LqNEFpr4ZFBEPmCDPgJ4iCYwed7TqtuDEcDH7xnWu+fSYCnyM3OGPWvjBKkuGDZGvWNBC2KPGNFuVj2ldiV9V9czZu7LVVM4I2jrwjexXKyH1hm9stH5O3HiDit+/ku3GfMSVdHJe3P/+CkEU+cPu86TNNalKROIl14feEQCIJIS9VgDUfFj4+KbFquknnUlD/Py/hdG765JAaCou6Zz7OUezC5n/WGrSc92CRlKK3qmEVlOY8ybTrcYbV62i/ftlFeeLPFgc+igYIMADv36UFUkUTsoxtzDi6RyWO5Z/56PmAeidiult1XmuiORGRjZ+JaLzJA1FXn+c= root@autopkgtest 986s -----END SSH HOST KEY KEYS----- 986s [ 18.493995] cloud-init[775]: Cloud-init v. 25.1.2-0ubuntu0~22.04.2 finished at Fri, 04 Jul 2025 09:05:53 +0000. Datasource DataSourceConfigDrive [net,ver=2][source=/dev/sr0]. Up 18.48 seconds 986s 987s --------------------------------------------------- 987s ------- nova show 7eed045d-c3b4-4cb7-9c32-171965bc4d71 (adt-jammy-ppc64el-cluster-glue-20250704-082254-juju-7f2275-prod-proposed-migration-environment-23-f1468759-0849-492b-a844-847c05ab948f) ------ 1050s +----------------------------------------------+----------------------------------------------------------------------------------------------------------------------------------------------------------+ 1050s | Property | Value | 1050s +----------------------------------------------+----------------------------------------------------------------------------------------------------------------------------------------------------------+ 1050s | OS-DCF:diskConfig | MANUAL | 1050s | OS-EXT-AZ:availability_zone | AZ3 | 1050s | OS-EXT-SRV-ATTR:host | ps7-ra6-power9-n1.ps7.canonical.com | 1050s | OS-EXT-SRV-ATTR:hostname | adt-jammy-ppc64el-cluster-glue-20250704-082254-juju-7f2275-prod | 1050s | OS-EXT-SRV-ATTR:hypervisor_hostname | ps7-ra6-power9-n1.ps7.canonical.com | 1050s | OS-EXT-SRV-ATTR:instance_name | instance-000c9dd8 | 1050s | OS-EXT-SRV-ATTR:kernel_id | | 1050s | OS-EXT-SRV-ATTR:launch_index | 0 | 1050s | OS-EXT-SRV-ATTR:ramdisk_id | | 1050s | OS-EXT-SRV-ATTR:reservation_id | r-iwnwj1nb | 1050s | OS-EXT-SRV-ATTR:root_device_name | /dev/vda | 1050s | OS-EXT-STS:power_state | 1 | 1050s | OS-EXT-STS:task_state | - | 1050s | OS-EXT-STS:vm_state | active | 1050s | OS-SRV-USG:launched_at | 2025-07-04T09:05:25.000000 | 1050s | OS-SRV-USG:terminated_at | - | 1050s | accessIPv4 | | 1050s | accessIPv6 | | 1050s | config_drive | True | 1050s | created | 2025-07-04T09:05:20Z | 1050s | description | - | 1050s | flavor:disk | 20 | 1050s | flavor:ephemeral | 0 | 1050s | flavor:extra_specs | {"aggregate_instance_extra_specs:commit": "ppc64el", "hw:cpu_policy": "shared", "hw:mem_page_size": "large", "hw:pci_numa_affinity_policy": "preferred"} | 1050s | flavor:original_name | autopkgtest-cpu2-ram4-disk20-ppc64el | 1050s | flavor:ram | 4096 | 1050s | flavor:swap | 0 | 1050s | flavor:vcpus | 2 | 1050s | hostId | bdf4a6a4bf2da3f06c090d4b75042084ff97ee373ba238e2ed0bd3dc | 1050s | id | 7eed045d-c3b4-4cb7-9c32-171965bc4d71 | 1050s | image | adt/ubuntu-jammy-ppc64el-server-20250704.img (823b13fa-663c-4fce-ab34-09a1dfb61e0a) | 1050s | key_name | testbed-juju-7f2275-prod-proposed-migration-environment-23 | 1050s | locked | False | 1050s | locked_reason | - | 1050s | metadata | {} | 1050s | name | adt-jammy-ppc64el-cluster-glue-20250704-082254-juju-7f2275-prod-proposed-migration-environment-23-f1468759-0849-492b-a844-847c05ab948f | 1050s | net_prod-autopkgtest-workers-ppc64el network | 10.151.39.192 | 1050s | os-extended-volumes:volumes_attached | [] | 1050s | progress | 0 | 1050s | security_groups | autopkgtest-juju-7f2275-prod-proposed-migration-environment-23@sto01-ppc64el-23.secgroup | 1050s | server_groups | [] | 1050s | status | ACTIVE | 1050s | tags | [] | 1050s | tenant_id | 9bf77f46fd6c4d3da81ee79a717acf43 | 1050s | trusted_image_certificates | - | 1050s | updated | 2025-07-04T09:05:25Z | 1050s | user_id | 20f4f30c2cfd4bfe806cd0db10c0e446 | 1050s +----------------------------------------------+----------------------------------------------------------------------------------------------------------------------------------------------------------+ 1053s --------------------------------------------------- 1098s : failure: timed out waiting for testbed to reboot 1099s autopkgtest [09:21:55]: ERROR: testbed failure: unexpected eof from the testbed