GNU bug report logs - #77634
[shepherd] Test failures on GNU/Hurd

Previous Next

To reply to this bug, email your comments to 77634 AT debbugs.gnu.org.

Toggle the display of automated, internal messages from the tracker.

Message #5 received at submit <at> debbugs.gnu.org (full text, mbox):

From: yelninei <at> tutamail.com
To: bug-guix <at> gnu.org
Subject: [shepherd] Test failures on GNU/Hurd
Date: Tue, 8 Apr 2025 10:43:17 +0200 (CEST)

guix --version
guix (GNU Guix) 812f972f046e521eabc3ddd76e790d7a69d426b5

fibers test suite is hanging so I am skipping it for now.

Also I had to cheat a bit to get past automakes "t/output-order.sh" test where the guile build driver is leaking "GC Warning: Repeated allocation of very large block" onto stderr confusing the test (similar problem to https://issues.guix.gnu.org/73181). I added env["GC_LARGE_ALLOC_WARN_INTERVAL"] = "100" to DerivationGoal::startBuilder() and used the slightly patched daemon to build automake without changing the derivation.

guix build shepherd --without-tests=guile-fibers -s i586-gnu

These 3 tests are failing:
FAIL: tests/logging-failure.sh
FAIL: tests/forking-service.sh
FAIL: tests/services/system-log.sh

Some others are being skipped, looking at the shepherd code this seems to be expected.
SKIP: tests/logging-ENOSPC.sh
SKIP: tests/close-on-exec.sh
SKIP: tests/daemonize.sh

Here is the output of the failing ones:

FAIL: tests/logging-failure
===========================

+ shepherd --version
System lacks support for 'signalfd'; using fallback mechanism.
shepherd (GNU Shepherd) 1.0.3
Copyright (C) 2025 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) 1.0.3
Copyright (C) 2025 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.
+ log_directory=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-log-directory-8783
+ socket=t-socket-8783
+ conf=t-conf-8783
+ log=t-log-8783
+ pid=t-pid-8783
+ herd='herd -s t-socket-8783'
+ trap 'cat t-log-8783 || true; rm -f t-log-8783 t-socket-8783 t-conf-8783 t-pid-8783; rm -rf /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-log-directory-8783;
      kill $main_pid || true' EXIT
+ cat
+ rm -f t-pid-8783
+ main_pid=8788
+ test -f t-pid-8783
+ shepherd -I -s t-socket-8783 -c t-conf-8783 -l t-log-8783 --pid=t-pid-8783
+ sleep 0.3
System lacks support for 'signalfd'; using fallback mechanism.
GNU Shepherd 1.0.3 (Guile 3.0.9, i586-unknown-gnu)
Starting service root...
Service root started.
Service root running with value #<<process> id: 8788 command: #f>.
Service root has been started.
Configuration successfully loaded from 't-conf-8783'.
+ test -f t-pid-8783
+ herd -s t-socket-8783 status
Started:
+ root
Stopped:
- log-directory-does-not-exist
- log-directory-not-writable
+ test -f /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-log-directory-8783
+ herd -s t-socket-8783 start log-directory-does-not-exist
Service log-directory-does-not-exist has been started.
+ herd -s t-socket-8783 status log-directory-does-not-exist
+ grep running
  It is running since 07:53:13 (0 seconds ago).
+ herd -s t-socket-8783 status log-directory-does-not-exist
+ grep /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-log-directory-8783/service.log
  Log file: /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-log-directory-8783/service.log
