56c7d75ff068ce8b / check errored

Defined at .automate/pipelines.scm:143

Making check in .
make[1]: Entering directory '/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source'
make  check-TESTS
make[2]: Entering directory '/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source'
make[3]: Entering directory '/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source'
PASS: tests/check.scm
PASS: tests/contain.scm
PASS: tests/errors.scm
PASS: tests/events.scm
PASS: tests/forgejo.scm
PASS: tests/http.scm
PASS: tests/layout.scm
PASS: tests/masking.scm
PASS: tests/metrics.scm
PASS: tests/pages.scm
PASS: tests/model.scm
PASS: tests/pipeline.scm
FAIL: tests/pumphouse.scm
PASS: tests/records.scm
PASS: tests/scope.scm
PASS: tests/source.scm
PASS: tests/step-scheduling.scm
PASS: tests/uploader.scm
================================================
   guile-automate 0.0.0-dev: ./test-suite.log
================================================

# TOTAL: 18
# PASS:  17
# SKIP:  0
# XFAIL: 0
# FAIL:  1
# XPASS: 0
# ERROR: 0

System information (uname -a): Linux 6.18.13-gnu #1 SMP PREEMPT_DYNAMIC 1 x86_64
Distribution information (/etc/os-release):
NAME="Guix System"
ID=guix
PRETTY_NAME="Guix System"
LOGO=guix-icon
HOME_URL="https://guix.gnu.org"
DOCUMENTATION_URL="https://guix.gnu.org/en/manual"
SUPPORT_URL="https://guix.gnu.org/en/help"
BUG_REPORT_URL="https://lists.gnu.org/mailman/listinfo/bug-guix"

.. contents:: :depth: 2

FAIL: tests/pumphouse
=====================

http on port 35989
pumphouse address: /tmp/automate-pumphouse-s3WK8B/address
remote registrar: ocapn://kfsrhwzkerchgmmv2dgxkrhn2gkx5iur7rr3gufcrimifka2tgfq.tcp-tls/s/isUyrPd_J7qA78yI0d8UMw6P44NK5MrK_ZZqej7oF9s?port=38767&host=%3A%3A1
remote admin: ocapn://kfsrhwzkerchgmmv2dgxkrhn2gkx5iur7rr3gufcrimifka2tgfq.tcp-tls/s/cEgaK3p-or487SlKuuKPJ2dxyIA2h3yZwl9Hfe61mUk?port=38767&host=%3A%3A1
warning: steps run unconfined: this command cannot run itself again as guile
attached to pumphouse /tmp/automate-pumphouse-s3WK8B/address

