these 43 derivations will be built: /nix/store/90bv487j6m83fydqc7mygbyj74h7ykav-flakelet-relay.json.drv /nix/store/0n9b6vpia6b53s044gyh91r2n6mjdggs-flakelet-relay.service.drv /nix/store/wkzrhdwpnccakbivg3avgs18k0i42yzf-flakelet-flakelet-relay-units.drv /nix/store/2y7rgmznyprg1y6jz5ja46w7lwicysi2-flakelet-flakelet-relay.drv /nix/store/nw4j1bldm2qcwxym87zjp49spw72bxln-flakelet-config.json.drv /nix/store/454imcd8j1vin3z0ihncmxwa2jqfcsa6-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/phcma68zx6jmqixpnxxbq985cdqp8w8v-flakelet-agent.service.drv /nix/store/rxsnafj70l6bhfrwcq3qwrwg0g9rxywg-flakelet-flakelet-agent-units.drv /nix/store/4lm12yn7xxmzaqw3biwxnjiphivwvq36-flakelet-flakelet-agent.drv /nix/store/5kjhi9ryis9l2blcav0akzzjjm8cw49i-test-script.drv /nix/store/wwjszrv17qd22vrdjzasdpa3ll3ngavf-push.drv /nix/store/65vk94354cgm25wy7kdy6cfdzilmjj6l-system-path.drv /nix/store/y6hsyl2dqwrxifqd78s6n7pmiv03hkk0-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/gz1aak30aigvisb7zz1wpw4psl35w9np-unit-flakelet-flakelet-relay.service.drv /nix/store/zqc5apj389ypg21s26x9n010qpbcaqc3-unit-flakelet-reconcile.service.drv /nix/store/x065fyfnmmzskws32picpb5dbrpdygz8-system-units.drv /nix/store/l5zdaq7ybqswgr8wnlh2gdq1vblah2v9-etc.drv /nix/store/6hf73cm9ki1xrq12nq0d8syn4kdg0mzs-activate.drv /nix/store/6j28dvf7zvn0ximcck9bnvc5awxp7qj3-dbus-1.drv /nix/store/il7ijhrmy23f76gf9nng4rml0sqyhms4-X-Restart-Triggers-dbus-broker.drv /nix/store/7hcjzpq0ph7mjfdf9fv8d462k5blaivz-unit-dbus-broker.service.drv /nix/store/xg0n8qb4gzawlshzanzgwkq3arqsc910-user-units.drv /nix/store/bw7y90wjyas0bzckr2q71zinmxmvfzll-unit-dbus-broker.service.drv /nix/store/yprhnavfn6hv90vqxq6p6d89li3hlvq4-system-units.drv /nix/store/6qg2z8fadwhzq4i4ll1qray92fz5ifdq-etc.drv /nix/store/6s65a9698c8n3isfkfb9hhrqkgr9dikk-activate.drv /nix/store/q7n6lss02ra8j3pcli5mfc6rdkqcsn4k-X-Restart-Triggers-flakelet-flakelet-agent.drv /nix/store/b974hz24yshxi7kj3k5n3iprv46561xx-unit-flakelet-flakelet-agent.service.drv /nix/store/vz8xcc9zfa0hqngifzcfwvdzgdfsb1sw-flakelet-config.json.drv /nix/store/sy7a4svrjv41gv6wlcb1n90yqrwcsh66-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/br4sr4ygbf27alwcrzgdiks8v3y43ayv-unit-flakelet-reconcile.service.drv /nix/store/pbq6d0fqlqv08s40l5yc0mvxxscc5b64-system-units.drv /nix/store/g5ipp2zf48m9rmwxhx1iq0yh3hwmxr16-etc.drv /nix/store/z3bngklyvbv417dddrj7jmq2192bn3yx-activate.drv /nix/store/vcw60b3lazqza3gr36jydsxqzm42md3j-nixos-system-agent-test.drv /nix/store/96isz9a42lhynmphzv7212rnqbmc2831-run-agent-nspawn.drv /nix/store/grvxsh6x53dy90ms7bfk3jqbhddh4hvw-nixos-system-client-test.drv /nix/store/aj809f3hdb2s127pmylwa6n2v4fpgycz-run-client-nspawn.drv /nix/store/cnpjnxjxlgm9n1hr09r4fy7rgp8bd6li-nixos-system-relay-test.drv /nix/store/nzsfrm1kyl75dg9w17n5dl5mhg0yyvv5-run-relay-nspawn.drv /nix/store/b2xgwd63n7g7rnxd7v5g0rq4py7v8hm8-driverConfiguration.json.drv /nix/store/7z2zjhs6svwsjf6244kprg0x8l2a6jra-nixos-test-driver-flakelet-relay.drv /nix/store/m6xs868j0fy9f0zhfs8i4skwzir05j9d-container-test-run-flakelet-relay.drv building '/nix/store/5kjhi9ryis9l2blcav0akzzjjm8cw49i-test-script.drv' building '/nix/store/wwjszrv17qd22vrdjzasdpa3ll3ngavf-push.drv' building '/nix/store/q7n6lss02ra8j3pcli5mfc6rdkqcsn4k-X-Restart-Triggers-flakelet-flakelet-agent.drv' building '/nix/store/y6hsyl2dqwrxifqd78s6n7pmiv03hkk0-X-Restart-Triggers-flakelet-flakelet-relay.drv' X-Restart-Triggers-flakelet-flakelet-agent> tribuchet: building on jamie push> tribuchet: building on jamie test-script> tribuchet: building on jamie building '/nix/store/phcma68zx6jmqixpnxxbq985cdqp8w8v-flakelet-agent.service.drv' X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/90bv487j6m83fydqc7mygbyj74h7ykav-flakelet-relay.json.drv' flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> tribuchet: building on jamie flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/app (expect allow) flakelet-relay.json> agent/app allowed by ci flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/other (expect deny) flakelet-relay.json> agent/other denied building '/nix/store/b974hz24yshxi7kj3k5n3iprv46561xx-unit-flakelet-flakelet-agent.service.drv' unit-flakelet-flakelet-agent.service> tribuchet: building on jamie building '/nix/store/gz1aak30aigvisb7zz1wpw4psl35w9np-unit-flakelet-flakelet-relay.service.drv' unit-flakelet-flakelet-relay.service> tribuchet: building on jamie building '/nix/store/0n9b6vpia6b53s044gyh91r2n6mjdggs-flakelet-relay.service.drv' building '/nix/store/rxsnafj70l6bhfrwcq3qwrwg0g9rxywg-flakelet-flakelet-agent-units.drv' building '/nix/store/65vk94354cgm25wy7kdy6cfdzilmjj6l-system-path.drv' flakelet-flakelet-agent-units> tribuchet: building on jamie flakelet-relay.service> tribuchet: building on jamie system-path> tribuchet: building on jamie unit-flakelet-flakelet-agent.service> structuredAttrs is enabled unit-flakelet-flakelet-relay.service> structuredAttrs is enabled system-path> structuredAttrs is enabled system-path> created 6399 symlinks in user environment building '/nix/store/wkzrhdwpnccakbivg3avgs18k0i42yzf-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie building '/nix/store/4lm12yn7xxmzaqw3biwxnjiphivwvq36-flakelet-flakelet-agent.drv' flakelet-flakelet-agent> tribuchet: building on jamie building '/nix/store/vz8xcc9zfa0hqngifzcfwvdzgdfsb1sw-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/2y7rgmznyprg1y6jz5ja46w7lwicysi2-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/6j28dvf7zvn0ximcck9bnvc5awxp7qj3-dbus-1.drv' flakelet-config.json> structuredAttrs is enabled dbus-1> tribuchet: building on jamie building '/nix/store/nw4j1bldm2qcwxym87zjp49spw72bxln-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/sy7a4svrjv41gv6wlcb1n90yqrwcsh66-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled building '/nix/store/454imcd8j1vin3z0ihncmxwa2jqfcsa6-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/br4sr4ygbf27alwcrzgdiks8v3y43ayv-unit-flakelet-reconcile.service.drv' building '/nix/store/il7ijhrmy23f76gf9nng4rml0sqyhms4-X-Restart-Triggers-dbus-broker.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie X-Restart-Triggers-dbus-broker> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/zqc5apj389ypg21s26x9n010qpbcaqc3-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/7hcjzpq0ph7mjfdf9fv8d462k5blaivz-unit-dbus-broker.service.drv' building '/nix/store/bw7y90wjyas0bzckr2q71zinmxmvfzll-unit-dbus-broker.service.drv' unit-dbus-broker.service> tribuchet: building on jamie building '/nix/store/pbq6d0fqlqv08s40l5yc0mvxxscc5b64-system-units.drv' unit-dbus-broker.service> tribuchet: building on jamie system-units> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/x065fyfnmmzskws32picpb5dbrpdygz8-system-units.drv' building '/nix/store/yprhnavfn6hv90vqxq6p6d89li3hlvq4-system-units.drv' building '/nix/store/xg0n8qb4gzawlshzanzgwkq3arqsc910-user-units.drv' system-units> tribuchet: building on jamie system-units> tribuchet: building on jamie user-units> tribuchet: building on jamie building '/nix/store/g5ipp2zf48m9rmwxhx1iq0yh3hwmxr16-etc.drv' etc> tribuchet: building on jamie building '/nix/store/6qg2z8fadwhzq4i4ll1qray92fz5ifdq-etc.drv' etc> tribuchet: building on jamie building '/nix/store/l5zdaq7ybqswgr8wnlh2gdq1vblah2v9-etc.drv' etc> tribuchet: building on jamie building '/nix/store/z3bngklyvbv417dddrj7jmq2192bn3yx-activate.drv' activate> tribuchet: building on jamie building '/nix/store/6s65a9698c8n3isfkfb9hhrqkgr9dikk-activate.drv' building '/nix/store/6hf73cm9ki1xrq12nq0d8syn4kdg0mzs-activate.drv' activate> tribuchet: building on jamie activate> tribuchet: building on jamie building '/nix/store/vcw60b3lazqza3gr36jydsxqzm42md3j-nixos-system-agent-test.drv' nixos-system-agent-test> tribuchet: building on jamie nixos-system-agent-test> structuredAttrs is enabled building '/nix/store/grvxsh6x53dy90ms7bfk3jqbhddh4hvw-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on jamie building '/nix/store/cnpjnxjxlgm9n1hr09r4fy7rgp8bd6li-nixos-system-relay-test.drv' nixos-system-relay-test> tribuchet: building on jamie building '/nix/store/96isz9a42lhynmphzv7212rnqbmc2831-run-agent-nspawn.drv' run-agent-nspawn> tribuchet: building on jamie nixos-system-client-test> structuredAttrs is enabled nixos-system-relay-test> structuredAttrs is enabled building '/nix/store/aj809f3hdb2s127pmylwa6n2v4fpgycz-run-client-nspawn.drv' building '/nix/store/nzsfrm1kyl75dg9w17n5dl5mhg0yyvv5-run-relay-nspawn.drv' run-client-nspawn> tribuchet: building on jamie run-relay-nspawn> tribuchet: building on jamie building '/nix/store/b2xgwd63n7g7rnxd7v5g0rq4py7v8hm8-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/7z2zjhs6svwsjf6244kprg0x8l2a6jra-nixos-test-driver-flakelet-relay.drv' nixos-test-driver-flakelet-relay> tribuchet: building on jamie nixos-test-driver-flakelet-relay> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-flakelet-relay> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-flakelet-relay> All checks passed! nixos-test-driver-flakelet-relay> Linting test script (enable/disable: config.skipLint) nixos-test-driver-flakelet-relay> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-flakelet-relay> All checks passed! building '/nix/store/m6xs868j0fy9f0zhfs8i4skwzir05j9d-container-test-run-flakelet-relay.drv' container-test-run-flakelet-relay> tribuchet: building on jamie container-test-run-flakelet-relay> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-flakelet-relay> start all VLans container-test-run-flakelet-relay> (finished: start all VLans, in 0.00 seconds) container-test-run-flakelet-relay> Initializing machine ID from random generator. container-test-run-flakelet-relay> Test will time out and terminate in 3600.0 seconds container-test-run-flakelet-relay> run the VM test script container-test-run-flakelet-relay> start all VMs container-test-run-flakelet-relay> agent: systemd-nspawn running (pid 52) container-test-run-flakelet-relay> client: systemd-nspawn running (pid 53) container-test-run-flakelet-relay> agent: Waiting for journal at /build/vm-state-agent/var/log/journal... container-test-run-flakelet-relay> client: Waiting for journal at /build/vm-state-client/var/log/journal... container-test-run-flakelet-relay> relay: systemd-nspawn running (pid 56) container-test-run-flakelet-relay> relay: Waiting for journal at /build/vm-state-relay/var/log/journal... container-test-run-flakelet-relay> (finished: start all VMs, in 0.01 seconds) container-test-run-flakelet-relay> relay: waiting for unit flakelet-relay.service container-test-run-flakelet-relay> nixos-nspawn(client): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(client): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(agent): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(agent): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(relay): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(relay): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> ░ Spawning container agent on /build/vm-state-agent. container-test-run-flakelet-relay> ░ Spawning container client on /build/vm-state-client. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> ░ Spawning container relay on /build/vm-state-relay. container-test-run-flakelet-relay> agent # No journal files were found. container-test-run-flakelet-relay> agent # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> client # No journal files were found. container-test-run-flakelet-relay> client # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> relay # No journal files were found. container-test-run-flakelet-relay> relay # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> agent # [24585.793415] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [24585.793455] agent systemd-journald[57]: Runtime Journal (/run/log/journal/77377fae35df43a89eb12eda50b3b7d1) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [24585.804492] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [24585.816663] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [24585.830700] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [24585.793680] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [24585.831437] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [24585.793721] client systemd-journald[57]: Runtime Journal (/run/log/journal/a0cb5450005445079aac08f2c6b2d339) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [24585.865496] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/77377fae35df43a89eb12eda50b3b7d1 is 1.513ms for 6 entries. container-test-run-flakelet-relay> agent # [24585.865496] agent systemd-journald[57]: System Journal (/var/log/journal/77377fae35df43a89eb12eda50b3b7d1) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [24585.804679] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> relay # [24585.793957] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [24585.816856] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [24585.873848] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> client # [24585.831075] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [24585.874588] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [24585.793999] relay systemd-journald[57]: Runtime Journal (/run/log/journal/7cc3d64b57d643fda7c102ad509f888f) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [24585.874706] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [24585.889489] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [24585.805865] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [24585.831610] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [24585.817951] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [24585.947699] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [24585.832566] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [24586.818734] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [24585.833264] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [24585.868507] client systemd-journald[57]: Time spent on flushing to /var/log/journal/a0cb5450005445079aac08f2c6b2d339 is 1.501ms for 6 entries. container-test-run-flakelet-relay> relay # [24585.865817] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/7cc3d64b57d643fda7c102ad509f888f is 1.374ms for 6 entries. container-test-run-flakelet-relay> client # [24585.868507] client systemd-journald[57]: System Journal (/var/log/journal/a0cb5450005445079aac08f2c6b2d339) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [24585.865817] relay systemd-journald[57]: System Journal (/var/log/journal/7cc3d64b57d643fda7c102ad509f888f) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [24585.877071] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [24585.874544] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> client # [24585.877236] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [24585.875278] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> client # [24585.877336] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [24585.875399] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> client # [24585.892472] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [24585.890553] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> client # [24585.959637] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [24585.967910] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [24586.818791] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [24586.793831] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [24586.849860] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [24586.850871] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [24586.850168] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [24586.852177] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [24586.851272] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [24586.853794] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [24586.852575] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [24586.853836] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [24586.853902] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [24586.855268] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [24586.853949] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [24586.856503] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> relay # [24586.855270] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [24586.875348] client systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> relay # [24586.856553] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> client # [24586.875774] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [24586.875489] relay systemd-tmpfiles[169]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> client # [24586.876112] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/a0cb5450005445079aac08f2c6b2d339 failed: Operation not permitted container-test-run-flakelet-relay> relay # [24586.875928] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [24586.876458] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [24586.876270] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/7cc3d64b57d643fda7c102ad509f888f failed: Operation not permitted container-test-run-flakelet-relay> relay # [24586.876609] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [24586.854776] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> agent # [24586.855751] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> agent # [24586.857031] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [24586.858417] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [24586.858461] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [24586.859729] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> agent # [24586.860753] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [24586.878437] agent systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> agent # [24586.878828] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [24586.879132] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/77377fae35df43a89eb12eda50b3b7d1 failed: Operation not permitted container-test-run-flakelet-relay> agent # [24586.879461] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [24586.882867] agent suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.IDHrVkvOSy/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [24586.954454] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [24586.955105] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [24586.955139] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [24586.955190] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [24586.955326] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [24586.955790] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [24586.985745] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [24586.986475] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> agent # [24586.999381] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [24587.005313] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [24587.006165] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [24587.014972] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [24587.015057] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [24587.015118] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [24587.015138] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [24587.015151] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [24587.015243] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [24587.015421] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [24587.015511] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [24587.015524] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [24587.015550] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [24587.016770] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [24587.017384] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [24587.018247] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [24587.018789] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [24587.029441] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [24587.030585] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [24587.033452] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [24587.042542] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> client # [24586.878059] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.iXfWlOCSPz/chsh': Operation not permitted container-test-run-flakelet-relay> client # [24586.881806] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [24586.881910] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [24586.882122] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> client # [24586.910551] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [24586.938593] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [24586.950188] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [24586.953769] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [24586.954623] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [24586.994403] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [24587.001207] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [24587.002224] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [24587.010545] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [24587.010629] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [24587.010705] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [24587.010732] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [24587.010745] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [24587.010835] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [24587.010999] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [24587.011097] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [24587.011108] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [24587.011134] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [24587.012074] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [24587.012908] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [24587.013707] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [24587.029639] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [24586.879055] relay suid-sgid-wrappers-start[176]: chmod: changing permissions of '/run/wrappers/wrappers.YnS3l21f1W/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [24586.947223] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [24586.947956] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [24586.948055] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [24586.948210] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [24586.948421] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [24586.948788] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [24586.985859] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [24586.986972] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [24586.999212] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [24587.005333] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [24587.006352] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [24587.016725] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [24587.016803] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [24587.016866] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [24587.016888] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [24587.016904] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [24587.017006] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [24587.017185] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [24587.017278] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [24587.017294] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [24587.017321] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [24587.018617] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [24587.019503] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [24587.020402] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [24587.021115] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [24587.021748] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> relay # [24587.032588] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [24587.033270] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [24587.039100] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [24587.043817] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [24587.093010] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [24587.093267] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [24587.097437] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [24587.143747] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [24587.144157] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24587.144239] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [24587.148951] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [24587.159315] agent network-addresses-eth1-start[237]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [24587.162644] agent network-addresses-eth1-start[237]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [24587.168732] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [24587.216296] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [24587.216421] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [24587.217623] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [24587.218285] agent systemd[1]: Starting Update flakelet service flakelet-agent... container-test-run-flakelet-relay> agent # [24587.219016] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [24587.232545] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24587.253267] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [24587.255947] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [24587.262683] agent flakelet[305]: flakelet-agent: using prebuilt artifact /nix/store/zaac9xpycb2n0iycy94asnjv5bhrwnfn-flakelet-flakelet-agent container-test-run-flakelet-relay> agent # [24587.263230] agent flakelet[306]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24587.263630] agent flakelet[306]: other: activating generation 1 container-test-run-flakelet-relay> agent # [24587.263678] agent flakelet[305]: flakelet-agent: activating generation 1 container-test-run-flakelet-relay> agent # [24587.263785] agent flakelet[304]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [24587.264329] agent flakelet[304]: app: activating generation 1 container-test-run-flakelet-relay> agent # [24587.267390] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [24587.267428] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [24587.100130] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [24587.115593] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24587.143165] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [24587.145112] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [24587.146253] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [24587.146897] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [24587.147802] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [24587.166919] relay network-addresses-eth1-start[249]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [24587.170961] relay network-addresses-eth1-start[249]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [24587.174839] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> relay # [24587.214159] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [24587.214238] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [24587.215452] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [24587.216378] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [24587.217285] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [24587.262233] relay flakelet[311]: flakelet-relay: using prebuilt artifact /nix/store/lxrlfwdcsbarvp6whbb4byvc6kkj18x9-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [24587.262936] relay flakelet[311]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [24587.266832] relay systemd[1]: Reload requested from client PID 316 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [24587.266876] relay systemd[1]: Reloading... container-test-run-flakelet-relay> client # [24587.097678] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> client # [24587.100182] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [24587.143714] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> client # [24587.144731] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [24587.144868] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [24587.144920] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [24587.147821] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [24587.165564] client network-addresses-eth1-start[233]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> client # [24587.168522] client network-addresses-eth1-start[233]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [24587.172622] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [24587.253275] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [24587.253503] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [24587.253605] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [24587.255794] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> client # [24587.256932] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [24587.569418] relay nsncd[251]: Sep 06 13:54:25.531 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [24587.682039] relay systemd[1]: Reloading finished in 414 ms. container-test-run-flakelet-relay> agent # [24587.590653] agent nsncd[310]: Sep 06 13:54:25.552 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [24587.675344] agent systemd[1]: Reloading finished in 407 ms. container-test-run-flakelet-relay> client # [24587.594762] client nsncd[303]: Sep 06 13:54:25.556 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [24587.594923] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [24587.595027] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [24587.595128] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [24587.597474] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [24587.598938] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [24587.634136] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [24587.636085] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [24587.636139] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [24587.636167] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [24587.859965] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [24587.861738] agent systemd[1]: Reload requested from client PID 312 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [24587.861805] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [24587.823618] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [24587.824098] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [24587.824182] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [24587.825415] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [24587.826436] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [24587.844480] relay systemd[1]: Reload requested from client PID 357 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [24587.844545] relay systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [24587.875678] relay dnsmasq-pre-start[366]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> relay # [24588.204142] relay systemd[1]: Reloading finished in 358 ms. container-test-run-flakelet-relay> relay # [24588.359410] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [24588.388781] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [24588.388826] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [24588.388838] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [24588.391996] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [24588.204361] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [24588.356678] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [24588.356726] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24588.730961] agent systemd[1]: Reloading finished in 373 ms. container-test-run-flakelet-relay> agent # [24588.811473] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [24588.811530] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [24588.813112] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [24588.814129] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [24588.818164] agent systemd[1]: Reload requested from client PID 405 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [24588.818191] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [24588.833139] relay nginx-pre-start[402]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [24588.833801] relay nginx-pre-start[402]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [24588.850209] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> relay # [24589.065989] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [24589.024702] client systemd-logind[315]: New seat seat0. container-test-run-flakelet-relay> client # [24589.026906] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [24589.027098] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [24589.028694] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [24589.076457] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [24589.076841] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [24589.077204] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [24589.309313] relay systemd-logind[354]: New seat seat0. container-test-run-flakelet-relay> relay # [24589.309701] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [24589.312165] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [24589.347665] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24589.348041] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [24589.205416] agent systemd[1]: Reloading finished in 386 ms. container-test-run-flakelet-relay> agent # [24589.296570] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [24589.302654] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [24589.302769] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [24589.302931] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [24589.305498] agent systemd[1]: Reload requested from client PID 409 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [24589.305526] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24589.645663] agent systemd[1]: Reloading finished in 339 ms. container-test-run-flakelet-relay> relay # [24589.608112] relay dbus-broker-launch[408]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [24589.609295] relay dbus-broker-launch[408]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [24589.609295] relay dbus-broker-launch[408]: Invalid user-name in /nix/store/jc4z11b21x1n6xiiply0x9mfc84afs4d-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> relay # [24589.610102] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [24589.616131] relay dbus-broker-launch[408]: Ready container-test-run-flakelet-relay> relay # [24589.619344] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> relay # [24589.621777] relay dnsmasq[394]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [24589.621784] relay dnsmasq[394]: compile time options: IPv6 GNU-getopt DBus no-UBus no-i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth DNSSEC loop-detect inotify dumpfile container-test-run-flakelet-relay> relay # [24589.621790] relay dnsmasq[394]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [24589.621796] relay dnsmasq[394]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [24589.621889] relay dnsmasq[394]: read /etc/hosts - 9 names container-test-run-flakelet-relay> client # [24589.582399] client dbus-broker-launch[325]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [24589.583705] client dbus-broker-launch[325]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [24589.583705] client dbus-broker-launch[325]: Invalid user-name in /nix/store/xzxjva8r1cliyjkm44c1zi5gw5cd8j1a-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [24589.584505] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [24589.584981] client systemd[1]: Startup finished in 4.237s. container-test-run-flakelet-relay> client # [24589.590976] client dbus-broker-launch[325]: Ready container-test-run-flakelet-relay> agent # [24589.730521] agent systemd[1]: Reload requested from client PID 410 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [24589.730575] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24590.051043] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [24590.134499] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [24590.136638] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [24590.164439] agent systemd-logind[407]: New seat seat0. container-test-run-flakelet-relay> agent # [24590.170213] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [24590.170405] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [24590.172423] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [24590.173534] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [24590.174017] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [24590.174226] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [24590.210570] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24590.210745] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [24590.214136] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [24590.215045] agent flakelet[306]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [24590.215274] agent flakelet[304]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [24590.215731] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [24590.215983] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [24590.217871] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:28.179578Z","level":"WARN","message":"connect failed: connect relay:7443: Connection refused (os error 111)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24590.220272] agent flakelet[305]: flakelet-agent: updated to generation 1 container-test-run-flakelet-relay> agent # [24590.222132] agent systemd[1]: Finished Update flakelet service flakelet-agent. container-test-run-flakelet-relay> agent # [24590.222254] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> agent # [24590.222307] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> agent # [24590.236556] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:28.198382Z","level":"INFO","message":"local change","flakelet":"app","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24590.258655] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:28.220472Z","level":"INFO","message":"local change","flakelet":"other","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [24590.398135] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:28.359659Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [24590.399148] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:28.360266Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [24590.398569] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [24590.406200] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> agent # [24590.593569] agent dbus-broker-launch[505]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [24590.595178] agent dbus-broker-launch[505]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [24590.595178] agent dbus-broker-launch[505]: Invalid user-name in /nix/store/9jm4z4kmif1yf3786ghlinqlwra7q4q4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> agent # [24590.595868] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [24590.596284] agent systemd[1]: Startup finished in 5.252s. container-test-run-flakelet-relay> agent # [24590.602069] agent dbus-broker-launch[505]: Ready container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 6.17 seconds) container-test-run-flakelet-relay> relay: waiting for unit nginx.service container-test-run-flakelet-relay> relay: (finished: waiting for unit nginx.service, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet.target container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet.target, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet-agent.service container-test-run-flakelet-relay> relay # [24590.656211] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24590.656557] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay # [24590.664254] relay flakelet[311]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [24590.666877] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [24590.667434] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [24590.667615] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [24590.667864] relay systemd[1]: Startup finished in 5.321s. container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet-agent.service, in 0.02 seconds) container-test-run-flakelet-relay> client: waiting for unit multi-user.target container-test-run-flakelet-relay> client: (finished: waiting for unit multi-user.target, in 0.02 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1' container-test-run-flakelet-relay> relay # [24592.234721] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:30.196442Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(1), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [24592.234455] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:30.196243Z","level":"INFO","message":"connected","relay":"https://relay:7443","relay_name":"relay","relay_version":"0.1.0","host":"agent","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1', in 2.06 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service other.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service other.service, in 0.02 seconds) container-test-run-flakelet-relay> subtest: deploy with client certificate, relay found via SRV container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1 container-test-run-flakelet-relay> relay # [24593.181063] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:31.142802Z","level":"INFO","message":"deploy accepted","job":"75b8b5579d18e15a47bd263a8d761277","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24593.181939] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:31.143702Z","level":"INFO","message":"start","id":"e6f1b754650e5cde9a3ce3c919e43a44","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24593.182784] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:31.144570Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"e6f1b754650e5cde9a3ce3c919e43a44\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24593.220754] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24593.248973] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24593.253387] agent flakelet[933]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [24593.254046] agent flakelet[933]: app: activating generation 2 container-test-run-flakelet-relay> agent # [24593.270539] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [24593.272257] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24593.272572] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [24593.287711] agent systemd[1]: Reload requested from client PID 940 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24593.287774] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24593.617371] agent systemd[1]: Reloading finished in 328 ms. container-test-run-flakelet-relay> agent # [24593.686041] agent systemd[1]: Reload requested from client PID 970 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24593.686078] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24594.003831] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [24594.075714] agent systemd[1]: Reload requested from client PID 999 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24594.075753] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24594.395103] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [24594.472065] agent systemd[1]: Reload requested from client PID 1033 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24594.472102] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24594.790883] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [24594.857566] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [24594.888041] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [24594.892518] agent flakelet[933]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [24594.894680] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1, in 2.86 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl show app.service -p Description | grep -q 'app v2' container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl show app.service -p Description | grep -q 'app v2', in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2' container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2', in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet status --json app | jq -c '.[0].changed.by' container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet status --json app | jq -c '.[0].changed.by', in 0.03 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with client certificate, relay found via SRV, in 2.93 seconds) container-test-run-flakelet-relay> subtest: deploy with OIDC token, sub principal container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.05 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE3NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyODc0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJDUlJSV0taTUVGU1BTPT09IiwibmJmIjoxNzg4NzAyODc0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.-FKaupd66J2GRRF-elLETziumvMw09YMUUVJpqUxtfwbll3D8rnR3La1xzlbhE35GlRO0TZaDotcqPu0H6WLCA' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> agent # [24596.004767] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:33.966535Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24596.177718] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:34.139475Z","level":"INFO","message":"start","id":"3933dca38fa2fde37fd0fe1b4cfaedad","flakelet":"app","rule":"ci","relay":"relay","caller_name":"\"repo:github:example/app:ref:refs/heads/main\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24596.178225] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:34.140043Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"3933dca38fa2fde37fd0fe1b4cfaedad\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24596.217267] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24596.251117] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> relay # [24596.005992] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:33.967727Z","level":"INFO","message":"deploy finished","job":"75b8b5579d18e15a47bd263a8d761277","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24596.177380] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:34.139116Z","level":"INFO","message":"deploy accepted","job":"0495704faaa48d166b6711f1eb37fb46","caller":"repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24596.254842] agent flakelet[1108]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [24596.255398] agent flakelet[1108]: app: activating generation 3 container-test-run-flakelet-relay> agent # [24596.270288] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [24596.271975] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24596.272308] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [24596.290300] agent systemd[1]: Reload requested from client PID 1122 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24596.290365] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24596.616975] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [24596.692596] agent systemd[1]: Reload requested from client PID 1152 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24596.692634] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24597.007117] agent systemd[1]: Reloading finished in 314 ms. container-test-run-flakelet-relay> agent # [24597.077834] agent systemd[1]: Reload requested from client PID 1181 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24597.077873] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24597.395445] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [24597.460152] agent systemd[1]: Reload requested from client PID 1212 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24597.460185] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24597.776079] agent systemd[1]: Reloading finished in 315 ms. container-test-run-flakelet-relay> agent # [24597.844553] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [24597.871917] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [24597.876657] agent flakelet[1108]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [24597.878763] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE3NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyODc0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJDUlJSV0taTUVGU1BTPT09IiwibmJmIjoxNzg4NzAyODc0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.-FKaupd66J2GRRF-elLETziumvMw09YMUUVJpqUxtfwbll3D8rnR3La1xzlbhE35GlRO0TZaDotcqPu0H6WLCA' push --relay https://relay:7443 deploy agent/app 2>&1, in 2.86 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 2.93 seconds) container-test-run-flakelet-relay> subtest: policy denies uncovered target container-test-run-flakelet-relay> client: must fail: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE3NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyODc0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJDUlJSV0taTUVGU1BTPT09IiwibmJmIjoxNzg4NzAyODc0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.-FKaupd66J2GRRF-elLETziumvMw09YMUUVJpqUxtfwbll3D8rnR3La1xzlbhE35GlRO0TZaDotcqPu0H6WLCA' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE3NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyODc0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJDUlJSV0taTUVGU1BTPT09IiwibmJmIjoxNzg4NzAyODc0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.-FKaupd66J2GRRF-elLETziumvMw09YMUUVJpqUxtfwbll3D8rnR3La1xzlbhE35GlRO0TZaDotcqPu0H6WLCA' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: policy denies uncovered target, in 0.02 seconds) container-test-run-flakelet-relay> subtest: claim principal from groups, unchanged counts as success container-test-run-flakelet-relay> client: must succeed: echo '{"groups": ["wheel"]}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'someone' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": ["wheel"]}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'someone' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.05 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE3NiwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc4ODcwMjg3NywiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiUzVENERSQjdLMzJTQT09PSIsIm5iZiI6MTc4ODcwMjg3Nywic3ViIjoic29tZW9uZSJ9.2mwExfUPlQaRlZ3bNC9wsMWmhqh9D6TG_0UzmUdMfDtithVxqXEDBWeC6go2aAd-Ox2T96hjDhzJRoshE26DAA' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [24598.998161] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:36.959838Z","level":"INFO","message":"deploy finished","job":"0495704faaa48d166b6711f1eb37fb46","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24599.097410] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:37.059142Z","level":"INFO","message":"deploy accepted","job":"3210bb33025b0f1aa31428b12b302d4a","caller":"someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24598.996588] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:36.958351Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24599.097617] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:37.059361Z","level":"INFO","message":"start","id":"741697cbacbc5526de4f85a557903ed3","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"someone\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24599.098214] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:37.060028Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"741697cbacbc5526de4f85a557903ed3\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24599.138081] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [24599.172024] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [24599.176586] agent flakelet[1274]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24599.177165] agent flakelet[1274]: other: up to date container-test-run-flakelet-relay> agent # [24599.179865] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE3NiwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc4ODcwMjg3NywiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiUzVENERSQjdLMzJTQT09PSIsIm5iZiI6MTc4ODcwMjg3Nywic3ViIjoic29tZW9uZSJ9.2mwExfUPlQaRlZ3bNC9wsMWmhqh9D6TG_0UzmUdMfDtithVxqXEDBWeC6go2aAd-Ox2T96hjDhzJRoshE26DAA' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.65 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 0.70 seconds) container-test-run-flakelet-relay> subtest: push login via device flow, cached token used afterwards container-test-run-flakelet-relay> client: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1 container-test-run-flakelet-relay> relay # [24599.721261] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:37.683007Z","level":"INFO","message":"deploy finished","job":"3210bb33025b0f1aa31428b12b302d4a","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24599.746522] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 13:54:37] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> agent # [24599.719421] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:37.681170Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [24600.751459] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 13:54:38] "POST /token HTTP/1.1" 400 - container-test-run-flakelet-relay> client: (finished: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1, in 2.08 seconds) container-test-run-flakelet-relay> client: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600 container-test-run-flakelet-relay> client: (finished: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [24601.833988] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:39.795697Z","level":"INFO","message":"start","id":"44a34d8a9db788ce9577ddab18851b8c","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24601.834591] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:39.796386Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"44a34d8a9db788ce9577ddab18851b8c\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24601.873055] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [24601.898941] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [24601.903800] agent flakelet[1306]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24601.904313] agent flakelet[1306]: other: up to date container-test-run-flakelet-relay> agent # [24601.907568] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24601.799949] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 13:54:39] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [24601.833517] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:39.795304Z","level":"INFO","message":"deploy accepted","job":"031d41122d030f31924504c0ac1f2725","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.63 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [24602.447057] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:40.408797Z","level":"INFO","message":"deploy finished","job":"031d41122d030f31924504c0ac1f2725","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24602.468664] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:40.430469Z","level":"INFO","message":"deploy accepted","job":"586e27a92cc085d62c23f2a9d645fbd8","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24602.445572] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:40.407341Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24602.468973] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:40.430769Z","level":"INFO","message":"start","id":"e902f1333509c1cd1a962408f8221660","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24602.469351] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:40.431170Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"e902f1333509c1cd1a962408f8221660\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24602.510552] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [24602.548084] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [24602.552502] agent flakelet[1338]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24602.553061] agent flakelet[1338]: other: up to date container-test-run-flakelet-relay> agent # [24602.556037] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.65 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 3.38 seconds) container-test-run-flakelet-relay> subtest: waves: failing first wave skips the second container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave agent/other 2>&1 container-test-run-flakelet-relay> agent # [24603.095902] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:41.057670Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24603.135217] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:41.097007Z","level":"INFO","message":"start","id":"c4e46993c947e81d539c92a56fd748b0","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24603.135704] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:41.097520Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"c4e46993c947e81d539c92a56fd748b0\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24603.174942] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24603.211102] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24603.215790] agent flakelet[1365]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [24603.216511] agent flakelet[1365]: app: activating generation 4 container-test-run-flakelet-relay> agent # [24603.236733] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [24603.237317] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24603.237617] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [24603.254397] agent systemd[1]: Reload requested from client PID 1372 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24603.254473] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [24603.097711] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:41.059447Z","level":"INFO","message":"deploy finished","job":"586e27a92cc085d62c23f2a9d645fbd8","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24603.135031] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:41.096772Z","level":"INFO","message":"deploy accepted","job":"bb5d29db27e86f5b0796ec050443f8ee","caller":"admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24603.583854] agent systemd[1]: Reloading finished in 328 ms. container-test-run-flakelet-relay> agent # [24603.672118] agent systemd[1]: Reload requested from client PID 1402 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24603.672161] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24603.989879] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [24604.057677] agent systemd[1]: Reload requested from client PID 1431 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24604.057720] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24604.376571] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [24604.443285] agent systemd[1]: Reload requested from client PID 1465 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24604.443324] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24604.762088] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [24604.827602] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [24604.858346] agent (nonexistent)[1497]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [24604.858369] agent (nonexistent)[1497]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [24604.860696] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [24604.860822] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [24604.861080] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [24604.885877] agent systemd[1]: Reload requested from client PID 1506 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24604.885918] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24605.206564] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [24605.280381] agent systemd[1]: Reload requested from client PID 1536 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24605.280421] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24605.598433] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [24605.671302] agent systemd[1]: Reload requested from client PID 1566 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24605.671345] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24605.994788] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [24606.075548] agent systemd[1]: Reload requested from client PID 1596 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24606.075592] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24606.394719] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [24606.456642] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [24606.484031] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [24606.485246] agent flakelet[1365]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [24606.485246] agent flakelet[1365]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [24606.487307] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [24606.487432] agent systemd[1]: flakelet-relay-job-app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave agent/other 2>&1, in 4.11 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl show app.service -p Description | grep -q 'app v1' container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl show app.service -p Description | grep -q 'app v1', in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: waves: failing first wave skips the second, in 4.14 seconds) container-test-run-flakelet-relay> subtest: host patterns expand on the relay container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/app' 2>&1 container-test-run-flakelet-relay> relay # [24607.216262] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:45.177992Z","level":"INFO","message":"deploy finished","job":"bb5d29db27e86f5b0796ec050443f8ee","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24607.286173] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:45.247914Z","level":"INFO","message":"deploy accepted","job":"45bca214be43daab593a87d62066ef37","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24607.214676] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:45.176458Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24607.286491] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:45.248264Z","level":"INFO","message":"start","id":"11e2ef3d10b97986d01d8c5a2002a75c","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24607.287177] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:45.248998Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"11e2ef3d10b97986d01d8c5a2002a75c\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24607.328595] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24607.359991] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24607.364509] agent flakelet[1664]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [24607.365074] agent flakelet[1664]: app: up to date container-test-run-flakelet-relay> agent # [24607.368107] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/app' 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1 container-test-run-flakelet-relay> relay # [24607.909690] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:45.871426Z","level":"INFO","message":"deploy finished","job":"45bca214be43daab593a87d62066ef37","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24607.933239] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:45.895039Z","level":"INFO","message":"deploy accepted","job":"a3fcd63a05051758ee385f65ed741c00","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24607.908216] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:45.869963Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24607.933568] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:45.895368Z","level":"INFO","message":"start","id":"14cba6bc1d939c31531ef030b2c61155","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24607.933979] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:45.895801Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"14cba6bc1d939c31531ef030b2c61155\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24607.977097] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24608.007054] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24608.011777] agent flakelet[1688]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [24608.012300] agent flakelet[1688]: app: up to date container-test-run-flakelet-relay> agent # [24608.015319] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave '*/app' 2>&1 container-test-run-flakelet-relay> agent # [24608.546987] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:46.508767Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24608.567978] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:46.529778Z","level":"INFO","message":"start","id":"bb458b800e251cf9822becbb69810ba3","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24608.568239] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:46.530061Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"bb458b800e251cf9822becbb69810ba3\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24608.594617] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24608.624983] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24608.629120] agent flakelet[1720]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [24608.629645] agent flakelet[1720]: app: up to date container-test-run-flakelet-relay> agent # [24608.632292] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24608.548340] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:46.510105Z","level":"INFO","message":"deploy finished","job":"a3fcd63a05051758ee385f65ed741c00","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24608.567659] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:46.529472Z","level":"INFO","message":"deploy accepted","job":"ca98c9a2e2aafc12e24d827fd6e35705","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave '*/app' 2>&1, in 0.62 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: host patterns expand on the relay, in 1.95 seconds) container-test-run-flakelet-relay> subtest: detach returns once the job is accepted container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: timeout 20 push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --detach agent/app 2>&1 container-test-run-flakelet-relay> client: (finished: must succeed: timeout 20 push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --detach agent/app 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for success: systemctl is-active flakelet-relay-job-app.service container-test-run-flakelet-relay> relay # [24609.170114] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:47.131840Z","level":"INFO","message":"deploy finished","job":"ca98c9a2e2aafc12e24d827fd6e35705","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24609.224932] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:47.186702Z","level":"INFO","message":"deploy accepted","job":"6bb83aaa54e9a7870429eed301ebde15","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24609.168996] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:47.130770Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24609.225179] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:47.186972Z","level":"INFO","message":"start","id":"9f2fc33682c3b1594895f36b05700ce1","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24609.225441] agent flakelet-agent[504]: {"timestamp":"2026-09-06T13:54:47.187270Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"9f2fc33682c3b1594895f36b05700ce1\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24609.261460] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24609.289032] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24609.293325] agent flakelet[1748]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [24609.293976] agent flakelet[1748]: app: activating generation 4 container-test-run-flakelet-relay> agent # [24609.308300] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [24609.308836] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24609.309146] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [24609.327978] agent systemd[1]: Reload requested from client PID 1755 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24609.328066] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24609.654010] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [24609.721174] agent systemd[1]: Reload requested from client PID 1785 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24609.721213] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24610.035568] agent systemd[1]: Reloading finished in 313 ms. container-test-run-flakelet-relay> agent # [24610.100202] agent systemd[1]: Reload requested from client PID 1814 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24610.100242] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.25 seconds) container-test-run-flakelet-relay> ??? Warning (UserWarning): wait_until_fails(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-flakelet-relay> File "/nix/store/fv4yr9c0f9kyrfc00100i4rlshiiidbd-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> agent: waiting for failure: systemctl is-active flakelet-relay-job-app.service container-test-run-flakelet-relay> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-flakelet-relay> File "/nix/store/fv4yr9c0f9kyrfc00100i4rlshiiidbd-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> agent # [24610.416687] agent systemd[1]: Reloading finished in 316 ms. container-test-run-flakelet-relay> agent # [24610.484444] agent systemd[1]: Reload requested from client PID 1849 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24610.484482] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24610.802423] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [24610.869469] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent: (finished: waiting for failure: systemctl is-active flakelet-relay-job-app.service, in 6.47 seconds) container-test-run-flakelet-relay> (finished: subtest: detach returns once the job is accepted, in 7.76 seconds) container-test-run-flakelet-relay> subtest: unknown host is final, missing agent is retried, agents listing container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy nope/app 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy nope/app 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl stop flakelet-agent container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl stop flakelet-agent, in 0.06 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 0' container-test-run-flakelet-relay> relay: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 0', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/other > /tmp/retry.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/other > /tmp/retry.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent_unavailable.*retrying' /tmp/retry.out container-test-run-flakelet-relay> relay # [24616.984698] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:54.946447Z","level":"INFO","message":"agent disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [24616.935054] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [24616.942728] agent flakelet[1748]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [24616.946015] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24616.984145] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [24617.018442] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24617.018713] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [24617.018921] agent systemd[1]: flakelet-agent.service: Consumed 1.834s CPU time over 26.848s wall clock time. container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent_unavailable.*retrying' /tmp/retry.out, in 1.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl start flakelet-agent container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl start flakelet-agent, in 0.12 seconds) container-test-run-flakelet-relay> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-flakelet-relay> File "/nix/store/fv4yr9c0f9kyrfc00100i4rlshiiidbd-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out container-test-run-flakelet-relay> agent # [24618.092633] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [24618.151019] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:54:56.112794Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"9f2fc33682c3b1594895f36b05700ce1\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24618.190157] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [24618.203712] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:54:56.165499Z","level":"INFO","message":"connected","relay":"https://relay:7443","relay_name":"relay","relay_version":"0.1.0","host":"agent","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24618.204953] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:54:56.166773Z","level":"INFO","message":"start","id":"9f2fc33682c3b1594895f36b05700ce1","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [24618.203844] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:56.165580Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(4), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [24618.696418] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:54:56.658177Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24620.076924] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:54:58.038686Z","level":"INFO","message":"start","id":"8e0eed007d92618efd9a43ba9797b347","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24620.077591] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:54:58.039413Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"8e0eed007d92618efd9a43ba9797b347\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24620.121732] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [24620.154230] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [24620.159939] agent flakelet[2354]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24620.160952] agent flakelet[2354]: other: up to date container-test-run-flakelet-relay> agent # [24620.162510] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24620.076518] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:58.038234Z","level":"INFO","message":"deploy accepted","job":"a8b2d11aebc328f50dff86f06bcd58df","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24620.702294] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:54:58.664037Z","level":"INFO","message":"deploy finished","job":"a8b2d11aebc328f50dff86f06bcd58df","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24620.700679] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:54:58.662395Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out, in 3.04 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE5OSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyODk5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMNVE3UlUySVlJVlg2PT09IiwibmJmIjoxNzg4NzAyODk5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.JLGP_aqovpQ7bDY4EjC5fRahOrnqXPxlg7_cw9PZG-jxIYFGW5tPTyNxfkionVgyKpJuM4PWxkeTp4v6aEa0BA' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzE5OSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyODk5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMNVE3UlUySVlJVlg2PT09IiwibmJmIjoxNzg4NzAyODk5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.JLGP_aqovpQ7bDY4EjC5fRahOrnqXPxlg7_cw9PZG-jxIYFGW5tPTyNxfkionVgyKpJuM4PWxkeTp4v6aEa0BA' push --relay https://relay:7443 agents, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: unknown host is final, missing agent is retried, agents listing, in 4.38 seconds) container-test-run-flakelet-relay> subtest: out-of-band flakelet update reaches the relay without reconnect container-test-run-flakelet-relay> agent: must succeed: flakelet status --json app | jq '.[0].generation' container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet status --json app | jq '.[0].generation', in 0.03 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> app: activating generation 5 container-test-run-flakelet-relay> agent # [24621.407634] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [24621.408360] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24621.408496] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [24621.418392] agent systemd[1]: Reload requested from client PID 2396 ('systemctl')... container-test-run-flakelet-relay> agent # [24621.418429] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24621.740146] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [24621.882534] agent systemd[1]: Reload requested from client PID 2425 ('systemctl')... container-test-run-flakelet-relay> agent # [24621.882574] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24622.201685] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [24622.334644] agent systemd[1]: Reload requested from client PID 2456 ('systemctl')... container-test-run-flakelet-relay> agent # [24622.334677] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24622.652445] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [24622.751911] agent systemd[1]: Reload requested from client PID 2487 ('systemctl')... container-test-run-flakelet-relay> agent # [24622.751944] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.87 seconds) container-test-run-flakelet-relay> client: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@5' container-test-run-flakelet-relay> agent # [24623.082113] agent systemd[1]: Reloading finished in 329 ms. container-test-run-flakelet-relay> agent # [24623.202247] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [24623.253262] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@5', in 1.04 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-5- container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-5-, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app- container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> app: activating generation 6 container-test-run-flakelet-relay> agent # [24624.215596] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:02.177360Z","level":"INFO","message":"local change","flakelet":"app","generation":5,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24624.397210] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [24624.397680] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24624.397945] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [24624.418271] agent systemd[1]: Reload requested from client PID 2540 ('systemctl')... container-test-run-flakelet-relay> agent # [24624.418340] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24624.752349] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [24624.874710] agent systemd[1]: Reload requested from client PID 2569 ('systemctl')... container-test-run-flakelet-relay> agent # [24624.874746] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24625.194311] agent systemd[1]: Reloading finished in 319 ms. container-test-run-flakelet-relay> agent # [24625.334945] agent systemd[1]: Reload requested from client PID 2597 ('systemctl')... container-test-run-flakelet-relay> agent # [24625.334984] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24625.657492] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [24625.791981] agent systemd[1]: Reload requested from client PID 2626 ('systemctl')... container-test-run-flakelet-relay> agent # [24625.792027] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24626.112676] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.87 seconds) container-test-run-flakelet-relay> client: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@6' container-test-run-flakelet-relay> agent # [24626.202186] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [24626.233998] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@6', in 2.07 seconds) container-test-run-flakelet-relay> (finished: subtest: out-of-band flakelet update reaches the relay without reconnect, in 6.98 seconds) container-test-run-flakelet-relay> subtest: certificate not listed under agents cannot connect as agent container-test-run-flakelet-relay> client: must succeed: curl -s -o /dev/null -w '%{http_code}' --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/mallory/cert.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/mallory/key.pem -H 'Upgrade: websocket' -H 'Connection: Upgrade' -H 'Sec-WebSocket-Version: 13' -H 'Sec-WebSocket-Key: dGhlIHNhbXBsZSBub25jZQ==' https://relay:7443/v1/agent container-test-run-flakelet-relay> client: (finished: must succeed: curl -s -o /dev/null -w '%{http_code}' --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/mallory/cert.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/mallory/key.pem -H 'Upgrade: websocket' -H 'Connection: Upgrade' -H 'Sec-WebSocket-Version: 13' -H 'Sec-WebSocket-Key: dGhlIHNhbXBsZSBub25jZQ==' https://relay:7443/v1/agent, in 0.03 seconds) container-test-run-flakelet-relay> (finished: subtest: certificate not listed under agents cannot connect as agent, in 0.03 seconds) container-test-run-flakelet-relay> subtest: metrics container-test-run-flakelet-relay> relay: must succeed: curl -sf http://127.0.0.1:7400/metrics container-test-run-flakelet-relay> relay: (finished: must succeed: curl -sf http://127.0.0.1:7400/metrics, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: metrics, in 0.02 seconds) container-test-run-flakelet-relay> subtest: agent link drop mid-run replays missed lines once container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788702906 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [24628.217901] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:06.179651Z","level":"INFO","message":"local change","flakelet":"app","generation":6,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24628.395223] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:06.356964Z","level":"INFO","message":"start","id":"157d5b8f36bee4eaa00de6a842e66f92","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24628.395831] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:06.357653Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"157d5b8f36bee4eaa00de6a842e66f92\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24628.434907] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24628.464042] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24628.468603] agent flakelet[2687]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> relay # [24628.336109] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:06.297841Z","level":"INFO","message":"agent rejected: no agents entry matches","principals":"[\"x509:dns:mallory\"]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> relay # [24628.394683] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:06.356433Z","level":"INFO","message":"deploy accepted","job":"73020cfdeb517b36f4d5b140e41812bf","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24628.469216] agent flakelet[2687]: app: activating generation 7 container-test-run-flakelet-relay> agent # [24628.487438] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [24628.489194] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24628.489558] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [24628.506260] agent systemd[1]: Reload requested from client PID 2694 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24628.506327] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24628.838389] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [24628.917874] agent systemd[1]: Reload requested from client PID 2724 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24628.917911] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788702906 | grep -q 'app-slow', in 1.03 seconds) container-test-run-flakelet-relay> agent: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done container-test-run-flakelet-relay> agent: (finished: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done, in 0.02 seconds) container-test-run-flakelet-relay> relay: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done container-test-run-flakelet-relay> relay: (finished: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done, in 0.06 seconds) container-test-run-flakelet-relay> agent: must succeed: ss -K dport = 7443 container-test-run-flakelet-relay> agent # [24629.233871] agent systemd[1]: Reloading finished in 315 ms. container-test-run-flakelet-relay> agent # [24629.316764] agent systemd[1]: Reload requested from client PID 2753 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24629.316803] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: ss -K dport = 7443, in 0.03 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788702906 | grep -q 'updated to generation' container-test-run-flakelet-relay> relay # [24629.483708] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:07.445429Z","level":"INFO","message":"agent disconnected: IO error: Software caused connection abort (os error 103)","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [24629.516159] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:07.477671Z","level":"INFO","message":"disconnected: IO error: Software caused connection abort (os error 103)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24629.634480] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [24629.709570] agent systemd[1]: Reload requested from client PID 2798 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24629.709605] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24630.029930] agent systemd[1]: Reloading finished in 319 ms. container-test-run-flakelet-relay> agent # [24630.102127] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [24630.519527] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:08.481243Z","level":"WARN","message":"connect failed: connect relay:7443: No route to host (os error 113)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24632.521801] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:10.483522Z","level":"WARN","message":"connect failed: connect relay:7443: No route to host (os error 113)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24636.173930] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [24636.181915] agent flakelet[2687]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [24636.185163] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788702906 | grep -q 'updated to generation', in 7.10 seconds) container-test-run-flakelet-relay> agent: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route del unreachable $a; done container-test-run-flakelet-relay> agent: (finished: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route del unreachable $a; done, in 0.02 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/app: updated' /tmp/slow.out container-test-run-flakelet-relay> agent # [24636.524459] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:14.486028Z","level":"WARN","message":"connect failed: connect relay:7443: No route to host (os error 113)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24637.292335] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:15.254120Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(7)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/app: updated' /tmp/slow.out, in 8.09 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/slow.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/slow.out, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: agent link drop mid-run replays missed lines once, in 16.39 seconds) container-test-run-flakelet-relay> subtest: agent restart mid-run reattaches to the unit container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/restart.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/restart.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2' container-test-run-flakelet-relay> relay # [24644.529796] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:22.491523Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(7), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> relay # [24644.531450] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:22.493244Z","level":"INFO","message":"deploy finished","job":"73020cfdeb517b36f4d5b140e41812bf","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24644.776582] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:22.738357Z","level":"INFO","message":"deploy accepted","job":"9a383d6dec704f85dc9851ad9d2e1e13","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24644.529707] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:22.491428Z","level":"INFO","message":"connected","relay":"https://relay:7443","relay_name":"relay","relay_version":"0.1.0","host":"agent","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24644.530899] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:22.492713Z","level":"INFO","message":"start","id":"157d5b8f36bee4eaa00de6a842e66f92","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24644.777080] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:22.738749Z","level":"INFO","message":"start","id":"e32ecd815c3c934a8cccfaddf17fb2d0","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24644.777730] agent flakelet-agent[1929]: {"timestamp":"2026-09-06T13:55:22.739546Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"e32ecd815c3c934a8cccfaddf17fb2d0\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24644.819332] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24644.848167] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24644.852535] agent flakelet[2959]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [24644.853249] agent flakelet[2959]: app: activating generation 8 container-test-run-flakelet-relay> agent # [24644.870650] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [24644.872352] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24644.872617] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [24644.888238] agent systemd[1]: Reload requested from client PID 2966 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24644.888305] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24645.227811] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [24645.348551] agent systemd[1]: Reload requested from client PID 2996 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24645.348589] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2', in 1.03 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl restart flakelet-agent container-test-run-flakelet-relay> agent # [24645.686344] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [24645.769762] agent systemd[1]: Reload requested from client PID 3025 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24645.769803] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24646.093016] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [24646.225688] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [24646.234483] agent systemd[1]: Reload requested from client PID 3063 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24646.234526] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [24646.225979] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:24.187735Z","level":"INFO","message":"agent disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl restart flakelet-agent, in 1.04 seconds) container-test-run-flakelet-relay> agent: must succeed: test -n "$(ls /var/lib/flakelet-agent/jobs)" container-test-run-flakelet-relay> agent: (finished: must succeed: test -n "$(ls /var/lib/flakelet-agent/jobs)", in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out container-test-run-flakelet-relay> agent # [24646.583859] agent systemd[1]: Reloading finished in 348 ms. container-test-run-flakelet-relay> agent # [24646.696900] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24646.697111] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [24646.697126] agent systemd[1]: flakelet-agent.service: Consumed 2.077s CPU time over 28.604s wall clock time. container-test-run-flakelet-relay> agent # [24646.716959] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [24646.718023] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [24646.793836] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:24.755617Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"e32ecd815c3c934a8cccfaddf17fb2d0\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24646.831703] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [24646.844127] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:24.805825Z","level":"INFO","message":"connected","relay":"https://relay:7443","relay_name":"relay","relay_version":"0.1.0","host":"agent","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24646.845302] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:24.807124Z","level":"INFO","message":"start","id":"e32ecd815c3c934a8cccfaddf17fb2d0","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [24646.844192] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:24.805940Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(7), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [24652.859675] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [24652.869702] agent flakelet[2959]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [24652.872500] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24654.391066] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:32.352791Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(8)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [24654.392564] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:32.354320Z","level":"INFO","message":"deploy finished","job":"9a383d6dec704f85dc9851ad9d2e1e13","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out, in 8.09 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/restart.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/restart.out, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: agent restart mid-run reattaches to the unit, in 10.21 seconds) container-test-run-flakelet-relay> subtest: relay restart mid-run, push resumes via /v1/jobs container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788702932 | grep -q 'app-slow' container-test-run-flakelet-relay> relay # [24655.003586] relay flakelet-relay[400]: {"timestamp":"2026-09-06T13:55:32.965323Z","level":"INFO","message":"deploy accepted","job":"20b74128ad0f6061087853651fd44696","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24655.004071] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:32.965732Z","level":"INFO","message":"start","id":"34caf7128a538b7a69edf6441eb23cca","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24655.004639] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:32.966458Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"34caf7128a538b7a69edf6441eb23cca\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24655.043917] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [24655.074044] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [24655.078526] agent flakelet[3573]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [24655.079159] agent flakelet[3573]: app: activating generation 9 container-test-run-flakelet-relay> agent # [24655.097446] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [24655.097964] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [24655.098272] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [24655.115600] agent systemd[1]: Reload requested from client PID 3580 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24655.115668] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24655.449801] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [24655.541703] agent systemd[1]: Reload requested from client PID 3610 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24655.541740] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24655.863049] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788702932 | grep -q 'app-slow', in 1.03 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> agent # [24655.951080] agent systemd[1]: Reload requested from client PID 3639 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24655.951119] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24656.027571] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:33.989287Z","level":"INFO","message":"disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [24656.027026] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [24656.066332] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24656.066639] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [24656.066666] relay systemd[1]: flakelet-relay.service: Consumed 3.319s CPU time over 1min 7.674s wall clock time. container-test-run-flakelet-relay> relay # [24656.083653] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [24656.277141] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [24656.371054] agent systemd[1]: Reload requested from client PID 3673 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [24656.371092] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [24656.698597] agent systemd[1]: Reloading finished in 327 ms. container-test-run-flakelet-relay> agent # [24656.791648] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [24657.030464] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:34.992068Z","level":"WARN","message":"connect failed: connect relay:7443: Connection refused (os error 111)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: must succeed: systemctl restart flakelet-relay, in 1.48 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [24657.497657] relay flakelet-relay[932]: {"timestamp":"2026-09-06T13:55:35.459416Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [24657.498452] relay flakelet-relay[932]: {"timestamp":"2026-09-06T13:55:35.459840Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [24657.498106] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [24659.041384] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:37.003125Z","level":"INFO","message":"connected","relay":"https://relay:7443","relay_name":"relay","relay_version":"0.1.0","host":"agent","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [24659.041671] relay flakelet-relay[932]: {"timestamp":"2026-09-06T13:55:37.003417Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(8), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [24662.859036] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [24662.869620] agent flakelet[3573]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [24662.872648] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24663.046989] relay flakelet-relay[932]: {"timestamp":"2026-09-06T13:55:41.008700Z","level":"INFO","message":"job reattached","job":"20b74128ad0f6061087853651fd44696","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24663.951528] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:41.913219Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q '» ok' /tmp/resume.out, in 7.08 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/resume.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/resume.out, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: relay restart mid-run, push resumes via /v1/jobs, in 9.63 seconds) container-test-run-flakelet-relay> subtest: job history comes from the agents and survives a relay restart container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1 container-test-run-flakelet-relay> agent # [24664.613959] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:42.575742Z","level":"INFO","message":"start","id":"5be20c693e5c0b60e3f85779794dfb86","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24664.614648] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:42.576470Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24664.657532] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [24664.686109] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [24664.690668] agent flakelet[3768]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24664.691223] agent flakelet[3768]: other: up to date container-test-run-flakelet-relay> agent # [24664.693259] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24664.613583] relay flakelet-relay[932]: {"timestamp":"2026-09-06T13:55:42.575326Z","level":"INFO","message":"deploy accepted","job":"188b06c4636b65849b3ba8daac22dc7c","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> relay # [24665.232299] relay flakelet-relay[932]: {"timestamp":"2026-09-06T13:55:43.194017Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24665.248069] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [24665.283602] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24665.284049] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [24665.284091] relay systemd[1]: flakelet-relay.service: Consumed 1.833s CPU time over 9.200s wall clock time. container-test-run-flakelet-relay> relay # [24665.319985] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [24665.230934] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:43.192671Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24665.248238] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:43.210050Z","level":"INFO","message":"disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24666.251545] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:44.213282Z","level":"WARN","message":"connect failed: connect relay:7443: Connection refused (os error 111)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: must succeed: systemctl restart flakelet-relay, in 1.49 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1' container-test-run-flakelet-relay> relay # [24666.724065] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:44.685823Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [24666.724811] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:44.686274Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [24666.724512] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [24668.265273] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:46.227027Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(9), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [24668.265172] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:46.226904Z","level":"INFO","message":"connected","relay":"https://relay:7443","relay_name":"relay","relay_version":"0.1.0","host":"agent","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1', in 2.06 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzI0NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyOTQ2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXNFhPS1BKWjNTV0Q2PT09IiwibmJmIjoxNzg4NzAyOTQ2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.SNJlBuVdCqaXjLxgMnHv0EXzgOaNj1lLgq7y-YkUGcwRmJzFscG9wVxru-tp6YJt3-nht3cogWsbG8PCbtRiCg' push --relay https://relay:7443 deploy --id hist2 agent/app container-test-run-flakelet-relay> » job 6a239dbf87cfec796e49404c351d787f via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent/app | app: up to date container-test-run-flakelet-relay> agent # [24668.879381] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:46.841177Z","level":"INFO","message":"start","id":"dce6faec8455f85321e72ee634888126","flakelet":"app","rule":"ci","relay":"relay","caller_name":"\"example/app\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent/appagent # [24668.879730] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:46.841560Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dce6faec8455f85321e72ee634888126\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> | agent # [24668.917692] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> flakelet-relay-job-app.service: Deactivated successfully.agent # [24668.945979] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> container-test-run-flakelet-relay> agent # [24668.950893] agent flakelet[3816]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [24668.951466] agent flakelet[3816]: app: up to date container-test-run-flakelet-relay> agent # [24668.952219] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24668.879017] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:46.840799Z","level":"INFO","message":"deploy accepted","job":"6a239dbf87cfec796e49404c351d787f","caller":"example/app","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> » agent/app: unchanged (generation 9) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzI0NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyOTQ2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXNFhPS1BKWjNTV0Q2PT09IiwibmJmIjoxNzg4NzAyOTQ2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.SNJlBuVdCqaXjLxgMnHv0EXzgOaNj1lLgq7y-YkUGcwRmJzFscG9wVxru-tp6YJt3-nht3cogWsbG8PCbtRiCg' push --relay https://relay:7443 deploy --id hist2 agent/app, in 1.64 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzI0NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyOTQ2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXNFhPS1BKWjNTV0Q2PT09IiwibmJmIjoxNzg4NzAyOTQ2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.SNJlBuVdCqaXjLxgMnHv0EXzgOaNj1lLgq7y-YkUGcwRmJzFscG9wVxru-tp6YJt3-nht3cogWsbG8PCbtRiCg' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODcwMzI0NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NzAyOTQ2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXNFhPS1BKWjNTV0Q2PT09IiwibmJmIjoxNzg4NzAyOTQ2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.SNJlBuVdCqaXjLxgMnHv0EXzgOaNj1lLgq7y-YkUGcwRmJzFscG9wVxru-tp6YJt3-nht3cogWsbG8PCbtRiCg' push --relay https://relay:7443 jobs, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: job history comes from the agents and survives a relay restart, in 5.93 seconds) container-test-run-flakelet-relay> subtest: dashboard login via authorization code flow container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login, in 0.09 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 30 https://relay:7443/ui/jobs/1d0436330410c73b1f34c286ffe4022b/events || true container-test-run-flakelet-relay> relay # [24670.498194] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:48.459936Z","level":"INFO","message":"deploy finished","job":"6a239dbf87cfec796e49404c351d787f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24670.577283] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 13:55:48] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=CAS72tNt_ZP0SglQ2gj9PEkGOi56GpRWlm-CG8agQ3w&code_challenge=Q61sDQecv3UzDFfJz32N2mu4yxFhOgUNjFMvCwZWcaU&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> relay # [24670.628595] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 13:55:48] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [24670.629586] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:48.591387Z","level":"INFO","message":"login","name":"dev@example.org","principals":"[\"oidc:mock:someone\", \"oidc:mock:groups:wheel\"]","target":"flakelet_relay::relay::login"} container-test-run-flakelet-relay> relay # [24670.690455] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:48.652276Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24670.730211] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:48.692017Z","level":"INFO","message":"deploy accepted","job":"84ceadfc43ea05114f6a796cd8aa6fa6","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [24670.748908] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:48.710680Z","level":"INFO","message":"job reattached","job":"84ceadfc43ea05114f6a796cd8aa6fa6","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [24670.496840] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:48.458566Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24670.730504] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:48.692283Z","level":"INFO","message":"start","id":"a48e39f9438fdb3c24f079ecf9558618","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [24670.731171] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:48.692993Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"a48e39f9438fdb3c24f079ecf9558618\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [24670.762818] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [24670.795074] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [24670.799355] agent flakelet[3841]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24670.799890] agent flakelet[3841]: other: up to date container-test-run-flakelet-relay> agent # [24670.801785] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 30 https://relay:7443/ui/jobs/1d0436330410c73b1f34c286ffe4022b/events || true, in 0.61 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs/1d0436330410c73b1f34c286ffe4022b container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs/1d0436330410c73b1f34c286ffe4022b, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -sf -o /dev/null https://relay:7443/ui/static/htmx.min.js container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -sf -o /dev/null https://relay:7443/ui/static/htmx.min.js, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar 'https://relay:7443/ui/?q=status%3Ahealthy+oth' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar 'https://relay:7443/ui/?q=status%3Ahealthy+oth', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/flakelets/other container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/flakelets/other, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar 'https://relay:7443/ui/hosts?q=status%3Adisconnected' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar 'https://relay:7443/ui/hosts?q=status%3Adisconnected', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -H 'HX-Request: true' -X POST 'https://relay:7443/ui/retry?arg=1d0436330410c73b1f34c286ffe4022b' | grep -q 400 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -H 'HX-Request: true' -X POST 'https://relay:7443/ui/retry?arg=1d0436330410c73b1f34c286ffe4022b' | grep -q 400, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 15 'https://relay:7443/ui/events?path=jobs' > /tmp/ev.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 15 'https://relay:7443/ui/events?path=jobs' > /tmp/ev.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other container-test-run-flakelet-relay> » job 38796a7ba508eadfe82a1cd5def000bc via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/other | Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent/other | Started flakelet update other (via relay). container-test-run-flakelet-relay> agent/other | other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent/other | other: up to date container-test-run-flakelet-relay> agent # [24671.337855] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:49.299597Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent/otheragent # [24671.483896] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:49.445672Z","level":"INFO","message":"start","id":"5e317fc57863c2a7c03ebe1bdacd1356","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> | agent # [24671.484449] agent flakelet-agent[3095]: {"timestamp":"2026-09-06T13:55:49.446277Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> flakelet-relay-job-other.service: Deactivated successfully.agent # [24671.525125] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> container-test-run-flakelet-relay> agent # [24671.563250] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [24671.567822] agent flakelet[3873]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [24671.568341] agent flakelet[3873]: other: up to date container-test-run-flakelet-relay> agent # [24671.571145] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [24671.483503] relay flakelet-relay[1322]: {"timestamp":"2026-09-06T13:55:49.445258Z","level":"INFO","message":"deploy accepted","job":"38796a7ba508eadfe82a1cd5def000bc","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> » agent/other: unchanged (generation 1) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other, in 0.64 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q live1 /tmp/ev.out container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q live1 /tmp/ev.out, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: dashboard login via authorization code flow, in 1.64 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 87.35 seconds) container-test-run-flakelet-relay> test script finished in 87.40s container-test-run-flakelet-relay> cleanup container-test-run-flakelet-relay> kill NspawnMachine (pid 52) container-test-run-flakelet-relay> kill NspawnMachine (pid 53) container-test-run-flakelet-relay> Container agent terminated by signal KILL. container-test-run-flakelet-relay> kill NspawnMachine (pid 56) container-test-run-flakelet-relay> Container client terminated by signal KILL. container-test-run-flakelet-relay> (finished: cleanup, in 0.34 seconds) container-test-run-flakelet-relay> additionally exposed symbols: container-test-run-flakelet-relay> agent, client, relay, container-test-run-flakelet-relay> vlan1, container-test-run-flakelet-relay> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh container-test-run-flakelet-relay> » job 75b8b5579d18e15a47bd263a8d761277 via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent/app | app: activating generation 2 container-test-run-flakelet-relay> agent/app | app: updated to generation 2 container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> » agent/app: updated (generation 2) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> container-test-run-flakelet-relay> » job bb5d29db27e86f5b0796ec050443f8ee via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent/app | app: activating generation 4 container-test-run-flakelet-relay> agent/app | app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent/app | failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> » agent/app: rolled-back (generation 3) container-test-run-flakelet-relay> agent/app │ Starting app v1... container-test-run-flakelet-relay> agent/app │ Started app v1. container-test-run-flakelet-relay> agent/app │ Stopping app v1... container-test-run-flakelet-relay> agent/app │ app.service: Deactivated successfully. container-test-run-flakelet-relay> agent/app │ Stopped app v1. container-test-run-flakelet-relay> agent/app │ Starting app v2... container-test-run-flakelet-relay> agent/app │ Started app v2. container-test-run-flakelet-relay> agent/app │ Stopping app v2... container-test-run-flakelet-relay> agent/app │ app.service: Deactivated successfully. container-test-run-flakelet-relay> agent/app │ Stopped app v2. container-test-run-flakelet-relay> agent/app │ Starting app v1... container-test-run-flakelet-relay> agent/app │ Started app v1. container-test-run-flakelet-relay> agent/app │ Stopping app v1... container-test-run-flakelet-relay> agent/app │ app.service: Deactivated successfully. container-test-run-flakelet-relay> agent/app │ Stopped app v1. container-test-run-flakelet-relay> agent/app │ Starting app broken... container-test-run-flakelet-relay> agent/app │ app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent/app │ app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent/app │ app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent/app │ app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent/app │ Failed to start app broken. container-test-run-flakelet-relay> agent/app │ Starting app v1... container-test-run-flakelet-relay> agent/app │ Started app v1. container-test-run-flakelet-relay> » skipped: agent/other container-test-run-flakelet-relay> » failed container-test-run-flakelet-relay> container-test-run-flakelet-relay> » job 73020cfdeb517b36f4d5b140e41812bf via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent/app | app: activating generation 7 container-test-run-flakelet-relay> agent/app | app: updated to generation 7 container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> » agent/app: updated (generation 7) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> container-test-run-flakelet-relay> » job 9a383d6dec704f85dc9851ad9d2e1e13 via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent/app | app: activating generation 8 container-test-run-flakelet-relay> agent/app | app: updated to generation 8 container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> » agent/app: updated (generation 8) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> container-test-run-flakelet-relay> » job 20b74128ad0f6061087853651fd44696 via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent/app | app: activating generation 9 container-test-run-flakelet-relay> flakelet-push: stream: error reading a body from connection, resuming job e1c2715148de10b11a85fe98589879d3 container-test-run-flakelet-relay> flakelet-push: https://relay:7443: connect relay:7443: Connection refused (os error 111), retrying in 1s container-test-run-flakelet-relay> flakelet-push: https://relay:7443: connect relay:7443: Connection refused (os error 111), retrying in 2s container-test-run-flakelet-relay> flakelet-push: https://relay:7443: 404 Not Found: unknown_job: no connected agent knows this job, retrying in 4s container-test-run-flakelet-relay> » job 20b74128ad0f6061087853651fd44696 via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | app: updated to generation 9 container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> » agent/app: updated (generation 9) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> container-test-run-flakelet-relay> 1788702942 hist1 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788702932 e1c2715148de10b11a85fe98589879d3 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788702922 b54a6bba95af364c021b76fd8397e13e admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788702906 a5163070ea0f54f0e8a1094b19f8bbcc admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788702904 local-app-6-1788702904 root (shell) agent/app:updated container-test-run-flakelet-relay> 1788702901 local-app-5-1788702901 root (shell) agent/app:updated container-test-run-flakelet-relay> 1788702898 906e6aedb5a194c1078228844ec42e4c admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788702887 fdfa719b3d648443d3504390ae6990fd admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788702886 be071081b2b1fad66a36c4ed36bbb02e admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788702885 040de729a9e5cf81c5314cd2378bd85d admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788702885 e42e142228abca7ee417fd3409f81f29 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788702881 9f6642c85ee1678f097ca7a77a411b95 admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1788702880 982af96d6db37fa4a46922493be28a5d dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788702879 52077ff47162c846b091be726cfdee79 dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788702877 59030e5b5403733494846c87455a9f5c someone agent/other:unchanged container-test-run-flakelet-relay> 1788702874 b84665710f7dc128aa2cb9eed45521ff repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1788702871 71b52af1f78f0af044f97aa58ddd3795 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788702868 local-app-1-1788702868 host activation agent/app:updated container-test-run-flakelet-relay> 1788702868 local-other-1-1788702868 host activation agent/other:updated container-test-run-flakelet-relay> container-test-run-flakelet-relay> Container relay terminated by signal KILL. post-build step Upload coverage to codecov: ok Skipping codecov: project=Mic92/flakelet-relay attr=checks.x86_64-linux.nixos-test