===========================================
   GNU Shepherd 0.10.0: ./test-suite.log
===========================================

# TOTAL: 25
# PASS:  23
# SKIP:  0
# XFAIL: 0
# FAIL:  2
# XPASS: 0
# ERROR: 0

.. contents:: :depth: 2

FAIL: tests/pid-file
====================

+ shepherd --version
shepherd (GNU Shepherd) 0.10.0
Copyright (C) 2023 the Shepherd authors
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
+ herd --version
herd (GNU Shepherd) 0.10.0
Copyright (C) 2023 the Shepherd authors
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
+ socket=t-socket-3925
+ conf=t-conf-3925
+ log=t-log-3925
+ pid=t-pid-3925
+ service_pid=t-service-pid-3925
+ herd='herd -s t-socket-3925'
+ trap 'cat t-log-3925 || true; rm -f t-socket-3925 t-conf-3925 t-service-pid-3925 t-log-3925;
      test -f t-pid-3925 && kill `cat t-pid-3925` || true; rm -f t-pid-3925' EXIT
+ cat
+ rm -f t-pid-3925
+ test -f t-pid-3925
+ sleep 0.3
+ shepherd -I -s t-socket-3925 -c t-conf-3925 -l t-log-3925 --pid=t-pid-3925
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
Starting service root...
Service root started.
Service root running with value #t.
Service root has been started.
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
Starting service test-works...
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
+ test -f t-pid-3925
+ sleep 0.3
Service test-works has been started.
Service test-works started.
Service test-works running with value 5928.
+ test -f t-pid-3925
++ cat t-pid-3925
+ shepherd_pid=4718
+ herd -s t-socket-3925 status test-works
+ grep running
  It is running since 03:39:15 (2 seconds ago).
+ test -f t-service-pid-3925
++ cat t-service-pid-3925
+ kill -0 5928
+ herd -s t-socket-3925 stop test-works
Stopping service test-works...
Service test-works stopped.
Service test-works is now stopped.
+ rm t-service-pid-3925
+ herd -s t-socket-3925 start test
Service test could not be started.
herd: error: failed to start service test
+ true
+ grep stopped
+ herd -s t-socket-3925 status test
  It is stopped (failing).
+ test -f t-service-pid-3925
++ cat t-service-pid-3925
+ kill -0 7240
./tests/pid-file.sh: line 127: kill: (7240) - No such process
+ true
+ rm -f t-service-pid-3925
+ herd -s t-socket-3925 start test-daemonizes
Service test-daemonizes could not be started.
herd: error: failed to start service test-daemonizes
+ true
+ grep stopped
+ herd -s t-socket-3925 status test-daemonizes
  It is stopped (failing).
+ test -f t-service-pid-3925
++ cat t-service-pid-3925
+ kill -0 9303
+ false
+ cat t-log-3925
2023-05-24 03:39:12 Starting service root...
2023-05-24 03:39:12 Service root started.
2023-05-24 03:39:12 Service root running with value #t.
2023-05-24 03:39:12 Service root has been started.
2023-05-24 03:39:13 Starting service test-works...
2023-05-24 03:39:15 Service test-works has been started.
2023-05-24 03:39:15 Service test-works started.
2023-05-24 03:39:15 Service test-works running with value 5928.
2023-05-24 03:39:19 Stopping service test-works...
2023-05-24 03:39:19 Service test-works stopped.
2023-05-24 03:39:19 Service test-works is now stopped.
2023-05-24 03:39:20 Starting service test...
2023-05-24 03:39:26 Service test could not be started.
2023-05-24 03:39:27 Service test failed to start.
2023-05-24 03:39:30 Starting service test-daemonizes...
2023-05-24 03:39:36 Service test-daemonizes could not be started.
2023-05-24 03:39:36 Service test-daemonizes failed to start.
+ rm -f t-socket-3925 t-conf-3925 t-service-pid-3925 t-log-3925
+ test -f t-pid-3925
++ cat t-pid-3925
+ kill 4718
+ rm -f t-pid-3925
Stopping service root...
Exiting shepherd...
Exiting.

Some deprecated features have been used.  Set the environment
variable GUILE_WARN_DEPRECATED to "detailed" and rerun the
program to get more information.  Set it to "no" to suppress
this message.
FAIL tests/pid-file.sh (exit status: 1)

FAIL: tests/forking-service
===========================

+ shepherd --version
shepherd (GNU Shepherd) 0.10.0
Copyright (C) 2023 the Shepherd authors
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
+ herd --version
herd (GNU Shepherd) 0.10.0
Copyright (C) 2023 the Shepherd authors
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
+ socket=t-socket-3968
+ conf=t-conf-3968
+ log=t-log-3968
+ pid=t-pid-3968
+ service_pid=t-service-pid-3968
+ service_nofiles=t-service-nofiles-3968
+ service2_pid=t-service2-pid-3968
+ service2_started=t-service2-starts-3968
+ herd='herd -s t-socket-3968'
+ trap cleanup EXIT
+ cat
+ cat t-conf-3968
;; Leave a timeout long enough for slow machines.
(default-pid-file-timeout 10)