Goblins exception:
In message to #<local-object ^admin>:
  (run tests/nothing (run-request (id . "6f6c71e26a884b92") (parameters (n . 5)) (cause . #f) (ancestors)))
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &automate-error:
      kind: not-attached
      irritants: (tests/nothing #f)
  2. &message: "no pipeline process is attached under this name"
  3. &irritants: (tests/nothing #f)
In goblins/core.scm:
   1074:7  4 (syscaller-$ _ #<local-object ^admin> (run tests/nothing (run-request (id . "6f6c71e26a884b92") (parameters (n . 5)) (cause . #f) (ancestors))))
In automate/pumphouse.scm:
   136:15  3 (request-run! #<<pumphouse> records: #<local-object ^records> lives: #<hash-table 7f594189c1e0 9/31> shared: #<hash-table 7f594189c1c0 0/31> gates: #<hash-table 7f594189c1a0 0/31> timers: #<hash-table 7f594189c180 1/31> tokens: #<hash-table 7f594189c160 9/31> registrations: #<hash-table 7f594189c140 0/31> sink: "http://127.0.0.1:35989/output" web: "http://127.0.0.1:35989" publish: #<procedure 7f5941953780 at automate/pumphouse/process.scm:129:2 (object swiss-num)>> tests/nothing #)
     99:6  2 (live-of _ _)
In automate/model.scm:
     83:2  1 (raise-automate-error _ _ . _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

2026-09-20 20:35:10 (with-exception-handler) INFO: POST /output/2443bbed8405ed80/tick 200 4ms
2026-09-20 20:35:10 (with-exception-handler) INFO: POST /output/a683618ed9d2907a/tick 200 50ms
2026-09-20 20:35:10 (with-exception-handler) INFO: POST /output/68090af50f42339e/tick 200 18ms
2026-09-20 20:35:10 (with-exception-handler) INFO: POST /output/c1907f5bd5346811/tick 200 55ms
2026-09-20 20:35:10 (with-exception-handler) INFO: POST /output/459fbd70642f48a3/tick 200 12ms
2026-09-20 20:35:10 (with-exception-handler) INFO: POST /output/be46eab88e660d30/tick 200 12ms
2026-09-20 20:35:10 INFO: dropping a connection that failed to hand shake: #<&compound-exception components: (#<&error> #<&irritants irritants: (#<gnutls-error-enum The TLS connection was non-properly terminated.> handshake)> #<&exception-with-kind-and-args kind: gnutls-error args: (#<gnutls-error-enum The TLS connection was non-properly terminated.> handshake)>)>
2026-09-20 20:35:10 INFO: dropping a connection that failed to hand shake: #<&compound-exception components: (#<&external-error> #<&origin origin: "fport_write"> #<&message message: "~A"> #<&irritants irritants: ("Broken pipe")> #<&exception-with-kind-and-args kind: system-error args: ("fport_write" "~A" ("Broken pipe") (32))>)>
2026-09-20 20:35:11 INFO: dropping a connection that failed to hand shake: #<&compound-exception components: (#<&error> #<&irritants irritants: (#<gnutls-error-enum The TLS connection was non-properly terminated.> handshake)> #<&exception-with-kind-and-args kind: gnutls-error args: (#<gnutls-error-enum The TLS connection was non-properly terminated.> handshake)>)>

Goblins exception:
In message to #<local-object ^records>:
  (registration (/) 1789932911)
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &automate-error:
      kind: invalid-scope
      irritants: ((/))
  2. &message: "not a list of pipeline names and prefixes"
  3. &irritants: ((/))
In goblins/core.scm:
   1074:7  4 (syscaller-$ _ #<local-object ^records> (registration (/) 1789932911))
In unknown file:
           3 (_ #<procedure cons (_ _)>)
In automate/pumphouse/scope.scm:
     44:4  2 (datastore-registration! #<<datastore> directory: "/tmp/automate-pumphouse-s3WK8B" pumphouse: #<<sqlite-db> pointer: #<pointer 0x7f5934001ae8> open?: #t stmts: #<hash-table 7f59418e3de0 17/31>> pipelines: #<hash-table 7f59418e3ac0 9/31>> (/) 1789932911)
In automate/model.scm:
     83:2  1 (raise-automate-error _ _ . _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

2026-09-20 20:35:11 (with-exception-handler) INFO: POST /output/6a02c68d1eab4aa5/tick 200 26ms
2026-09-20 20:35:11 (with-exception-handler) INFO: POST /output/c66e9c45ef7570de/tick 200 7ms
2026-09-20 20:35:11 (with-exception-handler) INFO: POST /output/487741ee853ce2a2/tick 200 6ms
2026-09-20 20:35:11 (with-exception-handler) INFO: POST /output/2cbf5f3f39726efa/tick 200 5ms
2026-09-20 20:35:11 (with-exception-handler) INFO: POST /output/73f076d3529066c8/tick 200 12ms
warning: steps run unconfined: this command cannot run itself again as guile

Goblins exception:
In message to #<local-object ^scoped-registrar>:
  (register tests/nap "/tmp/automate-def-paoO34" (structure (version 2) (name tests/nap) (steps ((step (name nap) (label #f) (group #f) (timeout #f) (error-permitted #f) (outputs (value)) (inputs ())))) (resources ()) (params ()) (web-ui-options ())) #<remote-object> "ocapn://jrzmfg4kd22fub3a35ahsem2hay7tazwmqnmi7tcr3pkcgv6b4xq.tcp-tls/s/Hiulj2_-yx13-_V0jrYTtX-ZtOYs49tyHLza1AypnMY?" ())
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &automate-error:
      kind: not-permitted
      irritants: (tests/nap (tests/only tests/scoped/))
  2. &message: "this registration does not cover the pipeline"
  3. &irritants: (tests/nap (tests/only tests/scoped/))
In goblins/core.scm:
   1074:7  3 (syscaller-$ _ #<local-object ^scoped-registrar> (register tests/nap "/tmp/automate-def-paoO34" (structure (version 2) (name tests/nap) (steps ((step (name nap) (label #f) (group #f) (timeout #f) (error-permitted #f) (outputs (value)) (inputs ())))) (resources ()) (params ()) (web-ui-options ())) #<remote-object> "ocapn://jrzmfg4kd22fub3a35ahsem2hay7tazwmqnmi7tcr3pkcgv6b4xq.tcp-tls/s/Hiulj2_-yx13-_V0jrYTtX-ZtOYs49tyHLza1AypnMY?" ()))
In automate/pumphouse.scm:
    296:6  2 (register tests/nap "/tmp/automate-def-paoO34" (structure (version 2) (name tests/nap) (steps ((step (name nap) (label #f) (group #f) (timeout #f) (error-permitted #f) (outputs (value)) (inputs ())))) (resources ()) (params ()) (web-ui-options ())) #<remote-object> "ocapn://jrzmfg4kd22fub3a35ahsem2hay7tazwmqnmi7tcr3pkcgv6b4xq.tcp-tls/s/Hiulj2_-yx13-_V0jrYTtX-ZtOYs49tyHLza1AypnMY?" ())
In automate/model.scm:
     83:2  1 (raise-automate-error _ _ . _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

2026-09-20 20:35:13 (with-exception-handler) INFO: POST /output/2a28c47cfb6e4ed2/tick 200 45ms
pumphouse refused tests/nap: Unknown error occurred with remote object
attached to pumphouse ocapn://kfsrhwzkerchgmmv2dgxkrhn2gkx5iur7rr3gufcrimifka2tgfq.tcp-tls/s/agqmsUMp_BRrtKrDfDvvW-tKCRDMDooU-TaIZAFZ2mQ?port=38767&host=%3A%3A1
2026-09-20 20:35:13 (with-exception-handler) INFO: POST /output/f2d3399ff8554ab0/tick 200 14ms
2026-09-20 20:35:13 (with-exception-handler) INFO: POST /output/eef010ea8505265c/tick 200 3ms
2026-09-20 20:35:13 (with-exception-handler) INFO: POST /output/042c8673058770cb/tick 200 4ms
2026-09-20 20:35:13 (with-exception-handler) INFO: POST /output/55c9711ce76a8f7a/tick 200 2ms
2026-09-20 20:35:13 (with-exception-handler) INFO: POST /output/a53a26ad89bcf8d6/tick 200 17ms
2026-09-20 20:35:14 (with-exception-handler) INFO: POST /output/5f80fed18bf8cce4/tick 200 14ms
2026-09-20 20:35:14 (with-exception-handler) INFO: POST /output/9c47d7a2cfc4a84f/tick 200 13ms
2026-09-20 20:35:14 (with-exception-handler) INFO: POST /output/0332cd68bbab16e9/tick 200 8ms
2026-09-20 20:35:14 (with-exception-handler) INFO: POST /output/9d519339e4b9ab2d/tick 200 21ms
2026-09-20 20:35:14 (with-exception-handler) INFO: POST /output/b8d8501ba372a53e/tick 200 3ms
2026-09-20 20:35:15 (with-exception-handler) INFO: POST /output/39b5626d48e094cc/tick 200 7ms
2026-09-20 20:35:15 (with-exception-handler) INFO: POST /output/8306b896c78b7ae9/tick 200 12ms
2026-09-20 20:35:15 (with-exception-handler) INFO: POST /output/890e2f6158fc3efd/tick 200 7ms
2026-09-20 20:35:16 (with-exception-handler) INFO: POST /output/179017cfc962c181/tick 200 8ms
2026-09-20 20:35:16 (with-exception-handler) INFO: POST /output/92e751c81af5e337/tick 200 14ms
2026-09-20 20:35:16 (with-exception-handler) INFO: POST /output/7317146b384e2ba7/tick 200 2ms
2026-09-20 20:35:16 (with-exception-handler) INFO: POST /output/4b4f517a8de344dc/tick 200 6ms
2026-09-20 20:35:16 (with-exception-handler) INFO: POST /output/192c008535e912b6/tick 200 7ms
2026-09-20 20:35:17 (with-exception-handler) INFO: POST /output/e1749d5fd1c9200c/tick 200 2ms
2026-09-20 20:35:17 (with-exception-handler) INFO: POST /output/2e00d103a68b5d47/tick 200 4ms
2026-09-20 20:35:17 (with-exception-handler) INFO: POST /output/f0450b8640320aca/tick 200 1ms
2026-09-20 20:35:17 (with-exception-handler) INFO: POST /output/695052a95d0dffa8/tick 200 2ms
2026-09-20 20:35:17 (with-exception-handler) INFO: POST /output/14a6a503883a2959/tick 200 4ms
2026-09-20 20:35:17 (with-exception-handler) INFO: POST /output/f73b283269e7942c/tick 200 4ms
2026-09-20 20:35:18 (with-exception-handler) INFO: POST /output/8472fba5a22c8753/tick 200 10ms
2026-09-20 20:35:18 (with-exception-handler) INFO: POST /output/3f0a15a20330e880/tick 200 7ms
2026-09-20 20:35:18 (with-exception-handler) INFO: POST /output/77afd2ebed054267/tick 200 10ms
2026-09-20 20:35:18 (with-exception-handler) INFO: POST /output/c503f374f71b2bde/chatty 200 3ms
2026-09-20 20:35:18 (with-exception-handler) INFO: POST /output/a620cbf9c9abd385/tick 200 16ms
2026-09-20 20:35:19 (with-exception-handler) INFO: POST /output/a7ce758c91f3d4eb/tick 200 24ms
2026-09-20 20:35:19 (with-exception-handler) INFO: POST /output/aa17b1e704b9853c/tick 200 15ms
2026-09-20 20:35:19 (with-exception-handler) INFO: POST /output/04298a0d8ac90010/tick 200 22ms
2026-09-20 20:35:19 (with-exception-handler) INFO: POST /output/ceb5e97bd52a730e/tick 200 10ms
2026-09-20 20:35:19 (with-exception-handler) INFO: POST /output/05244e908dff1d9b/tick 200 20ms
2026-09-20 20:35:19 (with-exception-handler) INFO: POST /output/2bef8ffd56182e42/tick 200 3ms
2026-09-20 20:35:20 (with-exception-handler) INFO: POST /output/b7a616857bc4123c/chatty 200 14ms
run b7a616857bc4123c reported to /tmp/automate-pumphouse-s3WK8B/address
run succeeded
  chatty: succeeded
Error in IO handling wrapped resource #<input-output: file 89>:
#<&compound-exception components: (#<&external-error> #<&origin origin: "fport_write"> #<&message message: "~A"> #<&irritants irritants: ("Broken pipe")> #<&exception-with-kind-and-args kind: system-error args: ("fport_write" "~A" ("Broken pipe") (32))>)>
In fibers.scm:
     85:4 13 (%run-fibers _ _ _ _)
In fibers/interrupts.scm:
     98:4 12 (with-interrupts/thread-cputime _ _ _ _)
In fibers/scheduler.scm:
   380:26 11 (run-scheduler #<scheduler 7f593d1e6e00 (remote-peers: (7f593d1e6e70))> _)
In ice-9/boot-9.scm:
  1778:15 10 (with-exception-handler #<procedure 7f593d9e4cf0 at ice-9/boot-9.scm:1882:7 (exn)> _ #:unwind? _ #:unwind-for-type _)
  1784:12  9 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _)
In fibers/scheduler.scm:
   344:10  8 (next-task)
In fibers.scm:
    179:8  7 (_)
In goblins/actor-lib/io.scm:
    60:10  6 (_)
    85:15  5 (_ _)
In ice-9/boot-9.scm:
  1784:12  4 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _)
In goblins/actor-lib/io.scm:
    70:18  3 (run-and-send)
In ice-9/suspendable-ports.scm:
     83:4  2 (write-bytes #<input-output: file 89> #vu8(60 49 51 39 111 112 58 103 99 45 101 120 112 111 114 116 115 91 49 50 43 93 91 49 43 93 62 114 116 49 51 43 62 91 55 39 102 117 108 102 105 108 108 50 39 111 107 93 102 102 62 39 117 114 108 50 57 34 104 116 116 112 58 47 47 49 50 55 46 48 46 48 46 49 58 51 53 57 56 57 47 111 117 116 112 117 116 62 60 52 39 112 97 105 114 53 39 116 111 107 101 110 51 50 34 52 50 101 100 55 98 51 97 51 102 101 56 53 55 50 102 52 99 53 97 99 57 51 50 99 …) …)
In unknown file:
           1 (port-write #<input-output: file 89> #vu8(60 49 51 39 111 112 58 103 99 45 101 120 112 111 114 116 115 91 49 50 43 93 91 49 43 93 62 114 116 49 51 43 62 91 55 39 102 117 108 102 105 108 108 50 39 111 107 93 102 102 62 39 117 114 108 50 57 34 104 116 116 112 58 47 47 49 50 55 46 48 46 48 46 49 58 51 53 57 56 57 47 111 117 116 112 117 116 62 60 52 39 112 97 105 114 53 39 116 111 107 101 110 51 50 34 52 50 101 100 55 98 51 97 51 102 101 56 53 55 50 102 52 99 53 97 99 57 51 50 99 …) …)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

Uncaught exception in task:
In fibers.scm:
    179:8  8 (_)
In goblins/actor-lib/io.scm:
    60:10  7 (_)
    85:15  6 (_ _)
In ice-9/boot-9.scm:
  1784:12  5 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _)
In goblins/actor-lib/io.scm:
    70:18  4 (run-and-send)
In ice-9/suspendable-ports.scm:
     83:4  3 (write-bytes #<input-output: file 89> #vu8(60 49 51 39 111 112 58 103 99 45 101 120 112 111 114 116 115 91 49 50 43 93 91 49 43 93 62 114 116 49 51 43 62 91 55 39 102 117 108 102 105 108 108 50 39 111 107 93 102 102 62 39 117 114 108 50 57 34 104 116 116 112 58 47 47 49 50 55 46 48 46 48 46 49 58 51 53 57 56 57 47 111 117 116 112 117 116 62 60 52 39 112 97 105 114 53 39 116 111 107 101 110 51 50 34 52 50 101 100 55 98 51 97 51 102 101 56 53 55 50 102 52 99 53 97 99 57 51 50 99 …) …)
In unknown file:
           2 (port-write #<input-output: file 89> #vu8(60 49 51 39 111 112 58 103 99 45 101 120 112 111 114 116 115 91 49 50 43 93 91 49 43 93 62 114 116 49 51 43 62 91 55 39 102 117 108 102 105 108 108 50 39 111 107 93 102 102 62 39 117 114 108 50 57 34 104 116 116 112 58 47 47 49 50 55 46 48 46 48 46 49 58 51 53 57 56 57 47 111 117 116 112 117 116 62 60 52 39 112 97 105 114 53 39 116 111 107 101 110 51 50 34 52 50 101 100 55 98 51 97 51 102 101 56 53 55 50 102 52 99 53 97 99 57 51 50 99 …) …)
In ice-9/boot-9.scm:
  1706:22  1 (raise-exception _ #:continuable? _)
  1705:22  0 (raise-exception _ #:continuable? _)
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &non-continuable
2026-09-20 20:35:20 (with-exception-handler) INFO: POST /output/1c693232eb286fed/tick 200 112ms
2026-09-20 20:35:20 (with-exception-handler) INFO: POST /output/7cebe9fd3e2d4e4b/tick 200 6ms
2026-09-20 20:35:21 (with-exception-handler) INFO: POST /output/86ea9ef7ada4fcff/tick 200 7ms
2026-09-20 20:35:21 (with-exception-handler) INFO: POST /output/cc949c1d90fbc059/tick 200 86ms
2026-09-20 20:35:21 (with-exception-handler) INFO: POST /output/bc99664bda9d74d3/tick 200 10ms
2026-09-20 20:35:21 (with-exception-handler) INFO: POST /output/0f439bf5f8dfa7d3/tick 200 11ms
lost the pumphouse; reconnecting
2026-09-20 20:35:22 (with-exception-handler) INFO: POST /output/1b77182aa4e7d2d6/tick 200 22ms
2026-09-20 20:35:22 (with-exception-handler) INFO: POST /output/42ecbbd42111c575/tick 200 25ms
2026-09-20 20:35:22 (with-exception-handler) INFO: POST /output/29656fc3664d3ce9/tick 200 52ms
2026-09-20 20:35:22 (with-exception-handler) INFO: POST /output/2ed268497dff291a/tick 200 31ms
2026-09-20 20:35:22 (with-exception-handler) INFO: POST /output/f5b64c07585e1754/tick 200 10ms
2026-09-20 20:35:22 (with-exception-handler) INFO: GET /events/runs/30789f446b90ad0d 200 1252ms
2026-09-20 20:35:23 (with-exception-handler) INFO: GET /events/runs/nothing 404 3ms
GET /events/pumphouse: error replying to client
2026-09-20 20:35:23 (with-exception-handler) INFO: GET /events/pumphouse 200 incomplete
2026-09-20 20:35:23 (with-exception-handler) INFO: GET / 200 247ms
2026-09-20 20:35:23 (with-exception-handler) INFO: GET /runs/c503f374f71b2bde 200 18ms
2026-09-20 20:35:23 (with-exception-handler) INFO: GET /runs/c503f374f71b2bde/steps/chatty 200 66ms
attached to pumphouse /tmp/automate-pumphouse-s3WK8B/address
lost the pumphouse; reconnecting
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/1589dee06c356229/tick 200 6ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/f805a9d9ebcfcdc2/tick 200 6ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/4a2c42efdc8092b7/tick 200 11ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/61641e162cdba5d7/tick 200 8ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/b9ae69bce783efbf/tick 200 4ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/b65b75e38e27ae77/tick 200 15ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/c3866e32e6e02a2b/tick 200 3ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/b608f47f0361285d/tick 200 2ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/4bedfe5dfa290228/tick 200 2ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/a58931960dbc4645/tick 200 9ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/ffd64cc7399e9288/tick 200 6ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/d0b034a7c391540a/tick 200 72ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/5d66e175594f0455/tick 200 13ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/ac663168be0881fb/tick 200 6ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/8a59280189f1fb13/tick 200 8ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/906f31a521e18e36/tick 200 4ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/cfc945c5084492b8/tick 200 3ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/8d940796f7c4b5e0/tick 200 3ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/367ba2234d4cff4e/tick 200 6ms
2026-09-20 20:35:26 (with-exception-handler) INFO: POST /output/09abfce442201d8a/tick 200 6ms
attached to pumphouse /tmp/automate-pumphouse-s3WK8B/address
lost the pumphouse; reconnecting
2026-09-20 20:35:28 (with-exception-handler) INFO: POST /output/a24112a5e8d2d851/tick 200 12ms
2026-09-20 20:35:28 (with-exception-handler) INFO: POST /output/8a756461b553b8c8/after 200 29ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/92cd01eccad3d5d8/tick 200 32ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/7eea919db6a809fd/tick 200 16ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/9629c861f1018712/tick 200 11ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/8800ac813fd28461/tick 200 55ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/4a13f79e830ba07e/tick 200 17ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/2a2d1172f65f6770/tick 200 4ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/f2e44e65b1bc3b85/tick 200 4ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/a40fa61555325a80/tick 200 7ms
2026-09-20 20:35:29 (with-exception-handler) INFO: POST /output/0fa00311f5ea7469/tick 200 5ms
attached to pumphouse /tmp/automate-pumphouse-s3WK8B/address
2026-09-20 20:35:30 (with-exception-handler) INFO: POST /output/24f53c0991bca8d6/tick 200 66ms
lost the pumphouse; reconnecting
2026-09-20 20:35:34 (with-exception-handler) INFO: POST /webhook 202 994ms
2026-09-20 20:35:34 (with-exception-handler) INFO: POST /output/e64617687f67c378/tick 200 22ms
2026-09-20 20:35:34 (with-exception-handler) INFO: POST /output/897016b3ff646d4f/tick 200 33ms
2026-09-20 20:35:34 (with-exception-handler) INFO: POST /output/7986b13e356afb09/tick 200 48ms
2026-09-20 20:35:34 (with-exception-handler) INFO: POST /output/7f2c37d0a5743df7/tick 200 53ms
2026-09-20 20:35:34 (with-exception-handler) INFO: POST /output/12800b6610b6cd12/tick 200 53ms
2026-09-20 20:35:34 (with-exception-handler) INFO: POST /output/c9b8b7f45a64125b/tick 200 4ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/f1fb1faa60ec2745/tick 200 34ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/59018d1ee77cb1b7/tick 200 34ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/09f5fd9631c91080/tick 200 160ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/73dd9087fe01ac76/tick 200 37ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/9c33f0f5c6f57b86/tick 200 29ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /webhook 202 27ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/bb5887eaf6a52864/tick 200 44ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /hooks/other 202 31ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /hooks/other 403 0ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /webhook 403 0ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/875faf5d90d332be/tick 200 10ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/96963632f7114027/tick 200 2ms
2026-09-20 20:35:35 (with-exception-handler) INFO: POST /output/eafe6a6991616b0c/tick 200 12ms
attached to pumphouse /tmp/automate-pumphouse-s3WK8B/address
lost the pumphouse; reconnecting

Goblins exception:
In message to #<local-object ^admin>:
  (pause tests/no-such-timer)
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &automate-error:
      kind: no-timer
      irritants: (tests/no-such-timer)
  2. &message: "no timer of this name"
  3. &irritants: (tests/no-such-timer)
In goblins/core.scm:
   1074:7  3 (syscaller-$ _ #<local-object ^admin> (pause tests/no-such-timer))
In automate/pumphouse.scm:
    385:6  2 (pause _)
In automate/model.scm:
     83:2  1 (raise-automate-error _ _ . _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

lost the pumphouse; reconnecting
Error in spawn-fibrous-vow:
#<&compound-exception components: (#<&error> #<&origin origin: #f> #<&message message: "no address of the host accepted the connection ~S ~S"> #<&irritants irritants: ("::1" 38767)> #<&exception-with-kind-and-args kind: misc-error args: (#f "no address of the host accepted the connection ~S ~S" ("::1" 38767) #f)>)>
In ice-9/boot-9.scm:
  1778:15 14 (with-exception-handler #<procedure 7fb35b086e10 at ice-9/boot-9.scm:1882:7 (exn)> _ #:unwind? _ #:unwind-for-type _)
In fibers.scm:
   164:13 13 (run-fibers _ #:hz _ #:scheduler _ #:parallelism _ #:cpus _ #:install-suspendable-ports? _ #:drain? _)
     85:4 12 (%run-fibers _ _ _ _)
In fibers/interrupts.scm:
     98:4 11 (with-interrupts/thread-cputime _ _ _ _)
In fibers/scheduler.scm:
   380:26 10 (run-scheduler #<scheduler 7fb357e80c40 (remote-peers: (7fb357e80930))> _)
In ice-9/boot-9.scm:
  1778:15  9 (with-exception-handler #<procedure 7fb357e4bc90 at ice-9/boot-9.scm:1882:7 (exn)> _ #:unwind? _ #:unwind-for-type _)
  1784:12  8 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _)
In fibers/scheduler.scm:
   344:10  7 (next-task)
In fibers.scm:
    179:8  6 (_)
In goblins/vat.scm:
   1161:8  5 (_)
In ice-9/boot-9.scm:
  1784:12  4 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _)
In goblins/vat.scm:
  1159:25  3 (run-and-send)
In automate/utils/tcp-tls-netlayer.scm:
   172:22  2 (dial #<ocapn-peer transport: tcp-tls designator: *redacted*>)
In automate/utils/sockets.scm:
    81:10  1 (loop _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

Error in spawn-fibrous-vow:
#<&compound-exception components: (#<&error> #<&origin origin: #f> #<&message message: "no address of the host accepted the connection ~S ~S"> #<&irritants irritants: ("::1" 38767)> #<&exception-with-kind-and-args kind: misc-error args: (#f "no address of the host accepted the connection ~S ~S" ("::1" 38767) #f)>)>
In ice-9/boot-9.scm:
  1778:15 14 (with-exception-handler #<procedure 7fb35b086e10 at ice-9/boot-9.scm:1882:7 (exn)> _ #:unwind? _ #:unwind-for-type _)
In fibers.scm:
   164:13 13 (run-fibers _ #:hz _ #:scheduler _ #:parallelism _ #:cpus _ #:install-suspendable-ports? _ #:drain? _)
     85:4 12 (%run-fibers _ _ _ _)
In fibers/interrupts.scm:
     98:4 11 (with-interrupts/thread-cputime _ _ _ _)
In fibers/scheduler.scm:
   380:26 10 (run-scheduler #<scheduler 7fb357e80c40 (remote-peers: (7fb357e80930))> _)
In ice-9/boot-9.scm:
  1778:15  9 (with-exception-handler #<procedure 7fb357e4bc90 at ice-9/boot-9.scm:1882:7 (exn)> _ #:unwind? _ #:unwind-for-type _)
  1784:12  8 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _)
In fibers/scheduler.scm:
   344:10  7 (next-task)
In fibers.scm:
    179:8  6 (_)
In goblins/vat.scm:
   1161:8  5 (_)
In ice-9/boot-9.scm:
  1784:12  4 (with-exception-handler _ _ #:unwind? _ #:unwind-for-type _)
In goblins/vat.scm:
  1159:25  3 (run-and-send)
In automate/utils/tcp-tls-netlayer.scm:
   172:22  2 (dial #<ocapn-peer transport: tcp-tls designator: *redacted*>)
In automate/utils/sockets.scm:
    81:10  1 (loop _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

http on port 38147
pumphouse address: /tmp/automate-pumphouse-s3WK8B/address
remote registrar: ocapn://kfsrhwzkerchgmmv2dgxkrhn2gkx5iur7rr3gufcrimifka2tgfq.tcp-tls/s/isUyrPd_J7qA78yI0d8UMw6P44NK5MrK_ZZqej7oF9s?port=38767&host=%3A%3A1
remote admin: ocapn://kfsrhwzkerchgmmv2dgxkrhn2gkx5iur7rr3gufcrimifka2tgfq.tcp-tls/s/cEgaK3p-or487SlKuuKPJ2dxyIA2h3yZwl9Hfe61mUk?port=38767&host=%3A%3A1

Goblins exception:
In message to #<local-object ^scoped-registrar>:
  (register tests/nap "/tmp/automate-def-paoO34" (structure (version 2) (name tests/nap) (steps ((step (name nap) (label #f) (group #f) (timeout #f) (error-permitted #f) (outputs (value)) (inputs ())))) (resources ()) (params ()) (web-ui-options ())) #<remote-object> "ocapn://p4gi5j3axsfxqbx6cyazkp3r4jnbkqi22h6qxtqej6ehn4ps7jbq.tcp-tls/s/ynPTre5lJY-PM_TwjfAOhIGv6dFqRFt-Qv6maiN8f-8?" ())
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &automate-error:
      kind: not-permitted
      irritants: (tests/nap (tests/only tests/scoped/))
  2. &message: "this registration does not cover the pipeline"
  3. &irritants: (tests/nap (tests/only tests/scoped/))
In goblins/core.scm:
   1074:7  3 (syscaller-$ _ #<local-object ^scoped-registrar> (register tests/nap "/tmp/automate-def-paoO34" (structure (version 2) (name tests/nap) (steps ((step (name nap) (label #f) (group #f) (timeout #f) (error-permitted #f) (outputs (value)) (inputs ())))) (resources ()) (params ()) (web-ui-options ())) #<remote-object> "ocapn://p4gi5j3axsfxqbx6cyazkp3r4jnbkqi22h6qxtqej6ehn4ps7jbq.tcp-tls/s/ynPTre5lJY-PM_TwjfAOhIGv6dFqRFt-Qv6maiN8f-8?" ()))
In automate/pumphouse.scm:
    296:6  2 (register tests/nap "/tmp/automate-def-paoO34" (structure (version 2) (name tests/nap) (steps ((step (name nap) (label #f) (group #f) (timeout #f) (error-permitted #f) (outputs (value)) (inputs ())))) (resources ()) (params ()) (web-ui-options ())) #<remote-object> "ocapn://p4gi5j3axsfxqbx6cyazkp3r4jnbkqi22h6qxtqej6ehn4ps7jbq.tcp-tls/s/ynPTre5lJY-PM_TwjfAOhIGv6dFqRFt-Qv6maiN8f-8?" ())
In automate/model.scm:
     83:2  1 (raise-automate-error _ _ . _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

pumphouse refused tests/nap: Unknown error occurred with remote object
attached to pumphouse ocapn://kfsrhwzkerchgmmv2dgxkrhn2gkx5iur7rr3gufcrimifka2tgfq.tcp-tls/s/agqmsUMp_BRrtKrDfDvvW-tKCRDMDooU-TaIZAFZ2mQ?port=38767&host=%3A%3A1

Goblins exception:
In message to #<local-object ^admin>:
  (revoke (tests/nowhere))
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &automate-error:
      kind: no-registration
      irritants: ((tests/nowhere))
  2. &message: "no registration of this scope"
  3. &irritants: ((tests/nowhere))
In goblins/core.scm:
   1074:7  2 (syscaller-$ _ #<local-object ^admin> (revoke (tests/nowhere)))
In automate/model.scm:
     83:2  1 (raise-automate-error _ _ . _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)


Goblins exception:
In message to #<local-object ^admin>:
  (run tests/sum (run-request (id . "5aa3477cb49253f5") (parameters (n . 7)) (cause . #f) (ancestors)))
ice-9/boot-9.scm:1705:22: In procedure raise-exception:
ERROR:
  1. &automate-error:
      kind: not-attached
      irritants: (tests/sum #f)
  2. &message: "no pipeline process is attached under this name"
  3. &irritants: (tests/sum #f)
In goblins/core.scm:
   1074:7  4 (syscaller-$ _ #<local-object ^admin> (run tests/sum (run-request (id . "5aa3477cb49253f5") (parameters (n . 7)) (cause . #f) (ancestors))))
In automate/pumphouse.scm:
   136:15  3 (request-run! #<<pumphouse> records: #<local-object ^records> lives: #<hash-table 7fadb9c9f2e0 2/31> shared: #<hash-table 7fadb9c9f2c0 0/31> gates: #<hash-table 7fadb9c9f2a0 0/31> timers: #<hash-table 7fadb9c9f280 1/31> tokens: #<hash-table 7fadb9c9f260 0/31> registrations: #<hash-table 7fadb9c9f240 1/31> sink: "http://127.0.0.1:38147/output" web: "http://127.0.0.1:38147" publish: #<procedure 7fadb9dab2a0 at automate/pumphouse/process.scm:129:2 (object swiss-num)>> tests/sum (# …))
     99:6  2 (live-of _ _)
In automate/model.scm:
     83:2  1 (raise-automate-error _ _ . _)
In ice-9/boot-9.scm:
  1705:22  0 (raise-exception _ #:continuable? _)

== pumphouse.scm
  fail: the delivery's run succeeded
    expected: succeeded
    actual:   abandoned
stop 31074: kill #<unspecified>, waitpid (31074 . 0)
  fail: daemon registers again after the pumphouse restarts
  suite died: ERROR:
  1. &mystery-exception
  2. &message: "Unknown error occurred with remote object"
  3. &irritants: ()

stop 32589: kill #<unspecified>, waitpid (32589 . 9)
stop 31236: kill #<unspecified>, waitpid (31236 . 9)
stop 31083: kill #<unspecified>, waitpid (31083 . 9)
;;; note: auto-compilation is enabled, set GUILE_AUTO_COMPILE=0
;;;       or pass the --no-auto-compile argument to disable.
;;; compiling /home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/./tests/run.scm
;;; WARNING: compilation of /home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/./tests/run.scm failed:
;;; failed to create path for auto-compiled file "/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/./tests/run.scm"
;;; compiling /home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/tests/support.scm
;;; WARNING: compilation of /home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/tests/support.scm failed:
;;; failed to create path for auto-compiled file "/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/tests/support.scm"
;;; compiling /home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/tests/pumphouse.scm
;;; WARNING: compilation of /home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/tests/pumphouse.scm failed:
;;; failed to create path for auto-compiled file "/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source/tests/pumphouse.scm"
FAIL tests/pumphouse.scm (exit status: 1)

============================================================================
Testsuite summary for guile-automate 0.0.0-dev
============================================================================
# TOTAL: 18
# PASS:  17
# SKIP:  0
# XFAIL: 0
# FAIL:  1
# XPASS: 0
# ERROR: 0
============================================================================
See ./test-suite.log for debugging.
============================================================================
make[3]: *** [Makefile:892: test-suite.log] Error 1
make[3]: Leaving directory '/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source'
make[2]: *** [Makefile:1027: check-TESTS] Error 2
make[2]: Leaving directory '/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source'
make[1]: *** [Makefile:1248: check-am] Error 2
make[1]: Leaving directory '/home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source'
make: *** [Makefile:778: check-recursive] Error 1
error: #<&invoke-error program: "/gnu/store/jsrbz9xvhjag4nxfj999fnd22jwlpgr2-profile/bin/bash" arguments: ("-c" "set -eo pipefail\nexport GUIX_PROFILE=/gnu/store/jsrbz9xvhjag4nxfj999fnd22jwlpgr2-profile\nsource \"$GUIX_PROFILE/etc/profile\"\ncd /home/chris/automate.cbaines.net/guile-automate/checks/workspace/56c7d75ff068ce8b/work/source\nmake check VERBOSE=1") exit-status: 2 term-signal: #f stop-signal: #f>