these 42 derivations will be built: /nix/store/qdibbygs5533vhhkh9cdj7534xl102bs-push.drv /nix/store/r5nv207mwxl7pj26s9frij9clkl4p1mb-system-path.drv /nix/store/27vdbzr25w4s8iwm60glb6y3z8y2nv7l-dbus-1.drv /nix/store/3vbwsxgixjj6vg052mfgj3bxvrxrl9xv-X-Restart-Triggers-dbus-broker.drv /nix/store/808svx096gchh65nv6alinf179nhi2bl-unit-dbus-broker.service.drv /nix/store/23haxmx983ic7il29pqk8z1fkfb0xpdh-system-units.drv /nix/store/npz35cblx7w3pw3ns25rl9l8n7k26cl6-flakelet-relay.json.drv /nix/store/wz0chglh9wapchkd3nr5w18q4b41aki7-flakelet-relay.service.drv /nix/store/in5q13fcqia5dccdhy9qpd1krbp338qd-flakelet-flakelet-relay-units.drv /nix/store/29ff76j2lbzxxq21d4z1gissc006a6qn-flakelet-flakelet-relay.drv /nix/store/c50nzlbyya5y3p401vb4dz7prcln4pvi-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/2d0aqyzxq0r4yc8g4zgkxvb0ajx02pbb-unit-flakelet-flakelet-relay.service.drv /nix/store/wz62ka6dc55bx996na8rs8hb8l6vf3v1-unit-dbus-broker.service.drv /nix/store/2xij1sz42i6aqj5lyr6564zfbmim4cxn-user-units.drv /nix/store/slbvl2qh26zvd6fbgmyb31z6addli1iz-flakelet-config.json.drv /nix/store/w6lvrwinqlrmyj3lz3977jk8fc81k2yr-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/mkv30p97hrzypa3xvk6r3mbaprlh2019-unit-flakelet-reconcile.service.drv /nix/store/3fca6pik56z5gvql9vgfqf90dgcjqhin-system-units.drv /nix/store/3i7qh0zgnk024zw9rvlj4kc7vz63pacx-flakelet-agent.service.drv /nix/store/lwdszc57kdhwinqwz21cjs0c8rqzfnhg-flakelet-flakelet-agent-units.drv /nix/store/4j5h5xaw29grwdsjqkg1v9h5a74bh8sz-flakelet-flakelet-agent.drv /nix/store/zin6pdnq63m8rdpvgczhk7alwz94qfyi-flakelet-config.json.drv /nix/store/qra0iwh00iz72ch63qxncn7fnxz5l4ps-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/3l7b75ivmwx6bi97cmib1n9wawvhsb4l-unit-flakelet-reconcile.service.drv /nix/store/yvgd7iigclv9mjmiskznphlwfmj8mn0h-etc.drv /nix/store/3pj5q6n1l1ki9lj3hlqrqpzpkdb3iv7g-activate.drv /nix/store/jwbinvzcfcirg4036wdc0226dh6nckfz-etc.drv /nix/store/zf3zp32pilnxz1jxgr52wf5wkshlfix4-activate.drv /nix/store/ygc37bl4xyh7s3kji3fl4ji0nrkxddzn-nixos-system-relay-test.drv /nix/store/c9j96r3iggffl2ixny951mkaigb27jb2-run-relay-nspawn.drv /nix/store/wad42b4f4r63yyyfrg1l2lgxj78frkm3-nixos-system-client-test.drv /nix/store/rzpyd6pll1bai1wnbv1ilkq4swpl552m-run-client-nspawn.drv /nix/store/r6xxh59gbzbpkv3z73c92hp5c3ba2v16-X-Restart-Triggers-flakelet-flakelet-agent.drv /nix/store/jv53gfmdc0yfh7rg1sdcjjfpx911yb9i-unit-flakelet-flakelet-agent.service.drv /nix/store/8q9jvqfyqzsq0xplq5386z0j5k1cjaka-system-units.drv /nix/store/df0wggphq9qjm2dy57s4cwc328k9h9d3-etc.drv /nix/store/yyccxdd6727flrxk8zahy4kb0xs3vgqw-activate.drv /nix/store/z1zacni20b7pgwyg6b70lwq4nfckavl3-nixos-system-agent-test.drv /nix/store/xv4rk1vdvwdwz8qgjrhznnyrlq31qzhi-run-agent-nspawn.drv /nix/store/cxq684m6bk0xj9x74vsdghngdvzm800x-driverConfiguration.json.drv /nix/store/fd7ppiw3bclhx8rlq04jzqiz1zgjrv5z-nixos-test-driver-flakelet-relay.drv /nix/store/4p4pw16gxrl8wnc214d587b7w0p791gr-container-test-run-flakelet-relay.drv building '/nix/store/qdibbygs5533vhhkh9cdj7534xl102bs-push.drv' building '/nix/store/r6xxh59gbzbpkv3z73c92hp5c3ba2v16-X-Restart-Triggers-flakelet-flakelet-agent.drv' building '/nix/store/c50nzlbyya5y3p401vb4dz7prcln4pvi-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/3i7qh0zgnk024zw9rvlj4kc7vz63pacx-flakelet-agent.service.drv' X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/npz35cblx7w3pw3ns25rl9l8n7k26cl6-flakelet-relay.json.drv' flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> tribuchet: building on jamie building '/nix/store/jv53gfmdc0yfh7rg1sdcjjfpx911yb9i-unit-flakelet-flakelet-agent.service.drv' unit-flakelet-flakelet-agent.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/r5nv207mwxl7pj26s9frij9clkl4p1mb-system-path.drv' building '/nix/store/2d0aqyzxq0r4yc8g4zgkxvb0ajx02pbb-unit-flakelet-flakelet-relay.service.drv' system-path> tribuchet: building on jamie unit-flakelet-flakelet-relay.service> tribuchet: building on jamie building '/nix/store/wz0chglh9wapchkd3nr5w18q4b41aki7-flakelet-relay.service.drv' flakelet-relay.service> tribuchet: building on jamie building '/nix/store/lwdszc57kdhwinqwz21cjs0c8rqzfnhg-flakelet-flakelet-agent-units.drv' flakelet-flakelet-agent-units> tribuchet: building on jamie building '/nix/store/in5q13fcqia5dccdhy9qpd1krbp338qd-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie unit-flakelet-flakelet-agent.service> structuredAttrs is enabled unit-flakelet-flakelet-relay.service> structuredAttrs is enabled building '/nix/store/4j5h5xaw29grwdsjqkg1v9h5a74bh8sz-flakelet-flakelet-agent.drv' flakelet-flakelet-agent> tribuchet: building on jamie system-path> structuredAttrs is enabled building '/nix/store/29ff76j2lbzxxq21d4z1gissc006a6qn-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie system-path> created 6399 symlinks in user environment building '/nix/store/zin6pdnq63m8rdpvgczhk7alwz94qfyi-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/slbvl2qh26zvd6fbgmyb31z6addli1iz-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled flakelet-config.json> structuredAttrs is enabled building '/nix/store/qra0iwh00iz72ch63qxncn7fnxz5l4ps-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/27vdbzr25w4s8iwm60glb6y3z8y2nv7l-dbus-1.drv' building '/nix/store/w6lvrwinqlrmyj3lz3977jk8fc81k2yr-X-Restart-Triggers-flakelet-reconcile.drv' dbus-1> tribuchet: building on jamie X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/3l7b75ivmwx6bi97cmib1n9wawvhsb4l-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/mkv30p97hrzypa3xvk6r3mbaprlh2019-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/3vbwsxgixjj6vg052mfgj3bxvrxrl9xv-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie building '/nix/store/8q9jvqfyqzsq0xplq5386z0j5k1cjaka-system-units.drv' system-units> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/3fca6pik56z5gvql9vgfqf90dgcjqhin-system-units.drv' system-units> tribuchet: building on jamie building '/nix/store/808svx096gchh65nv6alinf179nhi2bl-unit-dbus-broker.service.drv' building '/nix/store/wz62ka6dc55bx996na8rs8hb8l6vf3v1-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/23haxmx983ic7il29pqk8z1fkfb0xpdh-system-units.drv' building '/nix/store/2xij1sz42i6aqj5lyr6564zfbmim4cxn-user-units.drv' system-units> tribuchet: building on jamie user-units> tribuchet: building on jamie building '/nix/store/df0wggphq9qjm2dy57s4cwc328k9h9d3-etc.drv' etc> tribuchet: building on jamie building '/nix/store/jwbinvzcfcirg4036wdc0226dh6nckfz-etc.drv' etc> tribuchet: building on jamie building '/nix/store/yvgd7iigclv9mjmiskznphlwfmj8mn0h-etc.drv' etc> tribuchet: building on jamie building '/nix/store/yyccxdd6727flrxk8zahy4kb0xs3vgqw-activate.drv' activate> tribuchet: building on jamie building '/nix/store/zf3zp32pilnxz1jxgr52wf5wkshlfix4-activate.drv' activate> tribuchet: building on jamie building '/nix/store/z1zacni20b7pgwyg6b70lwq4nfckavl3-nixos-system-agent-test.drv' building '/nix/store/3pj5q6n1l1ki9lj3hlqrqpzpkdb3iv7g-activate.drv' nixos-system-agent-test> tribuchet: building on jamie activate> tribuchet: building on jamie building '/nix/store/ygc37bl4xyh7s3kji3fl4ji0nrkxddzn-nixos-system-relay-test.drv' nixos-system-relay-test> tribuchet: building on jamie nixos-system-agent-test> structuredAttrs is enabled nixos-system-relay-test> structuredAttrs is enabled building '/nix/store/wad42b4f4r63yyyfrg1l2lgxj78frkm3-nixos-system-client-test.drv' building '/nix/store/xv4rk1vdvwdwz8qgjrhznnyrlq31qzhi-run-agent-nspawn.drv' nixos-system-client-test> tribuchet: building on jamie run-agent-nspawn> tribuchet: building on jamie building '/nix/store/c9j96r3iggffl2ixny951mkaigb27jb2-run-relay-nspawn.drv' run-relay-nspawn> tribuchet: building on jamie nixos-system-client-test> structuredAttrs is enabled building '/nix/store/rzpyd6pll1bai1wnbv1ilkq4swpl552m-run-client-nspawn.drv' run-client-nspawn> tribuchet: building on jamie building '/nix/store/cxq684m6bk0xj9x74vsdghngdvzm800x-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/fd7ppiw3bclhx8rlq04jzqiz1zgjrv5z-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/4p4pw16gxrl8wnc214d587b7w0p791gr-container-test-run-flakelet-relay.drv' container-test-run-flakelet-relay> tribuchet: building on jamie container-test-run-flakelet-relay> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-flakelet-relay> start all VLans container-test-run-flakelet-relay> (finished: start all VLans, in 0.00 seconds) container-test-run-flakelet-relay> Initializing machine ID from random generator. container-test-run-flakelet-relay> Test will time out and terminate in 3600.0 seconds container-test-run-flakelet-relay> run the VM test script container-test-run-flakelet-relay> start all VMs container-test-run-flakelet-relay> agent: systemd-nspawn running (pid 52) container-test-run-flakelet-relay> client: systemd-nspawn running (pid 53) container-test-run-flakelet-relay> agent: Waiting for journal at /build/vm-state-agent/var/log/journal... container-test-run-flakelet-relay> relay: systemd-nspawn running (pid 54) container-test-run-flakelet-relay> client: Waiting for journal at /build/vm-state-client/var/log/journal... container-test-run-flakelet-relay> relay: Waiting for journal at /build/vm-state-relay/var/log/journal... container-test-run-flakelet-relay> (finished: start all VMs, in 0.00 seconds) container-test-run-flakelet-relay> relay: waiting for unit flakelet-relay.service container-test-run-flakelet-relay> nixos-nspawn(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(client): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(client): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(relay): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(relay): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> ░ Spawning container agent on /build/vm-state-agent. container-test-run-flakelet-relay> ░ Spawning container relay on /build/vm-state-relay. container-test-run-flakelet-relay> ░ Spawning container client on /build/vm-state-client. container-test-run-flakelet-relay> client # No journal files were found. container-test-run-flakelet-relay> agent # No journal files were found. container-test-run-flakelet-relay> client # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> agent # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> relay # No journal files were found. container-test-run-flakelet-relay> relay # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> agent # [1723851.245481] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [1723851.245176] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [1723851.245527] agent systemd-journald[57]: Runtime Journal (/run/log/journal/8a23f6918f2842b7a1325529ab8fd3ff) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [1723851.245268] client systemd-journald[57]: Runtime Journal (/run/log/journal/125b7360224649de8f8833124882641c) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [1723851.256097] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [1723851.256216] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [1723851.268796] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [1723851.268907] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [1723851.283093] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [1723851.283933] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [1723851.283804] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [1723851.284521] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> agent # [1723851.315463] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/8a23f6918f2842b7a1325529ab8fd3ff is 1.763ms for 6 entries. container-test-run-flakelet-relay> client # [1723851.316024] client systemd-journald[57]: Time spent on flushing to /var/log/journal/125b7360224649de8f8833124882641c is 1.629ms for 6 entries. container-test-run-flakelet-relay> agent # [1723851.315463] agent systemd-journald[57]: System Journal (/var/log/journal/8a23f6918f2842b7a1325529ab8fd3ff) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [1723851.316024] client systemd-journald[57]: System Journal (/var/log/journal/125b7360224649de8f8833124882641c) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [1723851.326560] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> client # [1723851.324518] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [1723851.327503] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> client # [1723851.325293] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> agent # [1723851.327636] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> client # [1723851.325423] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [1723851.341652] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> client # [1723851.341684] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> agent # [1723851.397709] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [1723851.427398] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [1723852.244863] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [1723851.245273] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> relay # [1723851.245316] relay systemd-journald[57]: Runtime Journal (/run/log/journal/d6e8da749ec6486b88d23a29fca07a93) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [1723851.256207] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> relay # [1723851.269035] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> relay # [1723851.283549] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> relay # [1723851.284109] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [1723851.316195] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/d6e8da749ec6486b88d23a29fca07a93 is 1.728ms for 6 entries. container-test-run-flakelet-relay> relay # [1723851.316195] relay systemd-journald[57]: System Journal (/var/log/journal/d6e8da749ec6486b88d23a29fca07a93) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [1723851.324359] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [1723851.325040] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [1723851.325193] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [1723851.343393] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [1723851.427396] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [1723852.290645] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> agent # [1723852.291635] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> agent # [1723852.292569] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [1723852.293833] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [1723852.293863] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [1723852.294815] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> agent # [1723852.295639] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [1723852.314096] 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 # [1723852.314524] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [1723852.314836] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/8a23f6918f2842b7a1325529ab8fd3ff failed: Operation not permitted container-test-run-flakelet-relay> agent # [1723852.315177] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [1723852.272813] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [1723852.304485] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [1723852.305719] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [1723852.307116] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [1723852.308478] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [1723852.308529] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [1723852.309714] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [1723852.310550] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> client # [1723852.327087] 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 # [1723852.327513] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [1723852.327831] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/125b7360224649de8f8833124882641c failed: Operation not permitted container-test-run-flakelet-relay> client # [1723852.328182] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [1723852.272665] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [1723852.303737] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> relay # [1723852.304848] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [1723852.306111] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [1723852.307350] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [1723852.307395] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [1723852.308619] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [1723852.309731] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> relay # [1723852.328590] relay suid-sgid-wrappers-start[176]: chmod: changing permissions of '/run/wrappers/wrappers.ejdB40EQhi/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [1723852.328733] 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 # [1723852.329137] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [1723852.329438] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/d6e8da749ec6486b88d23a29fca07a93 failed: Operation not permitted container-test-run-flakelet-relay> relay # [1723852.329773] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [1723852.317726] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [1723852.320058] agent suid-sgid-wrappers-start[169]: chmod: changing permissions of '/run/wrappers/wrappers.KEiSvCTjjp/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [1723852.330724] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [1723852.330826] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [1723852.330947] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [1723852.332833] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [1723852.333553] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> agent # [1723852.345826] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [1723852.351190] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [1723852.352221] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [1723852.360787] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [1723852.360882] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [1723852.360950] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [1723852.361015] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [1723852.361030] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [1723852.361132] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [1723852.361316] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [1723852.361418] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [1723852.361436] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [1723852.361462] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [1723852.362639] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [1723852.363366] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [1723852.364353] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [1723852.365196] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [1723852.382865] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [1723852.383142] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [1723852.399389] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [1723852.441533] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723852.442897] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [1723852.443104] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [1723852.466972] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723852.489328] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [1723852.491144] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [1723852.492022] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [1723852.493426] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [1723852.494459] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [1723852.495494] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [1723852.334043] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [1723852.334102] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [1723852.334156] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [1723852.382813] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [1723852.436458] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723852.457734] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [1723852.461558] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [1723852.462273] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [1723852.499637] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [1723852.505733] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [1723852.506860] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [1723852.516994] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [1723852.517097] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [1723852.517164] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [1723852.517193] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [1723852.517208] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [1723852.517382] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [1723852.517567] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [1723852.517663] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [1723852.517678] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [1723852.517711] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [1723852.518837] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [1723852.519965] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [1723852.520604] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [1723852.521304] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [1723852.521882] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [1723852.333500] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.QCqey5DOPC/chsh': Operation not permitted container-test-run-flakelet-relay> client # [1723852.334618] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [1723852.334659] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [1723852.334720] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> client # [1723852.383343] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [1723852.437052] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [1723852.457678] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [1723852.461822] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [1723852.462542] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [1723852.499660] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [1723852.506656] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [1723852.507587] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [1723852.516217] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [1723852.516307] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [1723852.516384] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [1723852.516409] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [1723852.516421] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [1723852.516511] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [1723852.516717] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [1723852.516805] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [1723852.516816] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [1723852.516843] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [1723852.517913] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [1723852.518719] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [1723852.519548] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [1723852.514317] agent network-addresses-eth1-start[240]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [1723852.516973] agent network-addresses-eth1-start[240]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [1723852.524029] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [1723852.571486] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [1723852.571619] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [1723852.572791] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [1723852.573666] agent systemd[1]: Starting Update flakelet service flakelet-agent... container-test-run-flakelet-relay> agent # [1723852.574551] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [1723852.603488] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723852.603628] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [1723852.606259] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [1723852.609252] agent flakelet[304]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1723852.610019] agent flakelet[304]: app: activating generation 1 container-test-run-flakelet-relay> agent # [1723852.610474] agent flakelet[305]: flakelet-agent: using prebuilt artifact /nix/store/8gmz5zba6lay17v169gpspnl6hpp20cc-flakelet-flakelet-agent container-test-run-flakelet-relay> agent # [1723852.611124] agent flakelet[305]: flakelet-agent: activating generation 1 container-test-run-flakelet-relay> agent # [1723852.611159] agent flakelet[306]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1723852.611731] agent flakelet[306]: other: activating generation 1 container-test-run-flakelet-relay> agent # [1723852.615566] agent systemd[1]: Reload requested from client PID 311 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [1723852.615608] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1723852.533326] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [1723852.534168] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [1723852.539488] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [1723852.544853] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> relay # [1723852.609224] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723852.609336] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [1723852.611710] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [1723852.613389] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [1723852.613470] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [1723852.614306] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [1723852.615394] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [1723852.635735] relay network-addresses-eth1-start[250]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [1723852.639224] relay network-addresses-eth1-start[250]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [1723852.642950] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> relay # [1723852.676207] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [1723852.676857] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [1723852.678220] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [1723852.679069] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [1723852.679847] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [1723852.690659] relay flakelet[311]: flakelet-relay: using prebuilt artifact /nix/store/wbx0xkmz8zl4wd6vpxi380v674046r7l-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [1723852.691310] relay flakelet[311]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [1723852.694941] relay systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [1723852.694973] relay systemd[1]: Reloading... container-test-run-flakelet-relay> client # [1723852.536657] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> client # [1723852.609623] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [1723852.609740] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [1723852.612240] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [1723852.614765] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> client # [1723852.614900] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [1723852.616027] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> client # [1723852.616704] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [1723852.636253] client network-addresses-eth1-start[237]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> client # [1723852.639538] client network-addresses-eth1-start[237]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [1723852.644209] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [1723852.691405] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [1723852.691533] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> client # [1723852.723795] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [1723852.723965] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [1723852.726603] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [1723853.034750] relay nsncd[248]: Oct 01 12:02:41.322 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [1723853.116751] relay systemd[1]: Reloading finished in 421 ms. container-test-run-flakelet-relay> relay # [1723853.255061] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [1723853.255994] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [1723853.256048] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [1723853.257371] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [1723853.258323] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [1723853.268951] relay systemd[1]: Reload requested from client PID 357 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [1723853.269028] relay systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723853.060869] agent nsncd[310]: Oct 01 12:02:41.348 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [1723853.137354] agent systemd[1]: Reloading finished in 521 ms. container-test-run-flakelet-relay> agent # [1723853.258121] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [1723853.258697] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [1723853.258747] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [1723853.013298] client nsncd[303]: Oct 01 12:02:41.300 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [1723853.013304] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [1723853.013392] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [1723853.013504] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [1723853.026296] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [1723853.027733] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [1723853.066679] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [1723853.068420] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [1723853.068473] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [1723853.068501] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [1723853.383242] relay dnsmasq-pre-start[376]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> relay # [1723853.637460] relay systemd[1]: Reloading finished in 367 ms. container-test-run-flakelet-relay> relay # [1723853.747273] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [1723853.772559] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [1723853.772632] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [1723853.772706] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [1723853.774796] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [1723853.642179] agent systemd[1]: Reloading finished in 382 ms. container-test-run-flakelet-relay> agent # [1723853.750385] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [1723853.750435] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723854.113483] agent systemd[1]: Reloading finished in 362 ms. container-test-run-flakelet-relay> agent # [1723854.186138] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [1723854.186260] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [1723854.187630] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [1723854.188821] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [1723854.193815] agent systemd[1]: Reload requested from client PID 405 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [1723854.193844] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1723854.260354] relay nginx-pre-start[402]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [1723854.261178] relay nginx-pre-start[402]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [1723854.277516] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> relay # [1723854.388321] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [1723854.481657] client systemd-logind[315]: New seat seat0. container-test-run-flakelet-relay> client # [1723854.484066] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [1723854.484201] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [1723854.485791] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [1723854.524215] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [1723854.524569] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [1723854.524916] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> agent # [1723854.587046] agent systemd[1]: Reloading finished in 392 ms. container-test-run-flakelet-relay> agent # [1723854.665561] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [1723854.671850] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [1723854.671955] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [1723854.672080] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [1723854.673169] agent systemd[1]: Reload requested from client PID 408 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [1723854.673197] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1723854.735970] relay systemd-logind[355]: New seat seat0. container-test-run-flakelet-relay> relay # [1723854.736623] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [1723854.739111] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [1723854.786342] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723854.786564] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> relay # [1723854.942121] relay dbus-broker-launch[408]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [1723854.943323] relay dbus-broker-launch[408]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [1723854.943323] relay dbus-broker-launch[408]: 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 # [1723854.944428] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [1723854.952627] relay dbus-broker-launch[408]: Ready container-test-run-flakelet-relay> relay # [1723854.955917] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> relay # [1723854.957867] relay dnsmasq[394]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [1723854.957874] 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 # [1723854.957879] relay dnsmasq[394]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [1723854.957894] relay dnsmasq[394]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [1723854.958071] relay dnsmasq[394]: read /etc/hosts - 9 names container-test-run-flakelet-relay> client # [1723855.006889] client dbus-broker-launch[325]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [1723855.008617] client dbus-broker-launch[325]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [1723855.008617] client dbus-broker-launch[325]: Invalid user-name in /nix/store/x1rrw8knvin4icqibc7xffvwca30qrd2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [1723855.009625] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [1723855.010139] client systemd[1]: Startup finished in 4.189s. container-test-run-flakelet-relay> client # [1723855.014742] client dbus-broker-launch[325]: Ready container-test-run-flakelet-relay> agent # [1723855.017042] agent systemd[1]: Reloading finished in 343 ms. container-test-run-flakelet-relay> agent # [1723855.092566] agent systemd[1]: Reload requested from client PID 444 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [1723855.092609] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723855.428532] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1723855.497042] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1723855.499238] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [1723855.524010] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [1723855.527666] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [1723855.528509] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [1723855.546655] agent flakelet[304]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [1723855.547297] agent flakelet[306]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [1723855.549696] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [1723855.550044] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [1723855.577690] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:43.865117Z","level":"INFO","message":"local change","flakelet":"app","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723855.578231] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:43.865403Z","level":"INFO","message":"local change","flakelet":"other","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723855.578161] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [1723855.580060] agent systemd-logind[406]: New seat seat0. container-test-run-flakelet-relay> agent # [1723855.580788] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [1723855.580855] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [1723855.581749] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [1723855.582334] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:43.869813Z","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 # [1723855.583828] agent flakelet[305]: flakelet-agent: updated to generation 1 container-test-run-flakelet-relay> agent # [1723855.603194] agent systemd[1]: Finished Update flakelet service flakelet-agent. container-test-run-flakelet-relay> agent # [1723855.604588] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> agent # [1723855.614061] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723855.614203] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [1723855.615370] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> agent # [1723855.616615] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:43.904108Z","level":"INFO","message":"local change","flakelet":"flakelet-agent","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1723855.782168] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:44.069390Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1723855.783097] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:44.070019Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1723855.782778] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [1723855.792959] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> agent # [1723856.025895] agent dbus-broker-launch[900]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [1723856.027734] agent dbus-broker-launch[900]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [1723856.027734] agent dbus-broker-launch[900]: 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 # [1723856.028746] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [1723856.029179] agent systemd[1]: Startup finished in 5.208s. container-test-run-flakelet-relay> agent # [1723856.035041] agent dbus-broker-launch[900]: Ready container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 6.17 seconds) container-test-run-flakelet-relay> relay: waiting for unit nginx.service container-test-run-flakelet-relay> relay: (finished: waiting for unit nginx.service, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet.target container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet.target, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet-agent.service container-test-run-flakelet-relay> relay # [1723856.060777] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723856.061170] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay # [1723856.070655] relay flakelet[311]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [1723856.073113] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [1723856.073677] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [1723856.073852] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [1723856.074158] relay systemd[1]: Startup finished in 5.253s. 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 # [1723857.601715] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:45.889176Z","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 # [1723857.602239] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:45.889616Z","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 # [1723858.593785] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:46.881203Z","level":"INFO","message":"start","id":"a28fcd5be759e06609b3c84f7d360b7e","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723858.594712] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:46.882199Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"a28fcd5be759e06609b3c84f7d360b7e\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723858.639997] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723858.668251] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723858.673059] agent flakelet[926]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [1723858.673759] agent flakelet[926]: app: activating generation 2 container-test-run-flakelet-relay> agent # [1723858.692266] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1723858.693956] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723858.694240] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1723858.712550] agent systemd[1]: Reload requested from client PID 933 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723858.712616] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1723858.593077] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:46.880415Z","level":"INFO","message":"deploy accepted","job":"2182b9b6e9f48b1a28ed7d4ee7b499f5","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723859.057787] agent systemd[1]: Reloading finished in 344 ms. container-test-run-flakelet-relay> agent # [1723859.149404] agent systemd[1]: Reload requested from client PID 963 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723859.149442] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723859.496427] agent systemd[1]: Reloading finished in 346 ms. container-test-run-flakelet-relay> agent # [1723859.581513] agent systemd[1]: Reload requested from client PID 992 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723859.581551] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723859.913359] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [1723860.008814] agent systemd[1]: Reload requested from client PID 1026 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723860.008848] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723860.333021] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [1723860.401584] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [1723860.433143] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [1723860.439504] agent flakelet[926]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [1723860.441994] 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.99 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.07 seconds) container-test-run-flakelet-relay> subtest: deploy with OIDC token, sub principal container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.08 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ2OSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MTY5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPWEMyVEhUSE9TWENTPT09IiwibmJmIjoxNzkwODU2MTY5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.31C1AbjGQ1PjCqWbPy2JcplSllhqRKBvpYGKgD93YicOxNbi1TlaWtWS9BDWBoqPub9gWkcNRx0ha_wUolAoAw' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> agent # [1723861.549590] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:49.837037Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723861.744455] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:50.031858Z","level":"INFO","message":"start","id":"6b7675a44a871885733bdf462ad2e2c8","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 # [1723861.745135] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:50.032622Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"6b7675a44a871885733bdf462ad2e2c8\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723861.784871] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> relay # [1723861.551861] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:49.839261Z","level":"INFO","message":"deploy finished","job":"2182b9b6e9f48b1a28ed7d4ee7b499f5","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723861.744030] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:50.031478Z","level":"INFO","message":"deploy accepted","job":"32680449f6d1b4bd66ad8eac06e13039","caller":"repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723861.814218] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723861.818223] agent flakelet[1096]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1723861.818858] agent flakelet[1096]: app: activating generation 3 container-test-run-flakelet-relay> agent # [1723861.832289] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [1723861.832735] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723861.832996] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [1723861.849634] agent systemd[1]: Reload requested from client PID 1103 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723861.849701] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723862.181707] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [1723862.248139] agent systemd[1]: Reload requested from client PID 1133 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723862.248173] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723862.569447] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [1723862.646615] agent systemd[1]: Reload requested from client PID 1162 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723862.646654] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723862.966279] agent systemd[1]: Reloading finished in 319 ms. container-test-run-flakelet-relay> agent # [1723863.031942] agent systemd[1]: Reload requested from client PID 1193 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723863.031974] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723863.353414] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [1723863.416425] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1723863.448200] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [1723863.454131] agent flakelet[1096]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [1723863.456088] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ2OSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MTY5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPWEMyVEhUSE9TWENTPT09IiwibmJmIjoxNzkwODU2MTY5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.31C1AbjGQ1PjCqWbPy2JcplSllhqRKBvpYGKgD93YicOxNbi1TlaWtWS9BDWBoqPub9gWkcNRx0ha_wUolAoAw' push --relay https://relay:7443 deploy agent/app 2>&1, in 2.86 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 2.95 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ2OSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MTY5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPWEMyVEhUSE9TWENTPT09IiwibmJmIjoxNzkwODU2MTY5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.31C1AbjGQ1PjCqWbPy2JcplSllhqRKBvpYGKgD93YicOxNbi1TlaWtWS9BDWBoqPub9gWkcNRx0ha_wUolAoAw' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ2OSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MTY5LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPWEMyVEhUSE9TWENTPT09IiwibmJmIjoxNzkwODU2MTY5LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.31C1AbjGQ1PjCqWbPy2JcplSllhqRKBvpYGKgD93YicOxNbi1TlaWtWS9BDWBoqPub9gWkcNRx0ha_wUolAoAw' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ3MiwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MDg1NjE3MiwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiUVAzN0dPTldTMk5NRz09PSIsIm5iZiI6MTc5MDg1NjE3Miwic3ViIjoic29tZW9uZSJ9.PLM7jtjh7ORPyy1bTo-2rQgX_P5mTeQ5gtESu1ZAob_0A2ETkrPmmruzRsrSgs3iFGknm9Ph1KVcDgelg-sCDw' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [1723864.569053] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:52.856457Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723864.680436] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:52.967886Z","level":"INFO","message":"start","id":"4b28bf8598d0cacecfb304f56df95d36","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"someone\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723864.680793] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:52.968295Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"4b28bf8598d0cacecfb304f56df95d36\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723864.722773] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1723864.744152] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1723864.749231] agent flakelet[1247]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1723864.749876] agent flakelet[1247]: other: up to date container-test-run-flakelet-relay> agent # [1723864.750942] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723864.570869] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:52.858290Z","level":"INFO","message":"deploy finished","job":"32680449f6d1b4bd66ad8eac06e13039","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723864.680074] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:52.967501Z","level":"INFO","message":"deploy accepted","job":"e07b87d486aabab3a00e3ca448324d9d","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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ3MiwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MDg1NjE3MiwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiUVAzN0dPTldTMk5NRz09PSIsIm5iZiI6MTc5MDg1NjE3Miwic3ViIjoic29tZW9uZSJ9.PLM7jtjh7ORPyy1bTo-2rQgX_P5mTeQ5gtESu1ZAob_0A2ETkrPmmruzRsrSgs3iFGknm9Ph1KVcDgelg-sCDw' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 0.70 seconds) container-test-run-flakelet-relay> subtest: push login via device flow, cached token used afterwards container-test-run-flakelet-relay> client: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1 container-test-run-flakelet-relay> agent # [1723865.291461] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:53.578877Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1723865.293273] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:53.580675Z","level":"INFO","message":"deploy finished","job":"e07b87d486aabab3a00e3ca448324d9d","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723865.318606] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [01/Oct/2026 12:02:53] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [1723866.324386] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [01/Oct/2026 12:02:54] "POST /token HTTP/1.1" 400 - container-test-run-flakelet-relay> client: (finished: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1, in 2.08 seconds) container-test-run-flakelet-relay> client: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600 container-test-run-flakelet-relay> client: (finished: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [1723867.377148] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [01/Oct/2026 12:02:55] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [1723867.409400] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:55.696819Z","level":"INFO","message":"deploy accepted","job":"dd187ae91d334d65fcdbe2934caa76a7","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723867.409865] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:55.697289Z","level":"INFO","message":"start","id":"14a04a7c0aed7dd0d6dd615dd41c9741","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723867.410507] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:55.697994Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"14a04a7c0aed7dd0d6dd615dd41c9741\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723867.452112] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1723867.487308] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1723867.492275] agent flakelet[1271]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1723867.492891] agent flakelet[1271]: other: up to date container-test-run-flakelet-relay> agent # [1723867.495499] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.65 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [1723868.032667] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:56.320091Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723868.055832] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:56.343277Z","level":"INFO","message":"start","id":"0cad17a4b96cf5a89daa1b66d2f487f9","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723868.056189] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:56.343679Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"0cad17a4b96cf5a89daa1b66d2f487f9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723868.096389] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1723868.126202] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1723868.131260] agent flakelet[1295]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1723868.131846] agent flakelet[1295]: other: up to date container-test-run-flakelet-relay> agent # [1723868.134886] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723868.034633] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:56.321988Z","level":"INFO","message":"deploy finished","job":"dd187ae91d334d65fcdbe2934caa76a7","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723868.055557] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:56.343035Z","level":"INFO","message":"deploy accepted","job":"cabc407d70cac9042458cbf192f57994","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 3.38 seconds) container-test-run-flakelet-relay> subtest: waves: failing first wave skips the second container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave agent/other 2>&1 container-test-run-flakelet-relay> relay # [1723868.676366] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:56.963769Z","level":"INFO","message":"deploy finished","job":"cabc407d70cac9042458cbf192f57994","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723868.713774] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:02:57.001233Z","level":"INFO","message":"deploy accepted","job":"d2d4a82bbd3d9278f4b0b8f6d5bad684","caller":"admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723868.674470] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:56.961882Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723868.714141] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:57.001572Z","level":"INFO","message":"start","id":"a558cee25d7520a691a4bcdd5bf4f10b","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723868.714639] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:02:57.002128Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"a558cee25d7520a691a4bcdd5bf4f10b\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723868.755531] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723868.787218] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723868.792296] agent flakelet[1318]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [1723868.793073] agent flakelet[1318]: app: activating generation 4 container-test-run-flakelet-relay> agent # [1723868.810716] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1723868.812551] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723868.812887] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1723868.828781] agent systemd[1]: Reload requested from client PID 1325 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723868.828843] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723869.167311] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [1723869.239425] agent systemd[1]: Reload requested from client PID 1355 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723869.239458] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723869.562319] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [1723869.639523] agent systemd[1]: Reload requested from client PID 1386 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723869.639555] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723869.977224] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [1723870.066054] agent systemd[1]: Reload requested from client PID 1419 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723870.066090] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723870.388370] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [1723870.448938] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [1723870.477561] agent (nonexistent)[1449]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [1723870.477583] agent (nonexistent)[1449]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [1723870.479279] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [1723870.479394] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [1723870.479746] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [1723870.509601] agent systemd[1]: Reload requested from client PID 1455 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723870.509638] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723870.833288] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [1723870.899559] agent systemd[1]: Reload requested from client PID 1485 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723870.899595] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723871.220630] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [1723871.282595] agent systemd[1]: Reload requested from client PID 1515 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723871.282632] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723871.601764] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [1723871.676925] agent systemd[1]: Reload requested from client PID 1548 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723871.676962] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723872.004077] agent systemd[1]: Reloading finished in 326 ms. container-test-run-flakelet-relay> agent # [1723872.091238] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1723872.122171] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [1723872.123362] agent flakelet[1318]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [1723872.123362] agent flakelet[1318]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [1723872.125835] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [1723872.125936] 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.14 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.17 seconds) container-test-run-flakelet-relay> subtest: host patterns expand on the relay container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/app' 2>&1 container-test-run-flakelet-relay> agent # [1723872.824681] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:01.112102Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723872.881810] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:01.169287Z","level":"INFO","message":"start","id":"57a15205fbf0ae3164f44da42ebbb6ed","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723872.882140] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:01.169640Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"57a15205fbf0ae3164f44da42ebbb6ed\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723872.920073] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723872.946273] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723872.950932] agent flakelet[1605]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1723872.951537] agent flakelet[1605]: app: up to date container-test-run-flakelet-relay> agent # [1723872.953971] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723872.825996] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:01.113370Z","level":"INFO","message":"deploy finished","job":"d2d4a82bbd3d9278f4b0b8f6d5bad684","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723872.881562] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:01.169006Z","level":"INFO","message":"deploy accepted","job":"661b91ed4db5b2c891f8316bcb5c7f46","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/app' 2>&1, in 0.63 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1 container-test-run-flakelet-relay> agent # [1723873.490769] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:01.778163Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723873.516802] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:01.804232Z","level":"INFO","message":"start","id":"8ce575d40b6e7a8f42de9d497bc8baf6","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723873.517207] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:01.804695Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"8ce575d40b6e7a8f42de9d497bc8baf6\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723873.556340] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723873.584388] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723873.588757] agent flakelet[1625]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1723873.589406] agent flakelet[1625]: app: up to date container-test-run-flakelet-relay> agent # [1723873.590495] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723873.492706] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:01.780093Z","level":"INFO","message":"deploy finished","job":"661b91ed4db5b2c891f8316bcb5c7f46","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723873.516516] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:01.803934Z","level":"INFO","message":"deploy accepted","job":"06f0908f45a35ec9574e77ab9111cd2f","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> relay # [1723874.143663] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:02.431089Z","level":"INFO","message":"deploy finished","job":"06f0908f45a35ec9574e77ab9111cd2f","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723874.168603] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:02.456086Z","level":"INFO","message":"deploy accepted","job":"49facc8e316c628ad250c69a6698e862","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723874.141715] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:02.429110Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723874.168873] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:02.456342Z","level":"INFO","message":"start","id":"4fd34a2e6c5b4a4630f68d58c975d91c","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723874.169255] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:02.456745Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"4fd34a2e6c5b4a4630f68d58c975d91c\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723874.212082] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723874.243181] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723874.247887] agent flakelet[1649]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [1723874.248514] agent flakelet[1649]: app: up to date container-test-run-flakelet-relay> agent # [1723874.251605] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave '*/app' 2>&1, in 0.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.97 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 # [1723874.791562] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:03.078937Z","level":"INFO","message":"deploy finished","job":"49facc8e316c628ad250c69a6698e862","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723874.789677] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:03.077079Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1723874.856296] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:03.143724Z","level":"INFO","message":"deploy accepted","job":"384fd5f6acd648b28b41c212bd712d3f","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723874.856595] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:03.144004Z","level":"INFO","message":"start","id":"3bc3dda2004e890ffc78899bf79ab5ae","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723874.856990] agent flakelet-agent[504]: {"timestamp":"2026-10-01T12:03:03.144479Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"3bc3dda2004e890ffc78899bf79ab5ae\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723874.897978] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723874.910268] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723874.914244] agent flakelet[1673]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [1723874.914971] agent flakelet[1673]: app: activating generation 4 container-test-run-flakelet-relay> agent # [1723874.929242] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1723874.934071] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723874.934448] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1723874.950328] agent systemd[1]: Reload requested from client PID 1680 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723874.950395] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723875.282802] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [1723875.368972] agent systemd[1]: Reload requested from client PID 1710 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723875.369017] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723875.690295] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [1723875.776323] agent systemd[1]: Reload requested from client PID 1741 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723875.776359] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.35 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 # [1723876.139056] agent systemd[1]: Reloading finished in 362 ms. container-test-run-flakelet-relay> agent # [1723876.220226] agent systemd[1]: Reload requested from client PID 1775 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723876.220260] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723876.604977] agent systemd[1]: Reloading finished in 384 ms. container-test-run-flakelet-relay> agent # [1723876.698858] 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.55 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 # [1723882.742261] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [1723882.750769] agent flakelet[1673]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [1723882.753836] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723882.795653] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [1723882.829149] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723882.829421] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [1723882.829783] agent systemd[1]: flakelet-agent.service: Consumed 1.922s CPU time over 27.305s wall clock time. container-test-run-flakelet-relay> relay # [1723882.796146] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:11.083550Z","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.10 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 # [1723883.905615] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [1723883.966182] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:12.253634Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"3bc3dda2004e890ffc78899bf79ab5ae\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723883.986366] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [1723883.996710] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:12.284177Z","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 # [1723883.997904] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:12.285394Z","level":"INFO","message":"start","id":"3bc3dda2004e890ffc78899bf79ab5ae","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [1723883.996762] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:12.284201Z","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 # [1723884.509318] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:12.796757Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1723885.892835] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:14.180264Z","level":"INFO","message":"deploy accepted","job":"0d08353f29e6e4cb17109ae20a7fc31a","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723885.893346] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:14.180768Z","level":"INFO","message":"start","id":"2b3f4662640e3aa5151846e8f32826c0","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723885.894051] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:14.181493Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"2b3f4662640e3aa5151846e8f32826c0\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723885.935904] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1723885.967345] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1723885.972360] agent flakelet[2251]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1723885.972903] agent flakelet[2251]: other: up to date container-test-run-flakelet-relay> agent # [1723885.976041] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723886.512613] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:14.800041Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [1723886.514395] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:14.801797Z","level":"INFO","message":"deploy finished","job":"0d08353f29e6e4cb17109ae20a7fc31a","ok":true,"target":"flakelet_relay::relay::api"} 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ5NSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MTk1LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJCWENDRDdQUjJMNEJFPT09IiwibmJmIjoxNzkwODU2MTk1LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.DmPYq5QF4G7MCmwctuN93dDAKprM72peR1LgY2gyUUBACMppb5RjdsYOKuUnM5dNyDcMiR86wYp5DJfnUDfoBQ' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjQ5NSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MTk1LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJCWENDRDdQUjJMNEJFPT09IiwibmJmIjoxNzkwODU2MTk1LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.DmPYq5QF4G7MCmwctuN93dDAKprM72peR1LgY2gyUUBACMppb5RjdsYOKuUnM5dNyDcMiR86wYp5DJfnUDfoBQ' 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.37 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.02 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 # [1723887.224246] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [1723887.225923] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723887.226207] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [1723887.242145] agent systemd[1]: Reload requested from client PID 2285 ('systemctl')... container-test-run-flakelet-relay> agent # [1723887.242215] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723887.577990] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1723887.670326] agent systemd[1]: Reload requested from client PID 2314 ('systemctl')... container-test-run-flakelet-relay> agent # [1723887.670360] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723887.988633] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [1723888.059109] agent systemd[1]: Reload requested from client PID 2344 ('systemctl')... container-test-run-flakelet-relay> agent # [1723888.059146] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723888.378040] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [1723888.444155] agent systemd[1]: Reload requested from client PID 2375 ('systemctl')... container-test-run-flakelet-relay> agent # [1723888.444191] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723888.763416] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.67 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 # [1723888.832827] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [1723888.862144] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [1723890.013714] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:18.301146Z","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 agents | grep -q 'app@5', in 2.07 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-5- container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-5-, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app- container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.02 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 # [1723891.042519] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [1723891.043026] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723891.043286] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [1723891.062600] agent systemd[1]: Reload requested from client PID 2421 ('systemctl')... container-test-run-flakelet-relay> agent # [1723891.062666] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723891.398309] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [1723891.466567] agent systemd[1]: Reload requested from client PID 2450 ('systemctl')... container-test-run-flakelet-relay> agent # [1723891.466603] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723891.784194] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [1723891.851310] agent systemd[1]: Reload requested from client PID 2478 ('systemctl')... container-test-run-flakelet-relay> agent # [1723891.851346] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723892.169795] agent systemd[1]: Reloading finished in 318 ms. container-test-run-flakelet-relay> agent # [1723892.247974] agent systemd[1]: Reload requested from client PID 2510 ('systemctl')... container-test-run-flakelet-relay> agent # [1723892.248015] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.67 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 # [1723892.566231] agent systemd[1]: Reloading finished in 317 ms. container-test-run-flakelet-relay> agent # [1723892.646020] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [1723892.678184] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [1723894.012685] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:22.300099Z","level":"INFO","message":"local change","flakelet":"app","generation":6,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@6', in 2.07 seconds) container-test-run-flakelet-relay> (finished: subtest: out-of-band flakelet update reaches the relay without reconnect, in 7.63 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=@1790856203 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [1723894.847936] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:23.135355Z","level":"INFO","message":"start","id":"8ba5768a36dd2b9f615bfa8d3b8b10bb","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723894.848356] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:23.135852Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"8ba5768a36dd2b9f615bfa8d3b8b10bb\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723894.888610] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723894.921268] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723894.926248] agent flakelet[2560]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [1723894.926937] agent flakelet[2560]: app: activating generation 7 container-test-run-flakelet-relay> agent # [1723894.946283] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [1723894.948177] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723894.948557] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [1723894.964582] agent systemd[1]: Reload requested from client PID 2567 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723894.964651] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1723894.783139] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:23.070409Z","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 # [1723894.847563] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:23.135002Z","level":"INFO","message":"deploy accepted","job":"ed3225b6bcd6c1a051a042e28ed52369","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723895.310312] agent systemd[1]: Reloading finished in 344 ms. container-test-run-flakelet-relay> agent # [1723895.383169] agent systemd[1]: Reload requested from client PID 2597 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723895.383206] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1790856203 | grep -q 'app-slow', in 1.03 seconds) container-test-run-flakelet-relay> agent: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done container-test-run-flakelet-relay> agent: (finished: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done, in 0.02 seconds) container-test-run-flakelet-relay> relay: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done container-test-run-flakelet-relay> relay: (finished: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done, in 0.06 seconds) container-test-run-flakelet-relay> agent: must succeed: ss -K dport = 7443 container-test-run-flakelet-relay> agent: (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=@1790856203 | grep -q 'updated to generation' container-test-run-flakelet-relay> agent # [1723895.721989] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [1723895.791447] agent systemd[1]: Reload requested from client PID 2626 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723895.791484] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723895.966323] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:24.253751Z","level":"INFO","message":"disconnected: IO error: Software caused connection abort (os error 103)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [1723895.935301] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:24.222737Z","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 # [1723896.129496] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [1723896.216153] agent systemd[1]: Reload requested from client PID 2674 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723896.216188] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723896.557148] agent systemd[1]: Reloading finished in 340 ms. container-test-run-flakelet-relay> agent # [1723896.633936] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [1723896.968561] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:25.255972Z","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 # [1723898.971816] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:27.259215Z","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 # [1723902.705207] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [1723902.713021] agent flakelet[2560]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [1723902.716375] 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=@1790856203 | grep -q 'updated to generation', in 7.12 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 # [1723902.974851] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:31.262121Z","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 # [1723903.800186] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:32.087592Z","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 # [1723910.979887] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:39.267284Z","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 # [1723910.979790] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:39.267180Z","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 # [1723910.981358] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:39.268838Z","level":"INFO","message":"deploy finished","job":"ed3225b6bcd6c1a051a042e28ed52369","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723910.980997] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:39.268485Z","level":"INFO","message":"start","id":"8ba5768a36dd2b9f615bfa8d3b8b10bb","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [1723911.254326] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:39.541592Z","level":"INFO","message":"deploy accepted","job":"74c5a0dd7daa3f4e99e0d16bfd024322","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723911.254690] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:39.541964Z","level":"INFO","message":"start","id":"d139426845ee1b14f221512262181e68","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723911.255333] agent flakelet-agent[1838]: {"timestamp":"2026-10-01T12:03:39.542817Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"d139426845ee1b14f221512262181e68\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723911.297598] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723911.336270] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723911.340171] agent flakelet[2796]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [1723911.340798] agent flakelet[2796]: app: activating generation 8 container-test-run-flakelet-relay> agent # [1723911.357990] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [1723911.358473] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723911.358731] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [1723911.377209] agent systemd[1]: Reload requested from client PID 2803 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723911.377276] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723911.713063] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [1723911.793185] agent systemd[1]: Reload requested from client PID 2833 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723911.793224] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723912.114820] agent systemd[1]: Reloading finished in 321 ms. 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 # [1723912.177817] agent systemd[1]: Reload requested from client PID 2864 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723912.177849] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723912.499460] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [1723912.578201] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [1723912.586088] agent systemd[1]: Reload requested from client PID 2901 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723912.586125] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1723912.578533] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:40.865926Z","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.84 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 # [1723912.919563] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [1723912.998078] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723912.998296] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [1723912.998312] agent systemd[1]: flakelet-agent.service: Consumed 1.613s CPU time over 29.092s wall clock time. container-test-run-flakelet-relay> agent # [1723913.016905] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [1723913.017845] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [1723913.080507] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:41.367958Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"d139426845ee1b14f221512262181e68\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723913.102406] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [1723913.113449] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:41.400927Z","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 # [1723913.114712] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:41.402210Z","level":"INFO","message":"start","id":"d139426845ee1b14f221512262181e68","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [1723913.113626] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:41.401045Z","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 # [1723919.091201] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [1723919.100963] agent flakelet[2796]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [1723919.104542] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723919.676603] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:47.964017Z","level":"INFO","message":"deploy finished","job":"74c5a0dd7daa3f4e99e0d16bfd024322","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723919.674884] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:47.962315Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(8)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out, in 7.08 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/restart.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/restart.out, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: agent restart mid-run reattaches to the unit, in 9.01 seconds) container-test-run-flakelet-relay> subtest: relay restart mid-run, push resumes via /v1/jobs container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1790856228 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [1723920.274649] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:48.562068Z","level":"INFO","message":"start","id":"dabf4c2545442ed175ca77b993d8d9b8","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723920.275059] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:48.562499Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dabf4c2545442ed175ca77b993d8d9b8\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723920.315548] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723920.347301] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723920.352012] agent flakelet[3378]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [1723920.352688] agent flakelet[3378]: app: activating generation 9 container-test-run-flakelet-relay> agent # [1723920.372075] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [1723920.372544] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [1723920.372811] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [1723920.390609] agent systemd[1]: Reload requested from client PID 3385 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723920.390677] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [1723920.274322] relay flakelet-relay[400]: {"timestamp":"2026-10-01T12:03:48.561747Z","level":"INFO","message":"deploy accepted","job":"69e05243847f719237c4b6bcba4e538d","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723920.732051] agent systemd[1]: Reloading finished in 340 ms. container-test-run-flakelet-relay> agent # [1723920.814593] agent systemd[1]: Reload requested from client PID 3415 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723920.814631] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1790856228 | 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 # [1723921.141745] agent systemd[1]: Reloading finished in 326 ms. container-test-run-flakelet-relay> agent # [1723921.222559] agent systemd[1]: Reload requested from client PID 3447 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723921.222595] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723921.303664] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:49.591074Z","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 # [1723921.303155] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [1723921.337883] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723921.338315] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [1723921.338354] relay systemd[1]: flakelet-relay.service: Consumed 3.191s CPU time over 1min 7.563s wall clock time. container-test-run-flakelet-relay> relay # [1723921.373910] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [1723921.556017] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [1723921.639828] agent systemd[1]: Reload requested from client PID 3482 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [1723921.639862] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [1723921.972734] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [1723922.056798] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [1723922.307601] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:50.594825Z","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.55 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [1723922.840498] relay flakelet-relay[931]: {"timestamp":"2026-10-01T12:03:51.127914Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1723922.841364] relay flakelet-relay[931]: {"timestamp":"2026-10-01T12:03:51.128361Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1723922.840925] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [1723924.319233] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:52.606640Z","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 # [1723924.319583] relay flakelet-relay[931]: {"timestamp":"2026-10-01T12:03:52.606966Z","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 # [1723928.137144] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [1723928.147661] agent flakelet[3378]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [1723928.151505] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723928.325129] relay flakelet-relay[931]: {"timestamp":"2026-10-01T12:03:56.612329Z","level":"INFO","message":"job reattached","job":"69e05243847f719237c4b6bcba4e538d","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723929.219725] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:57.507127Z","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.09 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/resume.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/resume.out, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: relay restart mid-run, push resumes via /v1/jobs, in 9.72 seconds) container-test-run-flakelet-relay> subtest: job history comes from the agents and survives a relay restart container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1 container-test-run-flakelet-relay> agent # [1723929.967980] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:58.255399Z","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 # [1723929.968629] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:58.256121Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723930.011935] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1723930.038211] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1723930.043121] agent flakelet[3556]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1723930.043751] agent flakelet[3556]: other: up to date container-test-run-flakelet-relay> agent # [1723930.045053] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723929.967514] relay flakelet-relay[931]: {"timestamp":"2026-10-01T12:03:58.254919Z","level":"INFO","message":"deploy accepted","job":"188b06c4636b65849b3ba8daac22dc7c","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> agent # [1723930.586381] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:58.873791Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723930.605823] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:58.893298Z","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 # [1723930.588061] relay flakelet-relay[931]: {"timestamp":"2026-10-01T12:03:58.875482Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723930.605649] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [1723930.647505] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723930.647931] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [1723930.647970] relay systemd[1]: flakelet-relay.service: Consumed 2.106s CPU time over 9.273s wall clock time. container-test-run-flakelet-relay> relay # [1723930.683517] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [1723931.609419] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:03:59.896809Z","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.51 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 # [1723932.097829] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:00.385195Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1723932.098810] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:00.385644Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [1723932.098200] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [1723933.620703] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:01.908109Z","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 # [1723933.620933] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:01.908321Z","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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjU0MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MjQyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJSS1RLNUQ2VTdWVUhBPT09IiwibmJmIjoxNzkwODU2MjQyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.WWUH4PZE6Vm5-aZ8NxlpH906D8pqo0a7BiMwSOGEC3kFJj74IdacjZpWM5bu5KO8ZhoARhrdVtcCstw1l9OxAw' 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 # [1723934.266568] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:02.553979Z","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 # [1723934.266915] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:02.554411Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dce6faec8455f85321e72ee634888126\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723934.308222] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [1723934.342221] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [1723934.346983] agent flakelet[3584]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [1723934.347607] agent flakelet[3584]: app: up to date container-test-run-flakelet-relay> agent # [1723934.349187] 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 # [1723934.266072] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:02.553501Z","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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjU0MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MjQyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJSS1RLNUQ2VTdWVUhBPT09IiwibmJmIjoxNzkwODU2MjQyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.WWUH4PZE6Vm5-aZ8NxlpH906D8pqo0a7BiMwSOGEC3kFJj74IdacjZpWM5bu5KO8ZhoARhrdVtcCstw1l9OxAw' push --relay https://relay:7443 deploy --id hist2 agent/app, in 0.65 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjU0MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MjQyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJSS1RLNUQ2VTdWVUhBPT09IiwibmJmIjoxNzkwODU2MjQyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.WWUH4PZE6Vm5-aZ8NxlpH906D8pqo0a7BiMwSOGEC3kFJj74IdacjZpWM5bu5KO8ZhoARhrdVtcCstw1l9OxAw' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MDg1NjU0MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkwODU2MjQyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJSS1RLNUQ2VTdWVUhBPT09IiwibmJmIjoxNzkwODU2MjQyLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.WWUH4PZE6Vm5-aZ8NxlpH906D8pqo0a7BiMwSOGEC3kFJj74IdacjZpWM5bu5KO8ZhoARhrdVtcCstw1l9OxAw' push --relay https://relay:7443 jobs, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: job history comes from the agents and survives a relay restart, in 4.97 seconds) container-test-run-flakelet-relay> subtest: dashboard login via authorization code flow container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login, in 0.08 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 30 https://relay:7443/ui/jobs/f857770bbb685706b8dcac03d49eb6e6/events || true container-test-run-flakelet-relay> relay # [1723934.890598] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:03.177994Z","level":"INFO","message":"deploy finished","job":"6a239dbf87cfec796e49404c351d787f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723934.967565] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [01/Oct/2026 12:04:03] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=_haoIxsBF3xTbYn0yeado57ClDZ7WyuJiFR2Sg7a_JU&code_challenge=LtmdS7ttxnlOdkIGi--jY5TIX3cw7PYI7Qc0l7znlK4&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> relay # [1723935.013403] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [01/Oct/2026 12:04:03] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [1723935.014324] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:03.301801Z","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 # [1723935.077393] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:03.364802Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723935.123454] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:03.410865Z","level":"INFO","message":"deploy accepted","job":"75445454d450d52c14d1566f506849f5","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [1723935.146138] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:03.433482Z","level":"INFO","message":"job reattached","job":"75445454d450d52c14d1566f506849f5","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [1723934.888748] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:03.176159Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723935.123810] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:03.411258Z","level":"INFO","message":"start","id":"a854bb6096f316fbd56aacdb2af9be4a","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [1723935.124317] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:03.411810Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"a854bb6096f316fbd56aacdb2af9be4a\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723935.163140] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [1723935.195252] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [1723935.199925] agent flakelet[3608]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [1723935.200535] agent flakelet[3608]: other: up to date container-test-run-flakelet-relay> agent # [1723935.203841] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 30 https://relay:7443/ui/jobs/f857770bbb685706b8dcac03d49eb6e6/events || true, in 0.63 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/f857770bbb685706b8dcac03d49eb6e6 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/f857770bbb685706b8dcac03d49eb6e6, 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=f857770bbb685706b8dcac03d49eb6e6' | 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=f857770bbb685706b8dcac03d49eb6e6' | 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 # [1723935.746332] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:04.033743Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723935.906601] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:04.194004Z","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 # [1723935.907522] agent flakelet-agent[2933]: {"timestamp":"2026-10-01T12:04:04.194652Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [1723935.949428] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent/otheragent # [1723935.981258] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> | agent # [1723935.986255] agent flakelet[3628]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1agent # [1723935.986847] agent flakelet[3628]: other: up to date container-test-run-flakelet-relay> container-test-run-flakelet-relay> agent # [1723935.988182] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> agent/other | other: up to date container-test-run-flakelet-relay> agent/other | flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [1723935.906169] relay flakelet-relay[1321]: {"timestamp":"2026-10-01T12:04:04.193554Z","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.65 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.67 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 86.36 seconds) container-test-run-flakelet-relay> test script finished in 86.39s 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 2182b9b6e9f48b1a28ed7d4ee7b499f5 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 d2d4a82bbd3d9278f4b0b8f6d5bad684 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 ed3225b6bcd6c1a051a042e28ed52369 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 74c5a0dd7daa3f4e99e0d16bfd024322 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 69e05243847f719237c4b6bcba4e538d 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 58c773c706a90ea41a942cce09733ad6 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 69e05243847f719237c4b6bcba4e538d 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> 1790856238 hist1 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790856228 58c773c706a90ea41a942cce09733ad6 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790856219 624b4a8cad230ad43fc0f0bbef58e418 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790856203 e45530b725dda2466e6fcf42636cf82f admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790856200 local-app-6-1790856200 root (shell) agent/app:updated container-test-run-flakelet-relay> 1790856197 local-app-5-1790856197 root (shell) agent/app:updated container-test-run-flakelet-relay> 1790856194 0054f4327f2335cef25e5a024bdf3e33 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790856183 e25c6300a67b0049aa58c03f4d33fb0f admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790856182 e95af8289d1f63a02694436c1988c7e0 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1790856181 1b2c1f0a9b982bbcdb2c492058a001e1 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1790856181 cffef9ab51749514ca2b29c7e14cef45 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1790856177 d5641c6823a07d5603ba237371c09ff1 admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1790856176 601f0735268c0f552ecf63ad152570b4 dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790856175 47cea869d2919b1e8fdd711fd63820ae dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1790856172 8e6df6bb2a31dc4c76a1422afaaeb301 someone agent/other:unchanged container-test-run-flakelet-relay> 1790856170 a349a1926260f67e72633204a3fbc4aa repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1790856166 a435cf1f8372ce487ae7b880a6d37b85 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1790856163 local-app-1-1790856163 host activation agent/app:updated container-test-run-flakelet-relay> 1790856163 local-flakelet-agent-1-1790856163 host activation agent/flakelet-agent:updated container-test-run-flakelet-relay> 1790856163 local-other-1-1790856163 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