+ grep logging /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-log-directory-8783/service.log
2025-04-08 07:53:13 logging
+ herd -s t-socket-8783 start log-directory-not-writable
++ cat t-log-8783
2025-04-08 07:53:13 GNU Shepherd 1.0.3 (Guile 3.0.9, i586-unknown-gnu)
2025-04-08 07:53:13 Starting service root...
2025-04-08 07:53:13 Service root started.
2025-04-08 07:53:13 Service root running with value #<<process> id: 8788 command: #f>.
2025-04-08 07:53:13 Service root has been started.
2025-04-08 07:53:13 Configuration successfully loaded from 't-conf-8783'.
2025-04-08 07:53:13 Starting service log-directory-does-not-exist...
2025-04-08 07:53:13 Service log-directory-does-not-exist has been started.
2025-04-08 07:53:13 Service log-directory-does-not-exist started.
2025-04-08 07:53:13 Service log-directory-does-not-exist running with value #<<process> id: 8792 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "while true; do echo logging; sleep 0.2; done")>.
2025-04-08 07:53:13 Starting service log-directory-not-writable...
Terminated
++ rm -f t-log-8783 t-socket-8783 t-conf-8783 t-pid-8783
++ rm -rf /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-log-directory-8783
++ kill 8788
FAIL tests/logging-failure.sh (exit status: 124)

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

+ shepherd --version
System lacks support for 'signalfd'; using fallback mechanism.
shepherd (GNU Shepherd) 1.0.3
Copyright (C) 2025 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) 1.0.3
Copyright (C) 2025 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-10595
+ conf=t-conf-10595
+ log=t-log-10595
+ pid=t-pid-10595
+ service_pid=t-service-pid-10595
+ service_nofiles=t-service-nofiles-10595
+ service2_pid=t-service2-pid-10595
+ service2_started=t-service2-starts-10595
+ herd='herd -s t-socket-10595'
+ trap cleanup EXIT
+ cat
+ cat t-conf-10595
;; Leave a timeout long enough for slow machines.
(default-pid-file-timeout 10)

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

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

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

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

