0s autopkgtest [02:34:33]: starting date and time: 2026-01-30 02:34:33+0000 0s autopkgtest [02:34:33]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [02:34:33]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.l4ax3jq7/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-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@sto01-9.secgroup --name adt-resolute-amd64-stdsyslog-20260130-023433-juju-7f2275-prod-proposed-migration-environment-20-41160f1c-da75-43a1-bf8a-ed43f2b1fec2 --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-amd64-stdsyslog-20260130-023433-juju-7f2275-prod-proposed-migration-environment-20-41160f1c-da75-43a1-bf8a-ed43f2b1fec2 from image adt/ubuntu-resolute-amd64-server-20260130.img (UUID afba56f8-6ab4-44eb-9e07-036bcbd7054f)... 106s autopkgtest [02:36:19]: testbed dpkg architecture: amd64 106s autopkgtest [02:36:19]: testbed apt version: 3.1.14 107s autopkgtest [02:36:20]: @@@@@@@@@@@@@@@@@@@@ test bed setup 107s autopkgtest [02:36:20]: testbed release detected to be: None 107s autopkgtest [02:36:20]: updating testbed package index (apt update) 107s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 107s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 107s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 108s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 108s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [25.4 kB] 108s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [2820 B] 108s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [103 kB] 108s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1043 kB] 108s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [119 kB] 108s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [103 kB] 108s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 c-n-f Metadata [4404 B] 108s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [12.3 kB] 108s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [3696 B] 108s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 c-n-f Metadata [336 B] 108s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [837 kB] 108s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [332 kB] 108s Get:17 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 c-n-f Metadata [23.5 kB] 108s Get:18 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [23.2 kB] 108s Get:19 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [3336 B] 108s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 c-n-f Metadata [1036 B] 109s Fetched 2761 kB in 1s (3640 kB/s) 109s Reading package lists... 110s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 110s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 110s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 110s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 110s Reading package lists... 110s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s Calculating upgrade... 111s The following packages will be upgraded: 111s libnss-systemd libpam-systemd libsystemd-shared libsystemd0 libudev1 rsyslog 111s systemd systemd-cryptsetup systemd-resolved systemd-sysv systemd-userdbd 111s udev 111s 12 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 111s Need to get 9468 kB of archives. 111s After this operation, 1024 B of additional disk space will be used. 111s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 systemd-userdbd amd64 259-1ubuntu3 [52.0 kB] 111s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libnss-systemd amd64 259-1ubuntu3 [289 kB] 111s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libsystemd0 amd64 259-1ubuntu3 [543 kB] 111s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd-sysv amd64 259-1ubuntu3 [9248 B] 111s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd-resolved amd64 259-1ubuntu3 [298 kB] 111s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libpam-systemd amd64 259-1ubuntu3 [273 kB] 111s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libsystemd-shared amd64 259-1ubuntu3 [2519 kB] 111s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd amd64 259-1ubuntu3 [3120 kB] 111s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 systemd-cryptsetup amd64 259-1ubuntu3 [124 kB] 111s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 udev amd64 259-1ubuntu3 [1487 kB] 111s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libudev1 amd64 259-1ubuntu3 [213 kB] 111s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 rsyslog amd64 8.2512.0-1ubuntu3 [541 kB] 112s dpkg-preconfigure: unable to re-open stdin: No such file or directory 112s Fetched 9468 kB in 1s (15.6 MB/s) 112s (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 ... 124211 files and directories currently installed.) 112s Preparing to unpack .../systemd-userdbd_259-1ubuntu3_amd64.deb ... 112s Unpacking systemd-userdbd (259-1ubuntu3) over (259-1ubuntu2) ... 112s Preparing to unpack .../libnss-systemd_259-1ubuntu3_amd64.deb ... 112s Unpacking libnss-systemd:amd64 (259-1ubuntu3) over (259-1ubuntu2) ... 112s Preparing to unpack .../libsystemd0_259-1ubuntu3_amd64.deb ... 112s Unpacking libsystemd0:amd64 (259-1ubuntu3) over (259-1ubuntu2) ... 112s Setting up libsystemd0:amd64 (259-1ubuntu3) ... 112s (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 ... 124211 files and directories currently installed.) 112s Preparing to unpack .../systemd-sysv_259-1ubuntu3_amd64.deb ... 112s Unpacking systemd-sysv (259-1ubuntu3) over (259-1ubuntu2) ... 112s Preparing to unpack .../systemd-resolved_259-1ubuntu3_amd64.deb ... 112s Unpacking systemd-resolved (259-1ubuntu3) over (259-1ubuntu2) ... 112s Preparing to unpack .../libpam-systemd_259-1ubuntu3_amd64.deb ... 112s Unpacking libpam-systemd:amd64 (259-1ubuntu3) over (259-1ubuntu2) ... 112s Preparing to unpack .../libsystemd-shared_259-1ubuntu3_amd64.deb ... 112s Unpacking libsystemd-shared:amd64 (259-1ubuntu3) over (259-1ubuntu2) ... 112s Setting up libsystemd-shared:amd64 (259-1ubuntu3) ... 112s (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 ... 124211 files and directories currently installed.) 112s Preparing to unpack .../systemd_259-1ubuntu3_amd64.deb ... 112s Unpacking systemd (259-1ubuntu3) over (259-1ubuntu2) ... 112s Preparing to unpack .../systemd-cryptsetup_259-1ubuntu3_amd64.deb ... 112s Unpacking systemd-cryptsetup (259-1ubuntu3) over (259-1ubuntu2) ... 112s Preparing to unpack .../udev_259-1ubuntu3_amd64.deb ... 112s Unpacking udev (259-1ubuntu3) over (259-1ubuntu2) ... 113s Preparing to unpack .../libudev1_259-1ubuntu3_amd64.deb ... 113s Unpacking libudev1:amd64 (259-1ubuntu3) over (259-1ubuntu2) ... 113s Setting up libudev1:amd64 (259-1ubuntu3) ... 113s (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 ... 124211 files and directories currently installed.) 113s Preparing to unpack .../rsyslog_8.2512.0-1ubuntu3_amd64.deb ... 113s Unpacking rsyslog (8.2512.0-1ubuntu3) over (8.2512.0-1ubuntu2) ... 113s Setting up rsyslog (8.2512.0-1ubuntu3) ... 113s warn: The user `syslog' is already a member of `adm'. 113s Setting up libnss-systemd:amd64 (259-1ubuntu3) ... 113s Setting up systemd (259-1ubuntu3) ... 113s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 113s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 114s Setting up systemd-cryptsetup (259-1ubuntu3) ... 114s Setting up udev (259-1ubuntu3) ... 115s Setting up systemd-resolved (259-1ubuntu3) ... 115s Could not execute systemctl: at /usr/bin/deb-systemd-invoke line 148. 115s Setting up systemd-userdbd (259-1ubuntu3) ... 116s Setting up systemd-sysv (259-1ubuntu3) ... 116s Setting up libpam-systemd:amd64 (259-1ubuntu3) ... 116s Processing triggers for libc-bin (2.42-2ubuntu4) ... 116s Processing triggers for man-db (2.13.1-1) ... 117s Processing triggers for dbus (1.16.2-2ubuntu2) ... 117s Processing triggers for shared-mime-info (2.4-5build2) ... 118s Processing triggers for procps (2:4.0.4-9ubuntu1) ... 118s Processing triggers for initramfs-tools (0.150ubuntu7) ... 118s update-initramfs: Generating /boot/initrd.img-6.18.0-9-generic 122s autopkgtest [02:36:35]: upgrading testbed (apt dist-upgrade and autopurge) 122s Reading package lists... 123s Building dependency tree... 123s Reading state information... 123s Calculating upgrade... 123s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s Reading package lists... 123s Building dependency tree... 123s Reading state information... 123s Solving dependencies... 123s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s autopkgtest [02:36:36]: rebooting testbed after setup commands that affected boot 153s autopkgtest [02:37:06]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:49:02 UTC 2026 156s autopkgtest [02:37:09]: @@@@@@@@@@@@@@@@@@@@ apt-source stdsyslog 157s Get:1 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (dsc) [2413 B] 157s Get:2 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (tar) [31.2 kB] 157s Get:3 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (asc) [833 B] 157s Get:4 http://ftpmaster.internal/ubuntu resolute/universe stdsyslog 0.03.4-1 (diff) [6816 B] 157s gpgv: Signature made Tue Aug 27 11:04:03 2024 UTC 157s gpgv: using RSA key 2EE7A7A517FC124CF115C354651EEFB02527DF13 157s gpgv: issuer "roam@debian.org" 157s gpgv: Can't check signature: No public key 157s dpkg-source: warning: cannot verify inline signature for ./stdsyslog_0.03.4-1.dsc: no acceptable signature found 157s autopkgtest [02:37:10]: testing package stdsyslog version 0.03.4-1 157s autopkgtest [02:37:10]: build not needed 157s autopkgtest [02:37:10]: test upstream-stdtestlog: preparing testbed 157s Reading package lists... 158s Building dependency tree... 158s Reading state information... 158s Solving dependencies... 158s The following NEW packages will be installed: 158s python3-click stdsyslog 158s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 158s Need to get 92.5 kB of archives. 158s After this operation, 424 kB of additional disk space will be used. 158s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-click all 8.2.0+0.really.8.1.8-1build1 [80.2 kB] 158s Get:2 http://ftpmaster.internal/ubuntu resolute/universe amd64 stdsyslog amd64 0.03.4-1 [12.3 kB] 158s Fetched 92.5 kB in 0s (265 kB/s) 158s Selecting previously unselected package python3-click. 158s (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 ... 124211 files and directories currently installed.) 158s Preparing to unpack .../python3-click_8.2.0+0.really.8.1.8-1build1_all.deb ... 158s Unpacking python3-click (8.2.0+0.really.8.1.8-1build1) ... 158s Selecting previously unselected package stdsyslog. 158s Preparing to unpack .../stdsyslog_0.03.4-1_amd64.deb ... 158s Unpacking stdsyslog (0.03.4-1) ... 158s Setting up stdsyslog (0.03.4-1) ... 158s Setting up python3-click (8.2.0+0.really.8.1.8-1build1) ... 159s Processing triggers for man-db (2.13.1-1) ... 160s autopkgtest [02:37:13]: test upstream-stdtestlog: env PYTHONPATH="$(pwd)/python/src" python3 -B -u -m stdtestlog run 160s autopkgtest [02:37:13]: test upstream-stdtestlog: [----------------------- 160s Starting `rsyslogd -n -iNONE -f /tmp/stdtestlog.6t9jq_p8/rsyslog-stdtestlog.conf` 160s Got rsyslog pid 1553 160s Waiting for a second 160s rsyslogd: could not open config file '/tmp/stdtestlog.6t9jq_p8/rsyslog-stdtestlog.conf': Permission denied [v8.2512.0 try https://www.rsyslog.com/e/2104 ] 160s rsyslogd: run failed with error -2104 (see rsyslog.h or try https://www.rsyslog.com/e/2104 to learn what that number means) 161s Making sure rsyslog is still alive 161s Waiting for the rsyslogd process to go away 161s Traceback (most recent call last): 161s File "/tmp/autopkgtest.WiArjU/build.HPd/src/python/src/stdtestlog/__main__.py", line 297, in cmd_run 161s raise RuntimeError(repr(rsysproc.wait())) 161s RuntimeError: 1 161s 161s During handling of the above exception, another exception occurred: 161s 161s Traceback (most recent call last): 161s File "", line 198, in _run_module_as_main 161s File "", line 88, in _run_code 161s File "/tmp/autopkgtest.WiArjU/build.HPd/src/python/src/stdtestlog/__main__.py", line 336, in 161s main() 161s ~~~~^^ 161s File "/usr/lib/python3/dist-packages/click/core.py", line 1161, in __call__ 161s return self.main(*args, **kwargs) 161s ~~~~~~~~~^^^^^^^^^^^^^^^^^ 161s File "/usr/lib/python3/dist-packages/click/core.py", line 1082, in main 161s rv = self.invoke(ctx) 161s File "/usr/lib/python3/dist-packages/click/core.py", line 1697, in invoke 161s return _process_result(sub_ctx.command.invoke(sub_ctx)) 161s ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^ 161s File "/usr/lib/python3/dist-packages/click/core.py", line 1443, in invoke 161s return ctx.invoke(self.callback, **ctx.params) 161s ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 161s File "/usr/lib/python3/dist-packages/click/core.py", line 788, in invoke 161s return __callback(*args, **kwargs) 161s File "/tmp/autopkgtest.WiArjU/build.HPd/src/python/src/stdtestlog/__main__.py", line 323, in cmd_run 161s raise RuntimeError(repr(rsysres)) 161s RuntimeError: 1 161s autopkgtest [02:37:14]: test upstream-stdtestlog: -----------------------] 162s upstream-stdtestlog FAIL non-zero exit status 1 162s autopkgtest [02:37:15]: test upstream-stdtestlog: - - - - - - - - - - results - - - - - - - - - - 162s autopkgtest [02:37:15]: @@@@@@@@@@@@@@@@@@@@ summary 162s upstream-stdtestlog FAIL non-zero exit status 1