these 42 derivations will be built: /nix/store/jbha0c78l38n2g7vsrwkan8ys07rcsxb-flakelet-agent.service.drv /nix/store/50lvzf2zjxnfk5pbxcrrvpvig148jjbf-flakelet-flakelet-agent-units.drv /nix/store/z9mxvzhzaypzs5j692n2ffpzl1isknpp-flakelet-flakelet-agent.drv /nix/store/07imdpfh9gb4s5898a4z40657jy1iqnq-flakelet-config.json.drv /nix/store/1dw1c7j9sqn0i3wj5x811w3jdan5pz10-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/0ibxhzrb7sjpnw83n0s5y7vc1r461rj5-unit-flakelet-reconcile.service.drv /nix/store/vw21325zs1yvmj1hfmawnbzrn11248pk-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/6x8rs1izhs33bc2s6qv6ymbggxw2cxvk-unit-flakelet-flakelet-relay.service.drv /nix/store/v6djsdh0nhcv3q3d6vi3srx6mmk558w3-flakelet-relay.json.drv /nix/store/qcm1wll3csp2wfqygvk1kv0rnraxl577-flakelet-relay.service.drv /nix/store/nh1n4wihyr1q03l0f61jnsj8fx7amvna-flakelet-flakelet-relay-units.drv /nix/store/83pc1nq2jrp90rsga2kllbgvg4pmmxkm-flakelet-flakelet-relay.drv /nix/store/rx2jbi3yvscm5sairkak7h2vmn4mnkqx-flakelet-config.json.drv /nix/store/ma4mdcnh7p2b84bh5r7m2c0028nzidb1-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/h9fdbgwrad7pikjldqq5x9pm66iirih9-unit-flakelet-reconcile.service.drv /nix/store/180dvv9v6gv1yy80vx782h213k7bh0s5-system-units.drv /nix/store/15wvazxl2z32js3wpxpafv1wlfhkmcqa-etc.drv /nix/store/4hxbyafgr8vqp1wr5ffsfp5vg8si0sxx-push.drv /nix/store/cvy36jiq8yzw5fl49d37xhi2c4dmzn86-system-path.drv /nix/store/bc3f0wv04x2zsx859ncjpgwixw0nqlac-dbus-1.drv /nix/store/mlmgr53vlv328pi6kx8wzvb0w3p31mmb-X-Restart-Triggers-dbus-broker.drv /nix/store/dnqghrs1qbpdi4n8lnqkrp30nrp0ci4i-unit-dbus-broker.service.drv /nix/store/1hwl90ndv699ncxbfhpac6kqbf52fh3x-system-units.drv /nix/store/zymy89fxki9h1rvl7carwyliyinq0x3s-unit-dbus-broker.service.drv /nix/store/nabi1hh0vqlwa4h6bh1my8w0zmlg9ms3-user-units.drv /nix/store/ay4j71gvkikdgf78lv19sd02h64vmpgg-etc.drv /nix/store/hs33smxwwm87582hmz52bj0072f6fla4-activate.drv /nix/store/d2dfynjz9jr5snl8vwdj32hcq5vfz480-nixos-system-client-test.drv /nix/store/c2xc0yf340dxxjmkv1a7ivcv1y7lgjy4-run-client-nspawn.drv /nix/store/6d3y9hk6jxx32212wgmr1s44vcgywgcm-X-Restart-Triggers-flakelet-flakelet-agent.drv /nix/store/zpix2dzwji3szmq27jqxi4yns5c2x2xa-unit-flakelet-flakelet-agent.service.drv /nix/store/gkgxkrsxrlcsd5546n6fls582zm0nf90-system-units.drv /nix/store/bkl1l751lc1ymp4d1d280ri5s1mlnqk9-etc.drv /nix/store/mjx3mjqnfclpvdgvifvpfal29nqjwqzg-activate.drv /nix/store/zs7am71azmxlq4dnb55iazw38w4j5mkr-nixos-system-agent-test.drv /nix/store/dr0lvhyyjjkai867fnmyb4hr4sad3d85-run-agent-nspawn.drv /nix/store/qnldmkjadc898zyz226qhqph5q3k9y9l-activate.drv /nix/store/6zf9jjp39viq6f508798i6jk2l0s62jg-nixos-system-relay-test.drv /nix/store/xyacgbylx4r26pjyahiv3hhvi986z40y-run-relay-nspawn.drv /nix/store/9gwlvw8vnm9djmf9w302j1rwlk51zczi-driverConfiguration.json.drv /nix/store/4irs016hwqh0mcvjbwb3rny4gv8sw3qj-nixos-test-driver-flakelet-relay.drv /nix/store/z7kb9mrsp9h1cayyxj11w7nz8rx6f4xr-container-test-run-flakelet-relay.drv building '/nix/store/4hxbyafgr8vqp1wr5ffsfp5vg8si0sxx-push.drv' building '/nix/store/6d3y9hk6jxx32212wgmr1s44vcgywgcm-X-Restart-Triggers-flakelet-flakelet-agent.drv' building '/nix/store/vw21325zs1yvmj1hfmawnbzrn11248pk-X-Restart-Triggers-flakelet-flakelet-relay.drv' X-Restart-Triggers-flakelet-flakelet-agent> tribuchet: building on jamie push> tribuchet: building on jamie building '/nix/store/jbha0c78l38n2g7vsrwkan8ys07rcsxb-flakelet-agent.service.drv' X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/v6djsdh0nhcv3q3d6vi3srx6mmk558w3-flakelet-relay.json.drv' flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> tribuchet: building on jamie building '/nix/store/zpix2dzwji3szmq27jqxi4yns5c2x2xa-unit-flakelet-flakelet-agent.service.drv' unit-flakelet-flakelet-agent.service> tribuchet: building on jamie building '/nix/store/6x8rs1izhs33bc2s6qv6ymbggxw2cxvk-unit-flakelet-flakelet-relay.service.drv' 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 unit-flakelet-flakelet-relay.service> tribuchet: building on jamie 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/50lvzf2zjxnfk5pbxcrrvpvig148jjbf-flakelet-flakelet-agent-units.drv' building '/nix/store/cvy36jiq8yzw5fl49d37xhi2c4dmzn86-system-path.drv' flakelet-flakelet-agent-units> tribuchet: building on jamie system-path> tribuchet: building on jamie building '/nix/store/qcm1wll3csp2wfqygvk1kv0rnraxl577-flakelet-relay.service.drv' flakelet-relay.service> tribuchet: building on jamie building '/nix/store/nh1n4wihyr1q03l0f61jnsj8fx7amvna-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie system-path> structuredAttrs is enabled unit-flakelet-flakelet-relay.service> structuredAttrs is enabled unit-flakelet-flakelet-agent.service> structuredAttrs is enabled building '/nix/store/z9mxvzhzaypzs5j692n2ffpzl1isknpp-flakelet-flakelet-agent.drv' flakelet-flakelet-agent> tribuchet: building on jamie building '/nix/store/83pc1nq2jrp90rsga2kllbgvg4pmmxkm-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie system-path> created 6399 symlinks in user environment building '/nix/store/07imdpfh9gb4s5898a4z40657jy1iqnq-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/rx2jbi3yvscm5sairkak7h2vmn4mnkqx-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled flakelet-config.json> structuredAttrs is enabled building '/nix/store/bc3f0wv04x2zsx859ncjpgwixw0nqlac-dbus-1.drv' building '/nix/store/1dw1c7j9sqn0i3wj5x811w3jdan5pz10-X-Restart-Triggers-flakelet-reconcile.drv' dbus-1> tribuchet: building on jamie X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/ma4mdcnh7p2b84bh5r7m2c0028nzidb1-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/0ibxhzrb7sjpnw83n0s5y7vc1r461rj5-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/h9fdbgwrad7pikjldqq5x9pm66iirih9-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/mlmgr53vlv328pi6kx8wzvb0w3p31mmb-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/gkgxkrsxrlcsd5546n6fls582zm0nf90-system-units.drv' building '/nix/store/180dvv9v6gv1yy80vx782h213k7bh0s5-system-units.drv' system-units> tribuchet: building on jamie system-units> tribuchet: building on jamie building '/nix/store/dnqghrs1qbpdi4n8lnqkrp30nrp0ci4i-unit-dbus-broker.service.drv' building '/nix/store/zymy89fxki9h1rvl7carwyliyinq0x3s-unit-dbus-broker.service.drv' unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/1hwl90ndv699ncxbfhpac6kqbf52fh3x-system-units.drv' building '/nix/store/nabi1hh0vqlwa4h6bh1my8w0zmlg9ms3-user-units.drv' system-units> tribuchet: building on jamie user-units> tribuchet: building on jamie building '/nix/store/bkl1l751lc1ymp4d1d280ri5s1mlnqk9-etc.drv' etc> tribuchet: building on jamie building '/nix/store/15wvazxl2z32js3wpxpafv1wlfhkmcqa-etc.drv' etc> tribuchet: building on jamie building '/nix/store/ay4j71gvkikdgf78lv19sd02h64vmpgg-etc.drv' etc> tribuchet: building on jamie building '/nix/store/mjx3mjqnfclpvdgvifvpfal29nqjwqzg-activate.drv' building '/nix/store/qnldmkjadc898zyz226qhqph5q3k9y9l-activate.drv' activate> tribuchet: building on jamie activate> tribuchet: building on jamie building '/nix/store/hs33smxwwm87582hmz52bj0072f6fla4-activate.drv' activate> tribuchet: building on jamie building '/nix/store/6zf9jjp39viq6f508798i6jk2l0s62jg-nixos-system-relay-test.drv' building '/nix/store/zs7am71azmxlq4dnb55iazw38w4j5mkr-nixos-system-agent-test.drv' nixos-system-relay-test> tribuchet: building on jamie nixos-system-agent-test> tribuchet: building on jamie nixos-system-relay-test> structuredAttrs is enabled nixos-system-agent-test> structuredAttrs is enabled building '/nix/store/d2dfynjz9jr5snl8vwdj32hcq5vfz480-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on jamie building '/nix/store/xyacgbylx4r26pjyahiv3hhvi986z40y-run-relay-nspawn.drv' building '/nix/store/dr0lvhyyjjkai867fnmyb4hr4sad3d85-run-agent-nspawn.drv' run-relay-nspawn> tribuchet: building on jamie run-agent-nspawn> tribuchet: building on jamie nixos-system-client-test> structuredAttrs is enabled building '/nix/store/c2xc0yf340dxxjmkv1a7ivcv1y7lgjy4-run-client-nspawn.drv' run-client-nspawn> tribuchet: building on jamie building '/nix/store/9gwlvw8vnm9djmf9w302j1rwlk51zczi-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/4irs016hwqh0mcvjbwb3rny4gv8sw3qj-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/z7kb9mrsp9h1cayyxj11w7nz8rx6f4xr-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> client: systemd-nspawn running (pid 53) container-test-run-flakelet-relay> agent: systemd-nspawn running (pid 52) container-test-run-flakelet-relay> relay: systemd-nspawn running (pid 54) container-test-run-flakelet-relay> client: Waiting for journal at /build/vm-state-client/var/log/journal... container-test-run-flakelet-relay> agent: Waiting for journal at /build/vm-state-agent/var/log/journal... 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(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> 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> 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> 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> ░ 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> 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> agent # No journal files were found. container-test-run-flakelet-relay> relay # 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> relay # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> client # [95577.307595] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [95577.307635] client systemd-journald[57]: Runtime Journal (/run/log/journal/6278dca6419b44869523c437bf5782b2) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [95577.357675] client systemd[1]: Listening on Journal Log Access Socket. container-test-run-flakelet-relay> client # [95577.358135] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [95577.372592] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [95577.473771] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [95577.477655] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [95577.482750] client systemd-journald[57]: Time spent on flushing to /var/log/journal/6278dca6419b44869523c437bf5782b2 is 3.172ms for 7 entries. container-test-run-flakelet-relay> client # [95577.482750] client systemd-journald[57]: System Journal (/var/log/journal/6278dca6419b44869523c437bf5782b2) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [95577.556177] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [95577.301904] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [95577.556494] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [95577.301999] relay systemd-journald[57]: Runtime Journal (/run/log/journal/41ddbea48767438699e54fc16613f0ae) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [95577.557369] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [95577.364214] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [95577.560357] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [95577.440423] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [95577.560513] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [95577.534337] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [95578.326173] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [95577.535677] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [95577.543685] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/41ddbea48767438699e54fc16613f0ae is 1.371ms for 6 entries. container-test-run-flakelet-relay> relay # [95577.543685] relay systemd-journald[57]: System Journal (/var/log/journal/41ddbea48767438699e54fc16613f0ae) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [95577.557077] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [95577.557980] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [95577.559375] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [95577.559504] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [95577.564860] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [95578.325318] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> agent # [95577.302214] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [95577.302257] agent systemd-journald[57]: Runtime Journal (/run/log/journal/5a4759df626b4f369a459e66aeec20f4) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [95577.344424] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [95577.364992] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [95577.443525] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [95577.444338] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> agent # [95577.452151] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/5a4759df626b4f369a459e66aeec20f4 is 3.448ms for 6 entries. container-test-run-flakelet-relay> agent # [95577.452151] agent systemd-journald[57]: System Journal (/var/log/journal/5a4759df626b4f369a459e66aeec20f4) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [95577.527744] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [95577.528175] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> agent # [95577.534739] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [95577.536930] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> agent # [95577.537109] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [95578.325277] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [95578.353133] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> agent # [95578.353143] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> relay # [95578.356456] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> agent # [95578.356441] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [95578.357665] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [95578.357541] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [95578.360814] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [95578.360721] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [95578.360843] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [95578.361806] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [95578.362830] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [95578.360751] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [95578.381773] relay systemd-tmpfiles[169]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> agent # [95578.361886] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [95578.382245] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [95578.362775] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [95578.381767] 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 # [95578.382244] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [95578.382545] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/41ddbea48767438699e54fc16613f0ae failed: Operation not permitted container-test-run-flakelet-relay> relay # [95578.382915] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [95578.382572] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/5a4759df626b4f369a459e66aeec20f4 failed: Operation not permitted container-test-run-flakelet-relay> agent # [95578.382927] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [95578.377756] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [95578.378958] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [95578.380413] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [95578.381700] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [95578.381746] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [95578.382717] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [95578.386692] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> client # [95578.405461] client systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> client # [95578.405833] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [95578.406123] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/6278dca6419b44869523c437bf5782b2 failed: Operation not permitted container-test-run-flakelet-relay> client # [95578.406434] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [95578.387125] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [95578.387559] agent suid-sgid-wrappers-start[169]: chmod: changing permissions of '/run/wrappers/wrappers.uWgL3xoQKB/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [95578.409591] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [95578.409687] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [95578.409910] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [95578.417788] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [95578.418929] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> agent # [95578.435298] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [95578.436828] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [95578.438025] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [95578.446392] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [95578.446499] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [95578.446583] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [95578.446635] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [95578.446650] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [95578.446760] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [95578.446914] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [95578.447021] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [95578.447036] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [95578.447065] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [95578.449640] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [95578.451231] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [95578.452172] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [95578.453025] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [95578.461124] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [95578.464624] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [95578.470149] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [95578.475669] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [95578.535260] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [95578.535357] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [95578.536430] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [95578.539470] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [95578.553675] agent network-addresses-eth1-start[236]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [95578.557084] agent network-addresses-eth1-start[236]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [95578.561145] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [95578.575359] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95578.387125] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [95578.387401] relay suid-sgid-wrappers-start[177]: chmod: changing permissions of '/run/wrappers/wrappers.yeOjIx5RuI/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [95578.409647] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [95578.409755] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [95578.409917] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [95578.417789] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [95578.419069] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [95578.436578] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [95578.439186] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [95578.441584] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [95578.450628] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [95578.450791] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [95578.450864] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [95578.450891] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [95578.450909] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [95578.451016] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [95578.451196] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [95578.451299] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [95578.451319] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [95578.451351] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [95578.452584] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [95578.453333] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [95578.454126] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [95578.455103] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [95578.455710] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> relay # [95578.464163] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [95578.466368] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [95578.473040] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [95578.478319] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> relay # [95578.540102] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [95578.540252] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [95578.541131] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [95578.542900] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [95578.560255] relay network-addresses-eth1-start[245]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [95578.569037] relay network-addresses-eth1-start[245]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [95578.579464] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [95578.407708] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.iBAuzFzKT9/chsh': Operation not permitted container-test-run-flakelet-relay> client # [95578.417117] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [95578.417159] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [95578.417220] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> client # [95578.418041] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [95578.450187] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [95578.451351] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [95578.461011] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [95578.470144] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [95578.473687] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [95578.483924] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [95578.484044] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [95578.484120] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [95578.484149] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [95578.484163] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [95578.484256] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [95578.484466] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [95578.484563] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [95578.484577] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [95578.484603] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [95578.485999] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [95578.487149] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [95578.488156] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [95578.508767] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [95578.748824] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [95578.750667] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [95578.751082] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95578.751289] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [95578.754136] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [95578.758774] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [95578.788053] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [95578.789785] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [95578.790166] relay systemd[1]: nscd.service: Failed to spawn executor: No such file or directory container-test-run-flakelet-relay> relay # [95578.790211] relay systemd[1]: nscd.service: Failed to spawn 'start' task: No such file or directory container-test-run-flakelet-relay> relay # [95578.790247] relay systemd[1]: nscd.service: Failed with result 'resources'. container-test-run-flakelet-relay> relay # [95578.790290] relay systemd[1]: Failed to start Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [95578.790306] relay systemd[1]: Dependency failed for User and Group Name Lookups. container-test-run-flakelet-relay> relay # [95578.790313] relay systemd[1]: nss-user-lookup.target: Job nss-user-lookup.target/start failed with result 'dependency'. container-test-run-flakelet-relay> relay # [95578.790321] relay systemd[1]: Dependency failed for Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [95578.790329] relay systemd[1]: nss-lookup.target: Job nss-lookup.target/start failed with result 'dependency'. container-test-run-flakelet-relay> relay # [95578.792272] relay systemd[1]: nscd.service: Scheduled restart job immediately on client request, restart counter is at 1. container-test-run-flakelet-relay> relay # [95578.793215] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [95578.794045] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [95578.805648] relay flakelet[313]: flakelet-relay: using prebuilt artifact /nix/store/h6yb79gkwajv3w0kgqcgpv6b2x0lxv95-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [95578.806597] relay flakelet[313]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [95578.811747] relay systemd[1]: Reload requested from client PID 318 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [95578.811818] relay systemd[1]: Reloading... container-test-run-flakelet-relay> client # [95578.749809] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [95578.751471] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [95578.751890] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [95578.752123] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [95578.755080] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> client # [95578.760075] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [95578.790636] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> client # [95578.792567] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [95578.794296] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [95578.809253] client network-addresses-eth1-start[236]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> client # [95578.813433] client network-addresses-eth1-start[236]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [95578.820045] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [95578.872473] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [95578.872726] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> client # [95578.944739] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [95578.945044] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [95578.949821] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [95578.575909] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [95578.583651] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [95578.749256] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [95578.750770] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [95578.778156] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95578.785558] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [95578.789710] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [95578.791137] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [95578.793689] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [95578.795542] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [95578.796985] agent systemd[1]: Starting Update flakelet service flakelet-agent... container-test-run-flakelet-relay> agent # [95578.798380] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [95578.807283] agent flakelet[308]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [95578.807917] agent flakelet[308]: app: activating generation 1 container-test-run-flakelet-relay> agent # [95578.808389] agent flakelet[309]: flakelet-agent: using prebuilt artifact /nix/store/mkhzwjb7dx52m7f63r4ck3bzjrcp1b9n-flakelet-flakelet-agent container-test-run-flakelet-relay> agent # [95578.809034] agent flakelet[309]: flakelet-agent: activating generation 1 container-test-run-flakelet-relay> agent # [95578.809883] agent flakelet[311]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95578.810480] agent flakelet[311]: other: activating generation 1 container-test-run-flakelet-relay> agent # [95578.812073] agent systemd[1]: Reload requested from client PID 312 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [95578.812112] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95579.462939] relay systemd[1]: Reloading finished in 650 ms. container-test-run-flakelet-relay> relay # [95579.565479] relay systemd[1]: Reload requested from client PID 347 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [95579.565517] relay systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95579.530801] agent systemd[1]: Reloading finished in 718 ms. container-test-run-flakelet-relay> agent # [95579.606650] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [95579.606692] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95579.922531] relay nsncd[311]: Oct 15 11:56:12.732 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [95579.955994] agent nsncd[307]: Oct 15 11:56:12.766 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [95580.105029] relay systemd[1]: Reloading finished in 539 ms. container-test-run-flakelet-relay> agent # [95580.126349] agent systemd[1]: Reloading finished in 519 ms. container-test-run-flakelet-relay> agent # [95580.238203] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [95579.962470] client nsncd[303]: Oct 15 11:56:12.772 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [95579.962624] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [95579.962710] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [95579.962808] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [95579.966260] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [95579.967670] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [95579.978549] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [95579.980533] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [95579.980593] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [95579.980625] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [95580.238084] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [95580.239340] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [95580.239431] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [95580.240850] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [95580.242157] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [95580.250123] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> relay # [95580.258553] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [95580.259716] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [95580.259783] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [95580.259860] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [95580.242261] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [95580.242303] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95580.740116] relay dnsmasq-pre-start[400]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> agent # [95580.772362] agent systemd[1]: Reloading finished in 529 ms. container-test-run-flakelet-relay> agent # [95580.846767] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [95580.846823] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [95580.848250] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [95580.868702] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [95580.874123] agent systemd[1]: Reload requested from client PID 404 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [95580.874159] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95581.240702] agent systemd[1]: Reloading finished in 366 ms. container-test-run-flakelet-relay> agent # [95581.309569] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [95581.317384] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [95581.317500] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [95581.317646] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [95581.319017] agent systemd[1]: Reload requested from client PID 412 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [95581.319045] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95581.481524] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [95581.673681] agent systemd[1]: Reloading finished in 354 ms. container-test-run-flakelet-relay> agent # [95581.770781] agent systemd[1]: Reload requested from client PID 413 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [95581.770828] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95582.278577] agent systemd[1]: Reloading finished in 507 ms. container-test-run-flakelet-relay> agent # [95582.382225] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [95582.383145] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [95582.383973] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [95582.389443] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [95582.394656] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [95582.414254] agent flakelet[311]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [95582.414564] agent flakelet[308]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [95582.417113] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [95582.417437] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [95582.452491] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:15.262845Z","level":"INFO","message":"local change","flakelet":"app","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95582.452807] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:15.263156Z","level":"INFO","message":"local change","flakelet":"other","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95582.453012] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [95582.464373] agent flakelet[309]: flakelet-agent: updated to generation 1 container-test-run-flakelet-relay> agent # [95582.489215] agent systemd[1]: Finished Update flakelet service flakelet-agent. container-test-run-flakelet-relay> agent # [95582.490554] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> agent # [95582.500386] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:15.310835Z","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 # [95582.503029] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:15.313486Z","level":"INFO","message":"local change","flakelet":"flakelet-agent","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client # [95582.399338] client systemd-logind[315]: New seat seat0. container-test-run-flakelet-relay> client # [95582.402393] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [95582.402527] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [95582.403945] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [95582.434047] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [95582.434359] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [95582.434702] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [95582.486667] relay dbus-broker-launch[404]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [95582.487278] relay dbus-broker-launch[404]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [95582.487278] relay dbus-broker-launch[404]: Invalid user-name in /nix/store/d6qla8vgy057drw03ps2mdgny56bml50-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> relay # [95582.488012] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [95582.494391] relay dbus-broker-launch[404]: Ready container-test-run-flakelet-relay> relay # [95582.496079] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> relay # [95582.497414] relay dnsmasq[402]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [95582.497422] relay dnsmasq[402]: 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 # [95582.497428] relay dnsmasq[402]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [95582.497442] relay dnsmasq[402]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [95582.497613] relay dnsmasq[402]: read /etc/hosts - 9 names container-test-run-flakelet-relay> relay # [95582.554342] relay nginx-pre-start[407]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [95582.554650] relay nginx-pre-start[407]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [95582.568885] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> relay # [95582.704492] relay systemd-logind[385]: New seat seat0. container-test-run-flakelet-relay> relay # [95582.704889] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [95582.707483] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [95582.749622] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95582.749939] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [95583.211153] client dbus-broker-launch[325]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [95583.212310] client dbus-broker-launch[325]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [95583.212310] client dbus-broker-launch[325]: Invalid user-name in /nix/store/pkwmxa4jfnmnj95xkrbf1pnhpg4qwmdi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [95583.213246] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [95583.213766] client systemd[1]: Startup finished in 6.325s. container-test-run-flakelet-relay> client # [95583.221748] client dbus-broker-launch[325]: Ready container-test-run-flakelet-relay> agent # [95583.122925] agent systemd-logind[407]: New seat seat0. container-test-run-flakelet-relay> agent # [95583.123183] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [95583.124869] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [95583.126764] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [95583.141224] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95583.141442] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [95583.141601] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [95583.589100] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:16.399202Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [95583.589841] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:16.400078Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [95583.589938] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [95583.601866] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> agent # [95583.759026] agent dbus-broker-launch[906]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [95583.760617] agent dbus-broker-launch[906]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [95583.760617] agent dbus-broker-launch[906]: Invalid user-name in /nix/store/8mp15gfn2m81r8005nnkppky8976lhbb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> agent # [95583.761840] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [95583.762407] agent systemd[1]: Startup finished in 6.874s. container-test-run-flakelet-relay> agent # [95583.766860] agent dbus-broker-launch[906]: Ready container-test-run-flakelet-relay> relay # [95583.953981] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95583.954328] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay # [95583.961071] relay flakelet[313]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [95583.963522] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [95583.964072] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [95583.964245] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [95583.964474] relay systemd[1]: Startup finished in 7.076s. container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 8.16 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.01 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.01 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet-agent.service 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: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1', in 0.02 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.01 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> agent # [95584.510285] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:17.320689Z","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 # [95584.623048] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:17.433445Z","level":"INFO","message":"start","id":"a09c1f2e8c82aa805af0fdcfddbdec61","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95584.623969] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:17.434433Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"a09c1f2e8c82aa805af0fdcfddbdec61\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95584.665407] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95584.701686] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95584.706145] agent flakelet[928]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [95584.706860] agent flakelet[928]: app: activating generation 2 container-test-run-flakelet-relay> agent # [95584.726053] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [95584.726507] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95584.726768] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [95584.744421] agent systemd[1]: Reload requested from client PID 935 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95584.744486] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95584.510469] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:17.320866Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(1), revision: Some(\"prebuilt:app\") }, Named { name: \"flakelet-agent\", generation: Some(1), revision: Some(\"prebuilt:flakelet-agent\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> relay # [95584.622192] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:17.432607Z","level":"INFO","message":"deploy accepted","job":"7babaac72e7f2b7f5191cf4bc14fc82d","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95585.104675] agent systemd[1]: Reloading finished in 359 ms. container-test-run-flakelet-relay> agent # [95585.203402] agent systemd[1]: Reload requested from client PID 965 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95585.203440] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95585.541723] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [95585.629260] agent systemd[1]: Reload requested from client PID 994 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95585.629300] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95585.983968] agent systemd[1]: Reloading finished in 354 ms. container-test-run-flakelet-relay> agent # [95586.079990] agent systemd[1]: Reload requested from client PID 1025 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95586.080059] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95586.438618] agent systemd[1]: Reloading finished in 358 ms. container-test-run-flakelet-relay> agent # [95586.535205] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [95586.567009] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [95586.571451] agent flakelet[928]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [95586.573309] 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 3.02 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 3.10 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.01 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.07 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTY4MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1MzgwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJLTkYzR1lSUEpES0EyPT09IiwibmJmIjoxNzkyMDY1MzgwLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.pKxrLrYzg4gX14eNIBL8gMNO-lUyorFMoavGNrE7rMjucHmbZzTN01IA2MqKo1MMdVhL-Eu-nFno3mudZWAfCA' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> agent # [95587.614653] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:20.425060Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95587.793080] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:20.603446Z","level":"INFO","message":"start","id":"5e411dcb8c7ca032aa3eb94a8a68e22f","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 # [95587.793475] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:20.603951Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"5e411dcb8c7ca032aa3eb94a8a68e22f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95587.829200] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95587.864977] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> relay # [95587.615878] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:20.426275Z","level":"INFO","message":"deploy finished","job":"7babaac72e7f2b7f5191cf4bc14fc82d","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95587.792693] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:20.603113Z","level":"INFO","message":"deploy accepted","job":"40a9b80c85ad9c456c63d1af0884cffa","caller":"repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95587.868592] agent flakelet[1094]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [95587.869256] agent flakelet[1094]: app: activating generation 3 container-test-run-flakelet-relay> agent # [95587.882017] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [95587.883855] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95587.884187] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [95587.899682] agent systemd[1]: Reload requested from client PID 1101 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95587.899746] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95588.258321] agent systemd[1]: Reloading finished in 357 ms. container-test-run-flakelet-relay> agent # [95588.344334] agent systemd[1]: Reload requested from client PID 1131 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95588.344371] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95588.676285] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [95588.766749] agent systemd[1]: Reload requested from client PID 1162 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95588.766785] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95589.108875] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [95589.192354] agent systemd[1]: Reload requested from client PID 1195 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95589.192390] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95589.532608] agent systemd[1]: Reloading finished in 339 ms. container-test-run-flakelet-relay> agent # [95589.612926] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [95589.641061] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [95589.645246] agent flakelet[1094]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [95589.647425] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTY4MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1MzgwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJLTkYzR1lSUEpES0EyPT09IiwibmJmIjoxNzkyMDY1MzgwLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.pKxrLrYzg4gX14eNIBL8gMNO-lUyorFMoavGNrE7rMjucHmbZzTN01IA2MqKo1MMdVhL-Eu-nFno3mudZWAfCA' push --relay https://relay:7443 deploy agent/app 2>&1, in 2.97 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 3.06 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTY4MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1MzgwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJLTkYzR1lSUEpES0EyPT09IiwibmJmIjoxNzkyMDY1MzgwLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.pKxrLrYzg4gX14eNIBL8gMNO-lUyorFMoavGNrE7rMjucHmbZzTN01IA2MqKo1MMdVhL-Eu-nFno3mudZWAfCA' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTY4MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1MzgwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJLTkYzR1lSUEpES0EyPT09IiwibmJmIjoxNzkyMDY1MzgwLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.pKxrLrYzg4gX14eNIBL8gMNO-lUyorFMoavGNrE7rMjucHmbZzTN01IA2MqKo1MMdVhL-Eu-nFno3mudZWAfCA' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTY4MywiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MjA2NTM4MywiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiQTZKWkNVM0w2RUw3ST09PSIsIm5iZiI6MTc5MjA2NTM4Mywic3ViIjoic29tZW9uZSJ9.uFlLTtBPNFA9GT1jvGx34n-_uxp77jpRJa4ffxQvGA0yrRm-idpCAvcnCRF2X1cz8lsF1l7aE-G1eLYHIgUYCA' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [95590.729326] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:23.539742Z","level":"INFO","message":"deploy finished","job":"40a9b80c85ad9c456c63d1af0884cffa","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95590.822847] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:23.633272Z","level":"INFO","message":"deploy accepted","job":"d388cef379ad0218cce3f6d3c34ba168","caller":"someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95590.727928] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:23.538326Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95590.823224] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:23.633629Z","level":"INFO","message":"start","id":"c292bc69eb2e2a44f5e859ff4143d1a8","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"someone\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95590.823737] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:23.634205Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"c292bc69eb2e2a44f5e859ff4143d1a8\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95590.860427] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [95590.897144] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [95590.900610] agent flakelet[1249]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95590.901183] agent flakelet[1249]: other: up to date container-test-run-flakelet-relay> agent # [95590.904321] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTY4MywiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MjA2NTM4MywiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiQTZKWkNVM0w2RUw3ST09PSIsIm5iZiI6MTc5MjA2NTM4Mywic3ViIjoic29tZW9uZSJ9.uFlLTtBPNFA9GT1jvGx34n-_uxp77jpRJa4ffxQvGA0yrRm-idpCAvcnCRF2X1cz8lsF1l7aE-G1eLYHIgUYCA' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.63 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 0.69 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 # [95591.438925] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:24.249326Z","level":"INFO","message":"deploy finished","job":"d388cef379ad0218cce3f6d3c34ba168","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95591.458016] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [15/Oct/2026 11:56:24] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> agent # [95591.437533] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:24.247902Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [95592.462609] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [15/Oct/2026 11:56:25] "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.07 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 # [95593.538458] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:26.348856Z","level":"INFO","message":"start","id":"7610c31faaf54711550ae71bb405cfca","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95593.539325] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:26.349639Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"7610c31faaf54711550ae71bb405cfca\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95593.567490] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [95593.596769] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [95593.600568] agent flakelet[1273]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95593.601132] agent flakelet[1273]: other: up to date container-test-run-flakelet-relay> agent # [95593.607234] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95593.510572] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [15/Oct/2026 11:56:26] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [95593.538088] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:26.348535Z","level":"INFO","message":"deploy accepted","job":"a7bb888b087ac00534fc5291cc7f23f9","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.62 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 # [95594.143752] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:26.954162Z","level":"INFO","message":"deploy finished","job":"a7bb888b087ac00534fc5291cc7f23f9","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95594.160036] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:26.970505Z","level":"INFO","message":"deploy accepted","job":"4910a8d81ff77dda366cd68ca0f9fe7f","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95594.142376] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:26.952737Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95594.160318] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:26.970753Z","level":"INFO","message":"start","id":"990a22a6342af2183ecb46ec82d2738d","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95594.163078] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:26.973546Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"990a22a6342af2183ecb46ec82d2738d\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95594.200361] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [95594.229981] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [95594.234126] agent flakelet[1293]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95594.234655] agent flakelet[1293]: other: up to date container-test-run-flakelet-relay> agent # [95594.235797] 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.63 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 3.33 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 # [95594.771318] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:27.581712Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95594.804543] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:27.614989Z","level":"INFO","message":"start","id":"2810064b983b0b71c3602f3aa7e54f31","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95594.804786] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:27.615260Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"2810064b983b0b71c3602f3aa7e54f31\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95594.828707] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95594.866042] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95594.870144] agent flakelet[1320]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [95594.870869] agent flakelet[1320]: app: activating generation 4 container-test-run-flakelet-relay> agent # [95594.880851] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [95594.881542] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95594.881670] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [95594.890613] agent systemd[1]: Reload requested from client PID 1327 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95594.890648] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95594.772617] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:27.583044Z","level":"INFO","message":"deploy finished","job":"4910a8d81ff77dda366cd68ca0f9fe7f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95594.804265] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:27.614715Z","level":"INFO","message":"deploy accepted","job":"b75f2369481c44220180bbd422237160","caller":"admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95595.224122] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [95595.318969] agent systemd[1]: Reload requested from client PID 1357 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95595.319013] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95595.672674] agent systemd[1]: Reloading finished in 353 ms. container-test-run-flakelet-relay> agent # [95595.756139] agent systemd[1]: Reload requested from client PID 1386 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95595.756178] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95596.102912] agent systemd[1]: Reloading finished in 346 ms. container-test-run-flakelet-relay> agent # [95596.189579] agent systemd[1]: Reload requested from client PID 1417 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95596.189616] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95596.526495] agent systemd[1]: Reloading finished in 336 ms. container-test-run-flakelet-relay> agent # [95596.600539] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [95596.610099] agent (nonexistent)[1450]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [95596.610120] agent (nonexistent)[1450]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [95596.612524] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [95596.612622] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [95596.612852] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [95596.639885] agent systemd[1]: Reload requested from client PID 1457 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95596.639921] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95596.986670] agent systemd[1]: Reloading finished in 346 ms. container-test-run-flakelet-relay> agent # [95597.088297] agent systemd[1]: Reload requested from client PID 1487 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95597.088336] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95597.433274] agent systemd[1]: Reloading finished in 344 ms. container-test-run-flakelet-relay> agent # [95597.494304] agent systemd[1]: Reload requested from client PID 1517 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95597.494338] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95597.827384] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [95597.893680] agent systemd[1]: Reload requested from client PID 1547 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95597.893715] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95598.236424] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [95598.305295] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [95598.334399] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [95598.335649] agent flakelet[1320]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [95598.335649] agent flakelet[1320]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [95598.338131] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [95598.338229] 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.25 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.28 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.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 '@all/app' 2>&1 container-test-run-flakelet-relay> agent # [95599.032993] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:31.843378Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95599.084848] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:31.895252Z","level":"INFO","message":"start","id":"7ee95e04f1b0bbf424141f40a0a3d544","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95599.085400] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:31.895863Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"7ee95e04f1b0bbf424141f40a0a3d544\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95599.122746] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95599.150960] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95599.155173] agent flakelet[1607]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [95599.155759] agent flakelet[1607]: app: up to date container-test-run-flakelet-relay> agent # [95599.158788] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95599.034431] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:31.844838Z","level":"INFO","message":"deploy finished","job":"b75f2369481c44220180bbd422237160","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95599.084556] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:31.894996Z","level":"INFO","message":"deploy accepted","job":"50a9a57de2601ee207c739e8797932d1","caller":"admin@example.org","targets":"[\"agent/app\"]","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 '@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 # [95599.701489] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:32.511896Z","level":"INFO","message":"deploy finished","job":"50a9a57de2601ee207c739e8797932d1","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95599.730717] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:32.541163Z","level":"INFO","message":"deploy accepted","job":"86ef394c6ad824d5d4f1e209e5b31de9","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95599.699992] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:32.510382Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95599.731100] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:32.541536Z","level":"INFO","message":"start","id":"bf52011534129793dac51f28e868bec9","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95599.731508] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:32.541972Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"bf52011534129793dac51f28e868bec9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95599.766524] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95599.801309] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95599.807228] agent flakelet[1627]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [95599.807784] agent flakelet[1627]: app: up to date container-test-run-flakelet-relay> agent # [95599.808971] 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> relay # [95600.345516] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:33.155920Z","level":"INFO","message":"deploy finished","job":"86ef394c6ad824d5d4f1e209e5b31de9","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95600.368181] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:33.178636Z","level":"INFO","message":"deploy accepted","job":"749993fa4eaaf1dc4ca3ea4448db5eba","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95600.343668] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:33.154055Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95600.368556] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:33.178989Z","level":"INFO","message":"start","id":"6743eaa07dd3b4d44aa5da2e9d268c3f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95600.368965] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:33.179436Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"6743eaa07dd3b4d44aa5da2e9d268c3f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95600.407073] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95600.435039] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95600.439258] agent flakelet[1647]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [95600.439813] agent flakelet[1647]: app: up to date container-test-run-flakelet-relay> agent # [95600.443169] 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 agent/app --wave '*/app' 2>&1, in 0.63 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.94 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 # [95600.979666] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:33.790039Z","level":"INFO","message":"deploy finished","job":"749993fa4eaaf1dc4ca3ea4448db5eba","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95601.032779] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:33.843196Z","level":"INFO","message":"deploy accepted","job":"e8397e3769538c8e15a55d31b0e8d167","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95600.978401] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:33.788803Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95601.033055] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:33.843505Z","level":"INFO","message":"start","id":"c15ffff31783c8e598081f700548199f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95601.033371] agent flakelet-agent[505]: {"timestamp":"2026-10-15T11:56:33.843849Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"c15ffff31783c8e598081f700548199f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95601.070258] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95601.096025] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95601.099879] agent flakelet[1675]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [95601.100605] agent flakelet[1675]: app: activating generation 4 container-test-run-flakelet-relay> agent # [95601.113022] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [95601.114714] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95601.114981] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [95601.129934] agent systemd[1]: Reload requested from client PID 1682 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95601.130000] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95601.476385] agent systemd[1]: Reloading finished in 345 ms. container-test-run-flakelet-relay> agent # [95601.533359] agent systemd[1]: Reload requested from client PID 1712 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95601.533395] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95601.876491] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [95601.940201] agent systemd[1]: Reload requested from client PID 1741 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95601.940237] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95602.270482] agent systemd[1]: Reloading finished in 329 ms. container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.30 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/f3vbkhcnzmgjphqaarrzgjdpzrb02va5-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/f3vbkhcnzmgjphqaarrzgjdpzrb02va5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> agent # [95602.345471] agent systemd[1]: Reload requested from client PID 1774 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95602.345508] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95602.680102] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [95602.757624] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [95608.827743] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [95608.834981] agent flakelet[1675]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [95608.837852] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent: (finished: waiting for failure: systemctl is-active flakelet-relay-job-app.service, in 7.51 seconds) container-test-run-flakelet-relay> (finished: subtest: detach returns once the job is accepted, in 8.84 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.09 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 # [95609.880258] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:42.690615Z","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 # [95609.879907] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [95609.916023] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95609.916509] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [95609.917074] agent systemd[1]: flakelet-agent.service: Consumed 1.376s CPU time over 27.532s 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.09 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/f3vbkhcnzmgjphqaarrzgjdpzrb02va5-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 # [95611.014548] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [95611.071344] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:43.881786Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"c15ffff31783c8e598081f700548199f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95611.093571] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [95611.102634] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:43.913084Z","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 # [95611.102724] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:43.913112Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(4), revision: Some(\"prebuilt:app\") }, Named { name: \"flakelet-agent\", generation: Some(1), revision: Some(\"prebuilt:flakelet-agent\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [95611.608844] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:44.419272Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [95612.999261] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:45.809631Z","level":"INFO","message":"deploy accepted","job":"3656e96b01ebb25212d57bb06e703e17","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95612.999665] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:45.810054Z","level":"INFO","message":"start","id":"797a8d6323bbe0a42ce35ae9dc8b685f","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95613.000290] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:45.810758Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"797a8d6323bbe0a42ce35ae9dc8b685f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95613.038493] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [95613.072090] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [95613.076410] agent flakelet[2256]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95613.076977] agent flakelet[2256]: other: up to date container-test-run-flakelet-relay> agent # [95613.079084] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95613.618388] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:46.428760Z","level":"INFO","message":"deploy finished","job":"3656e96b01ebb25212d57bb06e703e17","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95613.616429] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:46.426841Z","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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTcwNiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1NDA3LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJWMlhSWVdKT1RFSjZHPT09IiwibmJmIjoxNzkyMDY1NDA3LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.pQWK_X5hBCo26uY4JSYoF1rAylGkP2B3dV0xgtdFCAbrWR2rrPytEQf3hMv1Tme5zBhGLFRXc0aftDDruSxGBg' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTcwNiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1NDA3LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJWMlhSWVdKT1RFSjZHPT09IiwibmJmIjoxNzkyMDY1NDA3LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.pQWK_X5hBCo26uY4JSYoF1rAylGkP2B3dV0xgtdFCAbrWR2rrPytEQf3hMv1Tme5zBhGLFRXc0aftDDruSxGBg' 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.39 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 # [95614.311709] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [95614.312220] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95614.312487] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [95614.330870] agent systemd[1]: Reload requested from client PID 2290 ('systemctl')... container-test-run-flakelet-relay> agent # [95614.330938] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95614.691873] agent systemd[1]: Reloading finished in 360 ms. container-test-run-flakelet-relay> agent # [95614.776245] agent systemd[1]: Reload requested from client PID 2319 ('systemctl')... container-test-run-flakelet-relay> agent # [95614.776286] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95615.121980] agent systemd[1]: Reloading finished in 345 ms. container-test-run-flakelet-relay> agent # [95615.200519] agent systemd[1]: Reload requested from client PID 2350 ('systemctl')... container-test-run-flakelet-relay> agent # [95615.200561] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95615.534026] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [95615.622308] agent systemd[1]: Reload requested from client PID 2380 ('systemctl')... container-test-run-flakelet-relay> agent # [95615.622347] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.80 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 # [95615.953432] agent systemd[1]: Reloading finished in 330 ms. container-test-run-flakelet-relay> agent # [95616.039359] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [95616.074936] 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 # [95617.120323] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:49.930727Z","level":"INFO","message":"local change","flakelet":"app","generation":5,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95617.214965] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [95617.215446] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95617.215705] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [95617.233346] agent systemd[1]: Reload requested from client PID 2426 ('systemctl')... container-test-run-flakelet-relay> agent # [95617.233417] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95617.579177] agent systemd[1]: Reloading finished in 345 ms. container-test-run-flakelet-relay> agent # [95617.668957] agent systemd[1]: Reload requested from client PID 2455 ('systemctl')... container-test-run-flakelet-relay> agent # [95617.668999] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95618.001663] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [95618.087158] agent systemd[1]: Reload requested from client PID 2483 ('systemctl')... container-test-run-flakelet-relay> agent # [95618.087200] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95618.419094] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [95618.499996] agent systemd[1]: Reload requested from client PID 2512 ('systemctl')... container-test-run-flakelet-relay> agent # [95618.500041] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.75 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 # [95618.834967] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [95618.901171] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [95618.928975] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [95619.118416] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:51.928685Z","level":"INFO","message":"local change","flakelet":"app","generation":6,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} 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 1.04 seconds) container-test-run-flakelet-relay> (finished: subtest: out-of-band flakelet update reaches the relay without reconnect, in 5.74 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.01 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=@1792065412 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [95620.058047] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:52.868449Z","level":"INFO","message":"start","id":"5ea53b8950b0704a81ff1ccd76aae227","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95620.058405] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:52.868878Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"5ea53b8950b0704a81ff1ccd76aae227\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95620.092975] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95620.126035] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95620.130518] agent flakelet[2561]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [95620.131185] agent flakelet[2561]: app: activating generation 7 container-test-run-flakelet-relay> agent # [95620.148476] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [95620.150261] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95620.150581] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [95620.166115] agent systemd[1]: Reload requested from client PID 2568 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95620.166184] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95620.003115] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:52.813342Z","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 # [95620.057667] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:52.868109Z","level":"INFO","message":"deploy accepted","job":"c939dc4f76566067dabdddefc3583262","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95620.510222] agent systemd[1]: Reloading finished in 343 ms. container-test-run-flakelet-relay> agent # [95620.592082] agent systemd[1]: Reload requested from client PID 2598 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95620.592122] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1792065412 | grep -q 'app-slow', in 1.02 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.11 seconds) container-test-run-flakelet-relay> agent: must succeed: ss -K dport = 7443 container-test-run-flakelet-relay> agent # [95620.922951] agent systemd[1]: Reloading finished in 330 ms. container-test-run-flakelet-relay> agent # [95620.996574] agent systemd[1]: Reload requested from client PID 2627 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95620.996614] 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=@1792065412 | grep -q 'updated to generation' container-test-run-flakelet-relay> relay # [95621.187059] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:56:53.997408Z","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 # [95621.219583] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:54.029842Z","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 # [95621.329194] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [95621.410180] agent systemd[1]: Reload requested from client PID 2675 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95621.410217] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95621.741802] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [95621.824447] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [95622.221944] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:55.032321Z","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 # [95624.224217] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:56:57.034394Z","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 # [95627.894054] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [95627.902856] agent flakelet[2561]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [95627.906096] 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=@1792065412 | 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 # [95628.226277] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:57:01.036551Z","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 # [95628.985223] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:57:01.795611Z","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.42 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 # [95636.230738] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:57:09.041135Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(7), revision: Some(\"prebuilt:app\") }, Named { name: \"flakelet-agent\", generation: Some(1), revision: Some(\"prebuilt:flakelet-agent\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> relay # [95636.232248] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:57:09.042712Z","level":"INFO","message":"deploy finished","job":"c939dc4f76566067dabdddefc3583262","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95636.475656] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:57:09.286070Z","level":"INFO","message":"deploy accepted","job":"0f82f633f804b9b102ca786a3bc0cf8c","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95636.230728] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:57:09.041041Z","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 # [95636.231862] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:57:09.042328Z","level":"INFO","message":"start","id":"5ea53b8950b0704a81ff1ccd76aae227","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95636.476037] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:57:09.286442Z","level":"INFO","message":"start","id":"cb3c1778b43cb0d2c86083dcdc40720f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95636.476669] agent flakelet-agent[1843]: {"timestamp":"2026-10-15T11:57:09.287139Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"cb3c1778b43cb0d2c86083dcdc40720f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95636.511627] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95636.548027] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95636.552309] agent flakelet[2797]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [95636.553023] agent flakelet[2797]: app: activating generation 8 container-test-run-flakelet-relay> agent # [95636.570705] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [95636.572582] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95636.572902] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [95636.587957] agent systemd[1]: Reload requested from client PID 2804 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95636.588042] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95636.933407] agent systemd[1]: Reloading finished in 344 ms. container-test-run-flakelet-relay> agent # [95637.009119] agent systemd[1]: Reload requested from client PID 2834 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95637.009158] 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.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl restart flakelet-agent container-test-run-flakelet-relay> agent # [95637.339846] agent systemd[1]: Reloading finished in 330 ms. container-test-run-flakelet-relay> agent # [95637.422290] agent systemd[1]: Reload requested from client PID 2866 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95637.422325] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95637.751397] agent systemd[1]: Reloading finished in 328 ms. container-test-run-flakelet-relay> agent # [95637.822012] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [95637.830718] agent systemd[1]: Reload requested from client PID 2902 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95637.830753] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [95637.822393] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:57:10.632739Z","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 0.85 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 # [95638.170371] agent systemd[1]: Reloading finished in 339 ms. container-test-run-flakelet-relay> agent # [95638.236100] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95638.236271] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [95638.236284] agent systemd[1]: flakelet-agent.service: Consumed 1.013s CPU time over 27.221s wall clock time. container-test-run-flakelet-relay> agent # [95638.254734] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [95638.255758] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [95638.312182] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:11.122607Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"cb3c1778b43cb0d2c86083dcdc40720f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95638.331042] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [95638.341118] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:11.151569Z","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 # [95638.342297] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:11.152765Z","level":"INFO","message":"start","id":"cb3c1778b43cb0d2c86083dcdc40720f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [95638.341229] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:57:11.151605Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(7), revision: Some(\"prebuilt:app\") }, Named { name: \"flakelet-agent\", generation: Some(1), revision: Some(\"prebuilt:flakelet-agent\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [95644.330038] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [95644.339021] agent flakelet[2797]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [95644.341585] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95644.899291] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:57:17.709619Z","level":"INFO","message":"deploy finished","job":"0f82f633f804b9b102ca786a3bc0cf8c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95644.897381] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:17.707775Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(8)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out, in 7.08 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 9.00 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.00 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1792065438 | grep -q 'app-slow' container-test-run-flakelet-relay> relay # [95645.482856] relay flakelet-relay[388]: {"timestamp":"2026-10-15T11:57:18.293241Z","level":"INFO","message":"deploy accepted","job":"7466ccd9ad91c32cf7bab7aed5d29343","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95645.483253] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:18.293677Z","level":"INFO","message":"start","id":"5b507f7b75b7a5b784d6da7bec313c74","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95645.483822] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:18.294292Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"5b507f7b75b7a5b784d6da7bec313c74\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95645.517716] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95645.549093] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95645.553183] agent flakelet[3379]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [95645.553827] agent flakelet[3379]: app: activating generation 9 container-test-run-flakelet-relay> agent # [95645.575433] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [95645.575880] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [95645.576163] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [95645.593101] agent systemd[1]: Reload requested from client PID 3386 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95645.593171] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95645.935439] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [95646.031086] agent systemd[1]: Reload requested from client PID 3416 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95646.031125] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1792065438 | grep -q 'app-slow', in 1.02 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> agent # [95646.363039] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [95646.442921] agent systemd[1]: Reload requested from client PID 3447 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95646.442961] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95646.506652] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:19.316961Z","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 # [95646.505856] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [95646.562164] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95646.562555] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [95646.562594] relay systemd[1]: flakelet-relay.service: Consumed 3.006s CPU time over 1min 6.312s wall clock time. container-test-run-flakelet-relay> relay # [95646.597976] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [95646.786931] agent systemd[1]: Reloading finished in 343 ms. container-test-run-flakelet-relay> agent # [95646.877586] agent systemd[1]: Reload requested from client PID 3483 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [95646.877624] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [95647.216931] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [95647.306245] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [95647.510416] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:20.320685Z","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.59 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [95648.079402] relay flakelet-relay[929]: {"timestamp":"2026-10-15T11:57:20.889790Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [95648.080315] relay flakelet-relay[929]: {"timestamp":"2026-10-15T11:57:20.890226Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [95648.079946] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [95649.522127] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:22.332522Z","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 # [95649.522202] relay flakelet-relay[929]: {"timestamp":"2026-10-15T11:57:22.332575Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(8), revision: Some(\"prebuilt:app\") }, Named { name: \"flakelet-agent\", generation: Some(1), revision: Some(\"prebuilt:flakelet-agent\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [95653.373985] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [95653.382308] agent flakelet[3379]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [95653.385410] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95653.522655] relay flakelet-relay[929]: {"timestamp":"2026-10-15T11:57:26.333020Z","level":"INFO","message":"job reattached","job":"7466ccd9ad91c32cf7bab7aed5d29343","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95654.452970] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:27.263358Z","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.07 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.72 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> relay # [95655.182990] relay flakelet-relay[929]: {"timestamp":"2026-10-15T11:57:27.993386Z","level":"INFO","message":"deploy accepted","job":"188b06c4636b65849b3ba8daac22dc7c","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95655.183489] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:27.993881Z","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 # [95655.184153] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:27.994617Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95655.214391] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [95655.249009] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [95655.253312] agent flakelet[3557]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95655.253863] agent flakelet[3557]: other: up to date container-test-run-flakelet-relay> agent # [95655.254941] agent systemd[1]: flakelet-relay-job-other.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 --id hist1 agent/other 2>&1, in 0.63 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> agent # [95655.789638] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:28.600027Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95655.806208] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:28.616655Z","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 # [95655.791165] relay flakelet-relay[929]: {"timestamp":"2026-10-15T11:57:28.601570Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95655.806049] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [95655.840387] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [95655.840665] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [95655.840694] relay systemd[1]: flakelet-relay.service: Consumed 1.990s CPU time over 9.242s wall clock time. container-test-run-flakelet-relay> relay # [95655.857361] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [95656.809227] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:29.619616Z","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.46 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 # [95657.252627] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:30.062993Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [95657.253614] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:30.063419Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [95657.253161] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [95658.824411] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:31.634767Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(9), revision: Some(\"prebuilt:app\") }, Named { name: \"flakelet-agent\", generation: Some(1), revision: Some(\"prebuilt:flakelet-agent\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::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.05 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> agent # [95658.824209] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:31.634607Z","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> 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTc1MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1NDUyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZRVlOQ0pGWTZCV0lDPT09IiwibmJmIjoxNzkyMDY1NDUyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.aHPS5gqj93k1sfLLQDmebydZbaIDG1NGrwzwRgnIzSbYgOym_vX_W7E1dhuc3_UD_M9daII05YN5hgrNWkhYBg' 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> relay # [95659.407864] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:32.218256Z","level":"INFO","message":"deploy accepted","job":"6a239dbf87cfec796e49404c351d787f","caller":"example/app","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95659.408227] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:32.218651Z","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 # [95659.408836] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:32.219305Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dce6faec8455f85321e72ee634888126\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95659.446505] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [95659.473950] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [95659.478194] agent flakelet[3585]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [95659.478762] agent flakelet[3585]: app: up to date container-test-run-flakelet-relay> agent # [95659.481971] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Deactivated successfully. 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTc1MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1NDUyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZRVlOQ0pGWTZCV0lDPT09IiwibmJmIjoxNzkyMDY1NDUyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.aHPS5gqj93k1sfLLQDmebydZbaIDG1NGrwzwRgnIzSbYgOym_vX_W7E1dhuc3_UD_M9daII05YN5hgrNWkhYBg' push --relay https://relay:7443 deploy --id hist2 agent/app, in 0.63 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTc1MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1NDUyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZRVlOQ0pGWTZCV0lDPT09IiwibmJmIjoxNzkyMDY1NDUyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.aHPS5gqj93k1sfLLQDmebydZbaIDG1NGrwzwRgnIzSbYgOym_vX_W7E1dhuc3_UD_M9daII05YN5hgrNWkhYBg' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjA2NTc1MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyMDY1NDUyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZRVlOQ0pGWTZCV0lDPT09IiwibmJmIjoxNzkyMDY1NDUyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.aHPS5gqj93k1sfLLQDmebydZbaIDG1NGrwzwRgnIzSbYgOym_vX_W7E1dhuc3_UD_M9daII05YN5hgrNWkhYBg' 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 4.88 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.08 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/9bd91d7220cf99308c6ab0b9aa14db54/events || true container-test-run-flakelet-relay> agent # [95660.018569] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:32.828958Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95660.242300] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:33.052723Z","level":"INFO","message":"start","id":"debcbfa390f8df7d327bf4cff7dfdad1","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [95660.242634] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:33.053108Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"debcbfa390f8df7d327bf4cff7dfdad1\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95660.279117] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> relay # [95660.020070] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:32.830443Z","level":"INFO","message":"deploy finished","job":"6a239dbf87cfec796e49404c351d787f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95660.089546] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [15/Oct/2026 11:57:32] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=oq-oYgMwnpVqPJ34rFk7GkLP76rp5RHAiB1u55TdOWk&code_challenge=eBfsswCL1M46kCI1OtaVonytlD9kIF-sstIgC8uVOpI&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> relay # [95660.139519] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [15/Oct/2026 11:57:32] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [95660.140476] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:32.950929Z","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 # [95660.202709] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:33.013135Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95660.241914] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:33.052352Z","level":"INFO","message":"deploy accepted","job":"5cca16579c7a1a9ee9fb72460f6e1bf2","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [95660.262412] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:33.072867Z","level":"INFO","message":"job reattached","job":"5cca16579c7a1a9ee9fb72460f6e1bf2","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [95660.307974] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [95660.312055] agent flakelet[3605]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95660.312631] agent flakelet[3605]: other: up to date container-test-run-flakelet-relay> agent # [95660.315994] 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/9bd91d7220cf99308c6ab0b9aa14db54/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/9bd91d7220cf99308c6ab0b9aa14db54 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/9bd91d7220cf99308c6ab0b9aa14db54, 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=9bd91d7220cf99308c6ab0b9aa14db54' | 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=9bd91d7220cf99308c6ab0b9aa14db54' | 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> relay # [95660.993476] relay flakelet-relay[1319]: {"timestamp":"2026-10-15T11:57:33.803888Z","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 # [95660.852223] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:33.662609Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95660.993866] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:33.804280Z","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 # [95660.994278] agent flakelet-agent[2934]: {"timestamp":"2026-10-15T11:57:33.804757Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [95661.029656] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [95661.065089] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [95661.069286] agent flakelet[3629]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [95661.069833] agent flakelet[3629]: other: up to date container-test-run-flakelet-relay> agent # [95661.072545] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> agent/other | flakelet-relay-job-other.service: Deactivated successfully. 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.63 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.62 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 85.34 seconds) container-test-run-flakelet-relay> test script finished in 85.37s 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> kill NspawnMachine (pid 54) container-test-run-flakelet-relay> Container agent terminated by signal KILL. container-test-run-flakelet-relay> Container client terminated by signal KILL. container-test-run-flakelet-relay> Container relay 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 7babaac72e7f2b7f5191cf4bc14fc82d 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 b75f2369481c44220180bbd422237160 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 c939dc4f76566067dabdddefc3583262 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 0f82f633f804b9b102ca786a3bc0cf8c 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 7466ccd9ad91c32cf7bab7aed5d29343 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 27e516282ce4af942e1fd79c98f29cd1 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 7466ccd9ad91c32cf7bab7aed5d29343 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> 1792065447 hist1 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792065438 27e516282ce4af942e1fd79c98f29cd1 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792065429 3050090730cf2efb8f937c4a954afced admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792065412 13c95e3abdb04fc948da6660ab082594 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792065411 local-app-6-1792065411 root (shell) agent/app:updated container-test-run-flakelet-relay> 1792065408 local-app-5-1792065408 root (shell) agent/app:updated container-test-run-flakelet-relay> 1792065405 ea5e86e7cdee0835efa01681eebf553d admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792065393 5f66f0712932d98a6b45f1c5d1dabefc admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792065393 ca6ef411725cc917c4648a1a4da0d4de admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1792065392 0c588d0580f98a221d753f62f3fca4ce admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1792065391 093e565fcabecd9ba13d84295e90102b admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1792065387 0586eb4a17e3d5b8763d41d1b2753ddb admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1792065386 338ce4624ef2a0d34ada42d57809df80 dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792065386 71eb242ab6616406c817ded140cdb1ad dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792065383 33b4f88b3938a5416369330ef8818bcf someone agent/other:unchanged container-test-run-flakelet-relay> 1792065380 9f5d5926806a2eca1fa4b9cf9f206713 repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1792065377 4059a7a3ac1fde3f390a3b1b88839828 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792065375 local-app-1-1792065375 host activation agent/app:updated container-test-run-flakelet-relay> 1792065375 local-flakelet-agent-1-1792065375 host activation agent/flakelet-agent:updated container-test-run-flakelet-relay> 1792065375 local-other-1-1792065375 host activation agent/other:updated container-test-run-flakelet-relay> post-build step Upload coverage to codecov: ok Skipping codecov: project=Mic92/flakelet-relay attr=checks.x86_64-linux.nixos-test