0s autopkgtest [05:30:57]: starting date and time: 2025-05-02 05:30:57+0000 0s autopkgtest [05:30:57]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [05:30:57]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.3d3zgzq4/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_proxy=127.0.0.1,127.0.1.1,localhost,localdomain,internal,login.ubuntu.com,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com\n" >> /etc/environment' --apt-pocket=proposed=src:guile-fibers --apt-upgrade shepherd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=guile-fibers/1.3.1-5 -- lxd -r lxd-armhf-10.145.243.210 lxd-armhf-10.145.243.210:autopkgtest/ubuntu/questing/armhf 21s autopkgtest [05:31:18]: testbed dpkg architecture: armhf 23s autopkgtest [05:31:20]: testbed apt version: 3.0.0 26s autopkgtest [05:31:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 28s autopkgtest [05:31:25]: testbed release detected to be: None 36s autopkgtest [05:31:33]: updating testbed package index (apt update) 38s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 38s Get:2 http://ftpmaster.internal/ubuntu questing InRelease [110 kB] 38s Get:3 http://ftpmaster.internal/ubuntu questing-updates InRelease [110 kB] 38s Get:4 http://ftpmaster.internal/ubuntu questing-security InRelease [110 kB] 39s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB] 39s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB] 39s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB] 39s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main armhf Packages [206 kB] 39s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe armhf Packages [1383 kB] 39s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse armhf Packages [15.1 kB] 39s Get:11 http://ftpmaster.internal/ubuntu questing/main Sources [1385 kB] 39s Get:12 http://ftpmaster.internal/ubuntu questing/universe Sources [21.1 MB] 40s Get:13 http://ftpmaster.internal/ubuntu questing/main armhf Packages [1358 kB] 40s Get:14 http://ftpmaster.internal/ubuntu questing/universe armhf Packages [15.0 MB] 44s Fetched 43.3 MB in 6s (7178 kB/s) 45s Reading package lists... 51s autopkgtest [05:31:48]: upgrading testbed (apt dist-upgrade and autopurge) 53s Reading package lists... 53s Building dependency tree... 53s Reading state information... 54s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 54s Starting 2 pkgProblemResolver with broken count: 0 54s Done 55s Entering ResolveByKeep 55s 56s Calculating upgrade... 56s The following packages will be upgraded: 56s base-files distro-info-data dpkg dpkg-dev libdpkg-perl motd-news-config 56s ubuntu-pro-client ubuntu-pro-client-l10n 56s 8 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 56s Need to get 2989 kB of archives. 56s After this operation, 1024 B of additional disk space will be used. 56s Get:1 http://ftpmaster.internal/ubuntu questing/main armhf motd-news-config all 13.7ubuntu1 [5260 B] 56s Get:2 http://ftpmaster.internal/ubuntu questing/main armhf base-files armhf 13.7ubuntu1 [75.4 kB] 57s Get:3 http://ftpmaster.internal/ubuntu questing/main armhf dpkg armhf 1.22.18ubuntu3 [1254 kB] 57s Get:4 http://ftpmaster.internal/ubuntu questing/main armhf distro-info-data all 0.64 [6664 B] 57s Get:5 http://ftpmaster.internal/ubuntu questing/main armhf ubuntu-pro-client-l10n armhf 35.1ubuntu0 [19.7 kB] 57s Get:6 http://ftpmaster.internal/ubuntu questing/main armhf ubuntu-pro-client armhf 35.1ubuntu0 [258 kB] 57s Get:7 http://ftpmaster.internal/ubuntu questing/main armhf dpkg-dev all 1.22.18ubuntu3 [1089 kB] 57s Get:8 http://ftpmaster.internal/ubuntu questing/main armhf libdpkg-perl all 1.22.18ubuntu3 [281 kB] 58s Fetched 2989 kB in 1s (3873 kB/s) 58s (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 ... 63953 files and directories currently installed.) 58s Preparing to unpack .../motd-news-config_13.7ubuntu1_all.deb ... 58s Unpacking motd-news-config (13.7ubuntu1) over (13.6ubuntu2) ... 58s Preparing to unpack .../base-files_13.7ubuntu1_armhf.deb ... 58s Unpacking base-files (13.7ubuntu1) over (13.6ubuntu2) ... 58s Setting up base-files (13.7ubuntu1) ... 58s Installing new version of config file /etc/issue ... 58s Installing new version of config file /etc/issue.net ... 58s Installing new version of config file /etc/lsb-release ... 59s motd-news.service is a disabled or a static unit not running, not starting it. 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 ... 63953 files and directories currently installed.) 59s Preparing to unpack .../dpkg_1.22.18ubuntu3_armhf.deb ... 59s Unpacking dpkg (1.22.18ubuntu3) over (1.22.18ubuntu2) ... 59s Setting up dpkg (1.22.18ubuntu3) ... 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 ... 63953 files and directories currently installed.) 59s Preparing to unpack .../distro-info-data_0.64_all.deb ... 59s Unpacking distro-info-data (0.64) over (0.63) ... 59s Preparing to unpack .../ubuntu-pro-client-l10n_35.1ubuntu0_armhf.deb ... 59s Unpacking ubuntu-pro-client-l10n (35.1ubuntu0) over (35) ... 59s Preparing to unpack .../ubuntu-pro-client_35.1ubuntu0_armhf.deb ... 60s Unpacking ubuntu-pro-client (35.1ubuntu0) over (35) ... 60s Preparing to unpack .../dpkg-dev_1.22.18ubuntu3_all.deb ... 60s Unpacking dpkg-dev (1.22.18ubuntu3) over (1.22.18ubuntu2) ... 60s Preparing to unpack .../libdpkg-perl_1.22.18ubuntu3_all.deb ... 60s Unpacking libdpkg-perl (1.22.18ubuntu3) over (1.22.18ubuntu2) ... 60s Setting up motd-news-config (13.7ubuntu1) ... 60s Setting up distro-info-data (0.64) ... 60s Setting up libdpkg-perl (1.22.18ubuntu3) ... 60s Setting up ubuntu-pro-client (35.1ubuntu0) ... 60s apparmor_parser: Unable to replace "ubuntu_pro_apt_news". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 60s 60s apparmor_parser: Unable to replace "apt_methods". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 60s 60s apparmor_parser: Unable to replace "ubuntu_pro_esm_cache". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 60s 62s Setting up ubuntu-pro-client-l10n (35.1ubuntu0) ... 62s Setting up dpkg-dev (1.22.18ubuntu3) ... 62s Processing triggers for install-info (7.1.1-1) ... 62s Processing triggers for man-db (2.13.0-1) ... 64s Processing triggers for plymouth-theme-ubuntu-text (24.004.60-2ubuntu7) ... 64s Processing triggers for initramfs-tools (0.147ubuntu1) ... 66s Reading package lists... 66s Building dependency tree... 66s Reading state information... 67s Starting pkgProblemResolver with broken count: 0 67s Starting 2 pkgProblemResolver with broken count: 0 67s Done 67s Solving dependencies... 68s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 70s autopkgtest [05:32:07]: rebooting testbed after setup commands that affected boot 110s autopkgtest [05:32:47]: testbed running kernel: Linux 6.8.0-58-generic #60~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Fri Mar 28 14:48:37 UTC 2 135s autopkgtest [05:33:12]: @@@@@@@@@@@@@@@@@@@@ apt-source shepherd 146s Get:1 http://ftpmaster.internal/ubuntu questing/universe shepherd 1.0.2-4 (dsc) [2568 B] 146s Get:2 http://ftpmaster.internal/ubuntu questing/universe shepherd 1.0.2-4 (tar) [811 kB] 146s Get:3 http://ftpmaster.internal/ubuntu questing/universe shepherd 1.0.2-4 (asc) [833 B] 146s Get:4 http://ftpmaster.internal/ubuntu questing/universe shepherd 1.0.2-4 (diff) [8432 B] 146s gpgv: Signature made Tue Mar 4 17:03:10 2025 UTC 146s gpgv: using EDDSA key A3CC9C870B9D310ABAD4CF2F51722B08FE4745A2 146s gpgv: issuer "simon@josefsson.org" 146s gpgv: Can't check signature: No public key 146s dpkg-source: warning: cannot verify inline signature for ./shepherd_1.0.2-4.dsc: no acceptable signature found 146s autopkgtest [05:33:23]: testing package shepherd version 1.0.2-4 149s autopkgtest [05:33:26]: build not needed 152s autopkgtest [05:33:29]: test herd--help: preparing testbed 153s Reading package lists... 154s Building dependency tree... 154s Reading state information... 154s Starting pkgProblemResolver with broken count: 0 154s Starting 2 pkgProblemResolver with broken count: 0 154s Done 155s The following NEW packages will be installed: 155s guile-3.0 guile-3.0-libs guile-fibers libgc1 shepherd 156s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 156s Need to get 8830 kB of archives. 156s After this operation, 58.1 MB of additional disk space will be used. 156s Get:1 http://ftpmaster.internal/ubuntu questing/main armhf libgc1 armhf 1:8.2.8-1 [81.2 kB] 156s Get:2 http://ftpmaster.internal/ubuntu questing/universe armhf guile-3.0-libs armhf 3.0.10+really3.0.10-4 [7658 kB] 156s Get:3 http://ftpmaster.internal/ubuntu questing/universe armhf guile-3.0 armhf 3.0.10+really3.0.10-4 [16.4 kB] 156s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/universe armhf guile-fibers armhf 1.3.1-5 [326 kB] 156s Get:5 http://ftpmaster.internal/ubuntu questing/universe armhf shepherd armhf 1.0.2-4 [749 kB] 157s Fetched 8830 kB in 1s (10.5 MB/s) 157s Selecting previously unselected package libgc1:armhf. 157s (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 ... 63953 files and directories currently installed.) 157s Preparing to unpack .../libgc1_1%3a8.2.8-1_armhf.deb ... 157s Unpacking libgc1:armhf (1:8.2.8-1) ... 157s Selecting previously unselected package guile-3.0-libs:armhf. 157s Preparing to unpack .../guile-3.0-libs_3.0.10+really3.0.10-4_armhf.deb ... 157s Unpacking guile-3.0-libs:armhf (3.0.10+really3.0.10-4) ... 157s Selecting previously unselected package guile-3.0. 157s Preparing to unpack .../guile-3.0_3.0.10+really3.0.10-4_armhf.deb ... 157s Unpacking guile-3.0 (3.0.10+really3.0.10-4) ... 157s Selecting previously unselected package guile-fibers. 157s Preparing to unpack .../guile-fibers_1.3.1-5_armhf.deb ... 157s Unpacking guile-fibers (1.3.1-5) ... 157s Selecting previously unselected package shepherd. 157s Preparing to unpack .../shepherd_1.0.2-4_armhf.deb ... 157s Unpacking shepherd (1.0.2-4) ... 157s Setting up libgc1:armhf (1:8.2.8-1) ... 157s Setting up guile-3.0-libs:armhf (3.0.10+really3.0.10-4) ... 157s Setting up guile-3.0 (3.0.10+really3.0.10-4) ... 157s update-alternatives: using /usr/lib/arm-linux-gnueabihf/guile/3.0/bin/guile to provide /usr/bin/guile (guile) in auto mode 157s Setting up guile-fibers (1.3.1-5) ... 157s Setting up shepherd (1.0.2-4) ... 157s Processing triggers for install-info (7.1.1-1) ... 158s Processing triggers for libc-bin (2.41-6ubuntu1) ... 158s Processing triggers for man-db (2.13.0-1) ... 166s autopkgtest [05:33:43]: test herd--help: herd --help 166s autopkgtest [05:33:43]: test herd--help: [----------------------- 168s herd [OPTIONS...] ACTION SERVICE [ARG...] 168s Apply ACTION (start, stop, status, etc.) on SERVICE with the ARGs. 168s --group=GROUP run the given program as GROUP 168s --user=USER run the given program as USER 168s -E, --environment-variable=ENVIRONMENT 168s pass the environment variable specified by ENVIRONMENT 168s -d, --working-directory=DIRECTORY 168s run service from DIRECTORY (for transient services) 168s --log-file=FILE log service output to FILE 168s -N, --service-name=NAME register new service under NAME 168s -n, --log-history=NUMBER display up to NUMBER service log lines 168s -s, --socket=FILE send commands to FILE 168s --help display this help and exit 168s --usage display short usage message and exit 168s --version display version information and exit 168s 168s Mandatory or optional arguments to long options are also mandatory or 168s optional to the corresponding short options. 168s 168s Report bugs to: bug-guix@gnu.org . 168s GNU Shepherd general home page: 168s General help using GNU software: 169s autopkgtest [05:33:46]: test herd--help: -----------------------] 173s autopkgtest [05:33:50]: test herd--help: - - - - - - - - - - results - - - - - - - - - - 173s herd--help PASS 177s autopkgtest [05:33:54]: test shepherd--help: preparing testbed 179s Reading package lists... 179s Building dependency tree... 179s Reading state information... 180s Starting pkgProblemResolver with broken count: 0 180s Starting 2 pkgProblemResolver with broken count: 0 180s Done 181s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 189s autopkgtest [05:34:06]: test shepherd--help: shepherd --help 189s autopkgtest [05:34:06]: test shepherd--help: [----------------------- 191s shepherd [OPTIONS...] 191s This is a service manager for Unix and GNU. 191s -s, --socket=FILE get commands from socket FILE or from stdin (-) 191s -c, --config=FILE read configuration from FILE 191s --pid[=FILE] when ready, write PID to FILE or stdout 191s -l, --logfile=FILE log actions in FILE 191s -I, --insecure don't ensure that the setup is secure 191s -S, --silent don't do output to stdout 191s --quiet synonym for --silent 191s --help display this help and exit 191s --usage display short usage message and exit 191s --version display version information and exit 191s 191s Mandatory or optional arguments to long options are also mandatory or 191s optional to the corresponding short options. 191s 191s Report bugs to: bug-guix@gnu.org . 191s GNU Shepherd general home page: 191s General help using GNU software: 191s autopkgtest [05:34:08]: test shepherd--help: -----------------------] 195s autopkgtest [05:34:12]: test shepherd--help: - - - - - - - - - - results - - - - - - - - - - 195s shepherd--help PASS 199s autopkgtest [05:34:16]: test herd--version: preparing testbed 201s Reading package lists... 201s Building dependency tree... 201s Reading state information... 202s Starting pkgProblemResolver with broken count: 0 202s Starting 2 pkgProblemResolver with broken count: 0 202s Done 203s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 210s autopkgtest [05:34:27]: test herd--version: herd --version 210s autopkgtest [05:34:27]: test herd--version: [----------------------- 212s herd (GNU Shepherd) 1.0.2 212s Copyright (C) 2025 the Shepherd authors 212s License GPLv3+: GNU GPL version 3 or later 212s This is free software: you are free to change and redistribute it. 212s There is NO WARRANTY, to the extent permitted by law. 213s autopkgtest [05:34:30]: test herd--version: -----------------------] 217s autopkgtest [05:34:34]: test herd--version: - - - - - - - - - - results - - - - - - - - - - 217s herd--version PASS 220s autopkgtest [05:34:37]: test shepherd--version: preparing testbed 222s Reading package lists... 223s Building dependency tree... 223s Reading state information... 223s Starting pkgProblemResolver with broken count: 0 223s Starting 2 pkgProblemResolver with broken count: 0 223s Done 224s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 232s autopkgtest [05:34:49]: test shepherd--version: shepherd --version 232s autopkgtest [05:34:49]: test shepherd--version: [----------------------- 234s shepherd (GNU Shepherd) 1.0.2 234s Copyright (C) 2025 the Shepherd authors 234s License GPLv3+: GNU GPL version 3 or later 234s This is free software: you are free to change and redistribute it. 234s There is NO WARRANTY, to the extent permitted by law. 234s autopkgtest [05:34:51]: test shepherd--version: -----------------------] 238s autopkgtest [05:34:55]: test shepherd--version: - - - - - - - - - - results - - - - - - - - - - 238s shepherd--version PASS 242s autopkgtest [05:34:59]: test tests-basic: preparing testbed 244s Reading package lists... 244s Building dependency tree... 244s Reading state information... 245s Starting pkgProblemResolver with broken count: 0 245s Starting 2 pkgProblemResolver with broken count: 0 245s Done 246s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 254s autopkgtest [05:35:11]: test tests-basic: sh -x tests/basic.sh 254s autopkgtest [05:35:11]: test tests-basic: [----------------------- 256s + shepherd --version 256s + herd --version 256s shepherd (GNU Shepherd) 1.0.2 256s Copyright (C) 2025 the Shepherd authors 256s License GPLv3+: GNU GPL version 3 or later 256s This is free software: you are free to change and redistribute it. 256s There is NO WARRANTY, to the extent permitted by law. 256s herd (GNU Shepherd) 1.0.2 256s Copyright (C) 2025 the Shepherd authors 256s License GPLv3+: GNU GPL version 3 or later 256s This is free software: you are free to change and redistribute it. 256s There is NO WARRANTY, to the extent permitted by law. 256s + socket=t-socket-1712 256s + conf=t-conf-1712 256s + confdir=t-confdir-1712 256s + datadir=t-datadir-1712 256s + log=t-log-1712 256s + stamp=t-stamp-1712 256s + pid=t-pid-1712 256s + herd=herd -s t-socket-1712 256s + trap cat t-log-1712 || true; rm -f t-socket-1712 t-conf-1712 t-stamp-1712 t-log-1712; 256s test -f t-pid-1712 && kill `cat t-pid-1712` || true; rm -f t-pid-1712 EXIT 256s + cat 256s + rm -f t-pid-1712 256s + test -f t-pid-1712 256s + sleep 0.3 256s + shepherd -I -s t-socket-1712 -c t-conf-1712 -l t-log-1712 --pid=t-pid-1712 256s GNU Shepherd 1.0.2 (Guile 3.0.10, arm-unknown-linux-gnueabihf) 256s Starting service root... 256s Service root started. 256s Service root running with value #< id: 1733 command: #f>. 256s Service root has been started. 256s Configuration successfully loaded from 't-conf-1712'. 256s + test -f t-pid-1712 256s + cat t-pid-1712 256s + shepherd_pid=1733 256s + kill -0 1733 256s + test -S t-socket-1712 256s + herd -s t-socket-1712 status -n 0 256s + pristine_status=Started: 256s + root 256s Stopped: 256s - broken 256s - spawn-with-system 256s - test 256s - test-2 256s + echo Started: + root Stopped: - broken - spawn-with-system - test - test-2 256s + grep -E (Start.*root|Stop.*test) 256s + herd -s t-socket-1712 status root 256s Started: + root Stopped: - broken - spawn-with-system - test - test-2 256s + cat t-pid-1712 256s + grep PID: 1733 257s + Main PID: 1733 257s herd -s t-socket-1712 status root 257s + grep Service root started 257s + herd -s t-socket-1712 status root 257s + grep actions: .*eval 257s 2025-05-02 05:35:13 Service root started. 257s Custom actions: help status halt power-off kexec load eval unload reload daemonize restart 257s + herd -s t-socket-1712 status root 257s + grep actions: .*load 257s + + herd -s t-socket-1712 status root 257s grep actions: .*halt 257s Custom actions: help status halt power-off kexec load eval unload reload daemonize restart 257s Custom actions: help status halt power-off kexec load eval unload reload daemonize restart 257s + herd -s t-socket-1712 graph 257s + grep "test-2" -> "test" 257s "test-2" -> "test"; 257s + herd -s t-socket-1712 start test 257s Service test has been started. 257s + test -f t-stamp-1712 257s + herd -s t-socket-1712 status test 257s + grep running 257s + grep Service test started 257s + herd -s t-socket-1712 status root 257s It is running since 05:35:14 (0 seconds ago). 257s + herd -s t-socket-1712 stop test 257s 2025-05-02 05:35:14 Service test started. 257s + test -f t-stamp-1712 257s + herd -s t-socket-1712 log 257s 2 May 2025 05:35:13 service root is being started 257s 2 May 2025 05:35:13 service root is running 257s 2 May 2025 05:35:14 service test is being started 257s 2 May 2025 05:35:14 service test is running 257s 2 May 2025 05:35:14 service test is being stopped 257s 2 May 2025 05:35:14 service test is stopped 257s + herd -s t-socket-1712 log 257s + grep service test is running 257s 2 May 2025 05:35:14 service test is running 257s + herd -s t-socket-1712 log 257s + grep service test is stopped 257s 2 May 2025 05:35:14 service test is stopped 257s + herd -s t-socket-1712 status test 257s + grep stopped 257s It is stopped since 05:35:14 (0 seconds ago). 257s + herd -s t-socket-1712 stop test 257s + herd -s t-socket-1712 stop test 257s + test -z 257s + herd -s t-socket-1712 disable test-2 257s Disabled service test-2. 257s + herd -s t-socket-1712 start test-2 257s herd: error: failed to start service test-2 257s Service test has been started. 257s Service test-2 is currently disabled. 257s + true 257s + herd -s t-socket-1712 start test-2 257s + grep test-2 is currently disabled 257s Service test-2 is currently disabled. 257s herd: error: failed to start service test-2 257s + herd -s t-socket-1712 enable test-2 257s Enabled service test-2. 257s + herd -s t-socket-1712 start test-2 257s Service test-2 has been started. 257s + wc -l 257s + test 25 -gt 0 257s + cut -c 21- 257s + grep ^$ 257s + wc -l 257s + test 0 -eq 0 257s + herd -s t-socket-1712 doc test-2 action hi 257s + grep Say hi\. 257s + herd -s t-socket-1712 hi test-2 257s hi: Say hi. 257s start 257s 257s end 257s + herd -s t-socket-1712 hi test-2 257s + grep ^start$ 257s start 257s + herd -s t-socket-1712 hi test-2 257s + grep ^end$ 257s end 257s + herd -s t-socket-1712 hi test-2 257s + wc -l 257s + test 3 -eq 3 257s + herd -s t-socket-1712 fail test-2 257s + true 257s + herd -s t-socket-1712 enable test-2 with extra arguments 257s herd: error: exception caught while executing 'enable' on service 'test-2': 257s Wrong number of arguments to # 257s + true 257s + herd -s t-socket-1712 status test-2 257s + grep running 257s + herd -s t-socket-1712 status test-2 something else that is useless 257s It is running since 05:35:14 (0 seconds ago). 257s herd: error: exception caught while executing 'status' on service 'test-2': 257s Wrong number of arguments to # 257s + true 257s + herd -s t-socket-1712 status does-not-exist 257s herd: error: service 'does-not-exist' could not be found 257s + true 257s + herd -s t-socket-1712 status does-not-exist 257s + grep does-not-exist.*not.*found 257s + herd -s t-socket-1712 start does-not-exist 257s herd: error: service 'does-not-exist' could not be found 257s herd: error: service 'does-not-exist' could not be found 257s + true 257s + herd -s t-socket-1712 start does-not-exist 257s + grep does-not-exist.*not.*found 257s herd: error: service 'does-not-exist' could not be found 257s + herd -s t-socket-1712 stop does-not-exist 257s herd: error: service 'does-not-exist' could not be found 257s + true 257s + herd -s t-socket-1712 stop does-not-exist 257s + grep does-not-exist.*not.*found 257s + herd -s t-socket-1712 an-action-that-does-not-exist root 257s herd: error: service 'does-not-exist' could not be found 257s herd: error: service 'root' does not have an action 'an-action-that-does-not-exist' 257s herd: hint: Run 'herd doc root list-actions' to list supported actions. 257s + true 257s + herd -s t-socket-1712 start broken 257s herd: error: exception caught while executing 'start' on service 'broken': 257s In procedure mkdir: No such file or directory 257s + herd -s t-socket-1712 status broken 257s + grep stopped 258s + herd -s t-socket-1712 start spawn-with-system 258s It is stopped (failing). 258s Service spawn-with-system has been started. 258s + grep running 258s + herd -s t-socket-1712 status spawn-with-system 258s It is running since 05:35:15 (0 seconds ago). 258s + herd -s t-socket-1712 status spawn-with-system 258s + grep starting from 258s 2025-05-02 05:35:15 starting from /tmp/autopkgtest.8THSQp/build.f0r/src 258s + herd -s t-socket-1712 stop spawn-with-system 258s + herd -s t-socket-1712 status spawn-with-system 258s + grep stopped 258s It is stopped since 05:35:15 (0 seconds ago). 258s + herd -s t-socket-1712 status root foo bar baz 258s herd: error: exception caught while executing 'status' on service 'root': 258s Wrong number of arguments to # 258s + true 258s + herd -s t-socket-1712 doc root action status 258s status: Return an s-expression showing information about all the services. 258s Clients such as 'herd' can read it and format it in a human-readable way. 258s + herd -s t-socket-1712 doc root action an-action-that-does-not-exist 258s herd: error: service 'root' does not have an action 'an-action-that-does-not-exist' 258s herd: hint: Run 'herd doc root list-actions' to list supported actions. 258s + true 258s + herd -s t-socket-1712 doc root action an-action-that-does-not-exist 258s + grep does not have an action 'an-action-that-does-not-exist' 258s herd: error: service 'root' does not have an action 'an-action-that-does-not-exist' 258s + herd -s t-socket-1712 doc root list-actions 258s + grep ^daemonize: 258s daemonize: 258s + herd -s t-socket-1712 doc root list-actions 258s + grep ^halt: 258s halt: 258s + herd -s t-socket-1712 load root /does/not/exist.scm 258s herd: error: exception caught while executing 'load' on service 'root': 258s In procedure open-fdes: No such file or directory 258s + true 258s + herd -s t-socket-1712 unload root broken 258s Loading /does/not/exist.scm. 258s Removing service 'broken'... 258s Service broken is not running. 258s Done. 258s + herd -s t-socket-1712 unload root test 258s Removing service 'test'... 258s Done. 258s + herd -s t-socket-1712 status -n 0 258s + grep -e - test-2 258s + herd -s t-socket-1712 reload root t-conf-1712 258s - test-2 258s Service test-2 is not running. 258s Service spawn-with-system is not running. 258s Loading t-conf-1712. 258s + herd -s t-socket-1712 status -n 0 258s + test Started: 258s + root 258s Stopped: 258s - broken 258s - spawn-with-system 258s - test 258s - test-2 == Started: 258s + root 258s Stopped: 258s - broken 258s - spawn-with-system 258s - test 258s - test-2 258s tests/basic.sh: 205: test: Started: 258s + root 258s Stopped: 258s - broken 258s - spawn-with-system 258s - test 258s - test-2: unexpected operator 258s + mkdir -p t-confdir-1712 258s + cat 258s + herd -s t-socket-1712 status test-loaded 258s herd: error: service 'test-loaded' could not be found 258s + true 258s + herd -s t-socket-1712 load root t-confdir-1712/some-conf.scm 258s Loading t-confdir-1712/some-conf.scm. 258s + rm t-confdir-1712/some-conf.scm 258s + grep register-services.*rest list.*deprecated t-log-1712 258s 2025-05-02 05:35:15 Passing 'register-services' services as a rest list is now deprecated. 258s + herd -s t-socket-1712 status test-loaded 258s ● Status of test-loaded: 258s It is stopped. 258s It is enabled. 258s Provides: test-loaded 258s Will not be respawned. 258s + herd -s t-socket-1712 status test-loaded 258s + grep stopped 258s It is stopped. 258s + herd -s t-socket-1712 start test-loaded 258s Greek letter λ 258s Service test-loaded has been started. 258s + herd -s t-socket-1712 status test-loaded 258s + grep -i running.*abc 258s + grep Greek letter t-log-1712 258s Running value is abc. 258s + herd -s t-socket-1712 stop test-loaded 258s 2025-05-02 05:35:15 Greek letter λ 258s + herd -s t-socket-1712 unload root test-loaded 258s Removing service 'test-loaded'... 258s Service test-loaded is not running. 258s Done. 258s + type -P pwd 258s + cat 258s + herd -s t-socket-1712 load root t-confdir-1712/some-conf.scm 258s Loading t-confdir-1712/some-conf.scm. 258s + herd -s t-socket-1712 start test-run-from-nonexistent-directory 258s + herd -s t-socket-1712 status test-run-from-nonexistent-directory 258s + grep exited with code 127 258s Starting service test-run-from-nonexistent-directory... 258s Service test-run-from-nonexistent-directory started. 258s Service test-run-from-nonexistent-directory running with value #< id: 2400 command: ("-P: not found\npwd is a shell builtin")>. 258s Service test-run-from-nonexistent-directory has been started. 258s Process exited with code 127. 258s + seq 1 10 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 258s + test 1733 -eq 1733 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 258s + test 1733 -eq 1733 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 258s + test 1733 -eq 1733 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 258s + test 1733 -eq 1733 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 258s + test 1733 -eq 1733 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 258s + test 1733 -eq 1733 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 258s + test 1733 -eq 1733 258s + herd -s t-socket-1712 eval root (getpid) 258s + grep ^[0-9] 259s + test 1733 -eq 1733 259s + herd -s t-socket-1712 eval root (getpid) 259s + grep ^[0-9] 259s + test 1733 -eq 1733 259s + herd -s t-socket-1712 eval root (getpid) 259s + grep ^[0-9] 259s + test 1733 -eq 1733 259s + herd -s t-socket-1712 unload root test-run-from-nonexistent-directory 259s Removing service 'test-run-from-nonexistent-directory'... 259s Service test-run-from-nonexistent-directory is not running. 259s Done. 259s + cat 259s + herd -s t-socket-1712 load root t-confdir-1712/some-conf.scm 259s + herd -s t-socket-1712 start test-loaded 259s Loading t-confdir-1712/some-conf.scm. 259s + herd -s t-socket-1712 status test-loaded 259s + grep -i running.*# 259s Starting service test-loaded... 259s Service test-loaded started. 259s Service test-loaded running with value #. 259s Service test-loaded has been started. 259s Running value is "#". 259s + herd -s t-socket-1712 stop test-loaded 259s + herd -s t-socket-1712 eval root (perform-service-action root-service 'unload "test-loaded") 259s Evaluating user expression (perform-service-action root-service (quote #) #). 259s Removing service 'test-loaded'... 259s Service test-loaded is not running. 259s Done. 259s "#" 259s + herd -s t-socket-1712 status test-loaded 259s herd: error: service 'test-loaded' could not be found 259s + true 259s + cat 259s + herd -s t-socket-1712 load root t-confdir-1712/some-conf.scm 259s herd: error: exception caught while executing 'load' on service 'root': 259s Syntax error: 259s unknown location: source expression failed to match any pattern in form (define x y z) 259s Loading t-confdir-1712/some-conf.scm. 259s + true 259s + herd -s t-socket-1712 status 259s + cat 259s + herd -s t-socket-1712 load root t-confdir-1712/some-conf.scm 259s Started: 259s + root 259s Stopped: 259s - broken 259s - spawn-with-system 259s - test 259s - test-2 259s herd: error: exception caught while executing 'load' on service 'root': 259s Throw to key `what?!' with args `("#<>")'. 259s Loading t-confdir-1712/some-conf.scm. 259s + true 259s + herd -s t-socket-1712 status 259s + herd -s t-socket-1712 eval root (/ 0 0) 259s Started: 259s + root 259s Stopped: 259s - broken 259s - spawn-with-system 259s - test 259s - test-2 259s Evaluating user expression (/ 0 0). 259s herd: error: exception caught while executing 'eval' on service 'root': 259s Throw to key `numerical-overflow' with args `("divide" "Numerical overflow" #f #f)'. 259s + true 259s + herd -s t-socket-1712 eval root (no closing paren 259s herd: error: exception caught while executing 'eval' on service 'root': 259s #:1:18: unexpected end of input while searching for: #\) 259s + true 259s + herd -s t-socket-1712 eval root (values) 259s + herd -s t-socket-1712 eval root ((@ (fibers) sleep) 1) 259s Evaluating user expression (values). 259s "#" 260s + herd -s t-socket-1712 unload root all 260s Evaluating user expression ((@ (fibers) sleep) 1). 260s "#" 260s Service broken is not running. 260s Service spawn-with-system is not running. 260s Service test-2 is not running. 260s Service test is not running. 260s + herd -s t-socket-1712 status 260s + grep Stopped: 260s + true 260s + herd -s t-socket-1712 status 260s + grep -e + root 260s + root 260s + grep already running t-log-1712 260s + true 260s + herd -s t-socket-1712 start root 260s + grep already running 260s Service root is already running. 260s + grep already running t-log-1712 260s 2025-05-02 05:35:17 Service root is already running. 260s + herd -s t-socket-1712 stop root 260s Stopping service root... 260s Exiting. 260s + kill -0 1733 260s tests/basic.sh: 332: kill: No such process 260s 260s + test -f t-log-1712 260s + export XDG_CONFIG_HOME=t-confdir-1712 260s + export XDG_DATA_HOME=t-datadir-1712 260s + export XDG_STATE_HOME=t-datadir-1712 260s + mkdir -p t-confdir-1712/shepherd 260s + mkdir -p t-datadir-1712/shepherd 260s + mv t-conf-1712 t-confdir-1712/shepherd/init.scm 260s + rm -f t-pid-1712 t-socket-1712 260s + test -f t-pid-1712 260s + sleep 0.3 260s + shepherd -I -s t-socket-1712 --pid=t-pid-1712 260s GNU Shepherd 1.0.2 (Guile 3.0.10, arm-unknown-linux-gnueabihf) 260s Starting service root... 260s Service root started. 260s Service root running with value #< id: 2717 command: #f>. 260s Service root has been started. 260s Configuration successfully loaded from 't-confdir-1712/shepherd/init.scm'. 260s + test -f t-pid-1712 260s + herd -s t-socket-1712 start test 260s + test -f t-stamp-1712 260s + herd -s t-socket-1712 status test 260s + grep running 260s Starting service test... 260s Service test started. 260s Service test running with value #t. 260s Service test has been started. 260s + herd -s t-socket-1712 stop test 260s It is running since 05:35:17 (0 seconds ago). 260s + test -f t-stamp-1712 260s + cat t-pid-1712 260s + shepherd_pid=2717 260s + herd -s t-socket-1712 stop root 261s Stopping service root... 261s Exiting. 261s + kill -0 2717 261s tests/basic.sh: 369: kill: No such process 261s 261s + rm -rf t-confdir-1712 t-datadir-1712 261s + cat t-log-1712 261s + rm -f t-socket-1712 t-conf-1712 t-stamp-1712 t-log-1712 261s 2025-05-02 05:35:13 GNU Shepherd 1.0.2 (Guile 3.0.10, arm-unknown-linux-gnueabihf) 261s 2025-05-02 05:35:13 Starting service root... 261s 2025-05-02 05:35:13 Service root started. 261s 2025-05-02 05:35:13 Service root running with value #< id: 1733 command: #f>. 261s 2025-05-02 05:35:13 Service root has been started. 261s 2025-05-02 05:35:13 Configuration successfully loaded from 't-conf-1712'. 261s 2025-05-02 05:35:14 Starting service test... 261s 2025-05-02 05:35:14 Service test has been started. 261s 2025-05-02 05:35:14 Service test started. 261s 2025-05-02 05:35:14 Service test running with value #t. 261s 2025-05-02 05:35:14 Stopping service test... 261s 2025-05-02 05:35:14 Service test might have failed to stop. 261s 2025-05-02 05:35:14 Service test is now stopped. 261s 2025-05-02 05:35:14 Disabled service test-2. 261s 2025-05-02 05:35:14 Starting service test... 261s 2025-05-02 05:35:14 Service test has been started. 261s 2025-05-02 05:35:14 Service test started. 261s 2025-05-02 05:35:14 Service test running with value #t. 261s 2025-05-02 05:35:14 Service test-2 is currently disabled. 261s 2025-05-02 05:35:14 Service test-2 is currently disabled. 261s 2025-05-02 05:35:14 Enabled service test-2. 261s 2025-05-02 05:35:14 Starting service test-2... 261s 2025-05-02 05:35:14 Service test-2 has been started. 261s 2025-05-02 05:35:14 Service test-2 started. 261s 2025-05-02 05:35:14 Service test-2 running with value #t. 261s 2025-05-02 05:35:14 hi: Say hi. 261s 2025-05-02 05:35:14 start 261s 2025-05-02 05:35:14 261s 2025-05-02 05:35:14 end 261s 2025-05-02 05:35:14 start 261s 2025-05-02 05:35:14 261s 2025-05-02 05:35:14 end 261s 2025-05-02 05:35:14 start 261s 2025-05-02 05:35:14 261s 2025-05-02 05:35:14 end 261s 2025-05-02 05:35:14 start 261s 2025-05-02 05:35:14 261s 2025-05-02 05:35:14 end 261s 2025-05-02 05:35:14 Starting service broken... 261s 2025-05-02 05:35:14 Service broken failed to start. 261s 2025-05-02 05:35:15 Starting service spawn-with-system... 261s 2025-05-02 05:35:15 Service spawn-with-system has been started. 261s 2025-05-02 05:35:15 [bash] starting from /tmp/autopkgtest.8THSQp/build.f0r/src 261s 2025-05-02 05:35:15 Service spawn-with-system started. 261s 2025-05-02 05:35:15 Service spawn-with-system running with value #t. 261s 2025-05-02 05:35:15 Stopping service spawn-with-system... 261s 2025-05-02 05:35:15 Registering new logger for spawn-with-system. 261s 2025-05-02 05:35:15 [bash] stopping from /tmp/autopkgtest.8THSQp/build.f0r/src 261s 2025-05-02 05:35:15 Service spawn-with-system stopped. 261s 2025-05-02 05:35:15 Service spawn-with-system is now stopped. 261s 2025-05-02 05:35:15 status: Return an s-expression showing information about all the services. 261s 2025-05-02 05:35:15 Clients such as 'herd' can read it and format it in a human-readable way. 261s 2025-05-02 05:35:15 help: 261s 2025-05-02 05:35:15 Show the help message for the 'root' service. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 status: 261s 2025-05-02 05:35:15 Return an s-expression showing information about all the services. 261s 2025-05-02 05:35:15 Clients such as 'herd' can read it and format it in a human-readable way. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 halt: 261s 2025-05-02 05:35:15 Halt the system. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 power-off: 261s 2025-05-02 05:35:15 Halt the system and turn it off. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 kexec: 261s 2025-05-02 05:35:15 Reboot the system and run kexec. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 load: 261s 2025-05-02 05:35:15 Load the Scheme code from FILE into shepherd. This is potentially 261s 2025-05-02 05:35:15 dangerous. You have been warned. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 eval: 261s 2025-05-02 05:35:15 Evaluate the given Scheme expression into the shepherd. This is 261s 2025-05-02 05:35:15 potentially dangerous, be careful. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 unload: 261s 2025-05-02 05:35:15 Unload the service identified by SERVICE-NAME or all services 261s 2025-05-02 05:35:15 except for 'root' if SERVICE-NAME is 'all'. Stop services before 261s 2025-05-02 05:35:15 removing them if needed. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 reload: 261s 2025-05-02 05:35:15 Unload all services, then load from FILE-NAME into shepherd. This 261s 2025-05-02 05:35:15 is potentially dangerous. You have been warned. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 daemonize: 261s 2025-05-02 05:35:15 Go into the background. Be careful, this means that a new 261s 2025-05-02 05:35:15 process will be created, so shepherd will not get SIGCHLD signals anymore 261s 2025-05-02 05:35:15 if previously spawned children terminate. Therefore, this action should 261s 2025-05-02 05:35:15 usually only be used (if at all) *before* children get spawned for which 261s 2025-05-02 05:35:15 we want to receive these signals. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 restart: 261s 2025-05-02 05:35:15 This does not work for the 'root' service. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 help: 261s 2025-05-02 05:35:15 Show the help message for the 'root' service. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 status: 261s 2025-05-02 05:35:15 Return an s-expression showing information about all the services. 261s 2025-05-02 05:35:15 Clients such as 'herd' can read it and format it in a human-readable way. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 halt: 261s 2025-05-02 05:35:15 Halt the system. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 power-off: 261s 2025-05-02 05:35:15 Halt the system and turn it off. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 kexec: 261s 2025-05-02 05:35:15 Reboot the system and run kexec. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 load: 261s 2025-05-02 05:35:15 Load the Scheme code from FILE into shepherd. This is potentially 261s 2025-05-02 05:35:15 dangerous. You have been warned. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 eval: 261s 2025-05-02 05:35:15 Evaluate the given Scheme expression into the shepherd. This is 261s 2025-05-02 05:35:15 potentially dangerous, be careful. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 unload: 261s 2025-05-02 05:35:15 Unload the service identified by SERVICE-NAME or all services 261s 2025-05-02 05:35:15 except for 'root' if SERVICE-NAME is 'all'. Stop services before 261s 2025-05-02 05:35:15 removing them if needed. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 reload: 261s 2025-05-02 05:35:15 Unload all services, then load from FILE-NAME into shepherd. This 261s 2025-05-02 05:35:15 is potentially dangerous. You have been warned. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 daemonize: 261s 2025-05-02 05:35:15 Go into the background. Be careful, this means that a new 261s 2025-05-02 05:35:15 process will be created, so shepherd will not get SIGCHLD signals anymore 261s 2025-05-02 05:35:15 if previously spawned children terminate. Therefore, this action should 261s 2025-05-02 05:35:15 usually only be used (if at all) *before* children get spawned for which 261s 2025-05-02 05:35:15 we want to receive these signals. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 restart: 261s 2025-05-02 05:35:15 This does not work for the 'root' service. 261s 2025-05-02 05:35:15 261s 2025-05-02 05:35:15 Loading /does/not/exist.scm. 261s 2025-05-02 05:35:15 Removing service 'broken'... 261s 2025-05-02 05:35:15 Service broken is not running. 261s 2025-05-02 05:35:15 Done. 261s 2025-05-02 05:35:15 Removing service 'test'... 261s 2025-05-02 05:35:15 Stopping service test-2... 261s 2025-05-02 05:35:15 Service test-2 might have failed to stop. 261s 2025-05-02 05:35:15 Service test-2 is now stopped. 261s 2025-05-02 05:35:15 Stopping service test... 261s 2025-05-02 05:35:15 Service test might have failed to stop. 261s 2025-05-02 05:35:15 Service test is now stopped. 261s 2025-05-02 05:35:15 Done. 261s 2025-05-02 05:35:15 Service test-2 is not running. 261s 2025-05-02 05:35:15 Service spawn-with-system is not running. 261s 2025-05-02 05:35:15 Loading t-conf-1712. 261s 2025-05-02 05:35:15 Loading t-confdir-1712/some-conf.scm. 261s 2025-05-02 05:35:15 Passing 'register-services' services as a rest list is now deprecated. 261s 2025-05-02 05:35:15 Starting service test-loaded... 261s 2025-05-02 05:35:15 Greek letter λ 261s 2025-05-02 05:35:15 Service test-loaded has been started. 261s 2025-05-02 05:35:15 Service test-loaded started. 261s 2025-05-02 05:35:15 Service test-loaded running with value abc. 261s 2025-05-02 05:35:15 Stopping service test-loaded... 261s 2025-05-02 05:35:15 Service test-loaded stopped. 261s 2025-05-02 05:35:15 Service test-loaded is now stopped. 261s 2025-05-02 05:35:15 Removing service 'test-loaded'... 261s 2025-05-02 05:35:15 Service test-loaded is not running. 261s 2025-05-02 05:35:15 Done. 261s 2025-05-02 05:35:15 Loading t-confdir-1712/some-conf.scm. 261s 2025-05-02 05:35:15 Starting service test-run-from-nonexistent-directory... 261s 2025-05-02 05:35:15 Service test-run-from-nonexistent-directory started. 261s 2025-05-02 05:35:15 Failed to run "-P: not found\npwd is a shell builtin": In procedure chdir: No such file or directory 261s 2025-05-02 05:35:15 Service test-run-from-nonexistent-directory running with value #< id: 2400 command: ("-P: not found\npwd is a shell builtin")>. 261s 2025-05-02 05:35:15 Service test-run-from-nonexistent-directory has been started. 261s 2025-05-02 05:35:15 Service test-run-from-nonexistent-directory (PID 2400) exited with 127. 261s 2025-05-02 05:35:15 Service test-run-from-nonexistent-directory has been disabled. 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:15 Evaluating user expression (getpid). 261s 2025-05-02 05:35:16 Evaluating user expression (getpid). 261s 2025-05-02 05:35:16 Evaluating user expression (getpid). 261s 2025-05-02 05:35:16 Removing service 'test-run-from-nonexistent-directory'... 261s 2025-05-02 05:35:16 Service test-run-from-nonexistent-directory is not running. 261s 2025-05-02 05:35:16 Done. 261s 2025-05-02 05:35:16 Loading t-confdir-1712/some-conf.scm. 261s 2025-05-02 05:35:16 Starting service test-loaded... 261s 2025-05-02 05:35:16 Service test-loaded started. 261s 2025-05-02 05:35:16 Service test-loaded running with value #. 261s 2025-05-02 05:35:16 Service test-loaded has been started. 261s 2025-05-02 05:35:16 Stopping service test-loaded... 261s 2025-05-02 05:35:16 Service test-loaded stopped. 261s 2025-05-02 05:35:16 Service test-loaded is now stopped. 261s 2025-05-02 05:35:16 Evaluating user expression (perform-service-action root-service (quote #) #). 261s 2025-05-02 05:35:16 Removing service 'test-loaded'... 261s 2025-05-02 05:35:16 Service test-loaded is not running. 261s 2025-05-02 05:35:16 Done. 261s 2025-05-02 05:35:16 Loading t-confdir-1712/some-conf.scm. 261s 2025-05-02 05:35:16 Loading t-confdir-1712/some-conf.scm. 261s 2025-05-02 05:35:16 Evaluating user expression (/ 0 0). 261s 2025-05-02 05:35:16 Evaluating user expression (values). 261s 2025-05-02 05:35:16 Evaluating user expression ((@ (fibers) sleep) 1). 261s 2025-05-02 05:35:17 Service broken is not running. 261s 2025-05-02 05:35:17 Service spawn-with-system is not running. 261s 2025-05-02 05:35:17 Service test-2 is not running. 261s 2025-05-02 05:35:17 Service test is not running. 261s 2025-05-02 05:35:17 Service root is already running. 261s 2025-05-02 05:35:17 Stopping service root... 261s + test -f t-pid-1712 261s + cat t-pid-1712 261s + kill 2717 261s tests/basic.sh: 2: kill: No such process 261s 261s + true 261s + rm -f t-pid-1712 261s autopkgtest [05:35:18]: test tests-basic: -----------------------] 265s autopkgtest [05:35:22]: test tests-basic: - - - - - - - - - - results - - - - - - - - - - 265s tests-basic PASS 269s autopkgtest [05:35:26]: test tests-starting-status: preparing testbed 271s Reading package lists... 271s Building dependency tree... 271s Reading state information... 272s Starting pkgProblemResolver with broken count: 0 272s Starting 2 pkgProblemResolver with broken count: 0 272s Done 273s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 281s autopkgtest [05:35:38]: test tests-starting-status: sh -x tests/starting-status.sh 281s autopkgtest [05:35:38]: test tests-starting-status: [----------------------- 283s + shepherd --version 283s shepherd (GNU Shepherd) 1.0.2 283s Copyright (C) 2025 the Shepherd authors 283s License GPLv3+: GNU GPL version 3 or later 283s This is free software: you are free to change and redistribute it. 283s There is NO WARRANTY, to the extent permitted by law. 283s + herd --version 283s herd (GNU Shepherd) 1.0.2 283s Copyright (C) 2025 the Shepherd authors 283s License GPLv3+: GNU GPL version 3 or later 283s This is free software: you are free to change and redistribute it. 283s There is NO WARRANTY, to the extent permitted by law. 283s + socket=t-socket-2956 283s + conf=t-conf-2956 283s + confdir=t-confdir-2956 283s + datadir=t-datadir-2956 283s + log=t-log-2956 283s + stamp=t-stamp-2956 283s + pid=t-pid-2956 283s + herd=herd -s t-socket-2956 283s + trap cat t-log-2956 || true; rm -f t-socket-2956 t-conf-2956 t-stamp-2956 t-log-2956; 283s test -f t-pid-2956 && kill `cat t-pid-2956` || true; rm -f t-pid-2956 EXIT 283s + cat 283s + rm -f t-pid-2956 t-stamp-2956 283s + test -f t-pid-2956 283s + sleep 0.3 283s + shepherd -I -s t-socket-2956 -c t-conf-2956 -l t-log-2956 --pid=t-pid-2956 283s GNU Shepherd 1.0.2 (Guile 3.0.10, arm-unknown-linux-gnueabihf) 283s Starting service root... 283s Service root started. 283s Service root running with value #< id: 2977 command: #f>. 283s Service root has been started. 283s Configuration successfully loaded from 't-conf-2956'. 283s + test -f t-pid-2956 283s + cat t-pid-2956 283s + shepherd_pid=2977 283s + herd_pid=2989 283s + herd -s t-socket-2956 status 283s + herd -s t-socket-2956 start test 283s Started: 283s + root 283s Starting: 283s ^ test 283s + herd -s t-socket-2956 status 283s + grep ^ test 283s + herd -s t-socket-2956 status test 283s ^ test 283s + herd -s t-socket-2956 status test 283s + grep starting 283s ● Status of test: 283s It is starting. 283s It is enabled. 283s Provides: test 283s Will not be respawned. 283s + herd_pid2=3036 283s + sleep 1 283s + herd -s t-socket-2956 start test 283s It is starting. 284s + kill -0 2989 284s + kill -0 3036 284s + touch t-stamp-2956 284s + n=0 284s + : 284s + herd -s t-socket-2956 status test 284s + grep running 284s + expr 0 + 1 284s + n=1 284s + test 1 -le 10 284s + sleep 1 285s Starting service test... 285s Service test has been started. 285s + : 285s + herd -s t-socket-2956 status test 285s + grep running 285s + break 285s + n=0 285s + : 285s + kill -0 2989 285s tests/starting-status.sh: 91: kill: No such process 285s 285s + kill -0 3036 285s tests/starting-status.sh: 91: kill: No such process 285s 285s + break 285s + herd -s t-socket-2956 stop test 285s It is running since 05:35:42 (0 seconds ago). 286s + test -f t-stamp-2956 286s + grep Starting service test t-log-2956 286s + wc -l 286s Now trying to stop a service in 'starting' state. 286s + test 1 = 1 286s + echo Now trying to stop a service in 'starting' state. 286s + herd_start_pid=3081 286s + herd -s t-socket-2956 start test 286s + herd -s t-socket-2956 status test 286s + grep starting 286s It is starting. 286s + herd_stop_pid1=3100 286s + herd_stop_pid2=3101 286s + herd -s t-socket-2956 stop test 286s + herd -s t-socket-2956 stop test 286s + seq 1 3 286s + herd -s t-socket-2956 status test 286s + grep starting 286s + sleep 0.3 286s It is starting. 286s + + grep starting 286s herd -s t-socket-2956 status test 286s It is starting. 286s + sleep 0.3 286s + herd -s t-socket-2956 status test 286s + grep starting 286s It is starting. 286s + sleep 0.3 287s 2025-05-02 05:35:43 Waiting for test to start... 287s 2025-05-02 05:35:43 Waiting for test to start... 287s + grep Waiting for test to start t-log-2956 287s + touch t-stamp-2956 287s + kill -0 3081 287s + sleep 0.5 287s + kill -0 3081 287s + sleep 0.5 288s + kill -0 3081 288s tests/starting-status.sh: 131: kill: No such process 288s 288s + kill -0 3100 288s tests/starting-status.sh: 132: kill: No such process 288s 288s + kill -0 3101 288s tests/starting-status.sh: 133: kill: No such process 288s 288s + herd -s t-socket-2956 status test 288s + grep stopped 288s Service test has been started. 288s It is stopped since 05:35:45 (0 seconds ago). 288s + herd -s t-socket-2956 stop root 288s Stopping service root... 288s Exiting. 288s + rm -rf t-confdir-2956 288s + rm -rf t-datadir-2956 288s + cat t-log-2956 288s + rm -f t-socket-2956 t-conf-2956 t-stamp-2956 t-log-2956 288s 2025-05-02 05:35:40 GNU Shepherd 1.0.2 (Guile 3.0.10, arm-unknown-linux-gnueabihf) 288s 2025-05-02 05:35:40 Starting service root... 288s 2025-05-02 05:35:40 Service root started. 288s 2025-05-02 05:35:40 Service root running with value #< id: 2977 command: #f>. 288s 2025-05-02 05:35:40 Service root has been started. 288s 2025-05-02 05:35:40 Configuration successfully loaded from 't-conf-2956'. 288s 2025-05-02 05:35:40 Starting service test... 288s 2025-05-02 05:35:42 Service test has been started. 288s 2025-05-02 05:35:42 Service test started. 288s 2025-05-02 05:35:42 Service test running with value #t. 288s 2025-05-02 05:35:42 Stopping service test... 288s 2025-05-02 05:35:42 Service test might have failed to stop. 288s 2025-05-02 05:35:42 Service test is now stopped. 288s 2025-05-02 05:35:43 Starting service test... 288s 2025-05-02 05:35:43 Waiting for test to start... 288s 2025-05-02 05:35:43 Waiting for test to start... 288s 2025-05-02 05:35:45 Service test has been started. 288s 2025-05-02 05:35:45 Service test started. 288s 2025-05-02 05:35:45 Service test running with value #t. 288s 2025-05-02 05:35:45 Stopping service test... 288s 2025-05-02 05:35:45 Service test might have failed to stop. 288s 2025-05-02 05:35:45 Service test is now stopped. 288s 2025-05-02 05:35:45 Stopping service root... 288s 2025-05-02 05:35:45 Exiting shepherd... 288s + test -f t-pid-2956 288s + cat t-pid-2956 288s + kill 2977 288s tests/starting-status.sh: 2: kill: No such process 288s 288s + true 288s + rm -f t-pid-2956 288s autopkgtest [05:35:45]: test tests-starting-status: -----------------------] 292s autopkgtest [05:35:49]: test tests-starting-status: - - - - - - - - - - results - - - - - - - - - - 292s tests-starting-status PASS 296s autopkgtest [05:35:53]: test tests-one-shot: preparing testbed 298s Reading package lists... 298s Building dependency tree... 298s Reading state information... 299s Starting pkgProblemResolver with broken count: 0 299s Starting 2 pkgProblemResolver with broken count: 0 299s Done 300s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 308s autopkgtest [05:36:05]: test tests-one-shot: sh -x tests/one-shot.sh 308s autopkgtest [05:36:05]: test tests-one-shot: [----------------------- 310s + shepherd --version 310s shepherd (GNU Shepherd) 1.0.2 310s Copyright (C) 2025 the Shepherd authors 310s License GPLv3+: GNU GPL version 3 or later 310s This is free software: you are free to change and redistribute it. 310s There is NO WARRANTY, to the extent permitted by law. 310s + herd --version 310s herd (GNU Shepherd) 1.0.2 310s Copyright (C) 2025 the Shepherd authors 310s License GPLv3+: GNU GPL version 3 or later 310s This is free software: you are free to change and redistribute it. 310s There is NO WARRANTY, to the extent permitted by law. 310s + socket=t-socket-3367 310s + conf=t-conf-3367 310s + confdir=t-confdir-3367 310s + log=t-log-3367 310s + stamp=t-stamp-3367 310s + pid=t-pid-3367 310s + herd=herd -s t-socket-3367 310s + trap cat t-log-3367 || true; rm -f t-socket-3367 t-conf-3367 t-stamp-3367 t-log-3367; 310s test -f t-pid-3367 && kill `cat t-pid-3367` || true; rm -f t-pid-3367 EXIT 310s + cat 310s + rm -f t-pid-3367 310s + test -f t-pid-3367 310s + sleep 0.3 310s + shepherd -I -s t-socket-3367 -c t-conf-3367 -l t-log-3367 --pid=t-pid-3367 310s GNU Shepherd 1.0.2 (Guile 3.0.10, arm-unknown-linux-gnueabihf) 310s Starting service root... 310s Service root started. 310s Service root running with value #< id: 3388 command: #f>. 310s Service root has been started. 310s Configuration successfully loaded from 't-conf-3367'. 310s Starting service one-shotty... 310s Service one-shotty started. 310s Service one-shotty running with value #t. 310s Service one-shotty has been started. 310s Starting service a... 310s Service a started. 310s Service a running with value #t. 310s Service a has been started. 310s Starting service b... 310s Service b started. 310s Service b running with value #t. 310s Service b has been started. 310s Starting service c... 310s Service c started. 310s Service c running with value #t. 310s Service c has been started. 310s Successfully started 3 services in the background. 310s + test -f t-pid-3367 310s + cat t-pid-3367 310s + shepherd_pid=3388 310s + kill -0 3388 310s + test -S t-socket-3367 310s + herd -s t-socket-3367 start always-fail 310s Starting service always-fail... 310s Service always-fail failed to start. 310s Service always-fail could not be started. 310s herd: error: failed to start service always-fail 310s + true 310s + rm -f t-stamp-3367 310s + herd -s t-socket-3367 start test 310s Starting service test... 310s Service test started. 310s Service test running with value #t. 310s Service test has been started. 310s + test -f t-stamp-3367 310s + herd -s t-socket-3367 status test 310s + grep stopped.*one-shot 310s It is stopped (one-shot). 310s + grep test.*started t-log-3367 310s 2025-05-02 05:36:07 Service test started. 310s 2025-05-02 05:36:07 Service test has been started. 310s + herd -s t-socket-3367 stop test 310s + rm -f t-stamp-3367 310s + herd -s t-socket-3367 start test 310s Service test has been started. 310s + test -f t-stamp-3367 310s + herd -s t-socket-3367 status test 310s + grep stopped.*one-shot 310s + grep test.*started t-log-3367 310s It is stopped (one-shot). 310s 2025-05-02 05:36:07 Service test started. 310s 2025-05-02 05:36:07 Service test has been started. 310s 2025-05-02 05:36:07 Service test has been started. 310s 2025-05-02 05:36:07 Service test started. 310s + herd -s t-socket-3367 stop test 310s + rm -f t-stamp-3367 310s + herd -s t-socket-3367 start test 310s Service test has been started. 310s + test -f t-stamp-3367 310s + herd -s t-socket-3367 status test 310s + grep stopped.*one-shot 310s It is stopped (one-shot). 310s + grep test.*started t-log-3367 310s 2025-05-02 05:36:07 Service test started. 310s 2025-05-02 05:36:07 Service test has been started. 310s 2025-05-02 05:36:07 Service test has been started. 310s 2025-05-02 05:36:07 Service test started. 310s 2025-05-02 05:36:07 Service test has been started. 310s 2025-05-02 05:36:07 Service test started. 310s + herd -s t-socket-3367 stop test 310s + herd -s t-socket-3367 status 310s + grep -i ^one-shot 310s One-shot: 310s + herd -s t-socket-3367 status 310s + rm -f t-stamp-3367 t-stamp-3367-2 310s Started: 310s + a 310s + b 310s + c 310s + root 310s Stopped: 310s - test-2 310s One-shot: 310s * always-fail 310s * one-shotty 310s * test 310s + herd -s t-socket-3367 start test-2 310s Service test has been started. 310s Service test-2 has been started. 310s + test -f t-stamp-3367 310s + test -f t-stamp-3367-2 310s + herd -s t-socket-3367 status test 310s + grep stopped.*one-shot 310s It is stopped (one-shot). 310s + herd -s t-socket-3367 status test-2 310s + grep running 310s It is running since 05:36:07 (0 seconds ago). 310s + herd -s t-socket-3367 stop test-2 310s + test -f t-stamp-3367-2 310s + true 310s + grep Starting service one-shotty t-log-3367 310s + wc -l 310s + test 1 -eq 1 310s + herd -s t-socket-3367 stop a 311s Stopping service c... 311s Service c stopped. 311s + herd -s t-socket-3367 start c 311s Service c is now stopped. 311s Stopping service b... 311s Service b stopped. 311s Service b is now stopped. 311s Stopping service a... 311s Service a stopped. 311s Service a is now stopped. 311s Starting service one-shotty... 311s Service one-shotty started. 311s Service one-shotty running with value #t. 311s Starting service a... 311s Service a started. 311s Service a running with value #t. 311s Starting service b... 311s Service b started. 311s Service b running with value #t. 311s Starting service c... 311s Service c started. 311s Service c running with value #t. 311s + grep Starting service one-shotty t-log-3367 311s + wc -l 311s + test 2 -eq 2 311s + herd -s t-socket-3367 stop a 311s Service one-shotty has been started. 311s Service a has been started. 311s Service b has been started. 311s Service c has been started. 311s Stopping service c... 311s Service c stopped. 311s Service c is now stopped. 311s Stopping service b... 311s Service b stopped. 311s Service b is now stopped. 311s Stopping service a... 311s Service a stopped. 311s Service a is now stopped. 311s + herd -s t-socket-3367 start c 311s Starting service one-shotty... 311s Service one-shotty started. 311s Service one-shotty running with value #t. 311s Starting service a... 311s Service a started. 311s Service a running with value #t. 311s Starting service b... 311s Service b started. 311s Service b running with value #t. 311s Starting service c... 311s Service c started. 311s Service c running with value #t. 311s Service one-shotty has been started. 311s Service a has been started. 311s Service b has been started. 311s Service c has been started. 311s + grep Starting service one-shotty t-log-3367 311s + wc -l 311s + test 3 -eq 3 311s + herd -s t-socket-3367 start one-shotty 311s Starting service one-shotty... 311s Service one-shotty started. 311s Service one-shotty running with value #t. 311s Service one-shotty has been started. 311s + grep Starting service one-shotty t-log-3367 311s + wc -l 311s + test 4 -eq 4 311s + cat 311s + rm -f t-stamp-3367 311s + herd -s t-socket-3367 load root t-conf-3367 311s Loading t-conf-3367. 311s + grep Service third started t-log-3367 311s + sleep 0.5 311s + grep Service third started t-log-3367 311s + sleep 0.5 312s + grep Service third started t-log-3367 312s + sleep 0.5 312s + grep Service third started t-log-3367 312s + sleep 0.5 313s 2025-05-02 05:36:10 Service third started. 313s + grep Service third started t-log-3367 313s + cat t-stamp-3367 313s + test third = third 313s + herd -s t-socket-3367 start fourth 313s Service always-fail could not be started. 313s Service fourth depends on always-fail. 313s herd: error: failed to start service fourth 313s + herd -s t-socket-3367 start fourth 313s herd: error: failed to start service fourth 313s + herd -s t-socket-3367 stop root 313s Service always-fail could not be started. 313s Service fourth depends on always-fail. 313s Stopping service root... 313s Stopping service c... 313s Service c stopped. 313s Service c is now stopped. 313s Stopping service b... 313s Service b stopped. 313s Service b is now stopped. 313s Stopping service a... 313s Service a stopped. 313s Service a is now stopped. 313s + cat t-log-3367 313s + rm -f t-socket-3367 t-conf-3367 t-stamp-3367 t-log-3367 313s + test -f t-pid-3367 313s + cat t-pid-3367 313s + kill 3388 313s tests/one-shot.sh: 2: kill: No such process 313s 313s + true 313s + rm -f t-pid-3367 313s Exiting. 313s 2025-05-02 05:36:07 GNU Shepherd 1.0.2 (Guile 3.0.10, arm-unknown-linux-gnueabihf) 313s 2025-05-02 05:36:07 Starting service root... 313s 2025-05-02 05:36:07 Service root started. 313s 2025-05-02 05:36:07 Service root running with value #< id: 3388 command: #f>. 313s 2025-05-02 05:36:07 Service root has been started. 313s 2025-05-02 05:36:07 Configuration successfully loaded from 't-conf-3367'. 313s 2025-05-02 05:36:07 Starting service one-shotty... 313s 2025-05-02 05:36:07 Service one-shotty started. 313s 2025-05-02 05:36:07 Service one-shotty running with value #t. 313s 2025-05-02 05:36:07 Service one-shotty has been started. 313s 2025-05-02 05:36:07 Starting service a... 313s 2025-05-02 05:36:07 Service a started. 313s 2025-05-02 05:36:07 Service a running with value #t. 313s 2025-05-02 05:36:07 Service a has been started. 313s 2025-05-02 05:36:07 Starting service b... 313s 2025-05-02 05:36:07 Service b started. 313s 2025-05-02 05:36:07 Service b running with value #t. 313s 2025-05-02 05:36:07 Service b has been started. 313s 2025-05-02 05:36:07 Starting service c... 313s 2025-05-02 05:36:07 Service c started. 313s 2025-05-02 05:36:07 Service c running with value #t. 313s 2025-05-02 05:36:07 Service c has been started. 313s 2025-05-02 05:36:07 Successfully started 3 services in the background. 313s 2025-05-02 05:36:07 Starting service always-fail... 313s 2025-05-02 05:36:07 Service always-fail failed to start. 313s 2025-05-02 05:36:07 Service always-fail could not be started. 313s 2025-05-02 05:36:07 Starting service test... 313s 2025-05-02 05:36:07 Service test started. 313s 2025-05-02 05:36:07 Service test running with value #t. 313s 2025-05-02 05:36:07 Service test has been started. 313s 2025-05-02 05:36:07 Starting service test... 313s 2025-05-02 05:36:07 Service test has been started. 313s 2025-05-02 05:36:07 Service test started. 313s 2025-05-02 05:36:07 Service test running with value #t. 313s 2025-05-02 05:36:07 Starting service test... 313s 2025-05-02 05:36:07 Service test has been started. 313s 2025-05-02 05:36:07 Service test started. 313s 2025-05-02 05:36:07 Service test running with value #t. 313s 2025-05-02 05:36:07 Starting service test... 313s 2025-05-02 05:36:07 Service test has been started. 313s 2025-05-02 05:36:07 Service test started. 313s 2025-05-02 05:36:07 Service test running with value #t. 313s 2025-05-02 05:36:07 Starting service test-2... 313s 2025-05-02 05:36:07 Service test-2 has been started. 313s 2025-05-02 05:36:07 Service test-2 started. 313s 2025-05-02 05:36:07 Service test-2 running with value #t. 313s 2025-05-02 05:36:07 Stopping service test-2... 313s 2025-05-02 05:36:07 Service test-2 stopped. 313s 2025-05-02 05:36:07 Service test-2 is now stopped. 313s 2025-05-02 05:36:07 Stopping service c... 313s 2025-05-02 05:36:07 Service c stopped. 313s 2025-05-02 05:36:07 Service c is now stopped. 313s 2025-05-02 05:36:07 Stopping service b... 313s 2025-05-02 05:36:07 Service b stopped. 313s 2025-05-02 05:36:07 Service b is now stopped. 313s 2025-05-02 05:36:07 Stopping service a... 313s 2025-05-02 05:36:07 Service a stopped. 313s 2025-05-02 05:36:07 Service a is now stopped. 313s 2025-05-02 05:36:07 Starting service one-shotty... 313s 2025-05-02 05:36:07 Service one-shotty has been started. 313s 2025-05-02 05:36:07 Service one-shotty started. 313s 2025-05-02 05:36:07 Service one-shotty running with value #t. 313s 2025-05-02 05:36:07 Starting service a... 313s 2025-05-02 05:36:07 Service a has been started. 313s 2025-05-02 05:36:08 Service a started. 313s 2025-05-02 05:36:08 Service a running with value #t. 313s 2025-05-02 05:36:08 Starting service b... 313s 2025-05-02 05:36:08 Service b has been started. 313s 2025-05-02 05:36:08 Service b started. 313s 2025-05-02 05:36:08 Service b running with value #t. 313s 2025-05-02 05:36:08 Starting service c... 313s 2025-05-02 05:36:08 Service c has been started. 313s 2025-05-02 05:36:08 Service c started. 313s 2025-05-02 05:36:08 Service c running with value #t. 313s 2025-05-02 05:36:08 Stopping service c... 313s 2025-05-02 05:36:08 Service c stopped. 313s 2025-05-02 05:36:08 Service c is now stopped. 313s 2025-05-02 05:36:08 Stopping service b... 313s 2025-05-02 05:36:08 Service b stopped. 313s 2025-05-02 05:36:08 Service b is now stopped. 313s 2025-05-02 05:36:08 Stopping service a... 313s 2025-05-02 05:36:08 Service a stopped. 313s 2025-05-02 05:36:08 Service a is now stopped. 313s 2025-05-02 05:36:08 Starting service one-shotty... 313s 2025-05-02 05:36:08 Service one-shotty has been started. 313s 2025-05-02 05:36:08 Service one-shotty started. 313s 2025-05-02 05:36:08 Service one-shotty running with value #t. 313s 2025-05-02 05:36:08 Starting service a... 313s 2025-05-02 05:36:08 Service a has been started. 313s 2025-05-02 05:36:08 Service a started. 313s 2025-05-02 05:36:08 Service a running with value #t. 313s 2025-05-02 05:36:08 Starting service b... 313s 2025-05-02 05:36:08 Service b has been started. 313s 2025-05-02 05:36:08 Service b started. 313s 2025-05-02 05:36:08 Service b running with value #t. 313s 2025-05-02 05:36:08 Starting service c... 313s 2025-05-02 05:36:08 Service c has been started. 313s 2025-05-02 05:36:08 Service c started. 313s 2025-05-02 05:36:08 Service c running with value #t. 313s 2025-05-02 05:36:08 Starting service one-shotty... 313s 2025-05-02 05:36:08 Service one-shotty has been started. 313s 2025-05-02 05:36:08 Service one-shotty started. 313s 2025-05-02 05:36:08 Service one-shotty running with value #t. 313s 2025-05-02 05:36:08 Loading t-conf-3367. 313s 2025-05-02 05:36:08 Starting service first... 313s 2025-05-02 05:36:09 Service first has been started. 313s 2025-05-02 05:36:09 Service first started. 313s 2025-05-02 05:36:09 Service first running with value #t. 313s 2025-05-02 05:36:09 Starting service second... 313s 2025-05-02 05:36:10 Service second has been started. 313s 2025-05-02 05:36:10 Service second started. 313s 2025-05-02 05:36:10 Service second running with value #t. 313s 2025-05-02 05:36:10 Starting service third... 313s 2025-05-02 05:36:10 Service third started. 313s 2025-05-02 05:36:10 Service third running with value #t. 313s 2025-05-02 05:36:10 Service third has been started. 313s 2025-05-02 05:36:10 Successfully started 3 services in the background. 313s 2025-05-02 05:36:10 Starting service always-fail... 313s 2025-05-02 05:36:10 Service always-fail could not be started. 313s 2025-05-02 05:36:10 Service always-fail failed to start. 313s 2025-05-02 05:36:10 Service fourth depends on always-fail. 313s 2025-05-02 05:36:10 Starting service always-fail... 313s 2025-05-02 05:36:10 Service always-fail could not be started. 313s 2025-05-02 05:36:10 Service always-fail failed to start. 313s 2025-05-02 05:36:10 Service fourth depends on always-fail. 313s 2025-05-02 05:36:10 Stopping service root... 313s 2025-05-02 05:36:10 Exiting shepherd... 313s 2025-05-02 05:36:10 Service always-fail is not running. 313s 2025-05-02 05:36:10 Service test is not running. 313s 2025-05-02 05:36:10 Service test-2 is not running. 313s 2025-05-02 05:36:10 Service one-shotty is not running. 313s 2025-05-02 05:36:10 Stopping service c... 313s 2025-05-02 05:36:10 Service c stopped. 313s 2025-05-02 05:36:10 Service c is now stopped. 313s 2025-05-02 05:36:10 Stopping service b... 313s 2025-05-02 05:36:10 Service b stopped. 313s 2025-05-02 05:36:10 Service b is now stopped. 313s 2025-05-02 05:36:10 Stopping service a... 313s 2025-05-02 05:36:10 Service a stopped. 313s 2025-05-02 05:36:10 Service a is now stopped. 313s 2025-05-02 05:36:10 Service b is not running. 313s 2025-05-02 05:36:10 Service c is not running. 313s 2025-05-02 05:36:10 Service first is not running. 313s 2025-05-02 05:36:10 Service second is not running. 313s autopkgtest [05:36:10]: test tests-one-shot: -----------------------] 318s tests-one-shot PASS 318s autopkgtest [05:36:15]: test tests-one-shot: - - - - - - - - - - results - - - - - - - - - - 322s autopkgtest [05:36:19]: @@@@@@@@@@@@@@@@@@@@ summary 322s herd--help PASS 322s shepherd--help PASS 322s herd--version PASS 322s shepherd--version PASS 322s tests-basic PASS 322s tests-starting-status PASS 322s tests-one-shot PASS