these 42 derivations will be built: /nix/store/sq87ajy6h61hgyqgags798givj91kgh3-flakelet-relay.json.drv /nix/store/61j48mlknbb908lfg90dv31qpdg6r2mi-flakelet-relay.service.drv /nix/store/39labgvmzkhcfv0f41gsl51sjmjr2rqd-flakelet-flakelet-relay-units.drv /nix/store/087qrkxa5a02yxwvdj0gj88mqqybqaba-flakelet-flakelet-relay.drv /nix/store/sgp7ap05k3x04vwx8dk14ayksa85gazj-push.drv /nix/store/3vv60il8rds2cbq01nq3lsm5y0fs9g3j-system-path.drv /nix/store/zf0hifl1zf3vviiv3m7c5c5sz5gs7vc2-dbus-1.drv /nix/store/i8x82dwbj342wp4awf10d9fndh44hi7p-X-Restart-Triggers-dbus-broker.drv /nix/store/0ndy59dxbsbiyy3rnjk4sv9l5ra7f5ry-unit-dbus-broker.service.drv /nix/store/av1mghc03kxkj5m3j9j2v7n84jkfp59i-user-units.drv /nix/store/7kc4w98hq569sph67h1rnp5h310120r1-unit-dbus-broker.service.drv /nix/store/s6gsxgf7qls6q4q6kqvz1kyqcz390iav-system-units.drv /nix/store/dkssp2jkmzmkd414cn886lnxyjbijp1d-etc.drv /nix/store/1wijld3ri3796q3y887asyj8dcfsbnbj-activate.drv /nix/store/sqax1v3wr7mbq9rpfxbggqib2zskx68a-X-Restart-Triggers-flakelet-flakelet-agent.drv /nix/store/c7ih8civ17sk0gb57gqn7sciy6r66xx8-unit-flakelet-flakelet-agent.service.drv /nix/store/qrj9ynm9ki0aqfhzn32rn5dh5lwmz231-flakelet-agent.service.drv /nix/store/s7f9j55fi3y46ws6nym91sjwlq6apky3-flakelet-flakelet-agent-units.drv /nix/store/mdx2k5261myagla87a9gq6d20nl3ghaw-flakelet-flakelet-agent.drv /nix/store/iwv806b9m6zf5isbmf8f10idrqnjyi3j-flakelet-config.json.drv /nix/store/30bn0s9rywjal2a35xki96d8r4nr4wcv-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/xq0gng5g6ifd981fwsc90kh4i7y65ihb-unit-flakelet-reconcile.service.drv /nix/store/hcrpip6bswz1d09iqd3hc9qqh7nsab1n-system-units.drv /nix/store/pf9vxqmyddgm539pzlmn8mfl6gxdxy2r-etc.drv /nix/store/jb28hwy0n549a83rvvsh0fbzlw644ppf-activate.drv /nix/store/2x0dr0f44jcgn5cl3j8wclz18a93zz4r-nixos-system-agent-test.drv /nix/store/6na1gfgqb86w2vpijmymgh4kzs40sv8c-nixos-system-client-test.drv /nix/store/8n4q87cvjl2pqbzqkr16ninza5ish57m-run-client-nspawn.drv /nix/store/rp6byhl0xh16rc86nl0nymm96crlb7l9-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/9cj6jjk4pzc7xq27kcapiibz686frbdk-unit-flakelet-flakelet-relay.service.drv /nix/store/m8gxfxiij8hq2jswp437rgkl9jjc5yrn-flakelet-config.json.drv /nix/store/wxkvrwk0lkvmac7ffazdzkc3936v4acg-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/sxjs618wclpl815z2csbn0d9r6jzlf1y-unit-flakelet-reconcile.service.drv /nix/store/ld5icnnsh1rc3mq3zqrsg1nbg48kwn98-system-units.drv /nix/store/ny299zxxlyhwhs9cg5hlv68b0cihiymr-etc.drv /nix/store/fqv0im1fh525zfdqnry7c5xawxcpvrl1-activate.drv /nix/store/bipbfcdw01lxpj2d7jzsg7pfp1ya3h3y-nixos-system-relay-test.drv /nix/store/anmk3a2ajplhav66z57ap0zh2i8jjslz-run-relay-nspawn.drv /nix/store/rxbyl6ip29317igy7rykh09wxdhhyldy-run-agent-nspawn.drv /nix/store/bdz7zqhqk0ymm290c35951drz8h05qxh-driverConfiguration.json.drv /nix/store/5gblp17vb4f8ck8arpafjfki5bd0kzlw-nixos-test-driver-flakelet-relay.drv /nix/store/fi9zynxxx3c2gv5dch2djzp8kc5h3b80-container-test-run-flakelet-relay.drv building '/nix/store/sgp7ap05k3x04vwx8dk14ayksa85gazj-push.drv' building '/nix/store/sqax1v3wr7mbq9rpfxbggqib2zskx68a-X-Restart-Triggers-flakelet-flakelet-agent.drv' building '/nix/store/rp6byhl0xh16rc86nl0nymm96crlb7l9-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/qrj9ynm9ki0aqfhzn32rn5dh5lwmz231-flakelet-agent.service.drv' X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/sq87ajy6h61hgyqgags798givj91kgh3-flakelet-relay.json.drv' flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> tribuchet: building on jamie flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/app (expect allow) flakelet-relay.json> agent/app allowed by ci flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/other (expect deny) building '/nix/store/c7ih8civ17sk0gb57gqn7sciy6r66xx8-unit-flakelet-flakelet-agent.service.drv' unit-flakelet-flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> agent/other denied building '/nix/store/9cj6jjk4pzc7xq27kcapiibz686frbdk-unit-flakelet-flakelet-relay.service.drv' unit-flakelet-flakelet-relay.service> tribuchet: building on jamie building '/nix/store/3vv60il8rds2cbq01nq3lsm5y0fs9g3j-system-path.drv' system-path> tribuchet: building on jamie building '/nix/store/61j48mlknbb908lfg90dv31qpdg6r2mi-flakelet-relay.service.drv' flakelet-relay.service> tribuchet: building on jamie building '/nix/store/s7f9j55fi3y46ws6nym91sjwlq6apky3-flakelet-flakelet-agent-units.drv' flakelet-flakelet-agent-units> tribuchet: building on jamie building '/nix/store/39labgvmzkhcfv0f41gsl51sjmjr2rqd-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie unit-flakelet-flakelet-agent.service> structuredAttrs is enabled unit-flakelet-flakelet-relay.service> structuredAttrs is enabled building '/nix/store/mdx2k5261myagla87a9gq6d20nl3ghaw-flakelet-flakelet-agent.drv' flakelet-flakelet-agent> tribuchet: building on jamie system-path> structuredAttrs is enabled system-path> created 6399 symlinks in user environment building '/nix/store/087qrkxa5a02yxwvdj0gj88mqqybqaba-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/iwv806b9m6zf5isbmf8f10idrqnjyi3j-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled building '/nix/store/m8gxfxiij8hq2jswp437rgkl9jjc5yrn-flakelet-config.json.drv' building '/nix/store/zf0hifl1zf3vviiv3m7c5c5sz5gs7vc2-dbus-1.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/30bn0s9rywjal2a35xki96d8r4nr4wcv-X-Restart-Triggers-flakelet-reconcile.drv' dbus-1> tribuchet: building on jamie X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled building '/nix/store/wxkvrwk0lkvmac7ffazdzkc3936v4acg-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/xq0gng5g6ifd981fwsc90kh4i7y65ihb-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/i8x82dwbj342wp4awf10d9fndh44hi7p-X-Restart-Triggers-dbus-broker.drv' building '/nix/store/sxjs618wclpl815z2csbn0d9r6jzlf1y-unit-flakelet-reconcile.service.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie unit-flakelet-reconcile.service> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/hcrpip6bswz1d09iqd3hc9qqh7nsab1n-system-units.drv' system-units> tribuchet: building on jamie building '/nix/store/ld5icnnsh1rc3mq3zqrsg1nbg48kwn98-system-units.drv' building '/nix/store/0ndy59dxbsbiyy3rnjk4sv9l5ra7f5ry-unit-dbus-broker.service.drv' building '/nix/store/7kc4w98hq569sph67h1rnp5h310120r1-unit-dbus-broker.service.drv' system-units> tribuchet: building on jamie 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/av1mghc03kxkj5m3j9j2v7n84jkfp59i-user-units.drv' building '/nix/store/s6gsxgf7qls6q4q6kqvz1kyqcz390iav-system-units.drv' user-units> tribuchet: building on jamie system-units> tribuchet: building on jamie building '/nix/store/ny299zxxlyhwhs9cg5hlv68b0cihiymr-etc.drv' building '/nix/store/pf9vxqmyddgm539pzlmn8mfl6gxdxy2r-etc.drv' etc> tribuchet: building on jamie etc> tribuchet: building on jamie building '/nix/store/dkssp2jkmzmkd414cn886lnxyjbijp1d-etc.drv' etc> tribuchet: building on jamie building '/nix/store/fqv0im1fh525zfdqnry7c5xawxcpvrl1-activate.drv' building '/nix/store/jb28hwy0n549a83rvvsh0fbzlw644ppf-activate.drv' activate> tribuchet: building on jamie activate> tribuchet: building on jamie building '/nix/store/1wijld3ri3796q3y887asyj8dcfsbnbj-activate.drv' activate> tribuchet: building on jamie building '/nix/store/bipbfcdw01lxpj2d7jzsg7pfp1ya3h3y-nixos-system-relay-test.drv' building '/nix/store/2x0dr0f44jcgn5cl3j8wclz18a93zz4r-nixos-system-agent-test.drv' nixos-system-relay-test> tribuchet: building on jamie nixos-system-agent-test> tribuchet: building on jamie building '/nix/store/6na1gfgqb86w2vpijmymgh4kzs40sv8c-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on jamie nixos-system-relay-test> structuredAttrs is enabled nixos-system-agent-test> structuredAttrs is enabled building '/nix/store/anmk3a2ajplhav66z57ap0zh2i8jjslz-run-relay-nspawn.drv' nixos-system-client-test> structuredAttrs is enabled building '/nix/store/rxbyl6ip29317igy7rykh09wxdhhyldy-run-agent-nspawn.drv' run-relay-nspawn> tribuchet: building on jamie run-agent-nspawn> tribuchet: building on jamie building '/nix/store/8n4q87cvjl2pqbzqkr16ninza5ish57m-run-client-nspawn.drv' run-client-nspawn> tribuchet: building on jamie building '/nix/store/bdz7zqhqk0ymm290c35951drz8h05qxh-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/5gblp17vb4f8ck8arpafjfki5bd0kzlw-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/fi9zynxxx3c2gv5dch2djzp8kc5h3b80-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> client: Waiting for journal at /build/vm-state-client/var/log/journal... container-test-run-flakelet-relay> relay: systemd-nspawn running (pid 54) 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.00 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> ░ Spawning container relay on /build/vm-state-relay. container-test-run-flakelet-relay> ░ Spawning container client on /build/vm-state-client. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> ░ Spawning container agent on /build/vm-state-agent. container-test-run-flakelet-relay> client # No journal files were found. container-test-run-flakelet-relay> client # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> relay # No journal files were found. container-test-run-flakelet-relay> relay # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> agent # No journal files were found. container-test-run-flakelet-relay> agent # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> client # [1118671.288256] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [1118671.288342] client systemd-journald[57]: Runtime Journal (/run/log/journal/12198d371d814dd2a9c4e4d0c8afda0f) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [1118671.299156] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [1118671.311411] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [1118671.325864] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [1118671.326666] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [1118671.354144] client systemd-journald[57]: Time spent on flushing to /var/log/journal/12198d371d814dd2a9c4e4d0c8afda0f is 1.911ms for 6 entries. container-test-run-flakelet-relay> client # [1118671.354144] client systemd-journald[57]: System Journal (/var/log/journal/12198d371d814dd2a9c4e4d0c8afda0f) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [1118671.363394] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> client # [1118671.364138] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> client # [1118671.364256] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> client # [1118671.381454] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> client # [1118671.454164] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [1118672.302603] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [1118672.323503] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [1118672.324242] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [1118672.325045] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [1118672.326028] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [1118672.326055] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [1118672.326935] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [1118672.327849] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> client # [1118672.347957] 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 # [1118672.348378] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [1118672.348661] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/12198d371d814dd2a9c4e4d0c8afda0f failed: Operation not permitted container-test-run-flakelet-relay> client # [1118672.349023] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [1118672.349739] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.53Q0Ty3pWY/chsh': Operation not permitted container-test-run-flakelet-relay> client # [1118672.350403] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [1118672.351072] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [1118672.351244] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [1118671.288456] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> relay # [1118671.288498] relay systemd-journald[57]: Runtime Journal (/run/log/journal/6551ee90c32443488e497603d61fed85) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [1118671.299495] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> relay # [1118671.311814] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> relay # [1118671.326664] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> relay # [1118671.327233] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [1118671.354181] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/6551ee90c32443488e497603d61fed85 is 1.636ms for 6 entries. container-test-run-flakelet-relay> relay # [1118671.354181] relay systemd-journald[57]: System Journal (/var/log/journal/6551ee90c32443488e497603d61fed85) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [1118671.363146] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [1118671.363906] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [1118671.364052] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [1118671.379750] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [1118671.463755] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [1118672.288231] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [1118672.330726] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> relay # [1118672.331940] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [1118672.333147] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [1118672.334289] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [1118672.334316] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [1118672.335246] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [1118672.335777] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> relay # [1118672.352479] relay systemd-tmpfiles[169]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> relay # [1118672.352874] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [1118672.353169] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/6551ee90c32443488e497603d61fed85 failed: Operation not permitted container-test-run-flakelet-relay> relay # [1118672.353489] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [1118671.288963] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [1118671.289015] agent systemd-journald[57]: Runtime Journal (/run/log/journal/f31d6c9e0a6f41e7bc23f5eb9a908e96) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [1118671.300112] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [1118671.312482] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [1118671.326941] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [1118671.327529] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> agent # [1118671.354611] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/f31d6c9e0a6f41e7bc23f5eb9a908e96 is 1.481ms for 6 entries. container-test-run-flakelet-relay> agent # [1118671.354611] agent systemd-journald[57]: System Journal (/var/log/journal/f31d6c9e0a6f41e7bc23f5eb9a908e96) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [1118671.363339] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [1118671.364094] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> agent # [1118671.364235] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [1118671.379504] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> agent # [1118671.447612] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [1118672.302690] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> agent # [1118672.333821] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> agent # [1118672.334952] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> agent # [1118672.336287] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [1118672.337608] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [1118672.337657] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [1118672.338849] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> agent # [1118672.340037] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [1118672.359188] 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 # [1118672.359602] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [1118672.359898] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/f31d6c9e0a6f41e7bc23f5eb9a908e96 failed: Operation not permitted container-test-run-flakelet-relay> agent # [1118672.360240] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [1118672.383639] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [1118672.412447] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [1118672.424641] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [1118672.426969] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [1118672.427995] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [1118672.458226] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [1118672.464636] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [1118672.465819] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [1118672.474525] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [1118672.474621] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [1118672.474685] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [1118672.474736] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [1118672.474749] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [1118672.474844] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [1118672.475010] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [1118672.475109] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [1118672.475124] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [1118672.475150] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [1118672.476228] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [1118672.477074] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [1118672.478112] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [1118672.495275] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> client # [1118672.553363] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [1118672.356752] relay suid-sgid-wrappers-start[177]: chmod: changing permissions of '/run/wrappers/wrappers.J7o5NNk1bO/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [1118672.362367] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [1118672.412161] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118672.424413] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [1118672.424509] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [1118672.424737] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [1118672.424897] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [1118672.427399] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [1118672.428008] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [1118672.458244] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [1118672.464694] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [1118672.465980] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [1118672.475782] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [1118672.475913] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [1118672.475980] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [1118672.476011] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [1118672.476025] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [1118672.476118] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [1118672.476281] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [1118672.476376] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [1118672.476390] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [1118672.476418] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [1118672.477588] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [1118672.478460] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [1118672.479055] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [1118672.479809] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [1118672.480412] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> relay # [1118672.494567] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [1118672.495637] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [1118672.499168] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [1118672.506274] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [1118672.365994] agent suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.wkKCNb0qRw/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [1118672.423273] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118672.436174] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [1118672.436214] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [1118672.436290] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [1118672.436439] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [1118672.448447] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [1118672.463029] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [1118672.463856] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> agent # [1118672.476695] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [1118672.483743] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [1118672.484958] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [1118672.496050] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [1118672.496156] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [1118672.496238] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [1118672.496264] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [1118672.496278] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [1118672.496387] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [1118672.496581] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [1118672.496678] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [1118672.496691] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [1118672.496721] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [1118672.498049] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [1118672.498755] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [1118672.499651] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [1118672.500400] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [1118672.511603] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [1118672.513128] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [1118672.519327] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [1118672.526054] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> client # [1118672.553498] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [1118672.559204] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> client # [1118672.568725] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [1118672.584350] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [1118672.588175] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [1118672.590925] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [1118672.604662] client network-addresses-eth1-start[233]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> client # [1118672.607594] client network-addresses-eth1-start[233]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [1118672.611245] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [1118672.658697] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [1118672.658841] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> client # [1118672.701183] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [1118672.706453] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [1118672.709415] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [1118672.585577] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118672.588197] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [1118672.591081] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [1118672.601117] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [1118672.601254] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [1118672.601958] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [1118672.602581] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [1118672.619670] agent network-addresses-eth1-start[242]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [1118672.622632] agent network-addresses-eth1-start[242]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [1118672.628523] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [1118672.706488] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [1118672.706739] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118672.706844] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [1118672.710446] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [1118672.712489] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [1118672.714059] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [1118672.715495] agent systemd[1]: Starting Update flakelet service flakelet-agent... container-test-run-flakelet-relay> agent # [1118672.716951] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [1118672.725295] agent flakelet[308]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1118672.725863] agent flakelet[308]: app: activating generation 1 container-test-run-flakelet-relay> agent # [1118672.726254] agent flakelet[310]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118672.726777] agent flakelet[310]: other: activating generation 1 container-test-run-flakelet-relay> agent # [1118672.727715] agent flakelet[309]: flakelet-agent: using prebuilt artifact /nix/store/jca6sazf5zsgy2dpb6il6ag7qqx634dw-flakelet-flakelet-agent container-test-run-flakelet-relay> agent # [1118672.728255] agent flakelet[309]: flakelet-agent: activating generation 1 container-test-run-flakelet-relay> agent # [1118672.735929] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [1118672.735999] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1118672.588189] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [1118672.588452] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118672.588569] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [1118672.592580] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [1118672.594280] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [1118672.595566] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [1118672.596693] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [1118672.613855] relay network-addresses-eth1-start[249]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [1118672.617495] relay network-addresses-eth1-start[249]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [1118672.622413] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> relay # [1118672.663857] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [1118672.664100] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [1118672.666115] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [1118672.667631] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [1118672.669161] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [1118672.714429] relay flakelet[311]: flakelet-relay: using prebuilt artifact /nix/store/lr9v9cr14mjhgvk29wc8hvnfwlm80y5k-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [1118672.715272] relay flakelet[311]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [1118672.720515] relay systemd[1]: Reload requested from client PID 316 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [1118672.720585] relay systemd[1]: Reloading... container-test-run-flakelet-relay> client # [1118673.057308] client nsncd[303]: Sep 24 11:56:21.344 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [1118673.057379] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [1118673.057487] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [1118673.057603] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [1118673.060100] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [1118673.061419] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [1118673.087168] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [1118673.090728] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [1118673.090789] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [1118673.090818] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [1118673.063180] agent nsncd[307]: Sep 24 11:56:21.350 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [1118673.141170] agent systemd[1]: Reloading finished in 404 ms. container-test-run-flakelet-relay> agent # [1118673.205840] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [1118673.206445] agent systemd[1]: Reload requested from client PID 312 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [1118673.206498] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1118673.023164] relay nsncd[251]: Sep 24 11:56:21.310 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [1118673.167165] relay systemd[1]: Reloading finished in 445 ms. container-test-run-flakelet-relay> relay # [1118673.218349] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [1118673.218817] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [1118673.218903] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [1118673.220373] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [1118673.221170] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [1118673.237850] relay systemd[1]: Reload requested from client PID 357 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [1118673.237888] relay systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1118673.423214] relay dnsmasq-pre-start[393]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> relay # [1118673.619165] relay systemd[1]: Reloading finished in 380 ms. container-test-run-flakelet-relay> relay # [1118673.657435] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [1118673.671806] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [1118673.671915] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [1118673.672016] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [1118673.676481] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [1118673.601935] agent systemd[1]: Reloading finished in 394 ms. container-test-run-flakelet-relay> agent # [1118673.649528] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [1118673.649583] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118674.014022] agent systemd[1]: Reloading finished in 363 ms. container-test-run-flakelet-relay> agent # [1118674.063412] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [1118674.063558] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [1118674.065171] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [1118674.066245] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [1118674.072963] agent systemd[1]: Reload requested from client PID 406 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [1118674.072995] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1118674.248314] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> relay # [1118674.426749] relay nginx-pre-start[403]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [1118674.427634] relay nginx-pre-start[403]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [1118674.442707] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> client # [1118674.449930] client systemd-logind[315]: New seat seat0. container-test-run-flakelet-relay> client # [1118674.450344] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [1118674.471725] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [1118674.473431] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [1118674.487596] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [1118674.488014] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [1118674.488373] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> agent # [1118674.445526] agent systemd[1]: Reloading finished in 372 ms. container-test-run-flakelet-relay> agent # [1118674.525488] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [1118674.526680] agent systemd[1]: Reload requested from client PID 409 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [1118674.526731] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118674.879177] agent systemd[1]: Reloading finished in 351 ms. container-test-run-flakelet-relay> agent # [1118674.935297] agent systemd[1]: Reload requested from client PID 410 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [1118674.935340] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1118674.780421] relay systemd-logind[354]: New seat seat0. container-test-run-flakelet-relay> relay # [1118674.780863] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [1118674.783535] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [1118674.820849] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118674.821244] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> relay # [1118674.851482] relay dbus-broker-launch[402]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [1118674.852805] relay dbus-broker-launch[402]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [1118674.852805] relay dbus-broker-launch[402]: 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 # [1118674.853944] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [1118674.860734] relay dbus-broker-launch[402]: Ready container-test-run-flakelet-relay> relay # [1118674.862615] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> relay # [1118674.864785] relay dnsmasq[394]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [1118674.864792] relay dnsmasq[394]: compile time options: IPv6 GNU-getopt DBus no-UBus no-i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth DNSSEC loop-detect inotify dumpfile container-test-run-flakelet-relay> relay # [1118674.864797] relay dnsmasq[394]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [1118674.864813] relay dnsmasq[394]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [1118674.864988] relay dnsmasq[394]: read /etc/hosts - 9 names container-test-run-flakelet-relay> client # [1118674.991575] client dbus-broker-launch[325]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [1118674.993057] client dbus-broker-launch[325]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [1118674.993057] client dbus-broker-launch[325]: Invalid user-name in /nix/store/i8b7g8rkyvih3fk2sx87kh5wq7q09g7w-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [1118674.993871] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [1118674.994471] client systemd[1]: Startup finished in 4.131s. container-test-run-flakelet-relay> client # [1118675.000165] client dbus-broker-launch[325]: Ready container-test-run-flakelet-relay> agent # [1118675.279194] agent systemd[1]: Reloading finished in 343 ms. container-test-run-flakelet-relay> agent # [1118675.338699] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [1118675.338795] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [1118675.338912] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [1118675.340016] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [1118675.342598] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1118675.365841] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [1118675.369371] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [1118675.369589] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [1118675.397740] agent flakelet[308]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [1118675.398339] agent flakelet[310]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [1118675.399327] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [1118675.399939] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [1118675.425635] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:23.713072Z","level":"INFO","message":"local change","flakelet":"app","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118675.426140] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:23.713318Z","level":"INFO","message":"local change","flakelet":"other","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118675.426096] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [1118675.430009] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:23.717472Z","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 # [1118675.432195] agent flakelet[309]: flakelet-agent: updated to generation 1 container-test-run-flakelet-relay> agent # [1118675.434161] agent systemd[1]: Finished Update flakelet service flakelet-agent. container-test-run-flakelet-relay> agent # [1118675.435319] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> agent # [1118675.444922] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:23.732411Z","level":"INFO","message":"local change","flakelet":"flakelet-agent","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118675.449827] agent systemd-logind[405]: New seat seat0. container-test-run-flakelet-relay> agent # [1118675.450728] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [1118675.450791] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [1118675.451522] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [1118675.475729] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118675.475976] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [1118675.476275] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [1118675.761151] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:24.048412Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1118675.762106] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:24.048869Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1118675.761624] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [1118675.769193] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> agent # [1118675.891474] agent dbus-broker-launch[905]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [1118675.892962] agent dbus-broker-launch[905]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [1118675.892962] agent dbus-broker-launch[905]: 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 # [1118675.893495] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [1118675.893976] agent systemd[1]: Startup finished in 5.027s. container-test-run-flakelet-relay> agent # [1118675.899410] agent dbus-broker-launch[905]: Ready container-test-run-flakelet-relay> relay # [1118676.022465] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 6.17 seconds) container-test-run-flakelet-relay> relay # [1118676.022836] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay: waiting for unit nginx.service container-test-run-flakelet-relay> relay # [1118676.030671] relay flakelet[311]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [1118676.033361] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [1118676.033933] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [1118676.034135] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [1118676.034365] relay systemd[1]: Startup finished in 5.172s. container-test-run-flakelet-relay> relay: (finished: waiting for unit nginx.service, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet.target container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet.target, in 0.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 1.03 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 # [1118677.448789] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:25.736212Z","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 # [1118677.667980] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:25.955395Z","level":"INFO","message":"start","id":"7a01c14d87e5d61d00887de62d490946","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118677.668849] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:25.956337Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"7a01c14d87e5d61d00887de62d490946\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1118677.449288] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:25.736693Z","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 # [1118677.666998] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:25.954379Z","level":"INFO","message":"deploy accepted","job":"1f7dfa79172de5e3dbfdb1323cf8889f","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118677.699576] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118677.724662] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118677.729214] agent flakelet[927]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [1118677.729899] agent flakelet[927]: app: activating generation 2 container-test-run-flakelet-relay> agent # [1118677.739779] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1118677.740486] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118677.740609] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1118677.753309] agent systemd[1]: Reload requested from client PID 934 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118677.753344] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118678.087069] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [1118678.170112] agent systemd[1]: Reload requested from client PID 964 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118678.170155] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118678.504597] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [1118678.573763] agent systemd[1]: Reload requested from client PID 993 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118678.573806] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118678.907765] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [1118678.981161] agent systemd[1]: Reload requested from client PID 1024 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118678.981198] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118679.315950] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [1118679.384815] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [1118679.417312] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [1118679.423099] agent flakelet[927]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [1118679.425555] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1, in 2.88 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl show app.service -p Description | grep -q 'app v2' container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl show app.service -p Description | grep -q 'app v2', in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2' container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2', in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet status --json app | jq -c '.[0].changed.by' container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet status --json app | jq -c '.[0].changed.by', in 0.03 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with client certificate, relay found via SRV, in 2.95 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.08 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTI4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUwOTg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJCM1RKQjVCVlFRT1BZPT09IiwibmJmIjoxNzkwMjUwOTg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.YTXcf1Oo-Qe0rAn1uuhtQ3WZ3czVdfxoPPtsYEKp6qbBR971EQq3vVARnJJ89B2vB6DEuq3lfNXcVfNYrpN5Cg' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> agent # [1118680.516803] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:28.804215Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118680.707173] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:28.994615Z","level":"INFO","message":"start","id":"b68ee2a06e18630d6446ff8e4b71ddb9","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 # [1118680.707638] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:28.995126Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"b68ee2a06e18630d6446ff8e4b71ddb9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118680.748492] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> relay # [1118680.518508] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:28.805908Z","level":"INFO","message":"deploy finished","job":"1f7dfa79172de5e3dbfdb1323cf8889f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118680.706685] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:28.994083Z","level":"INFO","message":"deploy accepted","job":"d5557fb74a4b824961b50dfd239fe21a","caller":"repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118680.773288] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118680.777306] agent flakelet[1093]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1118680.778032] agent flakelet[1093]: app: activating generation 3 container-test-run-flakelet-relay> agent # [1118680.791789] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [1118680.793516] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118680.793778] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [1118680.810664] agent systemd[1]: Reload requested from client PID 1100 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118680.810734] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118681.159113] agent systemd[1]: Reloading finished in 347 ms. container-test-run-flakelet-relay> agent # [1118681.235429] agent systemd[1]: Reload requested from client PID 1130 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118681.235470] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118681.569844] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [1118681.654112] agent systemd[1]: Reload requested from client PID 1162 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118681.654147] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118681.995399] agent systemd[1]: Reloading finished in 340 ms. container-test-run-flakelet-relay> agent # [1118682.084290] agent systemd[1]: Reload requested from client PID 1194 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118682.084327] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118682.420246] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1118682.504032] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1118682.535049] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [1118682.540636] agent flakelet[1093]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [1118682.542865] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTI4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUwOTg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJCM1RKQjVCVlFRT1BZPT09IiwibmJmIjoxNzkwMjUwOTg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.YTXcf1Oo-Qe0rAn1uuhtQ3WZ3czVdfxoPPtsYEKp6qbBR971EQq3vVARnJJ89B2vB6DEuq3lfNXcVfNYrpN5Cg' push --relay https://relay:7443 deploy agent/app 2>&1, in 2.96 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 3.05 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTI4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUwOTg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJCM1RKQjVCVlFRT1BZPT09IiwibmJmIjoxNzkwMjUwOTg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.YTXcf1Oo-Qe0rAn1uuhtQ3WZ3czVdfxoPPtsYEKp6qbBR971EQq3vVARnJJ89B2vB6DEuq3lfNXcVfNYrpN5Cg' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTI4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUwOTg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJCM1RKQjVCVlFRT1BZPT09IiwibmJmIjoxNzkwMjUwOTg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.YTXcf1Oo-Qe0rAn1uuhtQ3WZ3czVdfxoPPtsYEKp6qbBR971EQq3vVARnJJ89B2vB6DEuq3lfNXcVfNYrpN5Cg' 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.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTI5MSwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MDI1MDk5MSwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiUjdURlpRUFFJU1dQNj09PSIsIm5iZiI6MTc5MDI1MDk5MSwic3ViIjoic29tZW9uZSJ9.iLLJYOq8GTKKa7DuKVCP1zCW--1NXYRdiOT8uEM9NkfSQTWoWfcQIm6vBwCtPopq9tuyGUsYgLCSzuK_OvlgAw' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [1118683.622633] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:31.910049Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118683.725234] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:32.012662Z","level":"INFO","message":"start","id":"46c32bbd0291dc27982c40e9d9e22198","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"someone\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118683.725743] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:32.013237Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"46c32bbd0291dc27982c40e9d9e22198\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118683.766288] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1118683.797247] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1118683.801725] agent flakelet[1248]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118683.802323] agent flakelet[1248]: other: up to date container-test-run-flakelet-relay> agent # [1118683.804600] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118683.624330] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:31.911767Z","level":"INFO","message":"deploy finished","job":"d5557fb74a4b824961b50dfd239fe21a","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118683.724870] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:32.012284Z","level":"INFO","message":"deploy accepted","job":"724baadf577d3ab558ceea95cf04032a","caller":"someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTI5MSwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MDI1MDk5MSwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiUjdURlpRUFFJU1dQNj09PSIsIm5iZiI6MTc5MDI1MDk5MSwic3ViIjoic29tZW9uZSJ9.iLLJYOq8GTKKa7DuKVCP1zCW--1NXYRdiOT8uEM9NkfSQTWoWfcQIm6vBwCtPopq9tuyGUsYgLCSzuK_OvlgAw' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 0.70 seconds) container-test-run-flakelet-relay> subtest: push login via device flow, cached token used afterwards container-test-run-flakelet-relay> client: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1 container-test-run-flakelet-relay> agent # [1118684.343096] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:32.630434Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1118684.344522] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:32.631917Z","level":"INFO","message":"deploy finished","job":"724baadf577d3ab558ceea95cf04032a","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118684.368226] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [24/Sep/2026 11:56:32] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [1118685.373857] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [24/Sep/2026 11:56:33] "POST /token HTTP/1.1" 400 - container-test-run-flakelet-relay> client: (finished: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1, in 2.08 seconds) container-test-run-flakelet-relay> client: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600 container-test-run-flakelet-relay> client: (finished: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [1118686.427694] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [24/Sep/2026 11:56:34] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [1118686.457262] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:34.744721Z","level":"INFO","message":"deploy accepted","job":"7f5a8a710672324e80dd6ad82a876b0f","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118686.457702] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:34.745115Z","level":"INFO","message":"start","id":"8c2667a36a0586895d10392513b1098e","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118686.458695] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:34.745823Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"8c2667a36a0586895d10392513b1098e\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118686.500281] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1118686.540056] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1118686.544339] agent flakelet[1272]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118686.544901] agent flakelet[1272]: other: up to date container-test-run-flakelet-relay> agent # [1118686.548131] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.65 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [1118687.089260] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:35.376680Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118687.110356] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:35.397834Z","level":"INFO","message":"start","id":"76820eb3bf84bf6fc367a5081c76f4fb","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118687.110729] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:35.398220Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"76820eb3bf84bf6fc367a5081c76f4fb\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118687.150483] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1118687.178321] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1118687.183048] agent flakelet[1292]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118687.183614] agent flakelet[1292]: other: up to date container-test-run-flakelet-relay> agent # [1118687.185934] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118687.090754] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:35.378149Z","level":"INFO","message":"deploy finished","job":"7f5a8a710672324e80dd6ad82a876b0f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118687.110039] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:35.397508Z","level":"INFO","message":"deploy accepted","job":"0b97f1ac7f72f9510702359783809112","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.64 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 3.38 seconds) container-test-run-flakelet-relay> subtest: waves: failing first wave skips the second container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave agent/other 2>&1 container-test-run-flakelet-relay> relay # [1118687.727062] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:36.014466Z","level":"INFO","message":"deploy finished","job":"0b97f1ac7f72f9510702359783809112","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118687.763649] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:36.051073Z","level":"INFO","message":"deploy accepted","job":"d112ad4eba59ed122b4221539c99b3fc","caller":"admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118687.725665] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:36.013085Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118687.763958] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:36.051429Z","level":"INFO","message":"start","id":"e8133d0f4fb88b12b9c83ca21166048c","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118687.764384] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:36.051873Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"e8133d0f4fb88b12b9c83ca21166048c\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118687.800643] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118687.835320] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118687.841022] agent flakelet[1319]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [1118687.841788] agent flakelet[1319]: app: activating generation 4 container-test-run-flakelet-relay> agent # [1118687.859755] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1118687.860218] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118687.860491] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1118687.877680] agent systemd[1]: Reload requested from client PID 1326 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118687.877747] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118688.226684] agent systemd[1]: Reloading finished in 348 ms. container-test-run-flakelet-relay> agent # [1118688.318313] agent systemd[1]: Reload requested from client PID 1356 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118688.318353] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118688.653287] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [1118688.729066] agent systemd[1]: Reload requested from client PID 1385 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118688.729106] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118689.064616] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1118689.150610] agent systemd[1]: Reload requested from client PID 1416 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118689.150650] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118689.487149] agent systemd[1]: Reloading finished in 336 ms. container-test-run-flakelet-relay> agent # [1118689.565518] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [1118689.601578] agent (nonexistent)[1450]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [1118689.601614] agent (nonexistent)[1450]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [1118689.604326] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [1118689.604435] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [1118689.604697] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [1118689.638239] agent systemd[1]: Reload requested from client PID 1456 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118689.638279] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118689.975232] agent systemd[1]: Reloading finished in 336 ms. container-test-run-flakelet-relay> agent # [1118690.058301] agent systemd[1]: Reload requested from client PID 1486 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118690.058345] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118690.396042] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [1118690.473319] agent systemd[1]: Reload requested from client PID 1516 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118690.473363] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118690.812995] agent systemd[1]: Reloading finished in 339 ms. container-test-run-flakelet-relay> agent # [1118690.908078] agent systemd[1]: Reload requested from client PID 1546 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118690.908122] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118691.247470] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [1118691.357173] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1118691.364240] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [1118691.365459] agent flakelet[1319]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [1118691.365459] agent flakelet[1319]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [1118691.367553] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [1118691.367652] 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.27 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.30 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 # [1118692.008878] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:40.296297Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118692.064178] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:40.351619Z","level":"INFO","message":"start","id":"d738a2f0b7953816668c6d9a13aaf426","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118692.064413] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:40.351895Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"d738a2f0b7953816668c6d9a13aaf426\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118692.100975] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118692.130117] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118692.134185] agent flakelet[1606]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1118692.134752] agent flakelet[1606]: app: up to date container-test-run-flakelet-relay> agent # [1118692.138279] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118692.009881] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:40.297283Z","level":"INFO","message":"deploy finished","job":"d112ad4eba59ed122b4221539c99b3fc","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118692.063839] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:40.351267Z","level":"INFO","message":"deploy accepted","job":"611a6737266258ec0e4290e51715cede","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.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 '*/app' 2>&1 container-test-run-flakelet-relay> relay # [1118692.677071] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:40.964476Z","level":"INFO","message":"deploy finished","job":"611a6737266258ec0e4290e51715cede","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118692.699673] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:40.987145Z","level":"INFO","message":"deploy accepted","job":"0a1f246326bd261e39a0d1cdf184d39d","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118692.675410] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:40.962822Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118692.700019] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:40.987492Z","level":"INFO","message":"start","id":"0e034963e694f27f3426c65c89a923ed","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118692.700450] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:40.987940Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"0e034963e694f27f3426c65c89a923ed\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118692.734495] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118692.774300] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118692.779037] agent flakelet[1626]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1118692.779616] agent flakelet[1626]: app: up to date container-test-run-flakelet-relay> agent # [1118692.781368] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave '*/app' 2>&1 container-test-run-flakelet-relay> agent # [1118693.319631] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:41.607051Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118693.344909] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:41.632396Z","level":"INFO","message":"start","id":"906a730ef6b2e7c4f94a5d0600aee9d4","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118693.345128] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:41.632626Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"906a730ef6b2e7c4f94a5d0600aee9d4\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118693.380497] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118693.412163] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118693.416447] agent flakelet[1646]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1118693.417014] agent flakelet[1646]: app: up to date container-test-run-flakelet-relay> agent # [1118693.420598] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118693.320914] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:41.608318Z","level":"INFO","message":"deploy finished","job":"0a1f246326bd261e39a0d1cdf184d39d","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118693.344559] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:41.632034Z","level":"INFO","message":"deploy accepted","job":"632882bcb137150cdf17a35002a12541","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave '*/app' 2>&1, in 0.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 '@all/nope' 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: host patterns expand on the relay, in 1.95 seconds) container-test-run-flakelet-relay> subtest: detach returns once the job is accepted container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: timeout 20 push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --detach agent/app 2>&1 container-test-run-flakelet-relay> client: (finished: must succeed: timeout 20 push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --detach agent/app 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for success: systemctl is-active flakelet-relay-job-app.service container-test-run-flakelet-relay> relay # [1118693.959409] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:42.246798Z","level":"INFO","message":"deploy finished","job":"632882bcb137150cdf17a35002a12541","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118694.021959] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:42.309377Z","level":"INFO","message":"deploy accepted","job":"801ae41cb9e47c2a9319fe310a2c44a7","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118693.958045] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:42.245443Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118694.022304] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:42.309710Z","level":"INFO","message":"start","id":"d6ad89d8cfb0e999c78fcf12687766f9","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118694.022519] agent flakelet-agent[505]: {"timestamp":"2026-09-24T11:56:42.310021Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"d6ad89d8cfb0e999c78fcf12687766f9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118694.065661] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118694.102316] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118694.106891] agent flakelet[1674]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [1118694.107598] agent flakelet[1674]: app: activating generation 4 container-test-run-flakelet-relay> agent # [1118694.121988] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1118694.123856] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118694.124303] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1118694.141426] agent systemd[1]: Reload requested from client PID 1681 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118694.141495] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118694.490048] agent systemd[1]: Reloading finished in 347 ms. container-test-run-flakelet-relay> agent # [1118694.575008] agent systemd[1]: Reload requested from client PID 1711 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118694.575051] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118694.909130] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [1118694.991410] agent systemd[1]: Reload requested from client PID 1740 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118694.991451] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118695.326749] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.38 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 # [1118695.406894] agent systemd[1]: Reload requested from client PID 1772 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118695.406933] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118695.742445] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1118695.828628] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent: (finished: waiting for failure: systemctl is-active flakelet-relay-job-app.service, in 6.52 seconds) container-test-run-flakelet-relay> (finished: subtest: detach returns once the job is accepted, in 7.93 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 # [1118701.947249] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:50.234649Z","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 # [1118701.896171] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [1118701.905663] agent flakelet[1674]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [1118701.909181] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118701.947096] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [1118701.987762] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118701.988267] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [1118701.988775] agent systemd[1]: flakelet-agent.service: Consumed 1.388s CPU time over 26.622s 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.11 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 # [1118703.084456] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [1118703.153563] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:51.440982Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"d6ad89d8cfb0e999c78fcf12687766f9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118703.180440] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [1118703.190556] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:51.478031Z","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 # [1118703.191800] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:51.479299Z","level":"INFO","message":"start","id":"d6ad89d8cfb0e999c78fcf12687766f9","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [1118703.190728] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:51.478129Z","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 # [1118703.700378] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:51.987752Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118705.069916] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:53.357314Z","level":"INFO","message":"start","id":"ca5d230ef3c612986d15382d2ac907bc","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118705.070905] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:53.358135Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"ca5d230ef3c612986d15382d2ac907bc\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118705.115783] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1118705.150156] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1118705.155336] agent flakelet[2252]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118705.155922] agent flakelet[2252]: other: up to date container-test-run-flakelet-relay> agent # [1118705.158256] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118705.069385] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:53.356779Z","level":"INFO","message":"deploy accepted","job":"a9b8ab354f75c33c66a97ab068f26a8c","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118705.699332] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:56:53.986742Z","level":"INFO","message":"deploy finished","job":"a9b8ab354f75c33c66a97ab068f26a8c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118705.697745] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:53.985121Z","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.04 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTMxNCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUxMDE0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiI0QkVPSEZWWERWU1BBPT09IiwibmJmIjoxNzkwMjUxMDE0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Dhq9bKLD-NogXsZY38qBoBAoMhWeajMnqwaB5QHl3eQowNWP_O1EjsYB42CM4al9PLq5cgkVFN1cvx2l1O3ODg' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTMxNCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUxMDE0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiI0QkVPSEZWWERWU1BBPT09IiwibmJmIjoxNzkwMjUxMDE0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Dhq9bKLD-NogXsZY38qBoBAoMhWeajMnqwaB5QHl3eQowNWP_O1EjsYB42CM4al9PLq5cgkVFN1cvx2l1O3ODg' 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.44 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.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> 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 # [1118706.450646] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [1118706.451146] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118706.451434] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [1118706.470381] agent systemd[1]: Reload requested from client PID 2286 ('systemctl')... container-test-run-flakelet-relay> agent # [1118706.470450] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118706.818300] agent systemd[1]: Reloading finished in 347 ms. container-test-run-flakelet-relay> agent # [1118706.912135] agent systemd[1]: Reload requested from client PID 2315 ('systemctl')... container-test-run-flakelet-relay> agent # [1118706.912178] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118707.258709] agent systemd[1]: Reloading finished in 346 ms. container-test-run-flakelet-relay> agent # [1118707.343437] agent systemd[1]: Reload requested from client PID 2346 ('systemctl')... container-test-run-flakelet-relay> agent # [1118707.343481] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118707.680167] agent systemd[1]: Reloading finished in 336 ms. container-test-run-flakelet-relay> agent # [1118707.758891] agent systemd[1]: Reload requested from client PID 2376 ('systemctl')... container-test-run-flakelet-relay> agent # [1118707.758933] 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 # [1118708.100276] agent systemd[1]: Reloading finished in 340 ms. container-test-run-flakelet-relay> agent # [1118708.180585] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [1118708.209214] 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.05 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.02 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 # [1118709.204483] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:56:57.491889Z","level":"INFO","message":"local change","flakelet":"app","generation":5,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118709.363129] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [1118709.363641] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118709.363930] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [1118709.383103] agent systemd[1]: Reload requested from client PID 2422 ('systemctl')... container-test-run-flakelet-relay> agent # [1118709.383188] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118709.740750] agent systemd[1]: Reloading finished in 356 ms. container-test-run-flakelet-relay> agent # [1118709.819638] agent systemd[1]: Reload requested from client PID 2451 ('systemctl')... container-test-run-flakelet-relay> agent # [1118709.819682] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118710.151680] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [1118710.242032] agent systemd[1]: Reload requested from client PID 2479 ('systemctl')... container-test-run-flakelet-relay> agent # [1118710.242073] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118710.576950] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [1118710.671159] agent systemd[1]: Reload requested from client PID 2508 ('systemctl')... container-test-run-flakelet-relay> agent # [1118710.671203] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 2.17 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 # [1118711.377634] agent systemd[1]: Reloading finished in 706 ms. container-test-run-flakelet-relay> agent # [1118711.464224] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1118711.496143] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@6', in 2.06 seconds) container-test-run-flakelet-relay> (finished: subtest: out-of-band flakelet update reaches the relay without reconnect, in 7.21 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=@1790251021 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [1118713.205454] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:01.492880Z","level":"INFO","message":"local change","flakelet":"app","generation":6,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1118713.590283] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:01.877676Z","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 # [1118713.647747] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:01.935172Z","level":"INFO","message":"deploy accepted","job":"fb3bd12fb6508cfc2344ffb03da4d576","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118713.648220] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:01.935668Z","level":"INFO","message":"start","id":"3f341c129752a1c9048e8728e14d157f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118713.648856] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:01.936349Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"3f341c129752a1c9048e8728e14d157f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118713.686435] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118713.719131] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118713.723434] agent flakelet[2561]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [1118713.724116] agent flakelet[2561]: app: activating generation 7 container-test-run-flakelet-relay> agent # [1118713.743449] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1118713.745141] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118713.745415] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1118713.761204] agent systemd[1]: Reload requested from client PID 2568 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118713.761284] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118714.134632] agent systemd[1]: Reloading finished in 372 ms. container-test-run-flakelet-relay> agent # [1118714.224178] agent systemd[1]: Reload requested from client PID 2598 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118714.224221] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1790251021 | 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.06 seconds) container-test-run-flakelet-relay> agent: must succeed: ss -K dport = 7443 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=@1790251021 | grep -q 'updated to generation' container-test-run-flakelet-relay> agent # [1118714.583619] agent systemd[1]: Reloading finished in 358 ms. container-test-run-flakelet-relay> agent # [1118714.674201] agent systemd[1]: Reload requested from client PID 2635 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118714.674248] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118714.762459] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:03.049855Z","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> relay # [1118714.731046] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:03.018432Z","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 # [1118715.018243] agent systemd[1]: Reloading finished in 343 ms. container-test-run-flakelet-relay> agent # [1118715.099875] agent systemd[1]: Reload requested from client PID 2672 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118715.099920] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118715.436034] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1118715.531114] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [1118715.764962] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:04.052145Z","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 # [1118717.767304] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:06.054704Z","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: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1790251021 | 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 # [1118721.597569] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [1118721.604717] agent flakelet[2561]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [1118721.611084] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118721.769193] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:10.056508Z","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 # [1118722.675074] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:10.962482Z","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.37 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> agent # [1118729.773652] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:18.061072Z","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 # [1118729.774882] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:18.062371Z","level":"INFO","message":"start","id":"3f341c129752a1c9048e8728e14d157f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118730.015077] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:18.302444Z","level":"INFO","message":"start","id":"63d1d39f3d4f1efe39c7be71eb96bdb9","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118730.015418] agent flakelet-agent[1839]: {"timestamp":"2026-09-24T11:57:18.302914Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"63d1d39f3d4f1efe39c7be71eb96bdb9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1118729.773850] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:18.061170Z","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 # [1118729.775593] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:18.063058Z","level":"INFO","message":"deploy finished","job":"fb3bd12fb6508cfc2344ffb03da4d576","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118730.014655] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:18.302049Z","level":"INFO","message":"deploy accepted","job":"1cad6572a7a07f2edcca0b4baf4e3cdd","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118730.055791] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118730.090235] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118730.094590] agent flakelet[2797]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [1118730.095298] agent flakelet[2797]: app: activating generation 8 container-test-run-flakelet-relay> agent # [1118730.112983] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [1118730.113468] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118730.113743] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [1118730.130895] agent systemd[1]: Reload requested from client PID 2804 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118730.130972] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118730.484711] agent systemd[1]: Reloading finished in 353 ms. container-test-run-flakelet-relay> agent # [1118730.570412] agent systemd[1]: Reload requested from client PID 2834 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118730.570456] 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 # [1118730.906540] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1118730.985391] agent systemd[1]: Reload requested from client PID 2863 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118730.985432] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118731.323039] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [1118731.402648] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [1118731.409639] agent systemd[1]: Reload requested from client PID 2900 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118731.409682] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1118731.402955] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:19.690350Z","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.89 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 # [1118731.751119] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [1118731.822488] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118731.822705] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [1118731.822721] agent systemd[1]: flakelet-agent.service: Consumed 1.239s CPU time over 28.738s wall clock time. container-test-run-flakelet-relay> agent # [1118731.841390] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [1118731.842408] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [1118731.902427] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:20.189881Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"63d1d39f3d4f1efe39c7be71eb96bdb9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118731.919781] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [1118731.926898] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:20.214380Z","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 # [1118731.928041] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:20.215542Z","level":"INFO","message":"start","id":"63d1d39f3d4f1efe39c7be71eb96bdb9","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [1118731.927090] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:20.214431Z","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 # [1118737.914229] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [1118737.922764] agent flakelet[2797]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [1118737.925967] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118738.494611] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:26.781987Z","level":"INFO","message":"deploy finished","job":"1cad6572a7a07f2edcca0b4baf4e3cdd","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118738.492481] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:26.779889Z","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.05 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.02 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1790251047 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [1118739.082280] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:27.369703Z","level":"INFO","message":"start","id":"68b4e0781a16e47bd834210e0383fe69","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118739.082990] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:27.370479Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"68b4e0781a16e47bd834210e0383fe69\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118739.124301] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118739.154305] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118739.158948] agent flakelet[3377]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [1118739.159576] agent flakelet[3377]: app: activating generation 9 container-test-run-flakelet-relay> agent # [1118739.178815] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [1118739.180766] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1118739.181194] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [1118739.198054] agent systemd[1]: Reload requested from client PID 3384 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118739.198124] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1118739.081700] relay flakelet-relay[400]: {"timestamp":"2026-09-24T11:57:27.369103Z","level":"INFO","message":"deploy accepted","job":"9c6af5fdd27d315dacf9e1ea23fb220d","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118739.546087] agent systemd[1]: Reloading finished in 347 ms. container-test-run-flakelet-relay> agent # [1118739.633097] agent systemd[1]: Reload requested from client PID 3414 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118739.633139] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1790251047 | grep -q 'app-slow', in 1.03 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> agent # [1118739.965839] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [1118740.044226] agent systemd[1]: Reload requested from client PID 3446 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118740.044264] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118740.110520] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:28.397912Z","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 # [1118740.109862] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [1118740.148514] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118740.148984] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [1118740.149054] relay systemd[1]: flakelet-relay.service: Consumed 2.649s CPU time over 1min 6.472s wall clock time. container-test-run-flakelet-relay> relay # [1118740.190311] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [1118740.391783] agent systemd[1]: Reloading finished in 347 ms. container-test-run-flakelet-relay> agent # [1118740.481599] agent systemd[1]: Reload requested from client PID 3481 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1118740.481636] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1118740.820570] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [1118740.906067] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [1118741.113940] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:29.401125Z","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.52 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [1118741.613281] relay flakelet-relay[929]: {"timestamp":"2026-09-24T11:57:29.900674Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1118741.614212] relay flakelet-relay[929]: {"timestamp":"2026-09-24T11:57:29.901114Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1118741.613851] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [1118743.124949] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:31.412351Z","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 # [1118743.125300] relay flakelet-relay[929]: {"timestamp":"2026-09-24T11:57:31.412705Z","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 # [1118746.982123] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [1118746.990753] agent flakelet[3377]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [1118746.994508] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118747.130269] relay flakelet-relay[929]: {"timestamp":"2026-09-24T11:57:35.417664Z","level":"INFO","message":"job reattached","job":"9c6af5fdd27d315dacf9e1ea23fb220d","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118748.072365] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:36.359761Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q '» ok' /tmp/resume.out, in 7.08 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/resume.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/resume.out, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: relay restart mid-run, push resumes via /v1/jobs, in 9.67 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 # [1118748.732151] relay flakelet-relay[929]: {"timestamp":"2026-09-24T11:57:37.019540Z","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 # [1118748.732666] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:37.020042Z","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 # [1118748.733409] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:37.020895Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118748.768434] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1118748.802278] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1118748.806975] agent flakelet[3555]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118748.807557] agent flakelet[3555]: other: up to date container-test-run-flakelet-relay> agent # [1118748.810929] 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.65 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> agent # [1118749.353249] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:37.640648Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118749.372805] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:37.660248Z","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 # [1118749.355112] relay flakelet-relay[929]: {"timestamp":"2026-09-24T11:57:37.642396Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118749.372328] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [1118749.408748] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1118749.409351] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [1118749.409394] relay systemd[1]: flakelet-relay.service: Consumed 2.166s CPU time over 9.218s wall clock time. container-test-run-flakelet-relay> relay # [1118749.446085] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [1118750.375544] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:38.662924Z","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.50 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 # [1118750.853165] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:39.140593Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1118750.853859] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:39.141086Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1118750.853838] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [1118752.388835] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:40.676221Z","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 # [1118752.388959] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:40.676364Z","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> 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTM2MSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUxMDYxLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZWlhaN1NMMlJYWldRPT09IiwibmJmIjoxNzkwMjUxMDYxLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2B9IyYp_zSev6gIoMJs4hHhIjRS8hlXmIMapGG4kve_8To2ZGxivuIN5DtmX9W5qKtC1OkOLCGR6aQ4V9_jgAA' 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 # [1118753.004868] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:41.292302Z","level":"INFO","message":"deploy accepted","job":"6a239dbf87cfec796e49404c351d787f","caller":"example/app","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118753.005378] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:41.292793Z","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 # [1118753.005816] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:41.293313Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dce6faec8455f85321e72ee634888126\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118753.040428] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1118753.068322] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1118753.073183] agent flakelet[3583]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [1118753.073764] agent flakelet[3583]: app: up to date container-test-run-flakelet-relay> agent # [1118753.077015] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTM2MSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUxMDYxLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZWlhaN1NMMlJYWldRPT09IiwibmJmIjoxNzkwMjUxMDYxLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2B9IyYp_zSev6gIoMJs4hHhIjRS8hlXmIMapGG4kve_8To2ZGxivuIN5DtmX9W5qKtC1OkOLCGR6aQ4V9_jgAA' push --relay https://relay:7443 deploy --id hist2 agent/app, in 0.64 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTM2MSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUxMDYxLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZWlhaN1NMMlJYWldRPT09IiwibmJmIjoxNzkwMjUxMDYxLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2B9IyYp_zSev6gIoMJs4hHhIjRS8hlXmIMapGG4kve_8To2ZGxivuIN5DtmX9W5qKtC1OkOLCGR6aQ4V9_jgAA' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDI1MTM2MSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwMjUxMDYxLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJZWlhaN1NMMlJYWldRPT09IiwibmJmIjoxNzkwMjUxMDYxLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2B9IyYp_zSev6gIoMJs4hHhIjRS8hlXmIMapGG4kve_8To2ZGxivuIN5DtmX9W5qKtC1OkOLCGR6aQ4V9_jgAA' 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.94 seconds) container-test-run-flakelet-relay> subtest: dashboard login via authorization code flow container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login, in 0.09 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other', in 0.03 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/8b50c27606d2a12182ec7a1a084a0a73/events || true container-test-run-flakelet-relay> relay # [1118753.625586] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:41.913002Z","level":"INFO","message":"deploy finished","job":"6a239dbf87cfec796e49404c351d787f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118753.701376] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [24/Sep/2026 11:57:41] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=mba7PMe9VFIzBiKRwlCLZdeDtcbtE-RdkcaVNLxQgrY&code_challenge=9RzGr6IHlLoA7R3d9Mqeh5Le5e7DeIkGPdj_Bu_8ZqU&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> relay # [1118753.751734] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [24/Sep/2026 11:57:42] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [1118753.752532] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:42.040010Z","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 # [1118753.811674] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:42.099152Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118753.858390] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:42.145872Z","level":"INFO","message":"deploy accepted","job":"af1023c86f977c264bd275e4e5061c72","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1118753.877582] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:42.164976Z","level":"INFO","message":"job reattached","job":"af1023c86f977c264bd275e4e5061c72","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1118753.623926] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:41.911318Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118753.858735] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:42.146129Z","level":"INFO","message":"start","id":"ee8fa1140fedb3178ae63e79fc7399ab","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1118753.859452] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:42.146938Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"ee8fa1140fedb3178ae63e79fc7399ab\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118753.905299] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1118753.945346] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1118753.948044] agent flakelet[3603]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118753.948603] agent flakelet[3603]: other: up to date container-test-run-flakelet-relay> agent # [1118753.952183] 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/8b50c27606d2a12182ec7a1a084a0a73/events || true, in 0.64 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/8b50c27606d2a12182ec7a1a084a0a73 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/8b50c27606d2a12182ec7a1a084a0a73, 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=8b50c27606d2a12182ec7a1a084a0a73' | 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=8b50c27606d2a12182ec7a1a084a0a73' | grep -q 400, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 15 'https://relay:7443/ui/events?path=jobs' > /tmp/ev.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 15 'https://relay:7443/ui/events?path=jobs' > /tmp/ev.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other container-test-run-flakelet-relay> » job 38796a7ba508eadfe82a1cd5def000bc via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/other | Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent/other | Started flakelet update other (via relay). container-test-run-flakelet-relay> agent/other | other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent/other | other: up to date container-test-run-flakelet-relay> agent # [1118754.498255] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:42.785632Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118754.650035] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:42.937455Z","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 # [1118754.650851] agent flakelet-agent[2932]: {"timestamp":"2026-09-24T11:57:42.937977Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1118754.695110] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1118754.724976] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1118754.729800] agent flakelet[3627]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1118754.730368] agent flakelet[3627]: other: up to date container-test-run-flakelet-relay> agent # [1118754.732983] 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> relay # [1118754.649732] relay flakelet-relay[1319]: {"timestamp":"2026-09-24T11:57:42.937190Z","level":"INFO","message":"deploy accepted","job":"38796a7ba508eadfe82a1cd5def000bc","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> » agent/other: unchanged (generation 1) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other, in 0.64 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q live1 /tmp/ev.out container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q live1 /tmp/ev.out, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: dashboard login via authorization code flow, in 1.68 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 84.99 seconds) container-test-run-flakelet-relay> test script finished in 85.03s 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 1f7dfa79172de5e3dbfdb1323cf8889f 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 d112ad4eba59ed122b4221539c99b3fc 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 fb3bd12fb6508cfc2344ffb03da4d576 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 1cad6572a7a07f2edcca0b4baf4e3cdd 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 9c6af5fdd27d315dacf9e1ea23fb220d 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 954b640f4455c131631eb17eb2f392a6 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 9c6af5fdd27d315dacf9e1ea23fb220d 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> 1790251057 hist1 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790251047 954b640f4455c131631eb17eb2f392a6 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790251038 23b5949b0f3315c002193273ac08a771 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790251021 6c9254b19b09c202976d9f9c65ec9b1e admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790251019 local-app-6-1790251019 root (shell) agent/app:updated container-test-run-flakelet-relay> 1790251016 local-app-5-1790251016 root (shell) agent/app:updated container-test-run-flakelet-relay> 1790251013 86184211344610fad8e3ebc346afa51b admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790251002 99d58a5fd39e8d88dca4f33c78330e68 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790251001 2fca9b3e2f6c192a084383f86055652a admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1790251000 5e5e7e77e5881bda3b5f8af40a52d8d0 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1790251000 9d211f67af8aa8f7d748daf3ca656651 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1790250996 dbfab3657f3aacf7fbb4d07efec57815 admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1790250995 0b59b98f0b20affce9320e8c40e1cd98 dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790250994 d481b4dc9c957473e2a03e4c026e355c dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790250992 11621ca9a619b8cc5275ae347168e66c someone agent/other:unchanged container-test-run-flakelet-relay> 1790250988 30427904cbfba20928a5f4bb85ae5b94 repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1790250985 c27f8fc4fcb926f4d39954b369bae194 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790250983 local-app-1-1790250983 host activation agent/app:updated container-test-run-flakelet-relay> 1790250983 local-flakelet-agent-1-1790250983 host activation agent/flakelet-agent:updated container-test-run-flakelet-relay> 1790250983 local-other-1-1790250983 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