these 42 derivations will be built: /nix/store/c9rm38wj439q6h91nif370iwcb9d0092-push.drv /nix/store/w08zgvznkshzmdfn7s6sx81acnwpjq37-system-path.drv /nix/store/895ih9za878qs2a8yddl5iln93bich61-dbus-1.drv /nix/store/29klvzyd60575h3flxy0bc3vv6pkd7k0-X-Restart-Triggers-dbus-broker.drv /nix/store/b3lgk8jcyqrjd3xbazzkpny2q8haq213-unit-dbus-broker.service.drv /nix/store/3pn0rvw4gwd1d65s33nqsf6wr9dzwqli-system-units.drv /nix/store/8yb8h073cj1wsg3da983nh8w3j8mnhh4-unit-dbus-broker.service.drv /nix/store/97dnb24pkmzcsh97v831px4171ylhnbj-user-units.drv /nix/store/6jg9n9w1d3l1113hiy8f53w6b1cldwp1-etc.drv /nix/store/dgpb1s0ya76gq24dr448nldqdr96yi31-activate.drv /nix/store/050g1fr6g3gwxzhv3ik3vdwlbz50j977-nixos-system-client-test.drv /nix/store/jmnwj3zg9l6i31fi5vx38k2cqh9llrhr-flakelet-relay.json.drv /nix/store/9idp9n63hvkvvc4cff720hpn0csf0dyg-flakelet-relay.service.drv /nix/store/zixg87czag1g9k0pj30ymym834hpdsbv-flakelet-flakelet-relay-units.drv /nix/store/l324npcjhf05rx7zk4a8mj5wdiqgjygs-flakelet-flakelet-relay.drv /nix/store/4ssqcvf0m5gjr0v05y2skwqbzacxbmxv-flakelet-config.json.drv /nix/store/rnw98d5zv78dqi60kqaabd1p1vbykv3c-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/1nx818kgyl2nqqlk4sz8svi4mvjaxx7w-unit-flakelet-reconcile.service.drv /nix/store/2jpr5ahvqj8fffbb6xx9bpzzi13m73x9-run-client-nspawn.drv /nix/store/rz0s8m3n6jk39v9v07dslgc4dac6v8vk-flakelet-agent.service.drv /nix/store/gk2hfbfycg5m3hp99rawmsxqzzd1y655-flakelet-flakelet-agent-units.drv /nix/store/yyzmhcivgaflvd60vbh8znq4ikl06izb-flakelet-flakelet-agent.drv /nix/store/arvgmrzq8ikydzdzf0m0xf1036qapgi0-flakelet-config.json.drv /nix/store/a05mrxc0k5amq350qqgkk7qpvcvrmzqv-X-Restart-Triggers-flakelet-flakelet-agent.drv /nix/store/f200dl4qx3f3yp2z1rgccaib4hn1sn50-unit-flakelet-flakelet-agent.service.drv /nix/store/d97zqd7nym9w0a4yrjspg143i8x01hza-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/q675lkklh1v4f3xvg0hwwgsykv3bbr4z-unit-flakelet-reconcile.service.drv /nix/store/dcvgp2gw3dgaxds9j4mpgyqs2jdw2jsd-system-units.drv /nix/store/sn4arv0rsfy0j26h4b8br9riqw6ha0pg-etc.drv /nix/store/y5jhldcz2sqsm7had6bdzcmpbk3aaapa-activate.drv /nix/store/gcgsdx0215f1y44ai6aspflgqpgnx8cc-nixos-system-agent-test.drv /nix/store/4h7zkf0h101afh83mm4m3wlxflxx2h9c-run-agent-nspawn.drv /nix/store/svyiy4plw7n6d9sbd2i7lclz0mgrx3nc-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/c2kv3mlfc4g0iv29m6mw99xj97d93zn1-unit-flakelet-flakelet-relay.service.drv /nix/store/m42nhx1cydzwlv1am3avwj9fyl9cqswy-system-units.drv /nix/store/qsyx0ggdzm272l7zmwvc65x9f5r3zwga-etc.drv /nix/store/mv84c2z040bv5bpdb0mz6idgsf9r9ffm-activate.drv /nix/store/hgnhpxvqyyqbf7d5lh9b1x729j2nlqmk-nixos-system-relay-test.drv /nix/store/zixbk377r6sgiby437lfn6hy9hzvv1js-run-relay-nspawn.drv /nix/store/mnbfs3g7k95sx6h5dhknmrlplp6dmch0-driverConfiguration.json.drv /nix/store/a261czikig2gfkv2yin0xbbkdlqi0c68-nixos-test-driver-flakelet-relay.drv /nix/store/a68zx6jkvc1lx9i79ggp8k1638kdlbkj-container-test-run-flakelet-relay.drv building '/nix/store/c9rm38wj439q6h91nif370iwcb9d0092-push.drv' building '/nix/store/a05mrxc0k5amq350qqgkk7qpvcvrmzqv-X-Restart-Triggers-flakelet-flakelet-agent.drv' building '/nix/store/svyiy4plw7n6d9sbd2i7lclz0mgrx3nc-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/rz0s8m3n6jk39v9v07dslgc4dac6v8vk-flakelet-agent.service.drv' X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/jmnwj3zg9l6i31fi5vx38k2cqh9llrhr-flakelet-relay.json.drv' flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> tribuchet: building on jamie building '/nix/store/f200dl4qx3f3yp2z1rgccaib4hn1sn50-unit-flakelet-flakelet-agent.service.drv' building '/nix/store/c2kv3mlfc4g0iv29m6mw99xj97d93zn1-unit-flakelet-flakelet-relay.service.drv' unit-flakelet-flakelet-agent.service> tribuchet: building on jamie unit-flakelet-flakelet-relay.service> tribuchet: building on jamie flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/app (expect allow) flakelet-relay.json> agent/app allowed by ci flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/other (expect deny) flakelet-relay.json> agent/other denied building '/nix/store/gk2hfbfycg5m3hp99rawmsxqzzd1y655-flakelet-flakelet-agent-units.drv' flakelet-flakelet-agent-units> tribuchet: building on jamie building '/nix/store/w08zgvznkshzmdfn7s6sx81acnwpjq37-system-path.drv' building '/nix/store/9idp9n63hvkvvc4cff720hpn0csf0dyg-flakelet-relay.service.drv' system-path> tribuchet: building on jamie flakelet-relay.service> tribuchet: building on jamie building '/nix/store/zixg87czag1g9k0pj30ymym834hpdsbv-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie unit-flakelet-flakelet-relay.service> structuredAttrs is enabled unit-flakelet-flakelet-agent.service> structuredAttrs is enabled building '/nix/store/yyzmhcivgaflvd60vbh8znq4ikl06izb-flakelet-flakelet-agent.drv' flakelet-flakelet-agent> tribuchet: building on jamie building '/nix/store/l324npcjhf05rx7zk4a8mj5wdiqgjygs-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/arvgmrzq8ikydzdzf0m0xf1036qapgi0-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/4ssqcvf0m5gjr0v05y2skwqbzacxbmxv-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie system-path> structuredAttrs is enabled flakelet-config.json> structuredAttrs is enabled flakelet-config.json> structuredAttrs is enabled system-path> created 6399 symlinks in user environment building '/nix/store/d97zqd7nym9w0a4yrjspg143i8x01hza-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/rnw98d5zv78dqi60kqaabd1p1vbykv3c-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/q675lkklh1v4f3xvg0hwwgsykv3bbr4z-unit-flakelet-reconcile.service.drv' building '/nix/store/1nx818kgyl2nqqlk4sz8svi4mvjaxx7w-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/895ih9za878qs2a8yddl5iln93bich61-dbus-1.drv' unit-flakelet-reconcile.service> structuredAttrs is enabled unit-flakelet-reconcile.service> structuredAttrs is enabled dbus-1> tribuchet: building on jamie building '/nix/store/m42nhx1cydzwlv1am3avwj9fyl9cqswy-system-units.drv' building '/nix/store/dcvgp2gw3dgaxds9j4mpgyqs2jdw2jsd-system-units.drv' system-units> tribuchet: building on jamie system-units> tribuchet: building on jamie building '/nix/store/29klvzyd60575h3flxy0bc3vv6pkd7k0-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie building '/nix/store/8yb8h073cj1wsg3da983nh8w3j8mnhh4-unit-dbus-broker.service.drv' building '/nix/store/b3lgk8jcyqrjd3xbazzkpny2q8haq213-unit-dbus-broker.service.drv' unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/sn4arv0rsfy0j26h4b8br9riqw6ha0pg-etc.drv' etc> tribuchet: building on jamie building '/nix/store/qsyx0ggdzm272l7zmwvc65x9f5r3zwga-etc.drv' etc> tribuchet: building on jamie building '/nix/store/97dnb24pkmzcsh97v831px4171ylhnbj-user-units.drv' building '/nix/store/3pn0rvw4gwd1d65s33nqsf6wr9dzwqli-system-units.drv' user-units> tribuchet: building on jamie system-units> tribuchet: building on jamie building '/nix/store/y5jhldcz2sqsm7had6bdzcmpbk3aaapa-activate.drv' building '/nix/store/mv84c2z040bv5bpdb0mz6idgsf9r9ffm-activate.drv' activate> tribuchet: building on jamie activate> tribuchet: building on jamie building '/nix/store/6jg9n9w1d3l1113hiy8f53w6b1cldwp1-etc.drv' etc> tribuchet: building on jamie building '/nix/store/gcgsdx0215f1y44ai6aspflgqpgnx8cc-nixos-system-agent-test.drv' building '/nix/store/hgnhpxvqyyqbf7d5lh9b1x729j2nlqmk-nixos-system-relay-test.drv' nixos-system-agent-test> tribuchet: building on jamie nixos-system-relay-test> tribuchet: building on jamie nixos-system-relay-test> structuredAttrs is enabled nixos-system-agent-test> structuredAttrs is enabled building '/nix/store/4h7zkf0h101afh83mm4m3wlxflxx2h9c-run-agent-nspawn.drv' building '/nix/store/zixbk377r6sgiby437lfn6hy9hzvv1js-run-relay-nspawn.drv' run-agent-nspawn> tribuchet: building on jamie run-relay-nspawn> tribuchet: building on jamie building '/nix/store/dgpb1s0ya76gq24dr448nldqdr96yi31-activate.drv' activate> tribuchet: building on jamie building '/nix/store/050g1fr6g3gwxzhv3ik3vdwlbz50j977-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on jamie nixos-system-client-test> structuredAttrs is enabled building '/nix/store/2jpr5ahvqj8fffbb6xx9bpzzi13m73x9-run-client-nspawn.drv' run-client-nspawn> tribuchet: building on jamie building '/nix/store/mnbfs3g7k95sx6h5dhknmrlplp6dmch0-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/a261czikig2gfkv2yin0xbbkdlqi0c68-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/a68zx6jkvc1lx9i79ggp8k1638kdlbkj-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> relay: systemd-nspawn running (pid 54) 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: Waiting for journal at /build/vm-state-relay/var/log/journal... container-test-run-flakelet-relay> agent: Waiting for journal at /build/vm-state-agent/var/log/journal... container-test-run-flakelet-relay> (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(agent): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(agent): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(relay): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(relay): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> ░ Spawning container agent on /build/vm-state-agent. container-test-run-flakelet-relay> ░ Spawning container relay on /build/vm-state-relay. 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 client on /build/vm-state-client. container-test-run-flakelet-relay> relay # No journal files were found. container-test-run-flakelet-relay> client # No journal files were found. container-test-run-flakelet-relay> agent # 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> client # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> agent # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> relay # [2328365.414527] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> relay # [2328365.414639] relay systemd-journald[57]: Runtime Journal (/run/log/journal/246d9af36c004ddf8c320fcf7584a5fe) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [2328365.438725] relay systemd[1]: Listening on Journal Log Access Socket. container-test-run-flakelet-relay> relay # [2328365.439210] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> relay # [2328365.459440] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> relay # [2328365.513956] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> relay # [2328365.515027] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [2328365.524661] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/246d9af36c004ddf8c320fcf7584a5fe is 1.499ms for 7 entries. container-test-run-flakelet-relay> relay # [2328365.524661] relay systemd-journald[57]: System Journal (/var/log/journal/246d9af36c004ddf8c320fcf7584a5fe) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [2328365.536011] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [2328365.536892] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [2328365.537025] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [2328365.551367] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [2328365.623352] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [2328365.420427] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [2328365.414524] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [2328365.420470] client systemd-journald[57]: Runtime Journal (/run/log/journal/e66db42dd6904cadb39768503d0afdf8) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [2328365.414634] agent systemd-journald[57]: Runtime Journal (/run/log/journal/191efae35e8e461b94c37e588de8ac20) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [2328365.442065] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [2328365.438725] agent systemd[1]: Listening on Journal Log Access Socket. container-test-run-flakelet-relay> client # [2328365.468346] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [2328365.439235] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [2328365.513812] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [2328365.459316] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [2328365.514670] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> agent # [2328365.513608] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [2328365.524702] client systemd-journald[57]: Time spent on flushing to /var/log/journal/e66db42dd6904cadb39768503d0afdf8 is 1.554ms for 6 entries. container-test-run-flakelet-relay> agent # [2328365.514586] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [2328365.524702] client systemd-journald[57]: System Journal (/var/log/journal/e66db42dd6904cadb39768503d0afdf8) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [2328365.524262] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/191efae35e8e461b94c37e588de8ac20 is 1.592ms for 7 entries. container-test-run-flakelet-relay> client # [2328365.533302] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [2328365.524262] agent systemd-journald[57]: System Journal (/var/log/journal/191efae35e8e461b94c37e588de8ac20) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [2328365.533961] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> client # [2328365.534081] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> client # [2328365.549305] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> client # [2328365.606750] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [2328365.533063] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [2328365.533719] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> agent # [2328365.533852] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [2328365.550109] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> agent # [2328365.603575] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [2328366.416633] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [2328366.458368] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [2328366.459208] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [2328366.460016] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [2328366.461016] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [2328366.461045] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [2328366.462037] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [2328366.462791] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> client # [2328366.480614] 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 # [2328366.481017] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [2328366.481301] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/e66db42dd6904cadb39768503d0afdf8 failed: Operation not permitted container-test-run-flakelet-relay> client # [2328366.481618] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [2328366.441886] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [2328366.474081] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> relay # [2328366.475403] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [2328366.476726] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [2328366.478086] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [2328366.478133] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [2328366.479071] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [2328366.479966] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> relay # [2328366.497502] 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 # [2328366.497911] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [2328366.498218] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/246d9af36c004ddf8c320fcf7584a5fe failed: Operation not permitted container-test-run-flakelet-relay> relay # [2328366.498548] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [2328366.415144] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> agent # [2328366.473162] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> agent # [2328366.474451] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> agent # [2328366.475728] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [2328366.476954] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [2328366.477016] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [2328366.478313] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> agent # [2328366.479458] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [2328366.497314] agent suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.b9jTvyvbnA/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [2328366.499333] 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 # [2328366.499739] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [2328366.500062] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/191efae35e8e461b94c37e588de8ac20 failed: Operation not permitted container-test-run-flakelet-relay> agent # [2328366.500399] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [2328366.616540] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328366.637883] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [2328366.637919] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [2328366.637970] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [2328366.638117] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [2328366.638696] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [2328366.653878] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [2328366.654826] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [2328366.482905] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.orodCEtmNV/chsh': Operation not permitted container-test-run-flakelet-relay> client # [2328366.484155] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [2328366.496319] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [2328366.496542] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [2328366.502991] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> client # [2328366.505093] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [2328366.505907] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [2328366.518180] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [2328366.525749] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [2328366.526857] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [2328366.536594] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [2328366.536691] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [2328366.536775] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [2328366.536844] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [2328366.536863] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [2328366.536980] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [2328366.537199] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [2328366.537298] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [2328366.537310] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [2328366.537338] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [2328366.538840] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [2328366.551558] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [2328366.554249] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [2328366.602146] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [2328366.603184] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [2328366.634795] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [2328366.637387] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [2328366.641533] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [2328366.643705] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> client # [2328366.645914] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> client # [2328366.646259] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [2328366.647742] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> client # [2328366.649097] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [2328366.669591] client network-addresses-eth1-start[238]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> relay # [2328366.501642] relay suid-sgid-wrappers-start[176]: chmod: changing permissions of '/run/wrappers/wrappers.t8nVB306ep/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [2328366.562297] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328366.608109] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [2328366.608152] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [2328366.608220] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [2328366.608375] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [2328366.637550] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [2328366.654448] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [2328366.655128] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [2328366.668583] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [2328366.675829] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [2328366.676852] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [2328366.686571] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [2328366.686694] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [2328366.686772] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [2328366.686801] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [2328366.686817] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [2328366.686922] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [2328366.687134] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [2328366.687241] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [2328366.687255] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [2328366.687286] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [2328366.688578] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [2328366.689409] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [2328366.690103] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [2328366.691300] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [2328366.692053] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [2328366.668929] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [2328366.672607] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [2328366.673883] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [2328366.685227] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [2328366.685325] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [2328366.685410] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [2328366.685444] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [2328366.685461] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [2328366.685558] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [2328366.685725] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [2328366.685823] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [2328366.685835] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [2328366.685865] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [2328366.687134] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [2328366.687894] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [2328366.688678] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [2328366.689498] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [2328366.701138] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [2328366.702144] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [2328366.707370] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [2328366.714202] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [2328366.782316] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328366.795351] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [2328366.796834] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [2328366.797643] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [2328366.798538] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [2328366.799164] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [2328366.799982] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [2328366.818940] agent network-addresses-eth1-start[240]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [2328366.822029] agent network-addresses-eth1-start[240]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [2328366.826044] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [2328366.900188] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [2328366.900404] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328366.900514] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [2328366.902583] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [2328366.903789] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [2328366.904533] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [2328366.905353] agent systemd[1]: Starting Update flakelet service flakelet-agent... container-test-run-flakelet-relay> agent # [2328366.906073] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [2328366.915808] agent flakelet[308]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [2328366.916391] agent flakelet[308]: app: activating generation 1 container-test-run-flakelet-relay> agent # [2328366.917938] agent flakelet[310]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328366.918387] agent flakelet[309]: flakelet-agent: using prebuilt artifact /nix/store/ziygyv7pnn0bk451bmllxwxpszljs97f-flakelet-flakelet-agent container-test-run-flakelet-relay> agent # [2328366.918771] agent flakelet[309]: flakelet-agent: activating generation 1 container-test-run-flakelet-relay> agent # [2328366.918851] agent flakelet[310]: other: activating generation 1 container-test-run-flakelet-relay> agent # [2328366.920183] agent systemd[1]: Reload requested from client PID 312 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [2328366.920218] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [2328366.672924] client network-addresses-eth1-start[238]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [2328366.679917] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [2328366.734733] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [2328366.735132] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> client # [2328366.749655] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [2328366.749875] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [2328366.753523] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [2328366.702378] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [2328366.703282] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [2328366.709246] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [2328366.716330] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> relay # [2328366.772799] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328366.772912] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [2328366.795780] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [2328366.796053] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [2328366.796922] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [2328366.798135] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [2328366.798964] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [2328366.820484] relay network-addresses-eth1-start[250]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [2328366.823727] relay network-addresses-eth1-start[250]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [2328366.828741] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> relay # [2328366.866785] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [2328366.866911] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [2328366.868472] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [2328366.869586] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [2328366.870402] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [2328366.908814] relay flakelet[311]: flakelet-relay: using prebuilt artifact /nix/store/8kp7j72dj4626fpcssg5jf8m7nz7fwkw-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [2328366.909674] relay flakelet[311]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [2328366.914414] relay systemd[1]: Reload requested from client PID 316 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [2328366.914459] relay systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328367.229451] relay nsncd[245]: Oct 08 11:57:55.516 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [2328367.318386] relay systemd[1]: Reloading finished in 403 ms. container-test-run-flakelet-relay> relay # [2328367.449754] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [2328367.450765] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [2328367.450809] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [2328367.452249] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [2328367.453324] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [2328367.464764] relay systemd[1]: Reload requested from client PID 357 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [2328367.464829] relay systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328367.237557] agent nsncd[307]: Oct 08 11:57:55.524 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [2328367.308298] agent systemd[1]: Reloading finished in 387 ms. container-test-run-flakelet-relay> agent # [2328367.453791] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [2328367.458643] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [2328367.458707] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [2328367.254427] client nsncd[303]: Oct 08 11:57:55.541 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [2328367.254304] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [2328367.254398] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [2328367.254509] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [2328367.256840] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [2328367.258228] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [2328367.301991] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [2328367.303969] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [2328367.304033] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [2328367.304058] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [2328367.627458] relay dnsmasq-pre-start[393]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> relay # [2328367.840758] relay systemd[1]: Reloading finished in 375 ms. container-test-run-flakelet-relay> agent # [2328367.838478] agent systemd[1]: Reloading finished in 379 ms. container-test-run-flakelet-relay> agent # [2328367.976356] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [2328367.976407] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328367.973984] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [2328367.978365] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [2328367.978427] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [2328367.978496] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [2328367.999405] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [2328368.347655] agent systemd[1]: Reloading finished in 370 ms. container-test-run-flakelet-relay> agent # [2328368.414082] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [2328368.414198] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [2328368.415549] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [2328368.416445] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [2328368.420094] agent systemd[1]: Reload requested from client PID 405 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [2328368.420123] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328368.647727] relay nginx-pre-start[402]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [2328368.648621] relay nginx-pre-start[402]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [2328368.673884] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> relay # [2328368.677137] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [2328368.792446] agent systemd[1]: Reloading finished in 371 ms. container-test-run-flakelet-relay> agent # [2328368.868539] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [2328368.874096] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [2328368.874212] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [2328368.874363] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [2328368.876405] agent systemd[1]: Reload requested from client PID 408 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [2328368.876432] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [2328368.830374] client systemd-logind[315]: New seat seat0. container-test-run-flakelet-relay> client # [2328368.832400] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [2328368.832535] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [2328368.834117] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [2328368.873738] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [2328368.874066] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [2328368.875476] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [2328369.053365] relay systemd-logind[355]: New seat seat0. container-test-run-flakelet-relay> relay # [2328369.053835] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [2328369.056250] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [2328369.100179] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328369.100541] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> relay # [2328369.292214] relay dbus-broker-launch[405]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [2328369.293416] relay dbus-broker-launch[405]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [2328369.293452] relay dbus-broker-launch[405]: 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 # [2328369.294632] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [2328369.302431] relay dbus-broker-launch[405]: Ready container-test-run-flakelet-relay> relay # [2328369.305965] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> agent # [2328369.220116] agent systemd[1]: Reloading finished in 343 ms. container-test-run-flakelet-relay> agent # [2328369.299820] agent systemd[1]: Reload requested from client PID 445 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [2328369.299858] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328369.308449] relay dnsmasq[394]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [2328369.308463] 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 # [2328369.308475] relay dnsmasq[394]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [2328369.308499] relay dnsmasq[394]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [2328369.308788] relay dnsmasq[394]: read /etc/hosts - 9 names container-test-run-flakelet-relay> client # [2328369.374688] client dbus-broker-launch[325]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [2328369.376394] client dbus-broker-launch[325]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [2328369.376394] client dbus-broker-launch[325]: Invalid user-name in /nix/store/fn1p831b29fwxiz6x4q55zsbq43f6l3y-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [2328369.377291] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [2328369.377643] client systemd[1]: Startup finished in 4.415s. container-test-run-flakelet-relay> client # [2328369.383351] client dbus-broker-launch[325]: Ready container-test-run-flakelet-relay> agent # [2328369.650099] agent systemd[1]: Reloading finished in 349 ms. container-test-run-flakelet-relay> agent # [2328369.727031] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [2328369.731389] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [2328369.732225] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [2328369.735423] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [2328369.749156] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [2328369.752082] agent flakelet[308]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [2328369.754255] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [2328369.756861] agent flakelet[310]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [2328369.758938] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [2328369.782054] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:57:58.069460Z","level":"INFO","message":"local change","flakelet":"app","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328369.782662] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:57:58.069799Z","level":"INFO","message":"local change","flakelet":"other","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328369.782560] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [2328369.786188] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:57:58.073665Z","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 # [2328369.787849] agent flakelet[309]: flakelet-agent: updated to generation 1 container-test-run-flakelet-relay> agent # [2328369.789667] agent systemd[1]: Finished Update flakelet service flakelet-agent. container-test-run-flakelet-relay> agent # [2328369.789823] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> agent # [2328369.802514] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:57:58.090005Z","level":"INFO","message":"local change","flakelet":"flakelet-agent","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328369.881743] agent systemd-logind[406]: New seat seat0. container-test-run-flakelet-relay> agent # [2328369.883062] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [2328369.883136] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [2328369.884252] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [2328369.926824] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328369.927221] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [2328369.927587] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [2328370.179820] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:57:58.467097Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [2328370.180871] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:57:58.467681Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [2328370.180443] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [2328370.204790] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 6.16 seconds) container-test-run-flakelet-relay> relay: waiting for unit nginx.service container-test-run-flakelet-relay> relay: (finished: waiting for unit nginx.service, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet.target container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet.target, in 0.02 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> agent # [2328370.408658] agent dbus-broker-launch[904]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [2328370.410222] agent dbus-broker-launch[904]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [2328370.410222] agent dbus-broker-launch[904]: 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 # [2328370.410989] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [2328370.411575] agent systemd[1]: Startup finished in 5.455s. container-test-run-flakelet-relay> agent # [2328370.417578] agent dbus-broker-launch[904]: Ready container-test-run-flakelet-relay> relay # [2328370.493067] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328370.493515] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay # [2328370.501381] relay flakelet[311]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [2328370.504171] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [2328370.504752] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [2328370.504925] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [2328370.505221] relay systemd[1]: Startup finished in 5.549s. container-test-run-flakelet-relay> agent # [2328371.804791] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:00.092197Z","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 # [2328371.805209] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:00.092619Z","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: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1', in 2.06 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service other.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service other.service, in 0.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.02 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 # [2328372.737849] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:01.025251Z","level":"INFO","message":"start","id":"475e4cf157a51eb168e15ca41a0bb38a","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328372.738438] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:01.025925Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"475e4cf157a51eb168e15ca41a0bb38a\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328372.782048] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328372.813377] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328372.817943] agent flakelet[926]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [2328372.818683] agent flakelet[926]: app: activating generation 2 container-test-run-flakelet-relay> agent # [2328372.836564] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [2328372.838250] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328372.838509] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [2328372.854287] agent systemd[1]: Reload requested from client PID 933 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328372.854352] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328372.736908] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:01.024294Z","level":"INFO","message":"deploy accepted","job":"11a229250ccda6eda612cf215dbd7be8","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328373.196921] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [2328373.281196] agent systemd[1]: Reload requested from client PID 963 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328373.281234] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328373.608466] agent systemd[1]: Reloading finished in 326 ms. container-test-run-flakelet-relay> agent # [2328373.696590] agent systemd[1]: Reload requested from client PID 992 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328373.696627] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328374.029429] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [2328374.121053] agent systemd[1]: Reload requested from client PID 1027 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328374.121086] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328374.447267] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [2328374.534695] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [2328374.567297] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [2328374.572570] agent flakelet[926]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [2328374.575092] 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.95 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl show app.service -p Description | grep -q 'app v2' container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl show app.service -p Description | grep -q 'app v2', in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2' container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2', in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet status --json app | jq -c '.[0].changed.by' container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet status --json app | jq -c '.[0].changed.by', in 0.03 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with client certificate, relay found via SRV, in 3.03 seconds) container-test-run-flakelet-relay> subtest: deploy with OIDC token, sub principal container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.07 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MDk4NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNjg0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXUFpSM1AzUFpYVDVRPT09IiwibmJmIjoxNzkxNDYwNjg0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Z4JNb9CtfVKrY_71jdF1hagIVreYUF_QLJ_Wk1NezrnNIkVFjNMN5e-Vwj5j_2pgz8xcfqmKERTj4QMbDMQPCA' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> relay # [2328375.658518] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:03.945893Z","level":"INFO","message":"deploy finished","job":"11a229250ccda6eda612cf215dbd7be8","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328375.844754] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:04.132141Z","level":"INFO","message":"deploy accepted","job":"6e8dcdd6122f9746ad9bfa7c62fef779","caller":"repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328375.656450] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:03.943864Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328375.844906] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:04.132349Z","level":"INFO","message":"start","id":"5476fb0ff6298461218e8f5369560941","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 # [2328375.845355] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:04.132856Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"5476fb0ff6298461218e8f5369560941\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328375.884289] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328375.921359] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328375.925520] agent flakelet[1096]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [2328375.926157] agent flakelet[1096]: app: activating generation 3 container-test-run-flakelet-relay> agent # [2328375.941871] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [2328375.943544] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328375.943812] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [2328375.961151] agent systemd[1]: Reload requested from client PID 1103 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328375.961217] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328376.300990] agent systemd[1]: Reloading finished in 339 ms. container-test-run-flakelet-relay> agent # [2328376.386750] agent systemd[1]: Reload requested from client PID 1133 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328376.386787] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328376.779442] agent systemd[1]: Reloading finished in 392 ms. container-test-run-flakelet-relay> agent # [2328376.862367] agent systemd[1]: Reload requested from client PID 1162 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328376.862417] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328377.298132] agent systemd[1]: Reloading finished in 435 ms. container-test-run-flakelet-relay> agent # [2328377.386651] agent systemd[1]: Reload requested from client PID 1193 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328377.386700] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328377.788152] agent systemd[1]: Reloading finished in 401 ms. container-test-run-flakelet-relay> agent # [2328377.880686] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [2328377.921658] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [2328377.928799] agent flakelet[1096]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [2328377.931963] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MDk4NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNjg0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXUFpSM1AzUFpYVDVRPT09IiwibmJmIjoxNzkxNDYwNjg0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Z4JNb9CtfVKrY_71jdF1hagIVreYUF_QLJ_Wk1NezrnNIkVFjNMN5e-Vwj5j_2pgz8xcfqmKERTj4QMbDMQPCA' push --relay https://relay:7443 deploy agent/app 2>&1, in 3.12 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 3.21 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MDk4NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNjg0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXUFpSM1AzUFpYVDVRPT09IiwibmJmIjoxNzkxNDYwNjg0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Z4JNb9CtfVKrY_71jdF1hagIVreYUF_QLJ_Wk1NezrnNIkVFjNMN5e-Vwj5j_2pgz8xcfqmKERTj4QMbDMQPCA' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MDk4NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNjg0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJXUFpSM1AzUFpYVDVRPT09IiwibmJmIjoxNzkxNDYwNjg0LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Z4JNb9CtfVKrY_71jdF1hagIVreYUF_QLJ_Wk1NezrnNIkVFjNMN5e-Vwj5j_2pgz8xcfqmKERTj4QMbDMQPCA' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MDk4NywiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MTQ2MDY4NywiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiQ0UzWVg2QUs1NkNNSz09PSIsIm5iZiI6MTc5MTQ2MDY4Nywic3ViIjoic29tZW9uZSJ9.E6A5T_7EMT5e0wD8T9D4_K6GtXYoaMptiBt1M2jTaUDN1YQbqdPovM6-tnAs-OJRV71eA5MMQdVOB6CujeMfAw' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [2328378.925221] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:07.212671Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328379.046349] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:07.333718Z","level":"INFO","message":"start","id":"7131f53d41f26d6cb51d8a9858d0619a","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"someone\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328379.046718] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:07.334219Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"7131f53d41f26d6cb51d8a9858d0619a\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328379.112723] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [2328379.119740] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [2328379.124354] agent flakelet[1247]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328379.124929] agent flakelet[1247]: other: up to date container-test-run-flakelet-relay> agent # [2328379.137334] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328378.927224] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:07.214591Z","level":"INFO","message":"deploy finished","job":"6e8dcdd6122f9746ad9bfa7c62fef779","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328379.045959] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:07.333405Z","level":"INFO","message":"deploy accepted","job":"945c3a0e6e5735fa8ccad07a3645dfe5","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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MDk4NywiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MTQ2MDY4NywiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiQ0UzWVg2QUs1NkNNSz09PSIsIm5iZiI6MTc5MTQ2MDY4Nywic3ViIjoic29tZW9uZSJ9.E6A5T_7EMT5e0wD8T9D4_K6GtXYoaMptiBt1M2jTaUDN1YQbqdPovM6-tnAs-OJRV71eA5MMQdVOB6CujeMfAw' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.67 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 0.73 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 # [2328379.678558] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:07.966009Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [2328379.680245] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:07.967648Z","level":"INFO","message":"deploy finished","job":"945c3a0e6e5735fa8ccad07a3645dfe5","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328379.705017] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [08/Oct/2026 11:58:07] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [2328380.710639] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [08/Oct/2026 11:58:08] "POST /token HTTP/1.1" 400 - container-test-run-flakelet-relay> client: (finished: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1, in 2.08 seconds) container-test-run-flakelet-relay> client: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600 container-test-run-flakelet-relay> client: (finished: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [2328381.793922] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:10.081340Z","level":"INFO","message":"start","id":"175407882cc095b369a8b8ece0109914","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328381.794800] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:10.082022Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"175407882cc095b369a8b8ece0109914\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328381.840096] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [2328381.849324] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [2328381.853712] agent flakelet[1275]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328381.854316] agent flakelet[1275]: other: up to date container-test-run-flakelet-relay> agent # [2328381.857908] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328381.760446] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [08/Oct/2026 11:58:10] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [2328381.793577] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:10.081036Z","level":"INFO","message":"deploy accepted","job":"9fcbf43c1343cebcc20ee1cf06c0f80d","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.63 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [2328382.401972] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:10.689379Z","level":"INFO","message":"deploy finished","job":"9fcbf43c1343cebcc20ee1cf06c0f80d","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328382.423946] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:10.711420Z","level":"INFO","message":"deploy accepted","job":"e70a855c5f8aee4d7ce77382b57dc27d","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328382.400319] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:10.687735Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328382.424294] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:10.711768Z","level":"INFO","message":"start","id":"ccd7608b7599f85eebfa54f04d367010","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328382.424711] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:10.712201Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"ccd7608b7599f85eebfa54f04d367010\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328382.462102] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [2328382.487263] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [2328382.492353] agent flakelet[1295]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328382.492911] agent flakelet[1295]: other: up to date container-test-run-flakelet-relay> agent # [2328382.496360] 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.64 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 3.37 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.02 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave agent/other 2>&1 container-test-run-flakelet-relay> agent # [2328383.044809] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:11.332224Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328383.091515] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:11.378985Z","level":"INFO","message":"start","id":"47e64eb41b767bcb6eb1c21c5363b82f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328383.092067] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:11.379561Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"47e64eb41b767bcb6eb1c21c5363b82f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328383.153248] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328383.160721] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328383.165822] agent flakelet[1318]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [2328383.166545] agent flakelet[1318]: app: activating generation 4 container-test-run-flakelet-relay> agent # [2328383.183734] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [2328383.185540] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328383.185812] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [2328383.203947] agent systemd[1]: Reload requested from client PID 1325 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328383.204031] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328383.046296] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:11.333724Z","level":"INFO","message":"deploy finished","job":"e70a855c5f8aee4d7ce77382b57dc27d","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328383.091203] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:11.378651Z","level":"INFO","message":"deploy accepted","job":"4fe26b23a7918b882ed4fd7bec3a6f15","caller":"admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328383.551094] agent systemd[1]: Reloading finished in 346 ms. container-test-run-flakelet-relay> agent # [2328383.647691] agent systemd[1]: Reload requested from client PID 1355 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328383.647736] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328383.985257] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [2328384.073158] agent systemd[1]: Reload requested from client PID 1387 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328384.073196] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328384.415508] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [2328384.512139] agent systemd[1]: Reload requested from client PID 1419 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328384.512181] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328384.852866] agent systemd[1]: Reloading finished in 340 ms. container-test-run-flakelet-relay> agent # [2328384.926150] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [2328384.963739] agent (nonexistent)[1449]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [2328384.963766] agent (nonexistent)[1449]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [2328384.965832] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [2328384.965961] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [2328384.966311] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [2328384.994972] agent systemd[1]: Reload requested from client PID 1455 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328384.995021] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328385.357951] agent systemd[1]: Reloading finished in 362 ms. container-test-run-flakelet-relay> agent # [2328385.442231] agent systemd[1]: Reload requested from client PID 1485 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328385.442275] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328385.782562] agent systemd[1]: Reloading finished in 339 ms. container-test-run-flakelet-relay> agent # [2328385.861237] agent systemd[1]: Reload requested from client PID 1517 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328385.861283] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328386.203975] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [2328386.293859] agent systemd[1]: Reload requested from client PID 1549 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328386.293907] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328386.642516] agent systemd[1]: Reloading finished in 348 ms. container-test-run-flakelet-relay> agent # [2328386.731383] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [2328386.764370] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [2328386.765335] agent flakelet[1318]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [2328386.765335] agent flakelet[1318]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [2328386.767801] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [2328386.767906] 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.34 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.39 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> relay # [2328387.408387] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:15.695797Z","level":"INFO","message":"deploy finished","job":"4fe26b23a7918b882ed4fd7bec3a6f15","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328387.472764] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:15.760170Z","level":"INFO","message":"deploy accepted","job":"fc8b2115e3cff594d782d0f46d8464b8","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328387.406741] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:15.694186Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328387.473029] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:15.760480Z","level":"INFO","message":"start","id":"56f12e95af348785d59aa672e2ba3cf7","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328387.473422] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:15.760920Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"56f12e95af348785d59aa672e2ba3cf7\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328387.514643] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328387.546387] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328387.551193] agent flakelet[1605]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [2328387.551892] agent flakelet[1605]: app: up to date container-test-run-flakelet-relay> agent # [2328387.555497] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/app' 2>&1, in 0.65 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> agent # [2328388.095731] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:16.383157Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328388.120334] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:16.407819Z","level":"INFO","message":"start","id":"be3e2f8a87917ad28a124c72d094020a","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328388.120687] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:16.408186Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"be3e2f8a87917ad28a124c72d094020a\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328388.161263] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328388.196403] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328388.202140] agent flakelet[1629]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [2328388.202724] agent flakelet[1629]: app: up to date container-test-run-flakelet-relay> agent # [2328388.205087] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328388.096896] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:16.384304Z","level":"INFO","message":"deploy finished","job":"fc8b2115e3cff594d782d0f46d8464b8","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328388.119943] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:16.407422Z","level":"INFO","message":"deploy accepted","job":"d1a03def8f0aea72572b0e4966ef9055","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 '*/app' 2>&1, in 0.65 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 # [2328388.744418] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:17.031801Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328388.770263] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:17.057737Z","level":"INFO","message":"start","id":"a73424679fdc9cbe106a7b433eb76202","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328388.770661] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:17.058152Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"a73424679fdc9cbe106a7b433eb76202\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328388.807933] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328388.841042] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328388.845630] agent flakelet[1649]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [2328388.846253] agent flakelet[1649]: app: up to date container-test-run-flakelet-relay> agent # [2328388.847785] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328388.745798] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:17.033209Z","level":"INFO","message":"deploy finished","job":"d1a03def8f0aea72572b0e4966ef9055","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328388.769978] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:17.057459Z","level":"INFO","message":"deploy accepted","job":"9c70a4ca9cd9fec93c3ee348df4e219b","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.65 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.98 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 # [2328389.394236] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:17.681689Z","level":"INFO","message":"deploy finished","job":"9c70a4ca9cd9fec93c3ee348df4e219b","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328389.452287] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:17.739762Z","level":"INFO","message":"deploy accepted","job":"05c9011b935a644ff4bff4df3f3f21dc","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328389.392636] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:17.680079Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328389.452489] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:17.739941Z","level":"INFO","message":"start","id":"f16a8499a6cb0db82da681d36fb21a71","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328389.452825] agent flakelet-agent[503]: {"timestamp":"2026-10-08T11:58:17.740320Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"f16a8499a6cb0db82da681d36fb21a71\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328389.494271] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328389.526470] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328389.531477] agent flakelet[1673]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [2328389.532196] agent flakelet[1673]: app: activating generation 4 container-test-run-flakelet-relay> agent # [2328389.546388] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [2328389.548064] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328389.548332] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [2328389.569089] agent systemd[1]: Reload requested from client PID 1680 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328389.569160] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328389.918545] agent systemd[1]: Reloading finished in 348 ms. container-test-run-flakelet-relay> agent # [2328390.005311] agent systemd[1]: Reload requested from client PID 1714 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328390.005352] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328390.347746] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [2328390.430785] agent systemd[1]: Reload requested from client PID 1743 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328390.430830] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.39 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 # [2328390.769903] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [2328390.854823] agent systemd[1]: Reload requested from client PID 1776 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328390.854867] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328391.189463] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [2328391.278325] 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.51 seconds) container-test-run-flakelet-relay> (finished: subtest: detach returns once the job is accepted, in 7.94 seconds) container-test-run-flakelet-relay> subtest: unknown host is final, missing agent is retried, agents listing container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy nope/app 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy nope/app 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl stop flakelet-agent container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl stop flakelet-agent, in 0.06 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 0' container-test-run-flakelet-relay> relay: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 0', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/other > /tmp/retry.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/other > /tmp/retry.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent_unavailable.*retrying' /tmp/retry.out container-test-run-flakelet-relay> agent # [2328397.333419] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [2328397.342369] agent flakelet[1673]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [2328397.346025] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328397.391567] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [2328397.424046] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328397.424547] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [2328397.424990] agent systemd[1]: flakelet-agent.service: Consumed 1.477s CPU time over 27.692s wall clock time. container-test-run-flakelet-relay> relay # [2328397.391844] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:25.679237Z","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> client: (finished: waiting for success: grep -q 'agent_unavailable.*retrying' /tmp/retry.out, in 1.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl start flakelet-agent container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl start flakelet-agent, in 0.09 seconds) container-test-run-flakelet-relay> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-flakelet-relay> File "/nix/store/f3vbkhcnzmgjphqaarrzgjdpzrb02va5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out container-test-run-flakelet-relay> agent # [2328398.501389] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [2328398.552889] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:26.840348Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"f16a8499a6cb0db82da681d36fb21a71\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328398.574125] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [2328398.583882] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:26.871363Z","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 # [2328398.584028] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:26.871461Z","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 # [2328399.096491] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:27.383909Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328400.484350] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:28.771779Z","level":"INFO","message":"start","id":"f74129b157fdeb6d21de303099dd5161","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328400.485217] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:28.772303Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"f74129b157fdeb6d21de303099dd5161\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328400.530018] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [2328400.562466] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [2328400.567368] agent flakelet[2251]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328400.567960] agent flakelet[2251]: other: up to date container-test-run-flakelet-relay> agent # [2328400.571721] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328400.484120] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:28.771311Z","level":"INFO","message":"deploy accepted","job":"3b3e1d0bc7dd2cb95127dac6aabc16e2","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328401.112514] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:29.399969Z","level":"INFO","message":"deploy finished","job":"3b3e1d0bc7dd2cb95127dac6aabc16e2","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328401.111570] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:29.399004Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out, in 3.04 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MTAwOSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNzA5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJFTldOUUdNVkJMVzdNPT09IiwibmJmIjoxNzkxNDYwNzA5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.GvZACvpv0Qc1h8GD9AUOtt2wiK1Gw3iFt_419EtnRDC6swgnbV6X3Y2emozrridMPkFomjrndMekGbSeaDCmBQ' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MTAwOSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNzA5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJFTldOUUdNVkJMVzdNPT09IiwibmJmIjoxNzkxNDYwNzA5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.GvZACvpv0Qc1h8GD9AUOtt2wiK1Gw3iFt_419EtnRDC6swgnbV6X3Y2emozrridMPkFomjrndMekGbSeaDCmBQ' 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.36 seconds) container-test-run-flakelet-relay> subtest: out-of-band flakelet update reaches the relay without reconnect container-test-run-flakelet-relay> agent: must succeed: flakelet status --json app | jq '.[0].generation' container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet status --json app | jq '.[0].generation', in 0.03 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> app: activating generation 5 container-test-run-flakelet-relay> agent # [2328401.797546] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [2328401.799290] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328401.799575] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [2328401.819832] agent systemd[1]: Reload requested from client PID 2285 ('systemctl')... container-test-run-flakelet-relay> agent # [2328401.819907] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328402.193480] agent systemd[1]: Reloading finished in 372 ms. container-test-run-flakelet-relay> agent # [2328402.280163] agent systemd[1]: Reload requested from client PID 2314 ('systemctl')... container-test-run-flakelet-relay> agent # [2328402.280211] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328402.688233] agent systemd[1]: Reloading finished in 407 ms. container-test-run-flakelet-relay> agent # [2328402.772494] agent systemd[1]: Reload requested from client PID 2345 ('systemctl')... container-test-run-flakelet-relay> agent # [2328402.772539] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328403.225414] agent systemd[1]: Reloading finished in 452 ms. container-test-run-flakelet-relay> agent # [2328403.320426] agent systemd[1]: Reload requested from client PID 2375 ('systemctl')... container-test-run-flakelet-relay> agent # [2328403.320466] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 2.03 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 # [2328403.684877] agent systemd[1]: Reloading finished in 364 ms. container-test-run-flakelet-relay> agent # [2328403.786955] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [2328403.795214] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@5', in 1.04 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-5- container-test-run-flakelet-relay> agent # [2328404.601939] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:32.889367Z","level":"INFO","message":"local change","flakelet":"app","generation":5,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem 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 # [2328404.935163] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [2328404.935646] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328404.935919] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [2328404.955041] agent systemd[1]: Reload requested from client PID 2421 ('systemctl')... container-test-run-flakelet-relay> agent # [2328404.955115] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328405.298631] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [2328405.393546] agent systemd[1]: Reload requested from client PID 2450 ('systemctl')... container-test-run-flakelet-relay> agent # [2328405.393593] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328405.725109] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [2328405.794293] agent systemd[1]: Reload requested from client PID 2478 ('systemctl')... container-test-run-flakelet-relay> agent # [2328405.794338] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328406.125367] agent systemd[1]: Reloading finished in 330 ms. container-test-run-flakelet-relay> agent # [2328406.200808] agent systemd[1]: Reload requested from client PID 2507 ('systemctl')... container-test-run-flakelet-relay> agent # [2328406.200850] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328406.529011] agent systemd[1]: Reloading finished in 327 ms. container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.73 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 # [2328406.599420] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [2328406.630355] 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 6.99 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.02 seconds) container-test-run-flakelet-relay> (finished: subtest: metrics, in 0.02 seconds) container-test-run-flakelet-relay> subtest: agent link drop mid-run replays missed lines once container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1791460717 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [2328408.598107] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:36.885437Z","level":"INFO","message":"local change","flakelet":"app","generation":6,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328408.795231] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:37.082665Z","level":"INFO","message":"start","id":"3905a2d6dbe77d80b3dc7c07cb46bcb7","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328408.795716] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:37.083213Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"3905a2d6dbe77d80b3dc7c07cb46bcb7\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328408.837262] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> relay # [2328408.730702] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:37.018117Z","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 # [2328408.794835] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:37.082242Z","level":"INFO","message":"deploy accepted","job":"78cd7d1290a619d25018dbb3486ad955","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328408.866397] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328408.872223] agent flakelet[2560]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [2328408.872976] agent flakelet[2560]: app: activating generation 7 container-test-run-flakelet-relay> agent # [2328408.889656] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [2328408.890086] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328408.890357] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [2328408.908384] agent systemd[1]: Reload requested from client PID 2567 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328408.908456] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328409.247828] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [2328409.327045] agent systemd[1]: Reload requested from client PID 2597 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328409.327111] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1791460717 | 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.03 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 # [2328409.659215] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [2328409.725536] agent systemd[1]: Reload requested from client PID 2626 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328409.725581] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: ss -K dport = 7443, in 0.03 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1791460717 | grep -q 'updated to generation' container-test-run-flakelet-relay> relay # [2328409.886621] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:38.174052Z","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 # [2328409.917968] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:38.205249Z","level":"INFO","message":"disconnected: IO error: Software caused connection abort (os error 103)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328410.056758] agent systemd[1]: Reloading finished in 330 ms. container-test-run-flakelet-relay> agent # [2328410.150936] agent systemd[1]: Reload requested from client PID 2671 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328410.150976] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328410.485856] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [2328410.580803] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [2328410.920196] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:39.207630Z","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 # [2328412.923322] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:41.210713Z","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 # [2328416.650509] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [2328416.658475] agent flakelet[2560]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [2328416.661815] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1791460717 | grep -q 'updated to generation', in 7.11 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 # [2328416.926954] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:45.214155Z","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 # [2328417.735065] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:46.022421Z","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.10 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.41 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.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/app > /tmp/restart.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/restart.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2' container-test-run-flakelet-relay> relay # [2328424.931102] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:53.218460Z","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 # [2328424.932654] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:53.220126Z","level":"INFO","message":"deploy finished","job":"78cd7d1290a619d25018dbb3486ad955","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328424.930942] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:53.218358Z","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 # [2328424.932177] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:53.219668Z","level":"INFO","message":"start","id":"3905a2d6dbe77d80b3dc7c07cb46bcb7","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328425.191631] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:53.478969Z","level":"INFO","message":"start","id":"9fe396603adc5cd018b8f8296afbe532","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328425.192192] agent flakelet-agent[1838]: {"timestamp":"2026-10-08T11:58:53.479680Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"9fe396603adc5cd018b8f8296afbe532\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328425.232180] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328425.261304] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328425.265829] agent flakelet[2796]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [2328425.266538] agent flakelet[2796]: app: activating generation 8 container-test-run-flakelet-relay> agent # [2328425.284849] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [2328425.285323] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328425.285596] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [2328425.304214] agent systemd[1]: Reload requested from client PID 2803 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328425.304286] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328425.650857] agent systemd[1]: Reloading finished in 345 ms. container-test-run-flakelet-relay> agent # [2328425.742541] agent systemd[1]: Reload requested from client PID 2833 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328425.742591] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2', in 1.03 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl restart flakelet-agent container-test-run-flakelet-relay> agent # [2328426.076816] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [2328426.153591] agent systemd[1]: Reload requested from client PID 2862 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328426.153638] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328426.481394] agent systemd[1]: Reloading finished in 327 ms. container-test-run-flakelet-relay> agent # [2328426.542087] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [2328426.552951] agent systemd[1]: Reload requested from client PID 2897 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328426.552994] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328425.191347] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:53.478584Z","level":"INFO","message":"deploy accepted","job":"be278336742dec3412aa6ad9f0e38bee","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328426.542496] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:54.829873Z","level":"INFO","message":"agent disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl restart flakelet-agent, in 0.85 seconds) container-test-run-flakelet-relay> agent: must succeed: test -n "$(ls /var/lib/flakelet-agent/jobs)" container-test-run-flakelet-relay> agent: (finished: must succeed: test -n "$(ls /var/lib/flakelet-agent/jobs)", in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out container-test-run-flakelet-relay> agent # [2328426.888015] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [2328426.947189] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328426.947401] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [2328426.947419] agent systemd[1]: flakelet-agent.service: Consumed 1.781s CPU time over 28.445s wall clock time. container-test-run-flakelet-relay> agent # [2328426.967141] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [2328426.968278] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [2328427.031233] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:58:55.318692Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"9fe396603adc5cd018b8f8296afbe532\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328427.052984] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [2328427.066170] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:58:55.353643Z","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 # [2328427.067453] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:58:55.354949Z","level":"INFO","message":"start","id":"9fe396603adc5cd018b8f8296afbe532","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [2328427.066335] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:58:55.353746Z","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 # [2328433.049447] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [2328433.059918] agent flakelet[2796]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [2328433.062929] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328433.621814] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:59:01.909218Z","level":"INFO","message":"deploy finished","job":"be278336742dec3412aa6ad9f0e38bee","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328433.620336] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:01.907748Z","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.09 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/restart.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/restart.out, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: agent restart mid-run reattaches to the unit, in 9.02 seconds) container-test-run-flakelet-relay> subtest: relay restart mid-run, push resumes via /v1/jobs container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1791460742 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [2328434.225517] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:02.512940Z","level":"INFO","message":"start","id":"d3a53fc76749a0382bcd69ccab49237d","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328434.226315] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:02.513802Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"d3a53fc76749a0382bcd69ccab49237d\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328434.267699] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328434.301429] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328434.306927] agent flakelet[3374]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [2328434.307583] agent flakelet[3374]: app: activating generation 9 container-test-run-flakelet-relay> agent # [2328434.325300] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [2328434.325799] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [2328434.326076] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [2328434.345221] agent systemd[1]: Reload requested from client PID 3381 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328434.345293] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [2328434.225141] relay flakelet-relay[400]: {"timestamp":"2026-10-08T11:59:02.512560Z","level":"INFO","message":"deploy accepted","job":"d8deaf398029d880e51ff217d034439c","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328434.687715] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [2328434.760157] agent systemd[1]: Reload requested from client PID 3411 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328434.760197] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328435.089156] agent systemd[1]: Reloading finished in 328 ms. container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1791460742 | 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 # [2328435.163973] agent systemd[1]: Reload requested from client PID 3442 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328435.164018] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328435.252679] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:03.540085Z","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 # [2328435.252201] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [2328435.286341] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328435.286792] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [2328435.286841] relay systemd[1]: flakelet-relay.service: Consumed 2.887s CPU time over 1min 7.287s wall clock time. container-test-run-flakelet-relay> relay # [2328435.323899] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [2328435.502658] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [2328435.593822] agent systemd[1]: Reload requested from client PID 3478 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [2328435.593861] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [2328435.930421] agent systemd[1]: Reloading finished in 336 ms. container-test-run-flakelet-relay> agent # [2328436.002699] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [2328436.255606] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:04.542830Z","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.53 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [2328436.769176] relay flakelet-relay[932]: {"timestamp":"2026-10-08T11:59:05.056578Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [2328436.769947] relay flakelet-relay[932]: {"timestamp":"2026-10-08T11:59:05.057005Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [2328436.769723] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [2328438.266949] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:06.554345Z","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 # [2328438.267278] relay flakelet-relay[932]: {"timestamp":"2026-10-08T11:59:06.554654Z","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 # [2328442.072212] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [2328442.080619] agent flakelet[3374]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [2328442.084216] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328442.272896] relay flakelet-relay[932]: {"timestamp":"2026-10-08T11:59:10.560338Z","level":"INFO","message":"job reattached","job":"d8deaf398029d880e51ff217d034439c","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328443.189284] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:11.476669Z","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.10 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.70 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 # [2328443.903749] relay flakelet-relay[932]: {"timestamp":"2026-10-08T11:59:12.191162Z","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 # [2328443.904253] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:12.191650Z","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 # [2328443.904971] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:12.192458Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328443.949790] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [2328443.984322] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [2328443.990224] agent flakelet[3552]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328443.990789] agent flakelet[3552]: other: up to date container-test-run-flakelet-relay> agent # [2328443.992857] 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 # [2328444.530358] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:12.817793Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328444.548644] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:12.836128Z","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 # [2328444.531512] relay flakelet-relay[932]: {"timestamp":"2026-10-08T11:59:12.818904Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328444.548474] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [2328444.605485] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328444.605898] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [2328444.605941] relay systemd[1]: flakelet-relay.service: Consumed 2.012s CPU time over 9.281s wall clock time. container-test-run-flakelet-relay> relay # [2328444.648012] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [2328445.551376] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:13.838796Z","level":"WARN","message":"connect failed: connect relay:7443: Connection refused (os error 111)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: must succeed: systemctl restart flakelet-relay, in 1.59 seconds) container-test-run-flakelet-relay> 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 # [2328446.124291] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:14.411693Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [2328446.125176] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:14.412151Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [2328446.124860] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [2328447.565166] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:15.852577Z","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 # [2328447.565285] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:15.852702Z","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.06 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MTA1NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNzU2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJJQllYQ0RJSkMyTUQyPT09IiwibmJmIjoxNzkxNDYwNzU2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.cpEVWP3i88POpVSkYOBZRKebvsWM7BJZ2ZpqubNSzH6qSCSCNw8dHPygotnJoomkd7WtdnM9TYk-CuM6XcAHAQ' push --relay https://relay:7443 deploy --id hist2 agent/app container-test-run-flakelet-relay> » job 6a239dbf87cfec796e49404c351d787f via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent/app | app: up to date container-test-run-flakelet-relay> agent # [2328448.290203] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:16.577615Z","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 # [2328448.290481] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:16.577983Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dce6faec8455f85321e72ee634888126\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328448.323378] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [2328448.357461] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [2328448.362668] agent flakelet[3580]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [2328448.363320] agent flakelet[3580]: app: up to date container-test-run-flakelet-relay> agent # [2328448.364678] 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> relay # [2328448.289716] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:16.577177Z","level":"INFO","message":"deploy accepted","job":"6a239dbf87cfec796e49404c351d787f","caller":"example/app","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> » agent/app: unchanged (generation 9) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MTA1NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNzU2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJJQllYQ0RJSkMyTUQyPT09IiwibmJmIjoxNzkxNDYwNzU2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.cpEVWP3i88POpVSkYOBZRKebvsWM7BJZ2ZpqubNSzH6qSCSCNw8dHPygotnJoomkd7WtdnM9TYk-CuM6XcAHAQ' push --relay https://relay:7443 deploy --id hist2 agent/app, in 1.64 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MTA1NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNzU2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJJQllYQ0RJSkMyTUQyPT09IiwibmJmIjoxNzkxNDYwNzU2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.cpEVWP3i88POpVSkYOBZRKebvsWM7BJZ2ZpqubNSzH6qSCSCNw8dHPygotnJoomkd7WtdnM9TYk-CuM6XcAHAQ' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MTQ2MTA1NiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkxNDYwNzU2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJJQllYQ0RJSkMyTUQyPT09IiwibmJmIjoxNzkxNDYwNzU2LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.cpEVWP3i88POpVSkYOBZRKebvsWM7BJZ2ZpqubNSzH6qSCSCNw8dHPygotnJoomkd7WtdnM9TYk-CuM6XcAHAQ' 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 6.05 seconds) container-test-run-flakelet-relay> subtest: dashboard login via authorization code flow container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login, in 0.09 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 30 https://relay:7443/ui/jobs/5264d66839158e0bc044f879624e966e/events || true container-test-run-flakelet-relay> relay # [2328449.908401] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:18.195812Z","level":"INFO","message":"deploy finished","job":"6a239dbf87cfec796e49404c351d787f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328449.990377] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [08/Oct/2026 11:59:18] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=Wb7xyLb-BYO4x6bt2CVA5s7gQhCfa5KZss6Qxi_cLEw&code_challenge=t5QW2ZE74Jw4aGeSSrAMMbw3krsKVVl8no1Wt4tDf8c&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> relay # [2328450.043850] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [08/Oct/2026 11:59:18] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [2328450.044622] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:18.332109Z","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 # [2328450.107853] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:18.395310Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [2328450.150763] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:18.438233Z","level":"INFO","message":"deploy accepted","job":"03c8df0e59047cfe0f8dbdf017c27ff9","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [2328449.906309] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:18.193720Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328450.150908] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:18.438369Z","level":"INFO","message":"start","id":"71daf5ca357ac51214afeb291c2d8cb0","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [2328450.151275] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:18.438772Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"71daf5ca357ac51214afeb291c2d8cb0\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328450.182776] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [2328450.212423] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [2328450.216819] agent flakelet[3605]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328450.217408] agent flakelet[3605]: other: up to date container-test-run-flakelet-relay> agent # [2328450.219938] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328450.173017] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:18.460498Z","level":"INFO","message":"job reattached","job":"03c8df0e59047cfe0f8dbdf017c27ff9","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} 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/5264d66839158e0bc044f879624e966e/events || true, in 0.61 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs/5264d66839158e0bc044f879624e966e 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/5264d66839158e0bc044f879624e966e, 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=5264d66839158e0bc044f879624e966e' | 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=5264d66839158e0bc044f879624e966e' | 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 # [2328450.757877] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:19.045287Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328450.918684] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:19.206094Z","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 # [2328450.919653] agent flakelet-agent[2929]: {"timestamp":"2026-10-08T11:59:19.206492Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [2328450.951663] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [2328450.980357] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [2328450.985639] agent flakelet[3625]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [2328450.986167] agent flakelet[3625]: other: up to date container-test-run-flakelet-relay> agent/otheragent # [2328450.988508] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> | flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [2328450.918294] relay flakelet-relay[1322]: {"timestamp":"2026-10-08T11:59:19.205741Z","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.63 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q live1 /tmp/ev.out container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q live1 /tmp/ev.out, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: dashboard login via authorization code flow, in 1.65 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 87.20 seconds) container-test-run-flakelet-relay> test script finished in 87.23s container-test-run-flakelet-relay> cleanup container-test-run-flakelet-relay> kill NspawnMachine (pid 52) container-test-run-flakelet-relay> kill NspawnMachine (pid 53) container-test-run-flakelet-relay> Container agent terminated by signal KILL. container-test-run-flakelet-relay> kill NspawnMachine (pid 54) container-test-run-flakelet-relay> Container client terminated by signal KILL. container-test-run-flakelet-relay> (finished: cleanup, in 0.34 seconds) container-test-run-flakelet-relay> additionally exposed symbols: container-test-run-flakelet-relay> agent, client, relay, container-test-run-flakelet-relay> vlan1, container-test-run-flakelet-relay> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh container-test-run-flakelet-relay> » job 11a229250ccda6eda612cf215dbd7be8 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 4fe26b23a7918b882ed4fd7bec3a6f15 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 78cd7d1290a619d25018dbb3486ad955 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 be278336742dec3412aa6ad9f0e38bee 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 d8deaf398029d880e51ff217d034439c 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 609ea263d5fba72957850b1bd98f5b35 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 d8deaf398029d880e51ff217d034439c 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> 1791460752 hist1 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1791460742 609ea263d5fba72957850b1bd98f5b35 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1791460733 7e8b27270057a8e22b53275a2fc0325c admin@example.org agent/app:updated container-test-run-flakelet-relay> 1791460717 9002340fa5188b75a1ab9b79540c2320 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1791460714 local-app-6-1791460714 root (shell) agent/app:updated container-test-run-flakelet-relay> 1791460712 local-app-5-1791460712 root (shell) agent/app:updated container-test-run-flakelet-relay> 1791460708 791bc5e433afd46cce20adcd335c0c5b admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1791460697 158dfb84263f0f039414121fa942c44e admin@example.org agent/app:updated container-test-run-flakelet-relay> 1791460697 a2208a1acef170abe491b50e03790745 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1791460696 c131076fc8d702d2898b06e859cde085 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1791460695 b6318e237f06fada81a7ef9be6057c22 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1791460691 c6b4f3ec2e369889aded69d564d49159 admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1791460690 989abc4be27a29d13b7e3a8f1a33079c dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1791460690 a4db1e62ad4c466a78181d989c8887e2 dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1791460687 5d2fbbd19d71624207c8e8958d9c890c someone agent/other:unchanged container-test-run-flakelet-relay> 1791460684 416c101bc03aa86da203a97a513cc8e1 repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1791460681 fb4385400177e60114fe25a026934271 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1791460678 local-app-1-1791460678 host activation agent/app:updated container-test-run-flakelet-relay> 1791460678 local-flakelet-agent-1-1791460678 host activation agent/flakelet-agent:updated container-test-run-flakelet-relay> 1791460678 local-other-1-1791460678 host activation agent/other:updated container-test-run-flakelet-relay> container-test-run-flakelet-relay> Container relay terminated by signal KILL. post-build step Upload coverage to codecov: ok Skipping codecov: project=Mic92/flakelet-relay attr=checks.x86_64-linux.nixos-test