these 42 derivations will be built: /nix/store/sm4k1sqdvr24sw0dg0izxnn1kvzxdd0b-flakelet-relay.json.drv /nix/store/1j0n53gbqdxxgqjwh2gdd46yhwyxqa5f-flakelet-relay.service.drv /nix/store/fpbwxhd2rmps2290jv49h95rg970qcxa-flakelet-flakelet-relay-units.drv /nix/store/vz62m6jy02bxkgda2lx2h7ijjyv1w1qb-flakelet-flakelet-relay.drv /nix/store/5fjnl6wbm0y28vp0qcg4mizd7x3rng67-flakelet-config.json.drv /nix/store/62gkcvnwd4bnad4n5vfzl4bd7gip58n3-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/ar0prys2am60gzjp9gzq9snl0grkmyl2-unit-flakelet-flakelet-relay.service.drv /nix/store/45zzrslj27y22xalf763s6as8ricg70f-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/ijib0ghmp9c49d0g6n65yx7dgwqa6qg6-unit-flakelet-reconcile.service.drv /nix/store/yka9g0jfygj5d14rxdfq37qa75rmw7f5-system-units.drv /nix/store/4hkywrb5rxp2xddrw2cppq6kr3pn9a6k-etc.drv /nix/store/7vp2d9lbnnkq1wyr5bc6h7y741lyxmzm-activate.drv /nix/store/0ilpa2dj5mjwi2s524rgbxb6m2zgk6z7-nixos-system-relay-test.drv /nix/store/m0krm2ngi9qxf80rxj3rnak689n81zba-flakelet-agent.service.drv /nix/store/19pvh8vbhccb0xbw0z2ldgzzznxmhgyr-flakelet-flakelet-agent-units.drv /nix/store/cdxlgnj7m1vbpc3s40pk14kacp0hkxr1-flakelet-flakelet-agent.drv /nix/store/2ml2z61a17b81lwqsjyyg80pk55pnynm-flakelet-config.json.drv /nix/store/m5rnhfrikb8y9dj6idwvr628wiyqpzx3-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/w7mh25y37h95g0ry1k7py5r6dg11kcn9-unit-flakelet-reconcile.service.drv /nix/store/warsjm2k3xpfzprbl5c3yxf3lk28mimx-X-Restart-Triggers-flakelet-flakelet-agent.drv /nix/store/yb5pdfsifl2j9c421bv611j3kv9ajkw3-unit-flakelet-flakelet-agent.service.drv /nix/store/py8y8ycw9dji7iv6mv9ws02xbh8glr3n-system-units.drv /nix/store/mac9fng9r0nbkn5a07r62453v493kaj5-etc.drv /nix/store/sl222rgq4qbgffaxqx0plyi98wg0g2qc-activate.drv /nix/store/9dxssz5fwz9yjl9brgsrsy4467knqdni-nixos-system-agent-test.drv /nix/store/5dl0l7rn4c95p6hf1qlm4zbqd3383grl-run-agent-nspawn.drv /nix/store/b1xl2q9qkscs2jikxc7nslqqqff0ip4i-run-relay-nspawn.drv /nix/store/ckyhz7fdawr76gb0vhjz64h3nl54fzpd-push.drv /nix/store/b2z40yk5bq547b8b9477hyjq6gl63i9p-system-path.drv /nix/store/bnq1lbnpgfc1y2gf0gsni4hn55lb198g-dbus-1.drv /nix/store/wkrwygqwqsjjgskgiajshml76847p2qd-X-Restart-Triggers-dbus-broker.drv /nix/store/virk3yzpcw4kaid4iyx1rp5kp37f35q9-unit-dbus-broker.service.drv /nix/store/gss1p455n700b1cd06wszgxj29f6ki0m-system-units.drv /nix/store/yink3mdpvjazhr1knr9xyxxfrp8kslcx-unit-dbus-broker.service.drv /nix/store/zr2nxz5a0hb5h17m9nb6864k6lhs3kz3-user-units.drv /nix/store/cah29h65g6lxwn81pvz08gn7ks9000dq-etc.drv /nix/store/spb8kjxarc3azmv3z72hq7xm1x6ahbw8-activate.drv /nix/store/6wvsa8ll6d0n8k75v4jfbdp5yyavnsqw-nixos-system-client-test.drv /nix/store/wgw40icyjib5ws859iypwf7iwqa2i2k5-run-client-nspawn.drv /nix/store/38k09l4g46zrbn6n0xxqamqzb4f79yhw-driverConfiguration.json.drv /nix/store/fic1di54rgi7mhlqa6s4awpwhz7jck5x-nixos-test-driver-flakelet-relay.drv /nix/store/1idh60hsc82j8jnbhcv2lnbbpbvllgrq-container-test-run-flakelet-relay.drv building '/nix/store/ckyhz7fdawr76gb0vhjz64h3nl54fzpd-push.drv' building '/nix/store/warsjm2k3xpfzprbl5c3yxf3lk28mimx-X-Restart-Triggers-flakelet-flakelet-agent.drv' building '/nix/store/62gkcvnwd4bnad4n5vfzl4bd7gip58n3-X-Restart-Triggers-flakelet-flakelet-relay.drv' X-Restart-Triggers-flakelet-flakelet-agent> tribuchet: building on jamie push> tribuchet: building on jamie X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/m0krm2ngi9qxf80rxj3rnak689n81zba-flakelet-agent.service.drv' building '/nix/store/sm4k1sqdvr24sw0dg0izxnn1kvzxdd0b-flakelet-relay.json.drv' flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> tribuchet: building on jamie flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/app (expect allow) flakelet-relay.json> agent/app allowed by ci building '/nix/store/yb5pdfsifl2j9c421bv611j3kv9ajkw3-unit-flakelet-flakelet-agent.service.drv' flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/other (expect deny) flakelet-relay.json> agent/other denied unit-flakelet-flakelet-agent.service> tribuchet: building on jamie building '/nix/store/ar0prys2am60gzjp9gzq9snl0grkmyl2-unit-flakelet-flakelet-relay.service.drv' unit-flakelet-flakelet-relay.service> tribuchet: building on jamie building '/nix/store/b2z40yk5bq547b8b9477hyjq6gl63i9p-system-path.drv' building '/nix/store/19pvh8vbhccb0xbw0z2ldgzzznxmhgyr-flakelet-flakelet-agent-units.drv' system-path> tribuchet: building on jamie flakelet-flakelet-agent-units> tribuchet: building on jamie building '/nix/store/1j0n53gbqdxxgqjwh2gdd46yhwyxqa5f-flakelet-relay.service.drv' flakelet-relay.service> tribuchet: building on jamie unit-flakelet-flakelet-relay.service> structuredAttrs is enabled unit-flakelet-flakelet-agent.service> structuredAttrs is enabled building '/nix/store/cdxlgnj7m1vbpc3s40pk14kacp0hkxr1-flakelet-flakelet-agent.drv' flakelet-flakelet-agent> tribuchet: building on jamie building '/nix/store/fpbwxhd2rmps2290jv49h95rg970qcxa-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie building '/nix/store/2ml2z61a17b81lwqsjyyg80pk55pnynm-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie system-path> structuredAttrs is enabled system-path> created 6399 symlinks in user environment building '/nix/store/vz62m6jy02bxkgda2lx2h7ijjyv1w1qb-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled building '/nix/store/m5rnhfrikb8y9dj6idwvr628wiyqpzx3-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/5fjnl6wbm0y28vp0qcg4mizd7x3rng67-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/bnq1lbnpgfc1y2gf0gsni4hn55lb198g-dbus-1.drv' flakelet-config.json> structuredAttrs is enabled dbus-1> tribuchet: building on jamie building '/nix/store/w7mh25y37h95g0ry1k7py5r6dg11kcn9-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/45zzrslj27y22xalf763s6as8ricg70f-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/py8y8ycw9dji7iv6mv9ws02xbh8glr3n-system-units.drv' system-units> tribuchet: building on jamie building '/nix/store/ijib0ghmp9c49d0g6n65yx7dgwqa6qg6-unit-flakelet-reconcile.service.drv' building '/nix/store/wkrwygqwqsjjgskgiajshml76847p2qd-X-Restart-Triggers-dbus-broker.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie X-Restart-Triggers-dbus-broker> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/yka9g0jfygj5d14rxdfq37qa75rmw7f5-system-units.drv' system-units> tribuchet: building on jamie building '/nix/store/virk3yzpcw4kaid4iyx1rp5kp37f35q9-unit-dbus-broker.service.drv' building '/nix/store/yink3mdpvjazhr1knr9xyxxfrp8kslcx-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/mac9fng9r0nbkn5a07r62453v493kaj5-etc.drv' building '/nix/store/gss1p455n700b1cd06wszgxj29f6ki0m-system-units.drv' building '/nix/store/zr2nxz5a0hb5h17m9nb6864k6lhs3kz3-user-units.drv' etc> tribuchet: building on jamie system-units> tribuchet: building on jamie user-units> tribuchet: building on jamie building '/nix/store/4hkywrb5rxp2xddrw2cppq6kr3pn9a6k-etc.drv' etc> tribuchet: building on jamie building '/nix/store/sl222rgq4qbgffaxqx0plyi98wg0g2qc-activate.drv' activate> tribuchet: building on jamie building '/nix/store/cah29h65g6lxwn81pvz08gn7ks9000dq-etc.drv' etc> tribuchet: building on jamie building '/nix/store/9dxssz5fwz9yjl9brgsrsy4467knqdni-nixos-system-agent-test.drv' nixos-system-agent-test> tribuchet: building on jamie building '/nix/store/7vp2d9lbnnkq1wyr5bc6h7y741lyxmzm-activate.drv' activate> tribuchet: building on jamie nixos-system-agent-test> structuredAttrs is enabled building '/nix/store/spb8kjxarc3azmv3z72hq7xm1x6ahbw8-activate.drv' activate> tribuchet: building on jamie building '/nix/store/0ilpa2dj5mjwi2s524rgbxb6m2zgk6z7-nixos-system-relay-test.drv' nixos-system-relay-test> tribuchet: building on jamie building '/nix/store/5dl0l7rn4c95p6hf1qlm4zbqd3383grl-run-agent-nspawn.drv' run-agent-nspawn> tribuchet: building on jamie nixos-system-relay-test> structuredAttrs is enabled building '/nix/store/6wvsa8ll6d0n8k75v4jfbdp5yyavnsqw-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on jamie building '/nix/store/b1xl2q9qkscs2jikxc7nslqqqff0ip4i-run-relay-nspawn.drv' run-relay-nspawn> tribuchet: building on jamie nixos-system-client-test> structuredAttrs is enabled building '/nix/store/wgw40icyjib5ws859iypwf7iwqa2i2k5-run-client-nspawn.drv' run-client-nspawn> tribuchet: building on jamie building '/nix/store/38k09l4g46zrbn6n0xxqamqzb4f79yhw-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/fic1di54rgi7mhlqa6s4awpwhz7jck5x-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/1idh60hsc82j8jnbhcv2lnbbpbvllgrq-container-test-run-flakelet-relay.drv' container-test-run-flakelet-relay> tribuchet: building on jamie container-test-run-flakelet-relay> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-flakelet-relay> start all VLans container-test-run-flakelet-relay> (finished: start all VLans, in 0.00 seconds) container-test-run-flakelet-relay> Initializing machine ID from random generator. container-test-run-flakelet-relay> Test will time out and terminate in 3600.0 seconds container-test-run-flakelet-relay> run the VM test script container-test-run-flakelet-relay> start all VMs container-test-run-flakelet-relay> client: systemd-nspawn running (pid 52) container-test-run-flakelet-relay> agent: systemd-nspawn running (pid 53) container-test-run-flakelet-relay> client: Waiting for journal at /build/vm-state-client/var/log/journal... container-test-run-flakelet-relay> relay: systemd-nspawn running (pid 54) container-test-run-flakelet-relay> agent: Waiting for journal at /build/vm-state-agent/var/log/journal... container-test-run-flakelet-relay> relay: Waiting for journal at /build/vm-state-relay/var/log/journal... container-test-run-flakelet-relay> (finished: start all VMs, in 0.00 seconds) container-test-run-flakelet-relay> relay: waiting for unit flakelet-relay.service container-test-run-flakelet-relay> nixos-nspawn(relay): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(relay): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(client): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(client): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(agent): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(agent): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> 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 client on /build/vm-state-client. container-test-run-flakelet-relay> ░ Spawning container relay on /build/vm-state-relay. container-test-run-flakelet-relay> relay # No journal files were found. container-test-run-flakelet-relay> client # No journal files were found. container-test-run-flakelet-relay> relay # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> client # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> agent # No journal files were found. container-test-run-flakelet-relay> agent # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> client # [700390.235494] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [700390.235611] client systemd-journald[57]: Runtime Journal (/run/log/journal/60263719190e4c11bf27140e4d7d05ec) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [700390.251314] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [700390.267559] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [700390.286114] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [700390.287401] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [700390.318168] client systemd-journald[57]: Time spent on flushing to /var/log/journal/60263719190e4c11bf27140e4d7d05ec is 1.824ms for 6 entries. container-test-run-flakelet-relay> client # [700390.318168] client systemd-journald[57]: System Journal (/var/log/journal/60263719190e4c11bf27140e4d7d05ec) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [700390.328203] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> client # [700390.329193] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> client # [700390.329346] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> client # [700390.347247] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> client # [700390.405784] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [700390.239220] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> relay # [700390.236135] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [700390.239273] agent systemd-journald[57]: Runtime Journal (/run/log/journal/1de2fe6976b04121845c0febd4faa84a) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [700390.236183] relay systemd-journald[57]: Runtime Journal (/run/log/journal/d10137ea47c04e17a451aee45f0a3554) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [700390.250772] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> relay # [700390.250687] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [700390.265563] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> relay # [700390.264865] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [700390.282746] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> relay # [700390.285234] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [700390.283730] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [700390.286433] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> agent # [700390.317328] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/1de2fe6976b04121845c0febd4faa84a is 2.125ms for 6 entries. container-test-run-flakelet-relay> relay # [700390.317315] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/d10137ea47c04e17a451aee45f0a3554 is 3.177ms for 6 entries. container-test-run-flakelet-relay> agent # [700390.317328] agent systemd-journald[57]: System Journal (/var/log/journal/1de2fe6976b04121845c0febd4faa84a) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [700390.317315] relay systemd-journald[57]: System Journal (/var/log/journal/d10137ea47c04e17a451aee45f0a3554) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [700390.327212] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [700390.326533] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [700390.328139] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [700390.327636] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> agent # [700390.328282] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [700390.327845] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [700390.344209] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [700390.352172] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> agent # [700390.411104] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [700390.419755] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [700391.233853] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [700391.281900] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [700391.282822] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [700391.283724] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [700391.284742] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [700391.284773] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [700391.285853] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [700391.286658] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> client # [700391.308036] 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 # [700391.308531] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [700391.308850] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/60263719190e4c11bf27140e4d7d05ec failed: Operation not permitted container-test-run-flakelet-relay> client # [700391.309213] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [700391.235790] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [700391.293855] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> relay # [700391.294951] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [700391.295878] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [700391.297662] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [700391.297698] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [700391.298727] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [700391.300255] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> relay # [700391.322575] 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 # [700391.323062] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [700391.323452] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/d10137ea47c04e17a451aee45f0a3554 failed: Operation not permitted container-test-run-flakelet-relay> relay # [700391.323818] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [700391.261830] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> agent # [700391.300625] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> agent # [700391.301944] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> agent # [700391.303324] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [700391.304783] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [700391.304837] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [700391.305983] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> agent # [700391.306998] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [700391.327329] 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 # [700391.327782] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [700391.328151] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/1de2fe6976b04121845c0febd4faa84a failed: Operation not permitted container-test-run-flakelet-relay> agent # [700391.328529] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [700391.311587] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.a3TROpLTqP/chsh': Operation not permitted container-test-run-flakelet-relay> client # [700391.312212] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [700391.325456] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [700391.325703] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [700391.325848] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> client # [700391.327969] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [700391.328836] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [700391.345109] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [700391.351912] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [700391.353497] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [700391.368162] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [700391.368286] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [700391.368398] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [700391.368495] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [700391.368521] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [700391.368648] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [700391.368876] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [700391.368986] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [700391.369018] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [700391.369045] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [700391.370917] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [700391.372268] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [700391.373280] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [700391.394848] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> client # [700391.460586] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> client # [700391.460760] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [700391.462136] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> client # [700391.463102] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [700391.483795] client network-addresses-eth1-start[232]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> relay # [700391.324778] relay suid-sgid-wrappers-start[176]: chmod: changing permissions of '/run/wrappers/wrappers.3OV9YVMWxK/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [700391.325554] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [700391.326483] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [700391.326632] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [700391.327238] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [700391.342297] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [700391.343067] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [700391.357867] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [700391.365470] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [700391.366498] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [700391.379960] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [700391.380099] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [700391.380200] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [700391.380238] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [700391.380255] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [700391.380379] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [700391.380586] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [700391.380697] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [700391.380715] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [700391.380748] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [700391.382119] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [700391.383238] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [700391.383921] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [700391.384894] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [700391.385577] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> relay # [700391.399119] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [700391.401086] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [700391.409487] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [700391.414947] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> relay # [700391.470344] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [700391.471252] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [700391.472418] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [700391.473452] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [700391.332141] agent suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.Rxv6ArievP/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [700391.334724] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [700391.334767] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [700391.334849] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [700391.335430] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [700391.351811] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [700391.352572] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> agent # [700391.365887] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [700391.372359] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [700391.373763] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [700391.386138] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [700391.386251] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [700391.387333] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [700391.387366] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [700391.387383] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [700391.387498] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [700391.387679] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [700391.387790] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [700391.387803] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [700391.387832] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [700391.389351] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [700391.390238] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [700391.391046] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [700391.391777] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [700391.405888] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [700391.406901] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [700391.414874] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [700391.420568] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [700391.481096] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [700391.481294] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [700391.482413] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [700391.483337] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [700391.492640] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700391.493422] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [700391.501032] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [700391.499985] relay network-addresses-eth1-start[245]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [700391.506590] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700391.507373] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [700391.510518] relay network-addresses-eth1-start[245]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [700391.513338] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [700391.524302] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> relay # [700391.637362] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [700391.647695] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [700391.647929] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [700391.649363] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [700391.651114] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [700391.652275] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [700391.653238] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [700391.689999] relay flakelet[311]: flakelet-relay: using prebuilt artifact /nix/store/y3gnbrl1fryd5dds2nvy2yaq1gd1p6d7-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [700391.690980] relay flakelet[311]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [700391.695927] relay systemd[1]: Reload requested from client PID 316 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [700391.695980] relay systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700391.524043] agent network-addresses-eth1-start[236]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [700391.532890] agent network-addresses-eth1-start[236]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [700391.540142] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [700391.587106] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [700391.647442] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [700391.648564] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [700391.649099] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700391.649318] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [700391.654449] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [700391.656156] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [700391.681847] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [700391.683331] agent systemd[1]: Starting Update flakelet service flakelet-agent... container-test-run-flakelet-relay> agent # [700391.684506] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [700391.695252] agent flakelet[308]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [700391.695917] agent flakelet[308]: app: activating generation 1 container-test-run-flakelet-relay> agent # [700391.696790] agent flakelet[310]: flakelet-agent: using prebuilt artifact /nix/store/vz76x5rfl6mkhhwkjdbnnwlmnjvn913r-flakelet-flakelet-agent container-test-run-flakelet-relay> agent # [700391.697542] agent flakelet[310]: flakelet-agent: activating generation 1 container-test-run-flakelet-relay> agent # [700391.699260] agent flakelet[311]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700391.699917] agent flakelet[311]: other: activating generation 1 container-test-run-flakelet-relay> agent # [700391.702308] agent systemd[1]: Reload requested from client PID 312 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [700391.702372] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [700391.487495] client network-addresses-eth1-start[232]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [700391.498366] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [700391.525984] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [700391.526910] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [700391.532229] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [700391.652358] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [700391.653934] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [700391.683238] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [700391.683480] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> client # [700391.684838] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [700391.685050] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [700391.689603] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [700392.000075] relay nsncd[264]: Oct 22 11:56:24.810 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [700392.144027] relay systemd[1]: Reloading finished in 447 ms. container-test-run-flakelet-relay> client # [700392.041595] client nsncd[303]: Oct 22 11:56:24.852 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [700392.041826] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [700392.041931] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [700392.042206] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [700392.048190] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [700392.052481] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [700392.085627] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [700392.087945] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [700392.088022] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [700392.088056] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [700392.064187] agent nsncd[307]: Oct 22 11:56:24.874 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [700392.142577] agent systemd[1]: Reloading finished in 439 ms. container-test-run-flakelet-relay> agent # [700392.284681] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [700392.285850] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [700392.285896] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [700392.281989] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [700392.283303] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [700392.283423] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [700392.284696] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [700392.285739] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [700392.298701] relay systemd[1]: Reload requested from client PID 357 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [700392.298744] relay systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [700392.461622] relay dnsmasq-pre-start[393]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> relay # [700392.700929] relay systemd[1]: Reloading finished in 401 ms. container-test-run-flakelet-relay> relay # [700392.815654] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [700392.840993] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [700392.841093] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [700392.841125] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [700392.847959] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [700392.687795] agent systemd[1]: Reloading finished in 401 ms. container-test-run-flakelet-relay> agent # [700392.817131] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [700392.817175] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700393.217329] agent systemd[1]: Reloading finished in 399 ms. container-test-run-flakelet-relay> agent # [700393.293941] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [700393.294043] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [700393.295765] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [700393.297284] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [700393.302250] agent systemd[1]: Reload requested from client PID 405 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [700393.302281] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [700393.585280] client systemd-logind[313]: New seat seat0. container-test-run-flakelet-relay> client # [700393.586674] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [700393.586784] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [700393.587763] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [700393.635247] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [700393.635606] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [700393.635982] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [700393.591333] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> relay # [700393.686641] relay nginx-pre-start[403]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [700393.687175] relay nginx-pre-start[403]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [700393.706820] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> agent # [700393.715307] agent systemd[1]: Reloading finished in 412 ms. container-test-run-flakelet-relay> agent # [700393.796709] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [700393.798024] agent systemd[1]: Reload requested from client PID 407 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [700393.798072] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [700394.173593] relay systemd-logind[354]: New seat seat0. container-test-run-flakelet-relay> relay # [700394.174013] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [700394.176281] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [700394.216267] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700394.216969] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> relay # [700394.258513] relay dbus-broker-launch[402]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [700394.259429] relay dbus-broker-launch[402]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [700394.259429] relay dbus-broker-launch[402]: Invalid user-name in /nix/store/d6qla8vgy057drw03ps2mdgny56bml50-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> relay # [700394.261289] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [700394.266532] relay dbus-broker-launch[402]: Ready container-test-run-flakelet-relay> relay # [700394.269039] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> relay # [700394.271424] relay dnsmasq[394]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [700394.271433] 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 # [700394.271440] relay dnsmasq[394]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [700394.271456] relay dnsmasq[394]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [700394.271654] relay dnsmasq[394]: read /etc/hosts - 9 names container-test-run-flakelet-relay> agent # [700394.167162] agent systemd[1]: Reloading finished in 368 ms. container-test-run-flakelet-relay> agent # [700394.271735] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [700394.271882] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [700394.272063] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [700394.274487] agent systemd[1]: Reload requested from client PID 410 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [700394.274535] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [700394.235363] client dbus-broker-launch[325]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [700394.237138] client dbus-broker-launch[325]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [700394.237138] client dbus-broker-launch[325]: Invalid user-name in /nix/store/8w2iy6ppcnz5rh85pl49lll2sd0qdm3l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [700394.238195] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [700394.238749] client systemd[1]: Startup finished in 4.467s. container-test-run-flakelet-relay> client # [700394.250804] client dbus-broker-launch[325]: Ready container-test-run-flakelet-relay> agent # [700394.634546] agent systemd[1]: Reloading finished in 359 ms. container-test-run-flakelet-relay> agent # [700394.768185] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [700394.769310] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [700394.773084] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [700394.828456] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [700394.828692] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [700394.836137] agent flakelet[311]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [700394.836513] agent flakelet[308]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [700394.838362] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [700394.838750] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [700394.872568] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:27.682912Z","level":"INFO","message":"local change","flakelet":"app","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700394.872933] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:27.683311Z","level":"INFO","message":"local change","flakelet":"other","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700394.873187] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [700394.877520] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:27.687978Z","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 # [700394.879229] agent flakelet[310]: flakelet-agent: updated to generation 1 container-test-run-flakelet-relay> agent # [700394.881351] agent systemd[1]: Finished Update flakelet service flakelet-agent. container-test-run-flakelet-relay> agent # [700394.881519] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> agent # [700394.904302] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:27.714717Z","level":"INFO","message":"local change","flakelet":"flakelet-agent","generation":1,"by":"host activation","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700394.982183] agent systemd-logind[408]: New seat seat0. container-test-run-flakelet-relay> agent # [700394.982500] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [700394.983997] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [700394.985268] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [700395.021038] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700395.021265] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [700395.021452] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [700395.256787] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:28.067017Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [700395.257784] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:28.067910Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [700395.257552] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [700395.265086] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> agent # [700395.489848] agent dbus-broker-launch[905]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [700395.491271] agent dbus-broker-launch[905]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [700395.491271] agent dbus-broker-launch[905]: Invalid user-name in /nix/store/8mp15gfn2m81r8005nnkppky8976lhbb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> agent # [700395.491903] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [700395.492570] agent systemd[1]: Startup finished in 5.721s. container-test-run-flakelet-relay> agent # [700395.497885] agent dbus-broker-launch[905]: Ready container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 6.67 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.01 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet-agent.service container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet-agent.service, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for unit multi-user.target container-test-run-flakelet-relay> client: (finished: waiting for unit multi-user.target, in 0.02 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1' container-test-run-flakelet-relay> relay # [700395.583733] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700395.584169] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay # [700395.593154] relay flakelet[311]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [700395.596027] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [700395.596614] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [700395.596801] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [700395.597043] relay systemd[1]: Startup finished in 5.826s. container-test-run-flakelet-relay> relay: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1', in 1.04 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service other.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service other.service, in 0.01 seconds) container-test-run-flakelet-relay> subtest: deploy with client certificate, relay found via SRV container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1 container-test-run-flakelet-relay> relay # [700396.893310] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:29.703719Z","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 # [700396.998655] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:29.809099Z","level":"INFO","message":"deploy accepted","job":"e8d51949ef825f3ca944f3a69969b8f7","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700396.893099] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:29.703435Z","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 # [700396.999516] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:29.809950Z","level":"INFO","message":"start","id":"9ae9007640ce9f5b8644ed234165bddd","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700397.000214] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:29.810677Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"9ae9007640ce9f5b8644ed234165bddd\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700397.041289] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700397.085329] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700397.090094] agent flakelet[927]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [700397.090894] agent flakelet[927]: app: activating generation 2 container-test-run-flakelet-relay> agent # [700397.103217] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [700397.103997] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700397.104183] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [700397.115921] agent systemd[1]: Reload requested from client PID 934 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700397.115959] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700397.480898] agent systemd[1]: Reloading finished in 364 ms. container-test-run-flakelet-relay> agent # [700397.575116] agent systemd[1]: Reload requested from client PID 964 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700397.575166] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700397.949478] agent systemd[1]: Reloading finished in 373 ms. container-test-run-flakelet-relay> agent # [700398.034443] agent systemd[1]: Reload requested from client PID 993 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700398.034492] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700398.396495] agent systemd[1]: Reloading finished in 361 ms. container-test-run-flakelet-relay> agent # [700398.492807] agent systemd[1]: Reload requested from client PID 1024 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700398.492848] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700398.842652] agent systemd[1]: Reloading finished in 349 ms. container-test-run-flakelet-relay> agent # [700398.939526] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [700398.976282] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [700398.982923] agent flakelet[927]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [700398.985450] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1, in 3.05 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.02 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with client certificate, relay found via SRV, in 3.11 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDQ5MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMTkyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJYWVlDUk1PNVRaWFBFPT09IiwibmJmIjoxNzkyNjcwMTkyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.bWzbZVtnKM-WUQRnrCyiKFSa3eIxRh5Yf6_yl_h_fLPXlNwNr5ylqJWAKBbSoQL8cw6G7OjhQq7LWbiNfA3QCg' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> agent # [700400.014602] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:32.825053Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700400.197344] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:33.007789Z","level":"INFO","message":"start","id":"23526698a253a83873deafa066920266","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 # [700400.197655] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:33.008134Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"23526698a253a83873deafa066920266\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700400.233913] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700400.261039] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> relay # [700400.017204] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:32.827614Z","level":"INFO","message":"deploy finished","job":"e8d51949ef825f3ca944f3a69969b8f7","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700400.196926] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:33.007346Z","level":"INFO","message":"deploy accepted","job":"8d6d9635f2dbc59a21375afd7cfafe03","caller":"repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700400.265594] agent flakelet[1093]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [700400.266310] agent flakelet[1093]: app: activating generation 3 container-test-run-flakelet-relay> agent # [700400.276785] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [700400.277548] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700400.277699] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [700400.290253] agent systemd[1]: Reload requested from client PID 1100 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700400.290296] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700400.644514] agent systemd[1]: Reloading finished in 353 ms. container-test-run-flakelet-relay> agent # [700400.736907] agent systemd[1]: Reload requested from client PID 1130 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700400.736948] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700401.090708] agent systemd[1]: Reloading finished in 353 ms. container-test-run-flakelet-relay> agent # [700401.162833] agent systemd[1]: Reload requested from client PID 1161 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700401.162870] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700401.522359] agent systemd[1]: Reloading finished in 359 ms. container-test-run-flakelet-relay> agent # [700401.616149] agent systemd[1]: Reload requested from client PID 1194 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700401.616188] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700401.967397] agent systemd[1]: Reloading finished in 350 ms. container-test-run-flakelet-relay> agent # [700402.045838] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [700402.089562] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [700402.095850] agent flakelet[1093]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [700402.097973] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDQ5MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMTkyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJYWVlDUk1PNVRaWFBFPT09IiwibmJmIjoxNzkyNjcwMTkyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.bWzbZVtnKM-WUQRnrCyiKFSa3eIxRh5Yf6_yl_h_fLPXlNwNr5ylqJWAKBbSoQL8cw6G7OjhQq7LWbiNfA3QCg' push --relay https://relay:7443 deploy agent/app 2>&1, in 3.00 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 3.09 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDQ5MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMTkyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJYWVlDUk1PNVRaWFBFPT09IiwibmJmIjoxNzkyNjcwMTkyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.bWzbZVtnKM-WUQRnrCyiKFSa3eIxRh5Yf6_yl_h_fLPXlNwNr5ylqJWAKBbSoQL8cw6G7OjhQq7LWbiNfA3QCg' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDQ5MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMTkyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJYWVlDUk1PNVRaWFBFPT09IiwibmJmIjoxNzkyNjcwMTkyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.bWzbZVtnKM-WUQRnrCyiKFSa3eIxRh5Yf6_yl_h_fLPXlNwNr5ylqJWAKBbSoQL8cw6G7OjhQq7LWbiNfA3QCg' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDQ5NiwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MjY3MDE5NiwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiWENNS0I3QkpRSFlNVT09PSIsIm5iZiI6MTc5MjY3MDE5Niwic3ViIjoic29tZW9uZSJ9.9kbPRkzbBg6gImaywc5cDeANVwinnFgOqcCCj0rccEKQGk_Q0M6k9-kuV7WVJBbTRZUmqlDgJjNoXKOi2l19Aw' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [700403.159409] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:35.969782Z","level":"INFO","message":"deploy finished","job":"8d6d9635f2dbc59a21375afd7cfafe03","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700403.262171] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:36.072592Z","level":"INFO","message":"deploy accepted","job":"0d3e4137afec5de2d43ba4a829af1232","caller":"someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700403.157802] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:35.968240Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700403.262495] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:36.072940Z","level":"INFO","message":"start","id":"3c293b5e89b4147e4bcaf9222d89fba7","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"someone\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700403.262912] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:36.073390Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"3c293b5e89b4147e4bcaf9222d89fba7\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700403.301623] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [700403.331276] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [700403.336267] agent flakelet[1248]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700403.336870] agent flakelet[1248]: other: up to date container-test-run-flakelet-relay> agent # [700403.337911] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDQ5NiwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc5MjY3MDE5NiwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiWENNS0I3QkpRSFlNVT09PSIsIm5iZiI6MTc5MjY3MDE5Niwic3ViIjoic29tZW9uZSJ9.9kbPRkzbBg6gImaywc5cDeANVwinnFgOqcCCj0rccEKQGk_Q0M6k9-kuV7WVJBbTRZUmqlDgJjNoXKOi2l19Aw' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.63 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 0.69 seconds) container-test-run-flakelet-relay> subtest: push login via device flow, cached token used afterwards container-test-run-flakelet-relay> client: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1 container-test-run-flakelet-relay> relay # [700403.870419] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:36.680835Z","level":"INFO","message":"deploy finished","job":"0d3e4137afec5de2d43ba4a829af1232","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700403.895808] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [22/Oct/2026 11:56:36] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> agent # [700403.868903] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:36.679337Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [700404.901920] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [22/Oct/2026 11:56:37] "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.09 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 # [700405.957743] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [22/Oct/2026 11:56:38] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [700405.986921] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:38.797357Z","level":"INFO","message":"deploy accepted","job":"614c4008de12c03b5eed7a4be31f644d","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700405.987287] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:38.797714Z","level":"INFO","message":"start","id":"b8fe7542d84b8e47c93a55ec1157c05d","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700405.987876] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:38.798339Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"b8fe7542d84b8e47c93a55ec1157c05d\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700406.019925] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [700406.054015] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [700406.060876] agent flakelet[1272]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700406.061821] agent flakelet[1272]: other: up to date container-test-run-flakelet-relay> agent # [700406.063849] 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 1.63 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [700407.599892] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:40.410290Z","level":"INFO","message":"deploy finished","job":"614c4008de12c03b5eed7a4be31f644d","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700407.624945] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:40.435388Z","level":"INFO","message":"deploy accepted","job":"4bc3b13d368674c9471ab6669cdaf071","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700407.598571] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:40.408956Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700407.625194] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:40.435644Z","level":"INFO","message":"start","id":"85b5e074245f67926f074c7b5af04182","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700407.625665] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:40.436136Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"85b5e074245f67926f074c7b5af04182\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700407.652866] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [700407.704733] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [700407.709488] agent flakelet[1297]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700407.710153] agent flakelet[1297]: other: up to date container-test-run-flakelet-relay> agent # [700407.712220] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.64 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 4.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 # [700408.245367] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:41.055741Z","level":"INFO","message":"deploy finished","job":"4bc3b13d368674c9471ab6669cdaf071","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700408.282780] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:41.093176Z","level":"INFO","message":"deploy accepted","job":"37c8542e118152521f57c0024956a39e","caller":"admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700408.244152] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:41.054545Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700408.283098] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:41.093501Z","level":"INFO","message":"start","id":"26b8820952aabf013bd261690477a433","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700408.283571] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:41.094038Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"26b8820952aabf013bd261690477a433\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700408.320344] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700408.363748] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700408.370406] agent flakelet[1320]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [700408.371719] agent flakelet[1320]: app: activating generation 4 container-test-run-flakelet-relay> agent # [700408.385373] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [700408.387084] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700408.387379] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [700408.400898] agent systemd[1]: Reload requested from client PID 1327 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700408.400951] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700408.772852] agent systemd[1]: Reloading finished in 371 ms. container-test-run-flakelet-relay> agent # [700408.860709] agent systemd[1]: Reload requested from client PID 1357 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700408.860754] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700409.221374] agent systemd[1]: Reloading finished in 360 ms. container-test-run-flakelet-relay> agent # [700409.305551] agent systemd[1]: Reload requested from client PID 1388 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700409.305592] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700409.652870] agent systemd[1]: Reloading finished in 346 ms. container-test-run-flakelet-relay> agent # [700409.764039] agent systemd[1]: Reload requested from client PID 1421 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700409.764083] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700410.115519] agent systemd[1]: Reloading finished in 351 ms. container-test-run-flakelet-relay> agent # [700410.238202] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [700410.274058] agent (nonexistent)[1451]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [700410.274087] agent (nonexistent)[1451]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [700410.276290] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [700410.276413] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [700410.276787] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [700410.305286] agent systemd[1]: Reload requested from client PID 1457 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700410.305332] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700410.667876] agent systemd[1]: Reloading finished in 362 ms. container-test-run-flakelet-relay> agent # [700410.758248] agent systemd[1]: Reload requested from client PID 1487 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700410.758293] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700411.115766] agent systemd[1]: Reloading finished in 356 ms. container-test-run-flakelet-relay> agent # [700411.239301] agent systemd[1]: Reload requested from client PID 1519 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700411.239348] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700411.598180] agent systemd[1]: Reloading finished in 358 ms. container-test-run-flakelet-relay> agent # [700411.685379] agent systemd[1]: Reload requested from client PID 1551 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700411.685420] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700412.043950] agent systemd[1]: Reloading finished in 358 ms. container-test-run-flakelet-relay> agent # [700412.138747] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [700412.177397] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [700412.178634] agent flakelet[1320]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [700412.178634] agent flakelet[1320]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [700412.180922] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [700412.181037] 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.52 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.55 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 # [700412.778581] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:45.588951Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700412.838392] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:45.648792Z","level":"INFO","message":"start","id":"02a15bcec0398a2d0af76edbb3167cbe","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700412.838790] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:45.649259Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"02a15bcec0398a2d0af76edbb3167cbe\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700412.865664] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700412.897687] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700412.903107] agent flakelet[1607]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [700412.903717] agent flakelet[1607]: app: up to date container-test-run-flakelet-relay> agent # [700412.904250] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700412.780366] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:45.590782Z","level":"INFO","message":"deploy finished","job":"37c8542e118152521f57c0024956a39e","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700412.837912] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:45.648354Z","level":"INFO","message":"deploy accepted","job":"e93307b75f116e5ad4faeecb830e0b48","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 1.63 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1 container-test-run-flakelet-relay> relay # [700414.445264] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:47.255645Z","level":"INFO","message":"deploy finished","job":"e93307b75f116e5ad4faeecb830e0b48","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700414.468024] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:47.278469Z","level":"INFO","message":"deploy accepted","job":"a707c244a902bbd1200986c03e8c43ec","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700414.444066] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:47.254447Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700414.468384] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:47.278818Z","level":"INFO","message":"start","id":"d54f3cfb8f7dc0a9da2b80914f519e06","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700414.468797] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:47.279270Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"d54f3cfb8f7dc0a9da2b80914f519e06\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700414.504268] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700414.566236] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700414.570671] agent flakelet[1632]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [700414.571263] agent flakelet[1632]: app: up to date container-test-run-flakelet-relay> agent # [700414.574079] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1, in 0.66 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 # [700415.107059] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:47.917414Z","level":"INFO","message":"deploy finished","job":"a707c244a902bbd1200986c03e8c43ec","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700415.130371] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:47.940818Z","level":"INFO","message":"deploy accepted","job":"9095b93a3bc32a5053805bfd3ea965d2","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700415.105829] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:47.916176Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700415.130640] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:47.941079Z","level":"INFO","message":"start","id":"9b48d8b848fa414be6ea5103d064a322","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700415.130952] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:47.941425Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"9b48d8b848fa414be6ea5103d064a322\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700415.157739] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700415.186765] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700415.192842] agent flakelet[1656]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [700415.193441] agent flakelet[1656]: app: up to date container-test-run-flakelet-relay> agent # [700415.194718] 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 1.64 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: host patterns expand on the relay, in 3.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 # [700416.743290] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:49.553701Z","level":"INFO","message":"deploy finished","job":"9095b93a3bc32a5053805bfd3ea965d2","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700416.804704] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:49.615108Z","level":"INFO","message":"deploy accepted","job":"42b023e70da7e5e11840f148b495f286","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700416.742251] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:49.552654Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700416.805120] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:49.615433Z","level":"INFO","message":"start","id":"d32551ff7be29cae7f9d4755bd403a21","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700416.805428] agent flakelet-agent[504]: {"timestamp":"2026-10-22T11:56:49.615906Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"d32551ff7be29cae7f9d4755bd403a21\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700416.848322] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700416.895755] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700416.900358] agent flakelet[1681]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [700416.901173] agent flakelet[1681]: app: activating generation 4 container-test-run-flakelet-relay> agent # [700416.914166] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [700416.916087] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700416.916493] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [700416.933881] agent systemd[1]: Reload requested from client PID 1692 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700416.933959] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700417.301441] agent systemd[1]: Reloading finished in 366 ms. container-test-run-flakelet-relay> agent # [700417.392478] agent systemd[1]: Reload requested from client PID 1722 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700417.392528] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700417.753478] agent systemd[1]: Reloading finished in 360 ms. container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.03 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 # [700417.841237] agent systemd[1]: Reload requested from client PID 1752 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700417.841280] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700418.192414] agent systemd[1]: Reloading finished in 350 ms. container-test-run-flakelet-relay> agent # [700418.285641] agent systemd[1]: Reload requested from client PID 1784 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700418.285678] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700418.642066] agent systemd[1]: Reloading finished in 356 ms. container-test-run-flakelet-relay> agent # [700418.738213] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [700424.838955] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [700424.848123] agent flakelet[1681]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [700424.851859] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent: (finished: waiting for failure: systemctl is-active flakelet-relay-job-app.service, in 7.53 seconds) container-test-run-flakelet-relay> (finished: subtest: detach returns once the job is accepted, in 8.60 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.08 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 0' container-test-run-flakelet-relay> relay: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 0', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/other > /tmp/retry.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/other > /tmp/retry.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent_unavailable.*retrying' /tmp/retry.out container-test-run-flakelet-relay> relay # [700425.405735] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:58.216152Z","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 # [700425.405511] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [700425.447763] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700425.448080] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [700425.448440] agent systemd[1]: flakelet-agent.service: Consumed 1.352s CPU time over 30.678s wall clock time. container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent_unavailable.*retrying' /tmp/retry.out, in 1.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl start flakelet-agent container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl start flakelet-agent, in 0.11 seconds) container-test-run-flakelet-relay> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-flakelet-relay> File "/nix/store/f3vbkhcnzmgjphqaarrzgjdpzrb02va5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out container-test-run-flakelet-relay> relay # [700426.642996] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:56:59.453391Z","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 # [700426.535622] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [700426.609085] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:56:59.419525Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"d32551ff7be29cae7f9d4755bd403a21\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700426.629940] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [700426.642863] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:56:59.453298Z","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 # [700427.148730] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:56:59.959160Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [700428.518738] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:01.329149Z","level":"INFO","message":"deploy accepted","job":"3b39aef617f23402ac82a4b12c14b072","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700428.519128] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:01.329479Z","level":"INFO","message":"start","id":"f3a68652511b27c7acf142eedf29f67a","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700428.519673] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:01.329965Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"f3a68652511b27c7acf142eedf29f67a\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700428.554664] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [700428.596189] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [700428.601231] agent flakelet[2266]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700428.601893] agent flakelet[2266]: other: up to date container-test-run-flakelet-relay> agent # [700428.603192] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700429.137751] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:01.948154Z","level":"INFO","message":"deploy finished","job":"3b39aef617f23402ac82a4b12c14b072","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700429.136291] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:01.946678Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out, in 3.04 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.08 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDUyMiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMjIyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJGUFZOQjZERzNURFhFPT09IiwibmJmIjoxNzkyNjcwMjIyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2MNDW1yB38Sf3KZG8m3-cPplLggWrLPSxsO5iACx381PmZ1GA2Kq-bGtEYOQu489RUhVtOhn2O0DfdEK2J9TCg' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDUyMiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMjIyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJGUFZOQjZERzNURFhFPT09IiwibmJmIjoxNzkyNjcwMjIyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2MNDW1yB38Sf3KZG8m3-cPplLggWrLPSxsO5iACx381PmZ1GA2Kq-bGtEYOQu489RUhVtOhn2O0DfdEK2J9TCg' 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.42 seconds) container-test-run-flakelet-relay> subtest: out-of-band flakelet update reaches the relay without reconnect container-test-run-flakelet-relay> agent: must succeed: flakelet status --json app | jq '.[0].generation' container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet status --json app | jq '.[0].generation', in 0.03 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> app: activating generation 5 container-test-run-flakelet-relay> agent # [700429.883269] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [700429.886274] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700429.886574] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [700429.901426] agent systemd[1]: Reload requested from client PID 2300 ('systemctl')... container-test-run-flakelet-relay> agent # [700429.901482] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700430.279914] agent systemd[1]: Reloading finished in 377 ms. container-test-run-flakelet-relay> agent # [700430.371131] agent systemd[1]: Reload requested from client PID 2329 ('systemctl')... container-test-run-flakelet-relay> agent # [700430.371177] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700430.736104] agent systemd[1]: Reloading finished in 364 ms. container-test-run-flakelet-relay> agent # [700430.817245] agent systemd[1]: Reload requested from client PID 2359 ('systemctl')... container-test-run-flakelet-relay> agent # [700430.817287] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700431.174310] agent systemd[1]: Reloading finished in 356 ms. container-test-run-flakelet-relay> agent # [700431.269571] agent systemd[1]: Reload requested from client PID 2390 ('systemctl')... container-test-run-flakelet-relay> agent # [700431.269614] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.90 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 # [700431.632338] agent systemd[1]: Reloading finished in 362 ms. container-test-run-flakelet-relay> agent # [700431.718317] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [700431.749079] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@5', in 1.04 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-5- container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-5-, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app- container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs | grep local-app-, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> app: activating generation 6 container-test-run-flakelet-relay> agent # [700432.651349] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:05.461732Z","level":"INFO","message":"local change","flakelet":"app","generation":5,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700432.888851] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [700432.890084] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700432.890247] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [700432.900983] agent systemd[1]: Reload requested from client PID 2436 ('systemctl')... container-test-run-flakelet-relay> agent # [700432.901034] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700433.260622] agent systemd[1]: Reloading finished in 359 ms. container-test-run-flakelet-relay> agent # [700433.351666] agent systemd[1]: Reload requested from client PID 2465 ('systemctl')... container-test-run-flakelet-relay> agent # [700433.351709] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700433.710687] agent systemd[1]: Reloading finished in 358 ms. container-test-run-flakelet-relay> agent # [700433.803180] agent systemd[1]: Reload requested from client PID 2493 ('systemctl')... container-test-run-flakelet-relay> agent # [700433.803223] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700434.159847] agent systemd[1]: Reloading finished in 356 ms. container-test-run-flakelet-relay> agent # [700434.253303] agent systemd[1]: Reload requested from client PID 2522 ('systemctl')... container-test-run-flakelet-relay> agent # [700434.253345] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.88 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 # [700434.601422] agent systemd[1]: Reloading finished in 347 ms. container-test-run-flakelet-relay> agent # [700434.691070] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [700434.733271] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@6', in 2.07 seconds) container-test-run-flakelet-relay> (finished: subtest: out-of-band flakelet update reaches the relay without reconnect, in 7.01 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=@1792670229 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [700436.656580] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:09.466903Z","level":"INFO","message":"local change","flakelet":"app","generation":6,"by":"root (shell)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700436.901739] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:09.712144Z","level":"INFO","message":"start","id":"69957f71855dc78f98eafeb982369701","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700436.902251] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:09.712712Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"69957f71855dc78f98eafeb982369701\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [700436.839509] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:09.649331Z","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 # [700436.901412] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:09.711798Z","level":"INFO","message":"deploy accepted","job":"1a06bb7f9046289c791f4e7e645d1d1b","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700436.939548] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700436.983115] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700436.988146] agent flakelet[2575]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [700436.988895] agent flakelet[2575]: app: activating generation 7 container-test-run-flakelet-relay> agent # [700437.012024] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [700437.012517] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700437.012823] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [700437.042530] agent systemd[1]: Reload requested from client PID 2582 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700437.042578] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700437.400619] agent systemd[1]: Reloading finished in 357 ms. container-test-run-flakelet-relay> agent # [700437.489802] agent systemd[1]: Reload requested from client PID 2612 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700437.489842] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1792670229 | grep -q 'app-slow', in 1.02 seconds) container-test-run-flakelet-relay> agent: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done container-test-run-flakelet-relay> agent: (finished: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done, in 0.02 seconds) container-test-run-flakelet-relay> relay: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done container-test-run-flakelet-relay> relay: (finished: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done, in 0.07 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=@1792670229 | grep -q 'updated to generation' container-test-run-flakelet-relay> relay # [700437.996120] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:10.806402Z","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 # [700437.851795] agent systemd[1]: Reloading finished in 361 ms. container-test-run-flakelet-relay> agent # [700437.935987] agent systemd[1]: Reload requested from client PID 2650 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700437.936046] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700438.029405] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:10.839814Z","level":"INFO","message":"disconnected: IO error: Software caused connection abort (os error 103)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700438.290309] agent systemd[1]: Reloading finished in 353 ms. container-test-run-flakelet-relay> agent # [700438.374952] agent systemd[1]: Reload requested from client PID 2686 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700438.374993] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700438.726438] agent systemd[1]: Reloading finished in 351 ms. container-test-run-flakelet-relay> agent # [700438.803628] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [700439.033368] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:11.843801Z","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 # [700441.036558] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:13.846952Z","level":"WARN","message":"connect failed: connect relay:7443: No route to host (os error 113)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1792670229 | grep -q 'updated to generation', in 7.11 seconds) container-test-run-flakelet-relay> agent: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route del unreachable $a; done container-test-run-flakelet-relay> agent: (finished: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route del unreachable $a; done, in 0.02 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/app: updated' /tmp/slow.out container-test-run-flakelet-relay> agent # [700444.886265] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [700444.894679] agent flakelet[2575]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [700444.897104] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700445.039530] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:17.849930Z","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 # [700445.945449] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:18.755852Z","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 # [700453.044721] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:25.855137Z","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 # [700453.044607] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:25.855033Z","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 # [700453.046263] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:25.856724Z","level":"INFO","message":"deploy finished","job":"1a06bb7f9046289c791f4e7e645d1d1b","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700453.045867] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:25.856337Z","level":"INFO","message":"start","id":"69957f71855dc78f98eafeb982369701","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [700453.311343] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:26.121625Z","level":"INFO","message":"deploy accepted","job":"aa3311622a8d379f9a61962bb489a198","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700453.311685] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:26.121994Z","level":"INFO","message":"start","id":"dde07ed8a3551238758055b8fd3c308b","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700453.312268] agent flakelet-agent[1853]: {"timestamp":"2026-10-22T11:57:26.122730Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dde07ed8a3551238758055b8fd3c308b\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700453.351451] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700453.391376] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700453.396563] agent flakelet[2811]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [700453.397407] agent flakelet[2811]: app: activating generation 8 container-test-run-flakelet-relay> agent # [700453.413911] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [700453.415064] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700453.415302] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [700453.430279] agent systemd[1]: Reload requested from client PID 2818 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700453.430336] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700453.800914] agent systemd[1]: Reloading finished in 370 ms. container-test-run-flakelet-relay> agent # [700453.891105] agent systemd[1]: Reload requested from client PID 2848 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700453.891151] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700454.253955] agent systemd[1]: Reloading finished in 362 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 # [700454.343343] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [700454.346642] agent systemd[1]: Reload requested from client PID 2881 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700454.346696] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [700454.343706] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:27.154128Z","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 # [700454.726093] agent systemd[1]: Reloading finished in 378 ms. container-test-run-flakelet-relay> agent # [700454.815552] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700454.815778] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [700454.835739] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [700454.839871] agent systemd[1]: Reload requested from client PID 2912 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700454.839914] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700454.913800] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:27.724196Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"dde07ed8a3551238758055b8fd3c308b\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl restart flakelet-agent, in 1.01 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.02 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out container-test-run-flakelet-relay> agent # [700455.205107] agent systemd[1]: Reloading finished in 364 ms. container-test-run-flakelet-relay> agent # [700455.324914] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [700455.334224] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [700455.343691] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:28.154134Z","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 # [700455.344898] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:28.155369Z","level":"INFO","message":"start","id":"dde07ed8a3551238758055b8fd3c308b","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [700455.343788] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:28.154210Z","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 # [700461.410426] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [700461.417539] agent flakelet[2811]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [700461.420376] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700462.906882] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:35.717316Z","level":"INFO","message":"deploy finished","job":"aa3311622a8d379f9a61962bb489a198","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700462.905716] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:35.716138Z","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 8.10 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/restart.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/restart.out, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: agent restart mid-run reattaches to the unit, in 10.20 seconds) container-test-run-flakelet-relay> subtest: relay restart mid-run, push resumes via /v1/jobs container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/resume.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1792670256 | grep -q 'app-slow' container-test-run-flakelet-relay> relay # [700463.516398] relay flakelet-relay[400]: {"timestamp":"2026-10-22T11:57:36.326839Z","level":"INFO","message":"deploy accepted","job":"3cd5a5bd749cfb6cb4336cf02d6732f8","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700463.516818] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:36.327247Z","level":"INFO","message":"start","id":"f1229381b2ae88467ba91b70b48fd5aa","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700463.517333] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:36.327790Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"f1229381b2ae88467ba91b70b48fd5aa\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700463.555895] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700463.584330] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700463.589508] agent flakelet[3392]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [700463.590293] agent flakelet[3392]: app: activating generation 9 container-test-run-flakelet-relay> agent # [700463.603881] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [700463.605922] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700463.606269] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [700463.619933] agent systemd[1]: Reload requested from client PID 3399 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700463.619984] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700464.000193] agent systemd[1]: Reloading finished in 379 ms. container-test-run-flakelet-relay> agent # [700464.081400] agent systemd[1]: Reload requested from client PID 3429 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700464.081444] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1792670256 | 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 # [700464.447067] agent systemd[1]: Reloading finished in 365 ms. container-test-run-flakelet-relay> agent # [700464.530893] agent systemd[1]: Reload requested from client PID 3461 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700464.530942] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700464.546571] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:37.357011Z","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 # [700464.546030] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [700464.596837] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700464.597191] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [700464.597228] relay systemd[1]: flakelet-relay.service: Consumed 2.846s CPU time over 1min 11.748s wall clock time. container-test-run-flakelet-relay> relay # [700464.631417] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [700464.932824] agent systemd[1]: Reloading finished in 401 ms. container-test-run-flakelet-relay> agent # [700465.046996] agent systemd[1]: Reload requested from client PID 3492 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [700465.047050] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [700465.411484] agent systemd[1]: Reloading finished in 364 ms. container-test-run-flakelet-relay> agent # [700465.501177] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [700465.548817] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:38.359249Z","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.78 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [700466.307927] relay flakelet-relay[929]: {"timestamp":"2026-10-22T11:57:39.118343Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [700466.308734] relay flakelet-relay[929]: {"timestamp":"2026-10-22T11:57:39.118814Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [700466.308562] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [700467.556939] relay flakelet-relay[929]: {"timestamp":"2026-10-22T11:57:40.367369Z","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> relay # [700467.564165] relay flakelet-relay[929]: {"timestamp":"2026-10-22T11:57:40.374615Z","level":"INFO","message":"job reattached","job":"3cd5a5bd749cfb6cb4336cf02d6732f8","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700467.556874] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:40.367297Z","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 # [700471.571868] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [700471.580861] agent flakelet[3392]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [700471.584408] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [700472.630873] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:45.441277Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q '» ok' /tmp/resume.out, in 7.08 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/resume.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/resume.out, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: relay restart mid-run, push resumes via /v1/jobs, in 9.93 seconds) container-test-run-flakelet-relay> subtest: job history comes from the agents and survives a relay restart container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1 container-test-run-flakelet-relay> relay # [700473.428035] relay flakelet-relay[929]: {"timestamp":"2026-10-22T11:57:46.238442Z","level":"INFO","message":"deploy accepted","job":"188b06c4636b65849b3ba8daac22dc7c","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700473.428433] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:46.238845Z","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 # [700473.428868] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:46.239342Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700473.469151] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [700473.501125] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [700473.506089] agent flakelet[3571]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700473.506668] agent flakelet[3571]: other: up to date container-test-run-flakelet-relay> agent # [700473.508234] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1, in 0.65 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> relay # [700474.049552] relay flakelet-relay[929]: {"timestamp":"2026-10-22T11:57:46.859977Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700474.066092] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [700474.131509] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [700474.131930] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [700474.131963] relay systemd[1]: flakelet-relay.service: Consumed 2.076s CPU time over 9.500s wall clock time. container-test-run-flakelet-relay> relay # [700474.160094] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [700474.047895] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:46.858287Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700474.066896] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:46.877309Z","level":"INFO","message":"disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [700475.070885] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:47.881250Z","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.62 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 # [700475.674169] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:48.484586Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [700475.674770] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:48.484986Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [700475.674703] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [700477.084544] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:49.894967Z","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> agent # [700477.084439] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:49.894835Z","level":"INFO","message":"connected","relay":"https://relay:7443","relay_name":"relay","relay_version":"0.1.0","host":"agent","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1', in 2.06 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDU3MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMjcwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJRTVNWSEFNSlA0RlJRPT09IiwibmJmIjoxNzkyNjcwMjcwLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.z9gftobbg6KMw-hk7S5LGzZYL0bOuVE87D4L1tg_LF20FXDaTdgFtVHIQKHgudJJOSwuED7ds76Qp7_8mc9_Cw' push --relay https://relay:7443 deploy --id hist2 agent/app container-test-run-flakelet-relay> » job 6a239dbf87cfec796e49404c351d787f via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/app | app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent/app | app: up to date container-test-run-flakelet-relay> relay # [700477.843162] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:50.653569Z","level":"INFO","message":"deploy accepted","job":"6a239dbf87cfec796e49404c351d787f","caller":"example/app","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700477.843712] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:50.654104Z","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 # [700477.844354] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:50.654817Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dce6faec8455f85321e72ee634888126\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700477.880124] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [700477.907963] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [700477.912885] agent flakelet[3599]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [700477.913520] agent flakelet[3599]: app: up to date container-test-run-flakelet-relay> agent # [700477.914996] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> » agent/app: unchanged (generation 9) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDU3MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMjcwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJRTVNWSEFNSlA0RlJRPT09IiwibmJmIjoxNzkyNjcwMjcwLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.z9gftobbg6KMw-hk7S5LGzZYL0bOuVE87D4L1tg_LF20FXDaTdgFtVHIQKHgudJJOSwuED7ds76Qp7_8mc9_Cw' push --relay https://relay:7443 deploy --id hist2 agent/app, in 0.64 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDU3MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMjcwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJRTVNWSEFNSlA0RlJRPT09IiwibmJmIjoxNzkyNjcwMjcwLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.z9gftobbg6KMw-hk7S5LGzZYL0bOuVE87D4L1tg_LF20FXDaTdgFtVHIQKHgudJJOSwuED7ds76Qp7_8mc9_Cw' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc5MjY3MDU3MCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzkyNjcwMjcwLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJRTVNWSEFNSlA0RlJRPT09IiwibmJmIjoxNzkyNjcwMjcwLCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.z9gftobbg6KMw-hk7S5LGzZYL0bOuVE87D4L1tg_LF20FXDaTdgFtVHIQKHgudJJOSwuED7ds76Qp7_8mc9_Cw' push --relay https://relay:7443 jobs, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: job history comes from the agents and survives a relay restart, in 5.07 seconds) container-test-run-flakelet-relay> subtest: dashboard login via authorization code flow container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login, in 0.09 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other' container-test-run-flakelet-relay> relay # [700478.455095] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:51.265456Z","level":"INFO","message":"deploy finished","job":"6a239dbf87cfec796e49404c351d787f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700478.453530] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:51.263926Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [700478.535534] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [22/Oct/2026 11:57:51] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=DG08J-km751XmvPZXcLw924xnAbGCapub-tTZtLaDdE&code_challenge=FpM5aabwnVy-5SPFm1nwiEjPvIdolIgG5bpVVOGf34U&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> agent # [700478.714432] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:51.524698Z","level":"INFO","message":"start","id":"53cf003a8276a4a895d254201b62bb68","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [700478.592740] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [22/Oct/2026 11:57:51] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [700478.593786] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:51.404229Z","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 # [700478.665180] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:51.475591Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [700478.713815] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:51.524192Z","level":"INFO","message":"deploy accepted","job":"2e4c7aafd7f8db073bee5b34a0ac5640","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -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/d0402e561b925ca943f121278bf2dd3f/events || true container-test-run-flakelet-relay> relay # [700478.737735] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:51.548192Z","level":"INFO","message":"job reattached","job":"2e4c7aafd7f8db073bee5b34a0ac5640","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700478.714901] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:51.525365Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"53cf003a8276a4a895d254201b62bb68\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700478.751812] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [700478.778269] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [700478.783421] agent flakelet[3619]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700478.784077] agent flakelet[3619]: other: up to date container-test-run-flakelet-relay> agent # [700478.786772] 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/d0402e561b925ca943f121278bf2dd3f/events || true, in 0.61 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs/d0402e561b925ca943f121278bf2dd3f 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/d0402e561b925ca943f121278bf2dd3f, 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=d0402e561b925ca943f121278bf2dd3f' | 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=d0402e561b925ca943f121278bf2dd3f' | 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 # [700479.316858] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:52.127264Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700479.490367] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:52.300782Z","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 # [700479.491176] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:52.301280Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [700479.532222] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [700479.563991] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent/other | Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent/other | Started flakelet update other (via relay). container-test-run-flakelet-relay> agent/other | other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent/other | other: up to date container-test-run-flakelet-relay> relay # [700479.488951] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:52.299353Z","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 # [700479.570112] agent flakelet[3643]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [700479.570609] agent flakelet[3643]: other: up to date container-test-run-flakelet-relay> agent/otheragent # [700479.572283] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> | flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> » agent/other: unchanged (generation 1) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other, in 0.64 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q live1 /tmp/ev.out container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q live1 /tmp/ev.out, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: dashboard login via authorization code flow, in 1.69 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 91.00 seconds) container-test-run-flakelet-relay> test script finished in 91.34s container-test-run-flakelet-relay> cleanup container-test-run-flakelet-relay> kill NspawnMachine (pid 53) container-test-run-flakelet-relay> relay # [700480.112904] relay flakelet-relay[1319]: {"timestamp":"2026-10-22T11:57:52.923318Z","level":"INFO","message":"deploy finished","job":"38796a7ba508eadfe82a1cd5def000bc","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [700480.111243] agent flakelet-agent[2913]: {"timestamp":"2026-10-22T11:57:52.921659Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> kill NspawnMachine (pid 52) 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> Container relay terminated by signal KILL. container-test-run-flakelet-relay> (finished: cleanup, in 0.44 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 e8d51949ef825f3ca944f3a69969b8f7 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 37c8542e118152521f57c0024956a39e 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 1a06bb7f9046289c791f4e7e645d1d1b 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 aa3311622a8d379f9a61962bb489a198 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 3cd5a5bd749cfb6cb4336cf02d6732f8 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 e2eeb5ef52b0be4f6599c11a1b3e5665 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> » job 3cd5a5bd749cfb6cb4336cf02d6732f8 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> 1792670266 hist1 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792670256 e2eeb5ef52b0be4f6599c11a1b3e5665 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792670246 cdf060eb2d02d6a1af0b70ca612dcff3 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792670229 5571a30ee8f66d23cc85835b70f3ee24 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792670227 local-app-6-1792670227 root (shell) agent/app:updated container-test-run-flakelet-relay> 1792670224 local-app-5-1792670224 root (shell) agent/app:updated container-test-run-flakelet-relay> 1792670221 75e9d03d34a59d0c9eea6f121ba510fd admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792670209 97952b980470a70e3267e622f3147ac8 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792670207 2828e3470a9e853f93c6e7d1c86c9f6d admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1792670207 781f3e682d7bb002a572c0947c9f7007 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1792670205 f270a6587d87a6b166412fe23e14a3df admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1792670201 d60098e5ec16b02675a0cca831e8ddc9 admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1792670200 abba093026d24059ef3b8027ef4ad3cc dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792670198 c2888b0a25e37e6a492222a04c5c18e7 dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1792670196 34bd90bd392daef986b8e0d48f01219c someone agent/other:unchanged container-test-run-flakelet-relay> 1792670193 6bb529813de8353efea58be4377b2fd6 repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1792670189 a9a2b47b27b9efb1d2653605012456f1 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1792670187 local-app-1-1792670187 host activation agent/app:updated container-test-run-flakelet-relay> 1792670187 local-flakelet-agent-1-1792670187 host activation agent/flakelet-agent:updated container-test-run-flakelet-relay> 1792670187 local-other-1-1792670187 host activation agent/other:updated container-test-run-flakelet-relay> post-build step Upload coverage to codecov: ok Skipping codecov: project=Mic92/flakelet-relay attr=checks.x86_64-linux.nixos-test