(define %command3
  '("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-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/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-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-10595
+ test -f t-pid-10595
+ shepherd -I -s t-socket-10595 -c t-conf-10595 -l t-log-10595 --pid=t-pid-10595
+ sleep 0.3
System lacks support for 'signalfd'; using fallback mechanism.
GNU Shepherd 1.0.3 (Guile 3.0.9, i586-unknown-gnu)
Starting service root...
Service root started.
Service root running with value #<<process> id: 10602 command: #f>.
Service root has been started.
Configuration successfully loaded from 't-conf-10595'.
+ test -f t-pid-10595
++ cat t-pid-10595
+ shepherd_pid=10602
+ herd -s t-socket-10595 start test
Starting service test...
Service test has been started.
+ herd -s t-socket-10595 start test2
Starting service test2...
Service test2 started.
Service test2 running with value #<<process> id: 10623 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "echo started >> /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service2-starts-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service2-pid-10595")>.
Service test2 has been started.
+ herd -s t-socket-10595 status test
+ grep running
  It is running since 07:56:16 (1 second ago).
+ test -f t-service-pid-10595
++ cat t-service-pid-10595
+ service_pid_value=10610
+ kill 10610
+ kill -0 10610
./tests/forking-service.sh: line 133: kill: (10610) - No such process
+ within_seconds 10 'herd -s t-socket-10595 status test | grep stopped'
+ seconds=10
+ '[' 10 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
Uncaught exception in essential task process-monitor: (wrong-type-arg "=" "Wrong type argument in position ~A: ~S" (1 #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")>) (#<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")>))
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 10 - 1
+ seconds=9
+ '[' 9 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 9 - 1
+ seconds=8
+ '[' 8 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 8 - 1
+ seconds=7
+ '[' 7 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 7 - 1
+ seconds=6
+ '[' 6 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 6 - 1
+ seconds=5
+ '[' 5 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 5 - 1
+ seconds=4
+ '[' 4 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 4 - 1
+ seconds=3
+ '[' 3 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 3 - 1
+ seconds=2
+ '[' 2 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 2 - 1
+ seconds=1
+ '[' 1 -gt 0 ']'
+ /gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash -c 'herd -s t-socket-10595 status test | grep stopped'
+ sleep 1
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
++ expr 1 - 1
+ seconds=0
+ cleanup
+ cat t-log-10595
2025-04-08 07:56:14 GNU Shepherd 1.0.3 (Guile 3.0.9, i586-unknown-gnu)
2025-04-08 07:56:14 Starting service root...
2025-04-08 07:56:14 Service root started.
2025-04-08 07:56:14 Service root running with value #<<process> id: 10602 command: #f>.
2025-04-08 07:56:14 Service root has been started.
2025-04-08 07:56:14 Configuration successfully loaded from 't-conf-10595'.
2025-04-08 07:56:15 Starting service test...
2025-04-08 07:56:16 Service test has been started.
2025-04-08 07:56:16 Service test started.
2025-04-08 07:56:16 Service test running with value #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")>.
2025-04-08 07:56:16 Starting service test2...
2025-04-08 07:56:17 Service test2 has been started.
2025-04-08 07:56:17 Service test2 started.
2025-04-08 07:56:17 Service test2 running with value #<<process> id: 10623 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "echo started >> /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service2-starts-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service2-pid-10595")>.
2025-04-08 07:56:17 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:17 Uncaught exception in essential task process-monitor: (wrong-type-arg "=" "Wrong type argument in position ~A: ~S" (1 #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")>) (#<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.
2025-04-08 07:56:17 16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")>))
2025-04-08 07:56:18 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:18 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:19 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:19 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:20 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:20 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:21 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:21 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:22 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:22 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:23 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:23 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:24 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:24 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:25 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:25 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:26 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:26 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
2025-04-08 07:56:27 PID #<<process> id: 10610 command: ("/gnu/store/45ssyl3mps6yvh0k0zsgxs8wjqk9jd6r-bash-minimal-5.1.16/bin/bash" "-c" "ulimit -n >/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-nofiles-10595; sleep 600 & echo $! > /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-service-pid-10595")> (test) is dead!
+ rm -f t-socket-10595 t-conf-10595 t-log-10595 t-service2-starts-10595 t-service-nofiles-10595
+ test -f t-pid-10595
++ cat t-pid-10595
+ kill 10602
+ rm -f t-pid-10595
Stopping service root...
Exiting shepherd...
Ignoring error while stopping test: (system-error "getpgid" "~A" ("No such process") (1073741827))
Stopping service test2...
Awaiting PID 10622, which is already gone.
Service test2 stopped.
Service test2 is now stopped.
Service test3 is not running.
Service test4 is not running.
Exiting.
+ test -f t-service-pid-10595
++ cat t-service-pid-10595
+ kill 10610
./tests/forking-service.sh: line 40: kill: (10610) - No such process
+ true
+ rm -f t-service-pid-10595
+ test -f t-service2-pid-10595
++ cat t-service2-pid-10595
+ kill 10623
./tests/forking-service.sh: line 42: kill: (10623) - No such process
+ true
+ rm -f t-service2-pid-10595
FAIL tests/forking-service.sh (exit status: 1)

FAIL: tests/services/system-log
===============================

+ shepherd --version
System lacks support for 'signalfd'; using fallback mechanism.
shepherd (GNU Shepherd) 1.0.3
Copyright (C) 2025 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) 1.0.3
Copyright (C) 2025 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-12440
+ conf=t-conf-12440
+ log=t-log-12440
+ pid=t-pid-12440
+ logger=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-logger-12440.scm
+ kmsg=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-kmsg-12440
+ syslog_file=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-12440
+ syslog_auth_file=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-auth-12440
+ syslog_debug_file=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-debug-12440
+ syslog_remote_file=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440
+ syslog_socket=/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-socket-12440
+ herd='herd -s t-socket-12440'
+ trap 'zcat t-log-12440.* || true; cat t-log-12440 || true;
      rm -f t-socket-12440 t-conf-12440 t-log-12440* /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-logger-12440.scm /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-kmsg-12440 /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-socket-12440;
      rm -f /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-12440* /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-auth-12440* /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-debug-12440* /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440*;
      test -f t-pid-12440 && kill `cat t-pid-12440` || true; rm -f t-pid-12440' EXIT
+ cat
+ cat
+ chmod +x /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-logger-12440.scm
+ cat
+ rm -f t-pid-12440
+ test -f t-pid-12440
+ shepherd -I -s t-socket-12440 -c t-conf-12440 -l t-log-12440 --pid=t-pid-12440
+ sleep 0.3
System lacks support for 'signalfd'; using fallback mechanism.
GNU Shepherd 1.0.3 (Guile 3.0.9, i586-unknown-gnu)
Starting service root...
Service root started.
Service root running with value #<<process> id: 12448 command: #f>.
Service root has been started.
Configuration successfully loaded from 't-conf-12440'.
+ test -f t-pid-12440
+ herd -s t-socket-12440 eval root '(gc)'
Evaluating user expression (gc).
"#<unspecified>"
++ file_descriptor_count
++ wc -l
+++ cat t-pid-12440
++ ls -l '/proc/12448/fd/[0-9]*'
ls: cannot access '/proc/12448/fd/[0-9]*': No such file or directory
+ initial_fd_count=0
+ herd -s t-socket-12440 start logger
Starting service system-log...
Service system-log has been started.
Service system-log started.

;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-12440"))
Service system-log running with value #<system-log 39f82c0>.
Starting service logger...
Service logger has been started.
+ herd -s t-socket-12440 status logger
+ grep stopped
++ zcat 't-log-12440.*'
gzip: t-log-12440.*.gz: No such file or directory
Terminated
++ true
++ cat t-log-12440
2025-04-08 07:57:32 GNU Shepherd 1.0.3 (Guile 3.0.9, i586-unknown-gnu)
2025-04-08 07:57:32 Starting service root...
2025-04-08 07:57:32 Service root started.
2025-04-08 07:57:32 Service root running with value #<<process> id: 12448 command: #f>.
2025-04-08 07:57:32 Service root has been started.
2025-04-08 07:57:32 Configuration successfully loaded from 't-conf-12440'.
2025-04-08 07:57:32 Evaluating user expression (gc).
2025-04-08 07:57:32 Starting service system-log...
2025-04-08 07:57:59 Service system-log has been started.
2025-04-08 07:57:59 Service system-log started.
2025-04-08 07:58:32 
2025-04-08 07:58:32 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-12440"))
2025-04-08 07:58:32 Service system-log running with value #<system-log 39f82c0>.
2025-04-08 07:58:32 Starting service logger...
2025-04-08 07:58:32 Service logger has been started.
2025-04-08 07:58:32 Service logger started.
2025-04-08 07:58:32 
2025-04-08 07:58:32 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:58:32 
2025-04-08 07:58:32 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:58:32 Service logger running with value #<<process> id: 12978 command: ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-logger-12440.scm")>.
2025-04-08 07:58:32 
2025-04-08 07:58:32 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:58:32 
2025-04-08 07:58:43 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:58:43 
2025-04-08 07:58:45 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:58:45 
2025-04-08 07:58:59 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:58:59 
2025-04-08 07:59:00 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:59:00 
2025-04-08 07:59:05 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:59:05 
2025-04-08 07:59:05 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:59:05 
2025-04-08 07:59:06 ;;; (message-destination-> ("/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440"))
2025-04-08 07:59:06 t-syslog-logger-12440.scm[12978] starting logger
2025-04-08 07:59:07 Service logger has been disabled.
++ rm -f t-socket-12440 t-conf-12440 't-log-12440*' /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-logger-12440.scm /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-kmsg-12440 /tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-socket-12440
++ rm -f '/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-12440*' '/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-auth-12440*' '/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-debug-12440*' '/tmp/guix-build-shepherd-1.0.3.drv-0/shepherd-1.0.3/t-syslog-remote-12440*'
++ test -f t-pid-12440
+++ cat t-pid-12440
++ kill 12448
++ rm -f t-pid-12440
FAIL tests/services/system-log.sh (exit status: 124)

yelninei

Previous Next

GNU bug tracking system
Copyright (C) 1999 Darren O. Benham, 1997,2003 nCipher Corporation Ltd, 1994-97 Ian Jackson.