0s autopkgtest [00:33:47]: starting date and time: 2026-01-30 00:33:47+0000 0s autopkgtest [00:33:47]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [00:33:47]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.i4tbh67y/out --timeout-copy=6000 --needs-internet=try --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:rsyslog,src:sphinx-rtd-theme,src:systemd --apt-upgrade stdsyslog --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=rsyslog/8.2512.0-1ubuntu3 sphinx-rtd-theme/3.1.0+dfsg-1 systemd/259-1ubuntu3' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-ppc64el-1.secgroup --name adt-resolute-ppc64el-stdsyslog-20260130-003347-juju-7f2275-prod-proposed-migration-environment-2-d5249622-ef63-4aa6-bded-2222e578f0a1 --image adt/ubuntu-resolute-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-ppc64el-stdsyslog-20260130-003347-juju-7f2275-prod-proposed-migration-environment-2-d5249622-ef63-4aa6-bded-2222e578f0a1 from image adt/ubuntu-resolute-ppc64el-server-20260129.img (UUID 011be5ba-3d23-459d-9a9a-537803b22566)... 51s autopkgtest [00:34:38]: testbed dpkg architecture: ppc64el 51s autopkgtest [00:34:38]: testbed apt version: 3.1.14 51s autopkgtest [00:34:38]: @@@@@@@@@@@@@@@@@@@@ test bed setup 51s autopkgtest [00:34:38]: testbed release detected to be: None 52s autopkgtest [00:34:39]: updating testbed package index (apt update) 52s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 53s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 53s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 53s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 53s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1043 kB] 53s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [25.4 kB] 53s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [103 kB] 53s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [2820 B] 53s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el Packages [117 kB] 53s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el Packages [796 kB] 54s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse ppc64el Packages [16.6 kB] 54s Fetched 2228 kB in 1s (1547 kB/s) 55s Reading package lists... 55s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 55s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 55s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 55s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 56s Reading package lists... 56s Reading package lists... 56s Building dependency tree... 56s Reading state information... 57s Calculating upgrade... 57s The following packages will be upgraded: 57s gcc-15-base libatomic1 libgcc-s1 libnss-systemd libpam-systemd 57s libsgutils2-1.48 libstdc++6 libsystemd-shared libsystemd0 libudev1 rsyslog 57s sg3-utils sg3-utils-udev systemd systemd-cryptsetup systemd-resolved 57s systemd-sysv systemd-userdbd udev 57s 19 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 57s Need to get 12.8 MB of archives. 57s After this operation, 2048 B disk space will be freed. 57s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el systemd-userdbd ppc64el 259-1ubuntu3 [54.6 kB] 57s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libnss-systemd ppc64el 259-1ubuntu3 [347 kB] 57s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libsystemd0 ppc64el 259-1ubuntu3 [703 kB] 57s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el systemd-sysv ppc64el 259-1ubuntu3 [9250 B] 57s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el systemd-resolved ppc64el 259-1ubuntu3 [344 kB] 57s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libpam-systemd ppc64el 259-1ubuntu3 [372 kB] 57s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libsystemd-shared ppc64el 259-1ubuntu3 [2884 kB] 57s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el systemd ppc64el 259-1ubuntu3 [3301 kB] 58s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el systemd-cryptsetup ppc64el 259-1ubuntu3 [133 kB] 58s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el udev ppc64el 259-1ubuntu3 [1505 kB] 58s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libudev1 ppc64el 259-1ubuntu3 [252 kB] 58s Get:12 http://ftpmaster.internal/ubuntu resolute/main ppc64el libatomic1 ppc64el 15.2.0-12ubuntu1 [11.0 kB] 58s Get:13 http://ftpmaster.internal/ubuntu resolute/main ppc64el libstdc++6 ppc64el 15.2.0-12ubuntu1 [922 kB] 58s Get:14 http://ftpmaster.internal/ubuntu resolute/main ppc64el gcc-15-base ppc64el 15.2.0-12ubuntu1 [59.6 kB] 58s Get:15 http://ftpmaster.internal/ubuntu resolute/main ppc64el libgcc-s1 ppc64el 15.2.0-12ubuntu1 [40.2 kB] 58s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el rsyslog ppc64el 8.2512.0-1ubuntu3 [679 kB] 58s Get:17 http://ftpmaster.internal/ubuntu resolute/main ppc64el libsgutils2-1.48 ppc64el 1.48-3ubuntu2 [143 kB] 58s Get:18 http://ftpmaster.internal/ubuntu resolute/main ppc64el sg3-utils ppc64el 1.48-3ubuntu2 [1080 kB] 58s Get:19 http://ftpmaster.internal/ubuntu resolute/main ppc64el sg3-utils-udev all 1.48-3ubuntu2 [6610 B] 58s dpkg-preconfigure: unable to re-open stdin: No such file or directory 58s Fetched 12.8 MB in 1s (9666 kB/s) 59s (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 ... 120856 files and directories currently installed.) 59s Preparing to unpack .../systemd-userdbd_259-1ubuntu3_ppc64el.deb ... 59s Unpacking systemd-userdbd (259-1ubuntu3) over (259-1ubuntu2) ... 59s Preparing to unpack .../libnss-systemd_259-1ubuntu3_ppc64el.deb ... 59s Unpacking libnss-systemd:ppc64el (259-1ubuntu3) over (259-1ubuntu2) ... 60s Preparing to unpack .../libsystemd0_259-1ubuntu3_ppc64el.deb ... 60s Unpacking libsystemd0:ppc64el (259-1ubuntu3) over (259-1ubuntu2) ... 60s Setting up libsystemd0:ppc64el (259-1ubuntu3) ... 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 ... 120856 files and directories currently installed.) 60s Preparing to unpack .../systemd-sysv_259-1ubuntu3_ppc64el.deb ... 60s Unpacking systemd-sysv (259-1ubuntu3) over (259-1ubuntu2) ... 60s Preparing to unpack .../systemd-resolved_259-1ubuntu3_ppc64el.deb ... 61s Unpacking systemd-resolved (259-1ubuntu3) over (259-1ubuntu2) ... 61s Preparing to unpack .../libpam-systemd_259-1ubuntu3_ppc64el.deb ... 61s Unpacking libpam-systemd:ppc64el (259-1ubuntu3) over (259-1ubuntu2) ... 61s Preparing to unpack .../libsystemd-shared_259-1ubuntu3_ppc64el.deb ... 61s Unpacking libsystemd-shared:ppc64el (259-1ubuntu3) over (259-1ubuntu2) ... 61s Setting up libsystemd-shared:ppc64el (259-1ubuntu3) ... 62s (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 ... 120856 files and directories currently installed.) 62s Preparing to unpack .../systemd_259-1ubuntu3_ppc64el.deb ... 62s Unpacking systemd (259-1ubuntu3) over (259-1ubuntu2) ... 62s Preparing to unpack .../systemd-cryptsetup_259-1ubuntu3_ppc64el.deb ... 62s Unpacking systemd-cryptsetup (259-1ubuntu3) over (259-1ubuntu2) ... 62s Preparing to unpack .../udev_259-1ubuntu3_ppc64el.deb ... 63s Unpacking udev (259-1ubuntu3) over (259-1ubuntu2) ... 63s Preparing to unpack .../libudev1_259-1ubuntu3_ppc64el.deb ... 63s Unpacking libudev1:ppc64el (259-1ubuntu3) over (259-1ubuntu2) ... 63s Setting up libudev1:ppc64el (259-1ubuntu3) ... 63s (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 ... 120856 files and directories currently installed.) 63s Preparing to unpack .../libatomic1_15.2.0-12ubuntu1_ppc64el.deb ... 63s Unpacking libatomic1:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 64s Preparing to unpack .../libstdc++6_15.2.0-12ubuntu1_ppc64el.deb ... 64s Unpacking libstdc++6:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 64s Preparing to unpack .../gcc-15-base_15.2.0-12ubuntu1_ppc64el.deb ... 64s Unpacking gcc-15-base:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 64s Setting up gcc-15-base:ppc64el (15.2.0-12ubuntu1) ... 64s (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 ... 120856 files and directories currently installed.) 64s Preparing to unpack .../libgcc-s1_15.2.0-12ubuntu1_ppc64el.deb ... 64s Unpacking libgcc-s1:ppc64el (15.2.0-12ubuntu1) over (15.2.0-11ubuntu1) ... 64s Setting up libgcc-s1:ppc64el (15.2.0-12ubuntu1) ... 64s (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 ... 120856 files and directories currently installed.) 64s Preparing to unpack .../rsyslog_8.2512.0-1ubuntu3_ppc64el.deb ... 65s Unpacking rsyslog (8.2512.0-1ubuntu3) over (8.2512.0-1ubuntu2) ... 65s Preparing to unpack .../libsgutils2-1.48_1.48-3ubuntu2_ppc64el.deb ... 65s Unpacking libsgutils2-1.48:ppc64el (1.48-3ubuntu2) over (1.48-3ubuntu1) ... 65s Preparing to unpack .../sg3-utils_1.48-3ubuntu2_ppc64el.deb ... 66s Unpacking sg3-utils (1.48-3ubuntu2) over (1.48-3ubuntu1) ... 66s Preparing to unpack .../sg3-utils-udev_1.48-3ubuntu2_all.deb ... 66s Unpacking sg3-utils-udev (1.48-3ubuntu2) over (1.48-3ubuntu1) ... 66s Setting up rsyslog (8.2512.0-1ubuntu3) ... 67s warn: The user `syslog' is already a member of `adm'. 68s Setting up libsgutils2-1.48:ppc64el (1.48-3ubuntu2) ... 68s Setting up libnss-systemd:ppc64el (259-1ubuntu3) ... 68s Setting up systemd (259-1ubuntu3) ... 68s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 68s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 69s Setting up systemd-cryptsetup (259-1ubuntu3) ... 69s Setting up libatomic1:ppc64el (15.2.0-12ubuntu1) ... 69s Setting up udev (259-1ubuntu3) ... 70s Setting up libstdc++6:ppc64el (15.2.0-12ubuntu1) ... 71s Setting up systemd-resolved (259-1ubuntu3) ... 71s Could not execute systemctl: at /usr/bin/deb-systemd-invoke line 148. 71s Setting up sg3-utils (1.48-3ubuntu2) ... 71s Setting up systemd-userdbd (259-1ubuntu3) ... 72s Setting up systemd-sysv (259-1ubuntu3) ... 72s Setting up sg3-utils-udev (1.48-3ubuntu2) ... 72s update-initramfs: deferring update (trigger activated) 72s Setting up libpam-systemd:ppc64el (259-1ubuntu3) ... 73s Processing triggers for libc-bin (2.42-2ubuntu4) ... 73s Processing triggers for man-db (2.13.1-1) ... 76s Processing triggers for dbus (1.16.2-2ubuntu2) ... 76s Processing triggers for shared-mime-info (2.4-5build2) ... 82s Processing triggers for procps (2:4.0.4-9ubuntu1) ... 82s Processing triggers for initramfs-tools (0.150ubuntu7) ... 82s update-initramfs: Generating /boot/initrd.img-6.18.0-9-generic 93s autopkgtest [00:35:20]: upgrading testbed (apt dist-upgrade and autopurge) 93s Reading package lists... 93s Building dependency tree... 93s Reading state information... 94s Calculating upgrade... 94s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 94s Reading package lists... 94s Building dependency tree... 94s Reading state information... 94s Solving dependencies... 94s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 94s autopkgtest [00:35:21]: rebooting testbed after setup commands that affected boot 136s autopkgtest [00:36:03]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:45:54 UTC 2026 138s autopkgtest [00:36:05]: @@@@@@@@@@@@@@@@@@@@ apt-source stdsyslog 145s Get:1 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (dsc) [2413 B] 145s Get:2 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (tar) [31.2 kB] 145s Get:3 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (asc) [833 B] 145s Get:4 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (diff) [6816 B] 145s gpgv: Signature made Tue Aug 27 11:04:03 2024 UTC 145s gpgv: using RSA key 2EE7A7A517FC124CF115C354651EEFB02527DF13 145s gpgv: issuer "roam@debian.org" 145s gpgv: Can't check signature: No public key 145s dpkg-source: warning: cannot verify inline signature for ./stdsyslog_0.03.4-1.dsc: no acceptable signature found 146s autopkgtest [00:36:13]: testing package stdsyslog version 0.03.4-1 146s autopkgtest [00:36:13]: build not needed 146s autopkgtest [00:36:13]: test upstream-stdtestlog: preparing testbed 146s Reading package lists... 147s Building dependency tree... 147s Reading state information... 147s Solving dependencies... 147s The following NEW packages will be installed: 147s python3-click stdsyslog 147s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 147s Need to get 92.8 kB of archives. 147s After this operation, 469 kB of additional disk space will be used. 147s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-click all 8.2.0+0.really.8.1.8-1build1 [80.2 kB] 147s Get:2 http://ftpmaster.internal/ubuntu resolute/universe ppc64el stdsyslog ppc64el 0.03.4-1 [12.6 kB] 147s Fetched 92.8 kB in 0s (205 kB/s) 147s Selecting previously unselected package python3-click. 148s (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 ... 120856 files and directories currently installed.) 148s Preparing to unpack .../python3-click_8.2.0+0.really.8.1.8-1build1_all.deb ... 148s Unpacking python3-click (8.2.0+0.really.8.1.8-1build1) ... 148s Selecting previously unselected package stdsyslog. 148s Preparing to unpack .../stdsyslog_0.03.4-1_ppc64el.deb ... 148s Unpacking stdsyslog (0.03.4-1) ... 148s Setting up stdsyslog (0.03.4-1) ... 148s Setting up python3-click (8.2.0+0.really.8.1.8-1build1) ... 148s Processing triggers for man-db (2.13.1-1) ... 150s autopkgtest [00:36:17]: test upstream-stdtestlog: env PYTHONPATH="$(pwd)/python/src" python3 -B -u -m stdtestlog run 150s autopkgtest [00:36:17]: test upstream-stdtestlog: [----------------------- 150s Starting `rsyslogd -n -iNONE -f /tmp/stdtestlog.uw36etmi/rsyslog-stdtestlog.conf` 150s Got rsyslog pid 1676 150s Waiting for a second 150s rsyslogd: could not open config file '/tmp/stdtestlog.uw36etmi/rsyslog-stdtestlog.conf': Permission denied [v8.2512.0 try https://www.rsyslog.com/e/2104 ] 150s rsyslogd: run failed with error -2104 (see rsyslog.h or try https://www.rsyslog.com/e/2104 to learn what that number means) 151s Making sure rsyslog is still alive 151s Waiting for the rsyslogd process to go away 151s Traceback (most recent call last): 151s File "/tmp/autopkgtest.ibLk05/build.HmJ/src/python/src/stdtestlog/__main__.py", line 297, in cmd_run 151s raise RuntimeError(repr(rsysproc.wait())) 151s RuntimeError: 1 151s 151s During handling of the above exception, another exception occurred: 151s 151s Traceback (most recent call last): 151s File "", line 198, in _run_module_as_main 151s File "", line 88, in _run_code 151s File "/tmp/autopkgtest.ibLk05/build.HmJ/src/python/src/stdtestlog/__main__.py", line 336, in 151s main() 151s ~~~~^^ 151s File "/usr/lib/python3/dist-packages/click/core.py", line 1161, in __call__ 151s return self.main(*args, **kwargs) 151s ~~~~~~~~~^^^^^^^^^^^^^^^^^ 151s File "/usr/lib/python3/dist-packages/click/core.py", line 1082, in main 151s rv = self.invoke(ctx) 151s File "/usr/lib/python3/dist-packages/click/core.py", line 1697, in invoke 151s return _process_result(sub_ctx.command.invoke(sub_ctx)) 151s ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^ 151s File "/usr/lib/python3/dist-packages/click/core.py", line 1443, in invoke 151s return ctx.invoke(self.callback, **ctx.params) 151s ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 151s File "/usr/lib/python3/dist-packages/click/core.py", line 788, in invoke 151s return __callback(*args, **kwargs) 151s File "/tmp/autopkgtest.ibLk05/build.HmJ/src/python/src/stdtestlog/__main__.py", line 323, in cmd_run 151s raise RuntimeError(repr(rsysres)) 151s RuntimeError: 1 151s autopkgtest [00:36:18]: test upstream-stdtestlog: -----------------------] 152s upstream-stdtestlog FAIL non-zero exit status 1 152s autopkgtest [00:36:19]: test upstream-stdtestlog: - - - - - - - - - - results - - - - - - - - - - 152s autopkgtest [00:36:19]: @@@@@@@@@@@@@@@@@@@@ summary 152s upstream-stdtestlog FAIL non-zero exit status 1