(define %command
  '("/gnu/store/9q7cmydxbzfpc79ybn1yn257wq547kvz-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-0.10.0.drv-0/shepherd-0.10.0/t-service-nofiles-3968; sleep 600 & echo $! > /tmp/guix-build-shepherd-0.10.0.drv-0/shepherd-0.10.0/t-service-pid-3968"))

(register-services
 (list (service
	 ;; A service that forks into a different process.
	 '(test)
	 #:start (make-forkexec-constructor
                   %command
                   #:pid-file "/tmp/guix-build-shepherd-0.10.0.drv-0/shepherd-0.10.0/t-service-pid-3968"
                   #:resource-limits '((nofile 1567 1567)))
	 #:stop  (make-kill-destructor)
	 #:respawn? #f)))

(define %command2
  '("/gnu/store/9q7cmydxbzfpc79ybn1yn257wq547kvz-bash-minimal-5.1.16/bin/bash" "-c" "echo started >> /tmp/guix-build-shepherd-0.10.0.drv-0/shepherd-0.10.0/t-service2-starts-3968; sleep 600 & echo $! > /tmp/guix-build-shepherd-0.10.0.drv-0/shepherd-0.10.0/t-service2-pid-3968"))

(register-services
 (list (service
	 ;; A service that forks into a different process.
	 '(test2)
	 #:start (make-forkexec-constructor %command2
					    #:pid-file "/tmp/guix-build-shepherd-0.10.0.drv-0/shepherd-0.10.0/t-service2-pid-3968")
	 #:stop  (make-kill-destructor)
	 #:respawn? #t)))

(define %command3
  '("/gnu/store/9q7cmydxbzfpc79ybn1yn257wq547kvz-bash-minimal-5.1.16/bin/bash" "-c" "sleep 600"))

(register-services
 (list (service
	 ;; A service that forks into a different process.
	 '(test3)
	 #:start (make-forkexec-constructor %command3)
	 #:stop  (make-kill-destructor)
	 #:respawn? #t)))

(define %command4
  '("/gnu/store/9q7cmydxbzfpc79ybn1yn257wq547kvz-bash-minimal-5.1.16/bin/bash" "-c" "trap 'echo ignoring SIGTERM' SIGTERM; while true ; do : ; done"))

(register-services
 (list (service
	 ;; A service that ignores SIGTERM.
	 '(test4)
	 #:requirement '(test3)
	 #:start (make-forkexec-constructor %command4)
	 #:stop  (make-kill-destructor SIGTERM #:grace-period 3))))
+ rm -f t-pid-3968
+ test -f t-pid-3968
+ sleep 0.3
+ shepherd -I -s t-socket-3968 -c t-conf-3968 -l t-log-3968 --pid=t-pid-3968
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
Starting service root...
Service root started.
Service root running with value #t.
Service root has been started.
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
+ sleep 0.3
+ test -f t-pid-3968
++ cat t-pid-3968
+ shepherd_pid=4700
+ herd -s t-socket-3968 start test
Starting service test...
Service test has been started.
+ herd -s t-socket-3968 start test2
Starting service test2...
Service test2 has been started.
+ grep running
+ herd -s t-socket-3968 status test
  It is running since 03:39:18 (3 seconds ago).
+ test -f t-service-pid-3968
++ cat t-service-pid-3968
+ service_pid_value=6499
+ kill 6499
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
+ kill -0 6499
+ sleep 0.3
++ cleanup
++ cat t-log-3968
Stopping service root...
Exiting shepherd...
2023-05-24 03:39:14 Starting service root...
2023-05-24 03:39:14 Service root started.
2023-05-24 03:39:14 Service root running with value #t.
2023-05-24 03:39:14 Service root has been started.
2023-05-24 03:39:16 Starting service test...
2023-05-24 03:39:18 Service test has been started.
2023-05-24 03:39:18 Service test started.
2023-05-24 03:39:18 Service test running with value 6499.
2023-05-24 03:39:19 Starting service test2...
2023-05-24 03:39:20 Service test2 has been started.
2023-05-24 03:39:20 Service test2 started.
2023-05-24 03:39:20 Service test2 running with value 6884.
2023-05-24 03:41:59 Stopping service root...
2023-05-24 03:41:59 Exiting shepherd...
2023-05-24 03:41:59 Stopping service test...
2023-05-24 03:41:59 Service test stopped.
2023-05-24 03:41:59 Service test is now stopped.
Terminated
++ rm -f t-socket-3968 t-conf-3968 t-log-3968 t-service2-starts-3968 t-service-nofiles-3968
Exiting.

Some deprecated features have been used.  Set the environment
variable GUILE_WARN_DEPRECATED to "detailed" and rerun the
program to get more information.  Set it to "no" to suppress
this message.
++ test -f t-pid-3968
+++ cat t-pid-3968
++ kill 4700
./tests/forking-service.sh: line 38: kill: (4700) - No such process
++ true
++ rm -f t-pid-3968
++ test -f t-service-pid-3968
+++ cat t-service-pid-3968
++ kill 6499
++ rm -f t-service-pid-3968
++ test -f t-service2-pid-3968
+++ cat t-service2-pid-3968
++ kill 6884
++ rm -f t-service2-pid-3968
FAIL tests/forking-service.sh (exit status: 124)