these 36 derivations will be built: /nix/store/fcx6wd5461cjwpbpykqv1h551j1fx6an-push.drv /nix/store/i8gvxjjiz7l6y0lr4hxb638mzyz9hrr7-system-path.drv /nix/store/087fjf60znwqy7rqbq1c4rnh2wimi6lp-dbus-1.drv /nix/store/xl9rh1d8dsnz1c2yccidysbddf41y17p-flakelet-relay-0.1.0.drv /nix/store/ik6n07s5wrapf0fjyc7bzxlbahb863qk-flakelet-relay.json.drv /nix/store/1wmyari3w9fi12fm0kxddgdflhkhr71v-flakelet-relay.service.drv /nix/store/f07hywypndqwhpc7r1hjzmjj740ig592-flakelet-flakelet-relay-units.drv /nix/store/l59zdkbvsgbsiymiscq3qcnww5l5r0c7-flakelet-flakelet-relay.drv /nix/store/3jskw10c3v2g9r1c5wdksnv743smnmf5-flakelet-config.json.drv /nix/store/v14xbnr8chsqgla1y0cg77j0gv5li6bi-X-Restart-Triggers-dbus-broker.drv /nix/store/3k4p1bg0rs8wib759x7mj2rinx5jdpma-unit-dbus-broker.service.drv /nix/store/ixs14adrjk0z0xi81b7hmyzm7fkr7bnx-unit-dbus-broker.service.drv /nix/store/q609yshdklbdcc99nqv3ny0h0bmyy5yr-user-units.drv /nix/store/vdlya98h8rxnvh9vl6i8ql22q2349fc9-system-units.drv /nix/store/znzl0kpfbyaxd757r5vh6758ly3x0gig-etc.drv /nix/store/4kn7qa25kfm41ghakpj8zng99rgn5s19-activate.drv /nix/store/5j01rn8ibka6xw0j2plfmlxwcy0d063l-nixos-system-client-test.drv /nix/store/aqzl7hs096k7b7970qbp43yfi698icfd-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/ipdv5naqgjar3pgdjxz8qzxdx4zsd5gs-unit-flakelet-reconcile.service.drv /nix/store/syzc5vcbw35d3wanw6bvm2frv3wqxppc-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/lh5bkichg14br4k1gfn3f43vkcqvg433-unit-flakelet-flakelet-relay.service.drv /nix/store/b1lkvvarqksab3iy21hnr2ghns7wppsw-system-units.drv /nix/store/gaksbyg17jjb56mw6hpiggmzjvzjlkxi-etc.drv /nix/store/6zhng96sl0c8l45narq8nixkwirfhl2s-activate.drv /nix/store/idwskg2k3di6wjiz58aapk0ji9kx0nb8-nixos-system-relay-test.drv /nix/store/727ly0vp02whqhwc91a4h1az9j3sljzw-run-relay-nspawn.drv /nix/store/r2vv4a43f0nvq14p1dn2xal1l86y1z96-unit-flakelet-agent.service.drv /nix/store/p9cl4zz1hc5988y48ljk559x1zfiws2a-system-units.drv /nix/store/nfbwmyz6r7cn7z0j21rfxg4184lszm0r-etc.drv /nix/store/8p7z56jfhygszh4x7f3mscirb8dc75gp-activate.drv /nix/store/p2flcj4ba8pvq9fyw0qypzdy06ba8awz-nixos-system-agent-test.drv /nix/store/9pcc8f9laybxdppymrs3f81bpaglvj05-run-agent-nspawn.drv /nix/store/ly1h4gmsc7g1fxbysv9qwi5p4nrqgdxi-run-client-nspawn.drv /nix/store/hj963cjrb5028fm5r7w0kkkd5h818l3j-driverConfiguration.json.drv /nix/store/mrc8246d3klx11m1cg1g0hvp2wxdafk6-nixos-test-driver-flakelet-relay.drv /nix/store/cnf5znl2yvqiq26p1ywrqrahhbs2w1xd-container-test-run-flakelet-relay.drv building '/nix/store/fcx6wd5461cjwpbpykqv1h551j1fx6an-push.drv' building '/nix/store/r2vv4a43f0nvq14p1dn2xal1l86y1z96-unit-flakelet-agent.service.drv' building '/nix/store/syzc5vcbw35d3wanw6bvm2frv3wqxppc-X-Restart-Triggers-flakelet-flakelet-relay.drv' push> tribuchet: building on jamie unit-flakelet-agent.service> tribuchet: building on jamie X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/xl9rh1d8dsnz1c2yccidysbddf41y17p-flakelet-relay-0.1.0.drv' flakelet-relay-0.1.0> tribuchet: building on jamie flakelet-relay-0.1.0> Running phase: unpackPhase flakelet-relay-0.1.0> unpacking source archive /nix/store/yq8qqvrihsprpnjfg0bnp4vffi6vihiy-source flakelet-relay-0.1.0> source root is source flakelet-relay-0.1.0> Executing cargoSetupPostUnpackHook building '/nix/store/lh5bkichg14br4k1gfn3f43vkcqvg433-unit-flakelet-flakelet-relay.service.drv' unit-flakelet-flakelet-relay.service> tribuchet: building on jamie unit-flakelet-agent.service> structuredAttrs is enabled flakelet-relay-0.1.0> Finished cargoSetupPostUnpackHook flakelet-relay-0.1.0> Running phase: patchPhase flakelet-relay-0.1.0> Executing cargoSetupPostPatchHook flakelet-relay-0.1.0> Validating consistency between /build/source/Cargo.lock and /build/cargo-vendor-dir/Cargo.lock flakelet-relay-0.1.0> Finished cargoSetupPostPatchHook flakelet-relay-0.1.0> Running phase: updateAutotoolsGnuConfigScriptsPhase flakelet-relay-0.1.0> Running phase: configurePhase flakelet-relay-0.1.0> Running phase: buildPhase flakelet-relay-0.1.0> Executing cargoBuildHook flakelet-relay-0.1.0> cargoBuildHook flags: -j 24 --target x86_64-unknown-linux-gnu --offline --profile release unit-flakelet-flakelet-relay.service> structuredAttrs is enabled building '/nix/store/p9cl4zz1hc5988y48ljk559x1zfiws2a-system-units.drv' system-units> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling proc-macro2 v1.0.107 flakelet-relay-0.1.0> Compiling quote v1.0.47 flakelet-relay-0.1.0> Compiling unicode-ident v1.0.24 flakelet-relay-0.1.0> Compiling libc v0.2.189 flakelet-relay-0.1.0> Compiling autocfg v1.5.1 flakelet-relay-0.1.0> Compiling itoa v1.0.18 flakelet-relay-0.1.0> Compiling shlex v2.0.1 flakelet-relay-0.1.0> Compiling memchr v2.8.3 flakelet-relay-0.1.0> Compiling find-msvc-tools v0.1.11 flakelet-relay-0.1.0> Compiling cfg-if v1.0.4 flakelet-relay-0.1.0> Compiling pin-project-lite v0.2.17 flakelet-relay-0.1.0> Compiling once_cell v1.21.4 flakelet-relay-0.1.0> Compiling bytes v1.12.1 flakelet-relay-0.1.0> Compiling num-conv v0.2.2 flakelet-relay-0.1.0> Compiling minimal-lexical v0.2.1 flakelet-relay-0.1.0> Compiling time-core v0.1.9 flakelet-relay-0.1.0> Compiling thiserror v2.0.20 flakelet-relay-0.1.0> Compiling serde_core v1.0.229 flakelet-relay-0.1.0> Compiling version_check v0.9.5 flakelet-relay-0.1.0> Compiling zeroize v1.9.0 flakelet-relay-0.1.0> Compiling deranged v0.5.8 flakelet-relay-0.1.0> Compiling powerfmt v0.2.0 building '/nix/store/i8gvxjjiz7l6y0lr4hxb638mzyz9hrr7-system-path.drv' system-path> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling serde v1.0.229 flakelet-relay-0.1.0> Compiling httparse v1.10.1 flakelet-relay-0.1.0> Compiling utf8parse v0.2.2 flakelet-relay-0.1.0> Compiling cc v1.4.4 flakelet-relay-0.1.0> Compiling rustls-pki-types v1.15.1 flakelet-relay-0.1.0> Compiling zmij v1.0.23 flakelet-relay-0.1.0> Compiling log v0.4.34 flakelet-relay-0.1.0> Compiling tracing-core v0.1.36 flakelet-relay-0.1.0> Compiling time-macros v0.2.32 flakelet-relay-0.1.0> Compiling futures-core v0.3.34 flakelet-relay-0.1.0> Compiling untrusted v0.9.0 flakelet-relay-0.1.0> Compiling anstyle-parse v1.0.0 flakelet-relay-0.1.0> Compiling smallvec v1.16.0 flakelet-relay-0.1.0> Compiling regex-syntax v0.8.11 flakelet-relay-0.1.0> Compiling lazy_static v1.5.0 flakelet-relay-0.1.0> Compiling colorchoice v1.0.5 flakelet-relay-0.1.0> Compiling try-lock v0.2.5 flakelet-relay-0.1.0> Compiling proc-macro2-diagnostics v0.10.1 flakelet-relay-0.1.0> Compiling num-traits v0.2.19 flakelet-relay-0.1.0> Compiling is_terminal_polyfill v1.70.2 flakelet-relay-0.1.0> Compiling rustls v0.23.43 flakelet-relay-0.1.0> Compiling serde_json v1.0.151 flakelet-relay-0.1.0> Compiling oid-registry v0.8.1 flakelet-relay-0.1.0> Compiling anstyle-query v1.1.5 flakelet-relay-0.1.0> Compiling anstyle v1.0.14 flakelet-relay-0.1.0> Compiling want v0.3.1 flakelet-relay-0.1.0> Compiling futures-channel v0.3.34 flakelet-relay-0.1.0> Compiling httpdate v1.0.3 flakelet-relay-0.1.0> Compiling nom v7.1.3 flakelet-relay-0.1.0> Compiling anstream v1.0.0 flakelet-relay-0.1.0> Compiling http v1.5.0 flakelet-relay-0.1.0> Compiling strsim v0.11.1 flakelet-relay-0.1.0> Compiling clap_lex v1.1.0 system-path> structuredAttrs is enabled flakelet-relay-0.1.0> Compiling heck v0.5.0 flakelet-relay-0.1.0> Compiling subtle v2.6.1 flakelet-relay-0.1.0> Compiling atomic-waker v1.1.2 flakelet-relay-0.1.0> Compiling clap_builder v4.6.6 flakelet-relay-0.1.0> Compiling tracing-log v0.2.0 flakelet-relay-0.1.0> Compiling sharded-slab v0.1.7 flakelet-relay-0.1.0> Compiling thread_local v1.1.10 flakelet-relay-0.1.0> Compiling data-encoding v2.11.1 flakelet-relay-0.1.0> Compiling nu-ansi-term v0.50.3 flakelet-relay-0.1.0> Compiling webpki-roots v1.0.9 flakelet-relay-0.1.0> Compiling base64 v0.23.1 system-path> created 6399 symlinks in user environment flakelet-relay-0.1.0> Compiling syn v3.0.4 flakelet-relay-0.1.0> Compiling syn v2.0.119 flakelet-relay-0.1.0> Compiling ring v0.17.14 flakelet-relay-0.1.0> Compiling http-body v1.1.0 flakelet-relay-0.1.0> Compiling regex-automata v0.4.18 flakelet-relay-0.1.0> Compiling http-body-util v0.1.5 flakelet-relay-0.1.0> Compiling time v0.3.55 flakelet-relay-0.1.0> Compiling errno v0.3.14 flakelet-relay-0.1.0> Compiling socket2 v0.6.5 flakelet-relay-0.1.0> Compiling mio v1.2.2 flakelet-relay-0.1.0> Compiling getrandom v0.2.17 flakelet-relay-0.1.0> Compiling sd-notify v0.5.0 flakelet-relay-0.1.0> Compiling signal-hook-registry v1.4.8 flakelet-relay-0.1.0> Compiling num-integer v0.1.47 flakelet-relay-0.1.0> Compiling num-bigint v0.4.8 flakelet-relay-0.1.0> Compiling rusticata-macros v4.1.0 building '/nix/store/nfbwmyz6r7cn7z0j21rfxg4184lszm0r-etc.drv' etc> tribuchet: building on jamie building '/nix/store/087fjf60znwqy7rqbq1c4rnh2wimi6lp-dbus-1.drv' dbus-1> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling matchers v0.2.0 flakelet-relay-0.1.0> Compiling thiserror-impl v2.0.20 flakelet-relay-0.1.0> Compiling displaydoc v0.2.7 flakelet-relay-0.1.0> Compiling tokio-macros v2.7.2 flakelet-relay-0.1.0> Compiling serde_derive v1.0.229 flakelet-relay-0.1.0> Compiling clap_derive v4.6.4 building '/nix/store/8p7z56jfhygszh4x7f3mscirb8dc75gp-activate.drv' activate> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling synstructure v0.13.2 building '/nix/store/v14xbnr8chsqgla1y0cg77j0gv5li6bi-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling asn1-rs-derive v0.6.0 flakelet-relay-0.1.0> Compiling asn1-rs-impl v0.2.0 flakelet-relay-0.1.0> Compiling tracing-attributes v0.1.31 flakelet-relay-0.1.0> Compiling maud_macros v0.27.0 building '/nix/store/p2flcj4ba8pvq9fyw0qypzdy06ba8awz-nixos-system-agent-test.drv' nixos-system-agent-test> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling tokio v1.53.1 building '/nix/store/3k4p1bg0rs8wib759x7mj2rinx5jdpma-unit-dbus-broker.service.drv' building '/nix/store/ixs14adrjk0z0xi81b7hmyzm7fkr7bnx-unit-dbus-broker.service.drv' unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> tribuchet: building on jamie nixos-system-agent-test> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled flakelet-relay-0.1.0> Compiling clap v4.6.6 building '/nix/store/9pcc8f9laybxdppymrs3f81bpaglvj05-run-agent-nspawn.drv' run-agent-nspawn> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling maud v0.27.0 flakelet-relay-0.1.0> Compiling asn1-rs v0.7.2 building '/nix/store/vdlya98h8rxnvh9vl6i8ql22q2349fc9-system-units.drv' building '/nix/store/q609yshdklbdcc99nqv3ny0h0bmyy5yr-user-units.drv' system-units> tribuchet: building on jamie user-units> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling tracing v0.1.44 flakelet-relay-0.1.0> Compiling tracing-serde v0.2.0 flakelet-relay-0.1.0> Compiling tracing-subscriber v0.3.23 flakelet-relay-0.1.0> Compiling der-parser v10.0.0 flakelet-relay-0.1.0> Compiling x509-parser v0.18.1 flakelet-relay-0.1.0> Compiling rustls-webpki v0.103.15 building '/nix/store/znzl0kpfbyaxd757r5vh6758ly3x0gig-etc.drv' etc> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling hyper v1.11.1 flakelet-relay-0.1.0> Compiling hyper-util v0.1.20 building '/nix/store/4kn7qa25kfm41ghakpj8zng99rgn5s19-activate.drv' activate> tribuchet: building on jamie building '/nix/store/5j01rn8ibka6xw0j2plfmlxwcy0d063l-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling tokio-rustls v0.26.4 nixos-system-client-test> structuredAttrs is enabled flakelet-relay-0.1.0> Compiling flakelet-relay v0.1.0 (/build/source) building '/nix/store/ly1h4gmsc7g1fxbysv9qwi5p4nrqgdxi-run-client-nspawn.drv' run-client-nspawn> tribuchet: building on jamie flakelet-relay-0.1.0> Finished `release` profile [optimized] target(s) in 27.65s flakelet-relay-0.1.0> Executing cargoInstallPostBuildHook flakelet-relay-0.1.0> Finished cargoInstallPostBuildHook flakelet-relay-0.1.0> Finished cargoBuildHook flakelet-relay-0.1.0> Running phase: checkPhase flakelet-relay-0.1.0> Executing cargoCheckHook flakelet-relay-0.1.0> cargoCheckHook flags: -j 24 --profile release --target x86_64-unknown-linux-gnu --offline -- flakelet-relay-0.1.0> Compiling rustix v1.1.4 flakelet-relay-0.1.0> Compiling getrandom v0.4.3 flakelet-relay-0.1.0> Compiling linux-raw-sys v0.12.1 flakelet-relay-0.1.0> Compiling bitflags v2.13.1 flakelet-relay-0.1.0> Compiling fastrand v2.5.0 flakelet-relay-0.1.0> Compiling tempfile v3.27.0 flakelet-relay-0.1.0> Compiling flakelet-relay v0.1.0 (/build/source) flakelet-relay-0.1.0> Finished `release` profile [optimized] target(s) in 10.49s flakelet-relay-0.1.0> Running unittests src/lib.rs (target/x86_64-unknown-linux-gnu/release/deps/flakelet_relay-a0eaee9b21fdfd23) flakelet-relay-0.1.0> flakelet-relay-0.1.0> running 21 tests flakelet-relay-0.1.0> test auth::policy::tests::globbing ... ok flakelet-relay-0.1.0> test oidc::tests::encodes_forms ... ok flakelet-relay-0.1.0> test client::tests::urls ... ok flakelet-relay-0.1.0> test auth::policy::tests::agent_identity ... ok flakelet-relay-0.1.0> test auth::policy::tests::validate_catches_unknown_group ... ok flakelet-relay-0.1.0> test auth::policy::tests::deploy_rules ... ok flakelet-relay-0.1.0> test relay::pages::tests::short_rev_uses_rev_not_nar_hash ... ok flakelet-relay-0.1.0> test relay::pages::tests::short_prefers_email_over_opaque_sub ... ok flakelet-relay-0.1.0> test proto::tests::unknown_frame_type_is_tolerated ... ok flakelet-relay-0.1.0> test relay::pages::tests::filter_terms_words_and_toggle ... ok flakelet-relay-0.1.0> test relay::session::tests::roundtrip_and_tamper ... ok flakelet-relay-0.1.0> test srv::tests::parses_compressed_srv ... ok flakelet-relay-0.1.0> test proto::tests::unknown_fields_and_status_are_tolerated ... ok flakelet-relay-0.1.0> test sse::tests::roundtrip_split_across_chunks ... ok flakelet-relay-0.1.0> test ws::tests::rfc_example_accept_key ... ok flakelet-relay-0.1.0> test proto::tests::target_split_rejects_malformed ... ok flakelet-relay-0.1.0> test auth::jwt::tests::es256 ... ok flakelet-relay-0.1.0> test proto::tests::done_roundtrip_is_flat ... ok flakelet-relay-0.1.0> test auth::jwt::tests::ed25519_happy_and_claim_checks ... ok flakelet-relay-0.1.0> test relay::ui::tests::sse_keeps_trailing_newline ... ok flakelet-relay-0.1.0> test ws::tests::roundtrip_masked_large ... ok flakelet-relay-0.1.0> flakelet-relay-0.1.0> test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s flakelet-relay-0.1.0> flakelet-relay-0.1.0> Running unittests src/bin/flakelet-agent.rs (target/x86_64-unknown-linux-gnu/release/deps/flakelet_agent-1cb04c92098d9184) flakelet-relay-0.1.0> flakelet-relay-0.1.0> running 0 tests flakelet-relay-0.1.0> flakelet-relay-0.1.0> test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s flakelet-relay-0.1.0> flakelet-relay-0.1.0> Running unittests src/bin/flakelet-push.rs (target/x86_64-unknown-linux-gnu/release/deps/flakelet_push-e04fe5b96273a4a1) flakelet-relay-0.1.0> flakelet-relay-0.1.0> running 0 tests flakelet-relay-0.1.0> flakelet-relay-0.1.0> test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s flakelet-relay-0.1.0> flakelet-relay-0.1.0> Running unittests src/bin/flakelet-relay.rs (target/x86_64-unknown-linux-gnu/release/deps/flakelet_relay-2deef0a6284d0b44) flakelet-relay-0.1.0> flakelet-relay-0.1.0> running 0 tests flakelet-relay-0.1.0> flakelet-relay-0.1.0> test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s flakelet-relay-0.1.0> flakelet-relay-0.1.0> Doc-tests flakelet_relay flakelet-relay-0.1.0> flakelet-relay-0.1.0> running 0 tests flakelet-relay-0.1.0> flakelet-relay-0.1.0> test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s flakelet-relay-0.1.0> flakelet-relay-0.1.0> Finished cargoCheckHook flakelet-relay-0.1.0> Running phase: installPhase flakelet-relay-0.1.0> Executing cargoInstallHook flakelet-relay-0.1.0> Finished cargoInstallHook flakelet-relay-0.1.0> Running phase: fixupPhase flakelet-relay-0.1.0> shrinking RPATHs of ELF executables and libraries in /nix/store/dcckz5lr5c6qmxmykrhz6ylhmdglzzrd-flakelet-relay-0.1.0 flakelet-relay-0.1.0> shrinking /nix/store/dcckz5lr5c6qmxmykrhz6ylhmdglzzrd-flakelet-relay-0.1.0/bin/flakelet-agent flakelet-relay-0.1.0> shrinking /nix/store/dcckz5lr5c6qmxmykrhz6ylhmdglzzrd-flakelet-relay-0.1.0/bin/flakelet-push flakelet-relay-0.1.0> shrinking /nix/store/dcckz5lr5c6qmxmykrhz6ylhmdglzzrd-flakelet-relay-0.1.0/bin/flakelet-relay flakelet-relay-0.1.0> checking for references to /build/ in /nix/store/dcckz5lr5c6qmxmykrhz6ylhmdglzzrd-flakelet-relay-0.1.0... flakelet-relay-0.1.0> patching script interpreter paths in /nix/store/dcckz5lr5c6qmxmykrhz6ylhmdglzzrd-flakelet-relay-0.1.0 flakelet-relay-0.1.0> stripping (with command strip and flags -S -p) in /nix/store/dcckz5lr5c6qmxmykrhz6ylhmdglzzrd-flakelet-relay-0.1.0/bin building '/nix/store/ik6n07s5wrapf0fjyc7bzxlbahb863qk-flakelet-relay.json.drv' flakelet-relay.json> tribuchet: building on jamie flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/app (expect allow) flakelet-relay.json> agent/app allowed by ci flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/other (expect deny) flakelet-relay.json> agent/other denied building '/nix/store/1wmyari3w9fi12fm0kxddgdflhkhr71v-flakelet-relay.service.drv' flakelet-relay.service> tribuchet: building on jamie building '/nix/store/f07hywypndqwhpc7r1hjzmjj740ig592-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie building '/nix/store/l59zdkbvsgbsiymiscq3qcnww5l5r0c7-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/3jskw10c3v2g9r1c5wdksnv743smnmf5-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled building '/nix/store/aqzl7hs096k7b7970qbp43yfi698icfd-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/ipdv5naqgjar3pgdjxz8qzxdx4zsd5gs-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/b1lkvvarqksab3iy21hnr2ghns7wppsw-system-units.drv' system-units> tribuchet: building on jamie building '/nix/store/gaksbyg17jjb56mw6hpiggmzjvzjlkxi-etc.drv' etc> tribuchet: building on jamie building '/nix/store/6zhng96sl0c8l45narq8nixkwirfhl2s-activate.drv' activate> tribuchet: building on jamie building '/nix/store/idwskg2k3di6wjiz58aapk0ji9kx0nb8-nixos-system-relay-test.drv' nixos-system-relay-test> tribuchet: building on jamie nixos-system-relay-test> structuredAttrs is enabled building '/nix/store/727ly0vp02whqhwc91a4h1az9j3sljzw-run-relay-nspawn.drv' run-relay-nspawn> tribuchet: building on jamie building '/nix/store/hj963cjrb5028fm5r7w0kkkd5h818l3j-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/mrc8246d3klx11m1cg1g0hvp2wxdafk6-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/cnf5znl2yvqiq26p1ywrqrahhbs2w1xd-container-test-run-flakelet-relay.drv' container-test-run-flakelet-relay> tribuchet: building on jamie container-test-run-flakelet-relay> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-flakelet-relay> start all VLans container-test-run-flakelet-relay> (finished: start all VLans, in 0.00 seconds) container-test-run-flakelet-relay> Initializing machine ID from random generator. container-test-run-flakelet-relay> Test will time out and terminate in 3600.0 seconds container-test-run-flakelet-relay> run the VM test script container-test-run-flakelet-relay> start all VMs container-test-run-flakelet-relay> agent: systemd-nspawn running (pid 52) container-test-run-flakelet-relay> client: systemd-nspawn running (pid 53) container-test-run-flakelet-relay> 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> client: Waiting for journal at /build/vm-state-client/var/log/journal... container-test-run-flakelet-relay> relay: Waiting for journal at /build/vm-state-relay/var/log/journal... container-test-run-flakelet-relay> (finished: start all VMs, in 0.00 seconds) container-test-run-flakelet-relay> relay: waiting for unit flakelet-relay.service container-test-run-flakelet-relay> nixos-nspawn(agent): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(agent): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(client): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(client): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(relay): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(relay): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> ░ Spawning container agent on /build/vm-state-agent. 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 client on /build/vm-state-client. container-test-run-flakelet-relay> ░ Spawning container relay on /build/vm-state-relay. 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> 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 # [ 4129.362486] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [ 4129.362526] agent systemd-journald[57]: Runtime Journal (/run/log/journal/3f1be28c914842888d58978208fda2c7) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [ 4129.374085] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [ 4129.386579] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [ 4129.400620] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [ 4129.401332] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> agent # [ 4129.438179] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/3f1be28c914842888d58978208fda2c7 is 1.518ms for 6 entries. container-test-run-flakelet-relay> agent # [ 4129.438179] agent systemd-journald[57]: System Journal (/var/log/journal/3f1be28c914842888d58978208fda2c7) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [ 4129.446846] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [ 4129.447561] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> agent # [ 4129.447664] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [ 4129.462355] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> agent # [ 4129.514177] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [ 4130.388756] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [ 4129.363625] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> relay # [ 4129.363667] relay systemd-journald[57]: Runtime Journal (/run/log/journal/faf966da07bf470eb898a338738ca5f6) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [ 4129.374828] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> relay # [ 4129.387461] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> relay # [ 4129.401738] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> relay # [ 4129.402360] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [ 4129.438395] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/faf966da07bf470eb898a338738ca5f6 is 1.373ms for 6 entries. container-test-run-flakelet-relay> relay # [ 4129.438395] relay systemd-journald[57]: System Journal (/var/log/journal/faf966da07bf470eb898a338738ca5f6) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [ 4129.446864] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [ 4129.447227] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [ 4129.448305] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [ 4129.448410] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [ 4129.528598] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [ 4130.363405] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [ 4129.363361] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [ 4129.363402] client systemd-journald[57]: Runtime Journal (/run/log/journal/0f57984d835747a28d5e760a2b1dc084) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [ 4129.374445] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [ 4129.387083] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [ 4129.401388] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [ 4129.401909] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [ 4129.438493] client systemd-journald[57]: Time spent on flushing to /var/log/journal/0f57984d835747a28d5e760a2b1dc084 is 1.466ms for 6 entries. container-test-run-flakelet-relay> client # [ 4129.438493] client systemd-journald[57]: System Journal (/var/log/journal/0f57984d835747a28d5e760a2b1dc084) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [ 4129.447165] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> client # [ 4129.447847] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> client # [ 4129.447958] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> client # [ 4129.460108] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> client # [ 4129.510345] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [ 4130.388733] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [ 4130.419799] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [ 4130.420822] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [ 4130.422118] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [ 4130.423728] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [ 4130.423776] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [ 4130.425168] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [ 4130.426414] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [ 4130.419869] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [ 4130.444212] client systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> agent # [ 4130.420951] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [ 4130.444626] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [ 4130.422229] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [ 4130.423696] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [ 4130.423745] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [ 4130.425125] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> agent # [ 4130.426342] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [ 4130.444425] agent systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> client # [ 4130.444954] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/0f57984d835747a28d5e760a2b1dc084 failed: Operation not permitted container-test-run-flakelet-relay> client # [ 4130.445318] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [ 4130.444846] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [ 4130.445187] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/3f1be28c914842888d58978208fda2c7 failed: Operation not permitted container-test-run-flakelet-relay> agent # [ 4130.445535] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [ 4130.419862] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> relay # [ 4130.420975] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [ 4130.422289] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [ 4130.423525] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [ 4130.423567] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [ 4130.424853] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [ 4130.426373] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> relay # [ 4130.446086] 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 # [ 4130.446483] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [ 4130.446939] relay suid-sgid-wrappers-start[176]: chmod: changing permissions of '/run/wrappers/wrappers.RsdMwo90B6/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [ 4130.446785] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/faf966da07bf470eb898a338738ca5f6 failed: Operation not permitted container-test-run-flakelet-relay> relay # [ 4130.447122] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [ 4130.455072] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [ 4130.455111] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [ 4130.455172] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [ 4130.455846] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [ 4130.511646] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [ 4130.512685] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [ 4130.541888] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4130.542823] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [ 4130.544107] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [ 4130.546416] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [ 4130.546579] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [ 4130.555690] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [ 4130.556456] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [ 4130.556574] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [ 4130.556624] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [ 4130.556651] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [ 4130.556772] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [ 4130.556992] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [ 4130.557102] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [ 4130.557116] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [ 4130.557146] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [ 4130.558580] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [ 4130.559454] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [ 4130.560022] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [ 4130.560820] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [ 4130.561406] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> relay # [ 4130.569644] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [ 4130.570598] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [ 4130.575474] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [ 4130.581205] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> client # [ 4130.446557] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.SYPIvysWaR/chsh': Operation not permitted container-test-run-flakelet-relay> client # [ 4130.450693] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [ 4130.450789] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [ 4130.450985] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> client # [ 4130.451480] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [ 4130.466051] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [ 4130.466855] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [ 4130.542158] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [ 4130.542955] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [ 4130.543165] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [ 4130.546863] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [ 4130.547751] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [ 4130.556939] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [ 4130.557029] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [ 4130.557084] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [ 4130.557103] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [ 4130.557115] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [ 4130.557209] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [ 4130.557363] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [ 4130.557448] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [ 4130.557460] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [ 4130.557486] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [ 4130.558757] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [ 4130.559863] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [ 4130.560932] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [ 4130.578349] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> client # [ 4130.633771] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> client # [ 4130.633913] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [ 4130.638962] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [ 4130.446299] agent suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.cpdBPYngzc/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [ 4130.451342] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [ 4130.451380] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [ 4130.451433] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [ 4130.451982] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [ 4130.466438] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [ 4130.467132] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> agent # [ 4130.546180] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4130.546819] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [ 4130.546946] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [ 4130.549359] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [ 4130.549563] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [ 4130.559638] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [ 4130.559768] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [ 4130.559818] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [ 4130.559836] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [ 4130.559849] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [ 4130.559929] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [ 4130.560060] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [ 4130.560212] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [ 4130.560228] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [ 4130.560257] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [ 4130.561090] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [ 4130.561727] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [ 4130.562605] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [ 4130.563398] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [ 4130.572229] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [ 4130.573502] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [ 4130.579227] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [ 4130.584170] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [ 4130.633743] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [ 4130.633874] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [ 4130.634536] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [ 4130.649803] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [ 4130.632276] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [ 4130.632406] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [ 4130.633397] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [ 4130.634184] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [ 4130.650373] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4130.681261] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [ 4130.684321] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [ 4130.698520] relay network-addresses-eth1-start[246]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [ 4130.701506] relay network-addresses-eth1-start[246]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [ 4130.705859] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> relay # [ 4130.740779] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [ 4130.740881] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [ 4130.742532] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [ 4130.743391] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [ 4130.744164] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [ 4130.789486] relay flakelet[311]: flakelet-relay: using prebuilt artifact /nix/store/fl3yaf8n4z6kzaqxhir0h87s6hfzrnvv-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [ 4130.790155] relay flakelet[311]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [ 4130.795554] relay systemd[1]: Reload requested from client PID 316 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [ 4130.795625] relay systemd[1]: Reloading... container-test-run-flakelet-relay> client # [ 4130.681614] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [ 4130.681845] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [ 4130.681905] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [ 4130.685253] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [ 4130.699474] client network-addresses-eth1-start[233]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> client # [ 4130.702775] client network-addresses-eth1-start[233]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [ 4130.706864] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [ 4130.777165] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [ 4130.777549] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> client # [ 4130.788294] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [ 4130.788623] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [ 4130.792777] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [ 4130.681250] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4130.681308] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [ 4130.683985] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [ 4130.699547] agent network-addresses-eth1-start[237]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [ 4130.703332] agent network-addresses-eth1-start[237]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [ 4130.707361] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [ 4130.776866] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [ 4130.777401] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [ 4130.782968] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [ 4130.783740] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [ 4130.784465] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [ 4130.787559] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4130.787767] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [ 4130.790313] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [ 4130.794712] agent flakelet[305]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [ 4130.795252] agent flakelet[305]: app: activating generation 1 container-test-run-flakelet-relay> agent # [ 4130.795683] agent flakelet[306]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4130.796187] agent flakelet[306]: other: activating generation 1 container-test-run-flakelet-relay> agent # [ 4130.800991] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [ 4130.801026] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4130.870338] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:28.832046Z","level":"WARN","message":"SRV _flakelet-relay._tcp.test: lookup failed","target":"flakelet_agent"} container-test-run-flakelet-relay> agent # [ 4131.108712] agent nsncd[311]: Sep 06 08:13:29.070 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [ 4131.212584] agent systemd[1]: Reloading finished in 411 ms. container-test-run-flakelet-relay> agent # [ 4131.382043] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> relay # [ 4131.140156] relay nsncd[251]: Sep 06 08:13:29.101 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [ 4131.210954] relay systemd[1]: Reloading finished in 414 ms. container-test-run-flakelet-relay> relay # [ 4131.347943] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [ 4131.348402] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [ 4131.348487] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [ 4131.349715] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [ 4131.350547] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [ 4131.365735] relay systemd[1]: Reload requested from client PID 357 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [ 4131.365765] relay systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4131.471952] relay dnsmasq-pre-start[376]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> client # [ 4131.113419] client nsncd[303]: Sep 06 08:13:29.075 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [ 4131.113588] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [ 4131.113669] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [ 4131.113770] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [ 4131.116280] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [ 4131.118050] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [ 4131.153375] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [ 4131.155285] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [ 4131.155340] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [ 4131.155371] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [ 4131.382350] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [ 4131.386679] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [ 4131.386752] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4131.720345] relay systemd[1]: Reloading finished in 354 ms. container-test-run-flakelet-relay> agent # [ 4131.740307] agent systemd[1]: Reloading finished in 352 ms. container-test-run-flakelet-relay> agent # [ 4131.876528] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [ 4131.876670] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [ 4131.878118] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [ 4131.879177] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [ 4131.886737] agent systemd[1]: Reload requested from client PID 769 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [ 4131.886766] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4131.878226] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [ 4131.882124] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [ 4131.882191] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [ 4131.882269] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [ 4131.906288] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [ 4132.266661] agent systemd[1]: Reloading finished in 379 ms. container-test-run-flakelet-relay> agent # [ 4132.342467] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [ 4132.346642] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [ 4132.346702] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [ 4132.346765] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [ 4132.349405] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [ 4132.352244] agent systemd[1]: Reload requested from client PID 806 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [ 4132.352273] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4132.429654] relay nginx-pre-start[402]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [ 4132.430387] relay nginx-pre-start[402]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [ 4132.446103] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> relay # [ 4132.567955] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [ 4132.533431] client systemd-logind[315]: New seat seat0. container-test-run-flakelet-relay> client # [ 4132.540636] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [ 4132.540820] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [ 4132.542499] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [ 4132.576443] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [ 4132.576813] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [ 4132.577155] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> agent # [ 4132.748148] agent systemd[1]: Reloading finished in 395 ms. container-test-run-flakelet-relay> agent # [ 4132.819764] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [ 4132.826311] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [ 4132.835779] agent flakelet[305]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [ 4132.852479] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [ 4132.856130] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [ 4132.869857] agent flakelet[306]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [ 4132.871878] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [ 4132.872130] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [ 4132.830112] relay systemd-logind[354]: New seat seat0. container-test-run-flakelet-relay> relay # [ 4132.830488] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [ 4132.853802] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [ 4132.867291] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4132.867574] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> relay # [ 4133.063662] relay dbus-broker-launch[408]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [ 4133.065114] relay dbus-broker-launch[408]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [ 4133.065114] relay dbus-broker-launch[408]: Invalid user-name in /nix/store/27h4g2jdw18vrabfh6p1l0n8ss5dhbp5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> relay # [ 4133.066218] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [ 4133.072315] relay dbus-broker-launch[408]: Ready container-test-run-flakelet-relay> relay # [ 4133.075819] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> relay # [ 4133.077482] relay dnsmasq[394]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [ 4133.077489] 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 # [ 4133.077494] relay dnsmasq[394]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [ 4133.077501] relay dnsmasq[394]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [ 4133.077592] relay dnsmasq[394]: read /etc/hosts - 9 names container-test-run-flakelet-relay> client # [ 4133.069128] client dbus-broker-launch[325]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [ 4133.070651] client dbus-broker-launch[325]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [ 4133.070651] client dbus-broker-launch[325]: Invalid user-name in /nix/store/dnzidffc1dfdbxximnrmgywb0nyk9w6q-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [ 4133.071763] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [ 4133.072289] client systemd[1]: Startup finished in 4.174s. container-test-run-flakelet-relay> client # [ 4133.077921] client dbus-broker-launch[325]: Ready container-test-run-flakelet-relay> agent # [ 4133.306043] agent systemd-logind[767]: New seat seat0. container-test-run-flakelet-relay> agent # [ 4133.306646] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [ 4133.308772] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [ 4133.310379] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [ 4133.349918] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4133.350297] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [ 4133.350655] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> agent # [ 4133.716498] agent dbus-broker-launch[853]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [ 4133.718024] agent dbus-broker-launch[853]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [ 4133.718127] agent dbus-broker-launch[853]: Invalid user-name in /nix/store/q3c2gxfm178wqgzv8m87na4aa72wxc04-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> agent # [ 4133.718970] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [ 4133.719550] agent systemd[1]: Startup finished in 4.821s. container-test-run-flakelet-relay> agent # [ 4133.725812] agent dbus-broker-launch[853]: Ready container-test-run-flakelet-relay> relay # [ 4133.930837] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:31.892447Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [ 4133.931683] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:31.893152Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [ 4133.931568] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [ 4133.941763] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> relay # [ 4134.183704] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4134.184095] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay # [ 4134.231174] relay flakelet[311]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [ 4134.234107] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [ 4134.234656] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [ 4134.234831] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [ 4134.235116] relay systemd[1]: Startup finished in 5.329s. container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 6.16 seconds) container-test-run-flakelet-relay> relay: waiting for unit nginx.service container-test-run-flakelet-relay> relay: (finished: waiting for unit nginx.service, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet.target container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet.target, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet-agent.service container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet-agent.service, in 0.02 seconds) container-test-run-flakelet-relay> client: waiting for unit multi-user.target container-test-run-flakelet-relay> client: (finished: waiting for unit multi-user.target, in 0.02 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1' container-test-run-flakelet-relay> relay # [ 4135.892865] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:33.854606Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(1), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [ 4135.892540] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:33.854254Z","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.05 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service other.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service other.service, in 0.01 seconds) container-test-run-flakelet-relay> subtest: deploy with client certificate, relay found via SRV container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1 container-test-run-flakelet-relay> relay # [ 4136.723965] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:34.685721Z","level":"INFO","message":"deploy accepted","job":"1f66c3bae45a2f68de24222f8b7c61c0","caller":"x509:email:admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4136.725080] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:34.686761Z","level":"INFO","message":"start","id":"1258fb08b515dfb35a76fdb8041ae036","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4136.725963] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:34.687778Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"1258fb08b515dfb35a76fdb8041ae036\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4136.778658] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4136.818083] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4136.822493] agent flakelet[882]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [ 4136.823149] agent flakelet[882]: app: activating generation 2 container-test-run-flakelet-relay> agent # [ 4136.838207] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [ 4136.839875] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4136.840156] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [ 4136.856471] agent systemd[1]: Reload requested from client PID 889 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4136.856536] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4137.194713] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [ 4137.287065] agent systemd[1]: Reload requested from client PID 922 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4137.287101] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4137.608376] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [ 4137.700775] agent systemd[1]: Reload requested from client PID 953 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4137.700815] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4138.024210] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [ 4138.118394] agent systemd[1]: Reload requested from client PID 987 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4138.118430] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4138.438126] agent systemd[1]: Reloading finished in 319 ms. container-test-run-flakelet-relay> agent # [ 4138.510900] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [ 4138.556175] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [ 4138.570633] agent flakelet[882]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [ 4138.572717] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1, in 2.97 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> (finished: subtest: deploy with client certificate, relay found via SRV, in 3.02 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.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4MjcxNywiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDE3LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJGS0FMTzRGVVc1RUlVPT09IiwibmJmIjoxNzg4NjgyNDE3LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.tnNAnXhf_fHrmg_bWR_2mAbobzxcvQcQv2-8U6qG1fPJHWIwitgL6iMi6NQVieGiKeSSOqJuIb0gdam_7RV1CA' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> agent # [ 4139.665848] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:37.627544Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4139.798373] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:37.760168Z","level":"INFO","message":"start","id":"81aa5a435dff2cbd492eb196aaae7514","flakelet":"app","rule":"ci","relay":"relay","caller":"Some(\"oidc:mock:repo:github:example/app:ref:refs/heads/main\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4139.798643] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:37.760476Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"81aa5a435dff2cbd492eb196aaae7514\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4139.853230] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4139.884977] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4139.889213] agent flakelet[1067]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [ 4139.889861] agent flakelet[1067]: app: activating generation 3 container-test-run-flakelet-relay> agent # [ 4139.906044] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [ 4139.907701] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4139.907971] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [ 4139.924468] agent systemd[1]: Reload requested from client PID 1074 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4139.924534] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4139.667689] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:37.629422Z","level":"INFO","message":"deploy finished","job":"1f66c3bae45a2f68de24222f8b7c61c0","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4139.798045] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:37.759801Z","level":"INFO","message":"deploy accepted","job":"99195f4ffd4e784499fa0c01c14616d4","caller":"oidc:mock:repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4140.258556] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [ 4140.331707] agent systemd[1]: Reload requested from client PID 1104 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4140.331741] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4140.653327] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [ 4140.714327] agent systemd[1]: Reload requested from client PID 1133 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4140.714360] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4141.036007] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [ 4141.120931] agent systemd[1]: Reload requested from client PID 1167 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4141.120967] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4141.444409] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [ 4141.509761] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [ 4141.536976] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [ 4141.548657] agent flakelet[1067]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [ 4141.550200] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4MjcxNywiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDE3LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJGS0FMTzRGVVc1RUlVPT09IiwibmJmIjoxNzg4NjgyNDE3LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.tnNAnXhf_fHrmg_bWR_2mAbobzxcvQcQv2-8U6qG1fPJHWIwitgL6iMi6NQVieGiKeSSOqJuIb0gdam_7RV1CA' push --relay https://relay:7443 deploy agent/app 2>&1, in 2.90 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 2.97 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4MjcxNywiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDE3LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJGS0FMTzRGVVc1RUlVPT09IiwibmJmIjoxNzg4NjgyNDE3LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.tnNAnXhf_fHrmg_bWR_2mAbobzxcvQcQv2-8U6qG1fPJHWIwitgL6iMi6NQVieGiKeSSOqJuIb0gdam_7RV1CA' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4MjcxNywiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDE3LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJGS0FMTzRGVVc1RUlVPT09IiwibmJmIjoxNzg4NjgyNDE3LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.tnNAnXhf_fHrmg_bWR_2mAbobzxcvQcQv2-8U6qG1fPJHWIwitgL6iMi6NQVieGiKeSSOqJuIb0gdam_7RV1CA' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4MjcyMCwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc4ODY4MjQyMCwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiVlE1N1JIRkw2V0s3WT09PSIsIm5iZiI6MTc4ODY4MjQyMCwic3ViIjoic29tZW9uZSJ9.6he3_KeYg10UjVSNP1uqXVC5wdxzKr-bA5l9xrIfWjBXWPfdAc7PPBwrnOO4YxDzrc1BSfuyrHl6QZlnXfM8Bw' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [ 4142.667663] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:40.629366Z","level":"INFO","message":"deploy finished","job":"99195f4ffd4e784499fa0c01c14616d4","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4142.766756] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:40.728509Z","level":"INFO","message":"deploy accepted","job":"cf0b9ffa53e7077583011cd48d81bce3","caller":"oidc:mock:groups:wheel\noidc:mock:someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4142.665969] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:40.627677Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4142.767078] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:40.728824Z","level":"INFO","message":"start","id":"3ac18ff2f037cfbd9d9b0d8938798c12","flakelet":"other","rule":"admins","relay":"relay","caller":"Some(\"oidc:mock:groups:wheel\\noidc:mock:someone\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4142.767348] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:40.729180Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"3ac18ff2f037cfbd9d9b0d8938798c12\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4142.818459] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [ 4142.851091] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [ 4142.855268] agent flakelet[1233]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4142.855793] agent flakelet[1233]: other: up to date container-test-run-flakelet-relay> agent # [ 4142.858695] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4MjcyMCwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc4ODY4MjQyMCwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiVlE1N1JIRkw2V0s3WT09PSIsIm5iZiI6MTc4ODY4MjQyMCwic3ViIjoic29tZW9uZSJ9.6he3_KeYg10UjVSNP1uqXVC5wdxzKr-bA5l9xrIfWjBXWPfdAc7PPBwrnOO4YxDzrc1BSfuyrHl6QZlnXfM8Bw' push --relay https://relay:7443 deploy agent/other 2>&1, in 0.67 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 0.73 seconds) container-test-run-flakelet-relay> subtest: push login via device flow, cached token used afterwards container-test-run-flakelet-relay> client: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1 container-test-run-flakelet-relay> relay # [ 4143.415659] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:41.377413Z","level":"INFO","message":"deploy finished","job":"cf0b9ffa53e7077583011cd48d81bce3","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4143.437482] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 08:13:41] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> agent # [ 4143.414571] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:41.376298Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [ 4144.442676] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 08:13:42] "POST /token HTTP/1.1" 400 - container-test-run-flakelet-relay> client: (finished: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1, in 2.08 seconds) container-test-run-flakelet-relay> client: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600 container-test-run-flakelet-relay> client: (finished: must succeed: test "$(stat -c %a /root/.local/state/flakelet-push/token.json)" = 600, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> relay # [ 4145.492729] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 08:13:43] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [ 4145.523585] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:43.485381Z","level":"INFO","message":"deploy accepted","job":"7936c73f12ebaa53d53a040769aa6e19","caller":"oidc:mock:groups:wheel\noidc:mock:someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4145.524086] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:43.485762Z","level":"INFO","message":"start","id":"1f8f02b5f508e3b68909df2a85ee9496","flakelet":"other","rule":"admins","relay":"relay","caller":"Some(\"oidc:mock:groups:wheel\\noidc:mock:someone\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4145.524891] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:43.486412Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"1f8f02b5f508e3b68909df2a85ee9496\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4145.569259] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [ 4145.608442] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [ 4145.615693] agent flakelet[1281]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4145.616642] agent flakelet[1281]: other: up to date container-test-run-flakelet-relay> agent # [ 4145.617822] 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.67 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 # [ 4147.177947] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:45.139694Z","level":"INFO","message":"deploy finished","job":"7936c73f12ebaa53d53a040769aa6e19","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4147.196049] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:45.157846Z","level":"INFO","message":"deploy accepted","job":"d6daa007be740ee973d52511e44597fd","caller":"oidc:mock:groups:wheel\noidc:mock:someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4147.176441] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:45.138153Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4147.196396] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:45.158204Z","level":"INFO","message":"start","id":"3930e6a3d30f5766f5252451bf096cb6","flakelet":"other","rule":"admins","relay":"relay","caller":"Some(\"oidc:mock:groups:wheel\\noidc:mock:someone\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4147.196755] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:45.158575Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"3930e6a3d30f5766f5252451bf096cb6\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4147.259535] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [ 4147.290981] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [ 4147.295439] agent flakelet[1320]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4147.295952] agent flakelet[1320]: other: up to date container-test-run-flakelet-relay> agent # [ 4147.298737] 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.67 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 4.43 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 # [ 4147.850594] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:45.812323Z","level":"INFO","message":"deploy finished","job":"d6daa007be740ee973d52511e44597fd","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4147.887932] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:45.849704Z","level":"INFO","message":"deploy accepted","job":"9464e5a4500d6c0b96581a60fee2a085","caller":"x509:email:admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4147.849326] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:45.811044Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4147.888205] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:45.849972Z","level":"INFO","message":"start","id":"5ec57ad4e768ccd64ebac36ed1a936be","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4147.888593] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:45.850413Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"5ec57ad4e768ccd64ebac36ed1a936be\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4147.930060] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4147.966588] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4147.970902] agent flakelet[1351]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [ 4147.971566] agent flakelet[1351]: app: activating generation 4 container-test-run-flakelet-relay> agent # [ 4147.980313] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [ 4147.980996] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4147.981126] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [ 4147.991473] agent systemd[1]: Reload requested from client PID 1358 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4147.991505] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4148.325941] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [ 4148.396792] agent systemd[1]: Reload requested from client PID 1388 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4148.396827] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4148.726504] agent systemd[1]: Reloading finished in 329 ms. container-test-run-flakelet-relay> agent # [ 4148.787945] agent systemd[1]: Reload requested from client PID 1417 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4148.787980] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4149.118040] agent systemd[1]: Reloading finished in 329 ms. container-test-run-flakelet-relay> agent # [ 4149.191838] agent systemd[1]: Reload requested from client PID 1451 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4149.191875] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4149.515844] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [ 4149.584374] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [ 4149.617408] agent (nonexistent)[1483]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [ 4149.617434] agent (nonexistent)[1483]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [ 4149.618546] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [ 4149.618637] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [ 4149.618790] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [ 4149.655998] agent systemd[1]: Reload requested from client PID 1495 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4149.656047] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4149.978190] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [ 4150.066839] agent systemd[1]: Reload requested from client PID 1525 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4150.066879] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4150.389574] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [ 4150.464544] agent systemd[1]: Reload requested from client PID 1555 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4150.464579] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4150.785848] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [ 4150.857624] agent systemd[1]: Reload requested from client PID 1585 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4150.857661] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4151.181337] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [ 4151.244819] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [ 4151.275909] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [ 4151.277011] agent flakelet[1351]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [ 4151.277011] agent flakelet[1351]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [ 4151.278927] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [ 4151.279028] 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.16 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.01 seconds) container-test-run-flakelet-relay> (finished: subtest: waves: failing first wave skips the second, in 4.19 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 # [ 4152.022514] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:49.984250Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4152.074094] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:50.035860Z","level":"INFO","message":"start","id":"8ec6677744ce3960466df14a1337d36f","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4152.074523] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:50.036341Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"8ec6677744ce3960466df14a1337d36f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4152.129973] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4152.164205] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4152.169374] agent flakelet[1659]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [ 4152.169878] agent flakelet[1659]: app: up to date container-test-run-flakelet-relay> agent # [ 4152.171258] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4152.024091] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:49.985831Z","level":"INFO","message":"deploy finished","job":"9464e5a4500d6c0b96581a60fee2a085","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4152.073785] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:50.035557Z","level":"INFO","message":"deploy accepted","job":"8d6d916c8db5800e2afe87d3d354863e","caller":"x509:email:admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/app' 2>&1, in 0.67 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 # [ 4152.726766] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:50.688492Z","level":"INFO","message":"deploy finished","job":"8d6d916c8db5800e2afe87d3d354863e","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4152.750422] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:50.712227Z","level":"INFO","message":"deploy accepted","job":"f39cc1efa15e97de0fecb9decce9196e","caller":"x509:email:admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4152.725228] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:50.686944Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4152.750709] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:50.712516Z","level":"INFO","message":"start","id":"09a9ed6ce1816d616979afac81515849","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4152.750911] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:50.712740Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"09a9ed6ce1816d616979afac81515849\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4152.812551] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4152.848011] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4152.852633] agent flakelet[1687]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [ 4152.853253] agent flakelet[1687]: app: up to date container-test-run-flakelet-relay> agent # [ 4152.855948] 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.67 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 # [ 4153.399545] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:51.361296Z","level":"INFO","message":"deploy finished","job":"f39cc1efa15e97de0fecb9decce9196e","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4153.422567] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:51.384376Z","level":"INFO","message":"deploy accepted","job":"088d362a3a9c5640a40033210515275e","caller":"x509:email:admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4153.398604] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:51.360356Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4153.422859] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:51.384668Z","level":"INFO","message":"start","id":"77a3dab8835de52c3344b952625f9387","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4153.423075] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:51.384903Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"77a3dab8835de52c3344b952625f9387\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4153.460372] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4153.492022] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4153.496470] agent flakelet[1725]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [ 4153.497060] agent flakelet[1725]: app: up to date container-test-run-flakelet-relay> agent # [ 4153.498672] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app --wave '*/app' 2>&1, in 0.65 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: host patterns expand on the relay, in 2.03 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> agent # [ 4154.047994] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:52.009726Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4154.105845] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:52.067611Z","level":"INFO","message":"start","id":"e4188c89c0c7606f31c3df2bd20052c9","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4154.106084] agent flakelet-agent[304]: {"timestamp":"2026-09-06T08:13:52.067919Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"e4188c89c0c7606f31c3df2bd20052c9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4154.160523] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4154.183900] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4154.189195] agent flakelet[1757]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [ 4154.189840] agent flakelet[1757]: app: activating generation 4 container-test-run-flakelet-relay> agent # [ 4154.204504] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [ 4154.204954] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4154.205227] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [ 4154.223317] agent systemd[1]: Reload requested from client PID 1764 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4154.223383] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4154.048826] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:52.010574Z","level":"INFO","message":"deploy finished","job":"088d362a3a9c5640a40033210515275e","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4154.105543] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:13:52.067313Z","level":"INFO","message":"deploy accepted","job":"6ba4e5c90bdcd2d68f1645a76c1f65d0","caller":"x509:email:admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4154.555467] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [ 4154.635138] agent systemd[1]: Reload requested from client PID 1794 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4154.635174] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4154.956535] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [ 4155.030606] agent systemd[1]: Reload requested from client PID 1825 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4155.030637] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.31 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/fv4yr9c0f9kyrfc00100i4rlshiiidbd-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/fv4yr9c0f9kyrfc00100i4rlshiiidbd-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> agent # [ 4155.353888] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [ 4155.425256] agent systemd[1]: Reload requested from client PID 1859 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4155.425288] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4155.746046] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [ 4155.806888] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [ 4161.879104] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [ 4161.900824] agent flakelet[1757]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [ 4161.903632] 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.49 seconds) container-test-run-flakelet-relay> (finished: subtest: detach returns once the job is accepted, in 8.84 seconds) container-test-run-flakelet-relay> subtest: unknown host is final, missing agent is retried, agents listing container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy nope/app 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy nope/app 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl stop flakelet-agent container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl stop flakelet-agent, in 0.05 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 # [ 4162.944508] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:00.906280Z","level":"INFO","message":"agent disconnected: websocket closed","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [ 4162.944540] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [ 4162.979782] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4162.980194] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [ 4162.980602] agent systemd[1]: flakelet-agent.service: Consumed 2.099s CPU time over 32.196s 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.15 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/fv4yr9c0f9kyrfc00100i4rlshiiidbd-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out container-test-run-flakelet-relay> agent # [ 4164.036285] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [ 4164.092093] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:02.053890Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"e4188c89c0c7606f31c3df2bd20052c9\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4164.171673] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [ 4164.184995] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:02.146789Z","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 # [ 4164.185113] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:02.146860Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(4), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [ 4164.648697] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:02.610432Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4166.022191] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:03.983964Z","level":"INFO","message":"start","id":"4235f438c0a3c46391775c131dab08f5","flakelet":"other","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4166.023115] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:03.984385Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"4235f438c0a3c46391775c131dab08f5\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4166.080380] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [ 4166.104982] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [ 4166.109394] agent flakelet[2392]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4166.109913] agent flakelet[2392]: other: up to date container-test-run-flakelet-relay> agent # [ 4166.112486] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4166.021837] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:03.983589Z","level":"INFO","message":"deploy accepted","job":"feff0550a98dcf7187e0ff67a7d4b03e","caller":"x509:email:admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4166.661618] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:04.623374Z","level":"INFO","message":"deploy finished","job":"feff0550a98dcf7187e0ff67a7d4b03e","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4166.660150] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:04.621828Z","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.05 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4Mjc0NSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDQ1LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMNzZMNzZZQVFLSFc2PT09IiwibmJmIjoxNzg4NjgyNDQ1LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.dK0N5PPOt0-4vM7N5Ap3Fe4gN3iVu7rKWBRti_uFxDa9172sI8Z6BIq6zIzfEkNov919pf2wk9vaOrSYcDaNAg' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4Mjc0NSwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDQ1LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMNzZMNzZZQVFLSFc2PT09IiwibmJmIjoxNzg4NjgyNDQ1LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.dK0N5PPOt0-4vM7N5Ap3Fe4gN3iVu7rKWBRti_uFxDa9172sI8Z6BIq6zIzfEkNov919pf2wk9vaOrSYcDaNAg' 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.40 seconds) container-test-run-flakelet-relay> subtest: out-of-band flakelet update reaches the relay without reconnect container-test-run-flakelet-relay> agent: must succeed: flakelet status --json app | jq '.[0].generation' container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet status --json app | jq '.[0].generation', in 0.04 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-agent -o cat | grep -c '"connected"' || true, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> app: activating generation 5 container-test-run-flakelet-relay> agent # [ 4167.395919] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [ 4167.396411] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4167.396680] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [ 4167.417481] agent systemd[1]: Reload requested from client PID 2440 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4167.417547] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4167.756358] agent systemd[1]: Reloading finished in 337 ms. container-test-run-flakelet-relay> agent # [ 4168.495402] agent systemd[1]: Reload requested from client PID 2473 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4168.495436] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4168.819099] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [ 4168.906752] agent systemd[1]: Reload requested from client PID 2502 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4168.906790] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4169.355692] agent systemd[1]: Reloading finished in 448 ms. container-test-run-flakelet-relay> agent # [ 4169.438437] agent systemd[1]: Reload requested from client PID 2534 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4169.438476] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4169.764241] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [ 4169.909982] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 2.67 seconds) container-test-run-flakelet-relay> client: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@5' container-test-run-flakelet-relay> agent # [ 4170.027611] 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> agent: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> app: activating generation 6 container-test-run-flakelet-relay> agent # [ 4171.138022] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [ 4171.138494] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4171.138770] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [ 4171.156779] agent systemd[1]: Reload requested from client PID 2589 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4171.156846] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4171.500355] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [ 4171.579710] agent systemd[1]: Reload requested from client PID 2618 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4171.579747] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4171.908502] agent systemd[1]: Reloading finished in 328 ms. container-test-run-flakelet-relay> agent # [ 4171.967610] agent systemd[1]: Reload requested from client PID 2646 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4171.967647] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4172.291228] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [ 4172.364484] agent systemd[1]: Reload requested from client PID 2678 ('systemctl')... container-test-run-flakelet-relay> agent # [ 4172.364517] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.68 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 # [ 4172.687684] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [ 4172.750548] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [ 4172.777974] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> client: (finished: waiting for success: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents | grep -q 'app@6', in 2.06 seconds) container-test-run-flakelet-relay> (finished: subtest: out-of-band flakelet update reaches the relay without reconnect, in 7.55 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.02 seconds) container-test-run-flakelet-relay> (finished: subtest: certificate not listed under agents cannot connect as agent, in 0.03 seconds) container-test-run-flakelet-relay> subtest: metrics container-test-run-flakelet-relay> relay: must succeed: curl -sf http://127.0.0.1:7400/metrics container-test-run-flakelet-relay> relay: (finished: must succeed: curl -sf http://127.0.0.1:7400/metrics, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: metrics, in 0.01 seconds) container-test-run-flakelet-relay> subtest: agent link drop mid-run replays missed lines once container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788682452 | grep -q 'app-slow' container-test-run-flakelet-relay> relay # [ 4174.878109] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:12.839865Z","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 # [ 4174.935544] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:12.897309Z","level":"INFO","message":"deploy accepted","job":"e5872690f4e85631c914f77294b64844","caller":"x509:email:admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4174.935928] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:12.897698Z","level":"INFO","message":"start","id":"e6f2f1331fc776ea67293131199f144a","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4174.936553] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:12.898265Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"e6f2f1331fc776ea67293131199f144a\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4174.988419] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4175.020996] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4175.025205] agent flakelet[2742]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [ 4175.025870] agent flakelet[2742]: app: activating generation 7 container-test-run-flakelet-relay> agent # [ 4175.039192] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [ 4175.039650] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4175.039915] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [ 4175.056090] agent systemd[1]: Reload requested from client PID 2749 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4175.056154] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4175.399640] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [ 4175.478431] agent systemd[1]: Reload requested from client PID 2779 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4175.478471] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4175.800112] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788682452 | grep -q 'app-slow', in 1.03 seconds) container-test-run-flakelet-relay> agent: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done container-test-run-flakelet-relay> agent: (finished: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done, in 0.02 seconds) container-test-run-flakelet-relay> relay: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done container-test-run-flakelet-relay> relay: (finished: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done, in 0.06 seconds) container-test-run-flakelet-relay> agent: must succeed: ss -K dport = 7443 container-test-run-flakelet-relay> agent # [ 4175.882413] agent systemd[1]: Reload requested from client PID 2808 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4175.882451] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: ss -K dport = 7443, in 0.03 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788682452 | grep -q 'updated to generation' container-test-run-flakelet-relay> agent # [ 4176.052802] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:14.014459Z","level":"INFO","message":"disconnected: Software caused connection abort (os error 103)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4176.208402] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [ 4176.278282] agent systemd[1]: Reload requested from client PID 2856 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4176.278318] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4176.020915] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:13.982661Z","level":"INFO","message":"agent disconnected: Software caused connection abort (os error 103)","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [ 4176.601106] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [ 4176.668938] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [ 4177.055161] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:15.016707Z","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 # [ 4179.058068] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:17.019793Z","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 # [ 4182.746948] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [ 4182.761550] agent flakelet[2742]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [ 4182.763463] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788682452 | 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 # [ 4183.061485] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:21.023050Z","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 # [ 4183.863805] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:21.825550Z","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.08 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.38 seconds) container-test-run-flakelet-relay> subtest: agent restart mid-run reattaches to the unit container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/restart.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/restart.out 2>&1 &, in 0.00 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2' container-test-run-flakelet-relay> agent # [ 4191.066337] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:29.028040Z","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 # [ 4191.067467] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:29.029285Z","level":"INFO","message":"start","id":"e6f2f1331fc776ea67293131199f144a","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4191.300871] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:29.262631Z","level":"INFO","message":"start","id":"ea9cb4ed832eef9cf21999db3416d799","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4191.301456] agent flakelet-agent[1959]: {"timestamp":"2026-09-06T08:14:29.263275Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"ea9cb4ed832eef9cf21999db3416d799\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [ 4191.066376] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:29.028114Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(7), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> relay # [ 4191.067828] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:29.029648Z","level":"INFO","message":"deploy finished","job":"e5872690f4e85631c914f77294b64844","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4191.300455] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:29.262210Z","level":"INFO","message":"deploy accepted","job":"ab8cf24c009f46afd81990281eb21a12","caller":"x509:email:admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4191.356209] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4191.390028] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4191.395369] agent flakelet[3035]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [ 4191.396019] agent flakelet[3035]: app: activating generation 8 container-test-run-flakelet-relay> agent # [ 4191.408979] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [ 4191.409443] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4191.409712] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [ 4191.426485] agent systemd[1]: Reload requested from client PID 3042 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4191.426552] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4191.761077] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [ 4191.841661] agent systemd[1]: Reload requested from client PID 3072 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4191.841698] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2', in 1.03 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl restart flakelet-agent container-test-run-flakelet-relay> agent # [ 4192.164112] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [ 4192.263945] agent systemd[1]: Reload requested from client PID 3103 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4192.263978] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [ 4192.662956] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:30.624638Z","level":"INFO","message":"agent disconnected: websocket closed","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [ 4192.587000] agent systemd[1]: Reloading finished in 322 ms. container-test-run-flakelet-relay> agent # [ 4192.662361] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [ 4192.666178] agent systemd[1]: Reload requested from client PID 3140 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4192.666218] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4192.995503] agent systemd[1]: Reloading finished in 328 ms. container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl restart flakelet-agent, in 0.87 seconds) container-test-run-flakelet-relay> agent: must succeed: test -n "$(ls /var/lib/flakelet-agent/jobs)" container-test-run-flakelet-relay> agent: (finished: must succeed: test -n "$(ls /var/lib/flakelet-agent/jobs)", in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out container-test-run-flakelet-relay> agent # [ 4193.058528] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4193.058704] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [ 4193.058717] agent systemd[1]: flakelet-agent.service: Consumed 2.098s CPU time over 29.022s wall clock time. container-test-run-flakelet-relay> agent # [ 4193.062617] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [ 4193.064918] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [ 4193.119505] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:31.081301Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"ea9cb4ed832eef9cf21999db3416d799\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4193.182915] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [ 4193.193097] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:31.154892Z","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 # [ 4193.194264] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:31.156086Z","level":"INFO","message":"start","id":"ea9cb4ed832eef9cf21999db3416d799","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [ 4193.193192] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:31.154908Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(7), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [ 4199.135047] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [ 4199.156094] agent flakelet[3035]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [ 4199.158735] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4199.725057] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:37.686718Z","level":"INFO","message":"deploy finished","job":"ab8cf24c009f46afd81990281eb21a12","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4199.723421] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:37.685157Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(8)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/app: updated' /tmp/restart.out, in 7.08 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/restart.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/restart.out, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl is-active app.service container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl is-active app.service, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: agent restart mid-run reattaches to the unit, in 9.03 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=@1788682478 | grep -q 'app-slow' container-test-run-flakelet-relay> relay # [ 4200.341157] relay flakelet-relay[400]: {"timestamp":"2026-09-06T08:14:38.302915Z","level":"INFO","message":"deploy accepted","job":"5675950775baa32ac3f81982dde7ec7f","caller":"x509:email:admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4200.341509] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:38.303257Z","level":"INFO","message":"start","id":"2e247dc4255d8cf3e39c6a4107a3e4dc","flakelet":"app","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4200.342089] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:38.303909Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"2e247dc4255d8cf3e39c6a4107a3e4dc\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4200.392825] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [ 4200.401252] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [ 4200.406140] agent flakelet[3656]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [ 4200.406821] agent flakelet[3656]: app: activating generation 9 container-test-run-flakelet-relay> agent # [ 4200.420220] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [ 4200.420679] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4200.420947] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [ 4200.437740] agent systemd[1]: Reload requested from client PID 3663 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4200.437805] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4200.784344] agent systemd[1]: Reloading finished in 345 ms. container-test-run-flakelet-relay> agent # [ 4200.878469] agent systemd[1]: Reload requested from client PID 3693 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4200.878505] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788682478 | 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 # [ 4201.209587] agent systemd[1]: Reloading finished in 330 ms. container-test-run-flakelet-relay> agent # [ 4201.293599] agent systemd[1]: Reload requested from client PID 3724 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4201.293631] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4201.369088] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:39.330774Z","level":"INFO","message":"disconnected: websocket closed","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [ 4201.368454] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [ 4201.407096] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4201.407487] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [ 4201.407527] relay systemd[1]: flakelet-relay.service: Consumed 2.503s CPU time over 1min 9.500s wall clock time. container-test-run-flakelet-relay> relay # [ 4201.443743] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [ 4201.628311] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [ 4201.726190] agent systemd[1]: Reload requested from client PID 3760 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [ 4201.726223] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [ 4202.068535] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [ 4202.156416] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [ 4202.371783] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:40.333551Z","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> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [ 4202.975464] relay flakelet-relay[933]: {"timestamp":"2026-09-06T08:14:40.937259Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [ 4202.975935] relay flakelet-relay[933]: {"timestamp":"2026-09-06T08:14:40.937747Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [ 4202.976182] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [ 4204.385898] relay flakelet-relay[933]: {"timestamp":"2026-09-06T08:14:42.347663Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(8), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> relay # [ 4204.388341] relay flakelet-relay[933]: {"timestamp":"2026-09-06T08:14:42.350103Z","level":"INFO","message":"job reattached","job":"5675950775baa32ac3f81982dde7ec7f","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4204.385801] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:42.347552Z","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 # [ 4208.240154] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [ 4208.259090] agent flakelet[3656]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [ 4208.261718] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [ 4209.314937] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:47.276723Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q '» ok' /tmp/resume.out, in 7.07 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/resume.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/resume.out, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: relay restart mid-run, push resumes via /v1/jobs, in 9.76 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 # [ 4210.075698] relay flakelet-relay[933]: {"timestamp":"2026-09-06T08:14:48.037466Z","level":"INFO","message":"deploy accepted","job":"188b06c4636b65849b3ba8daac22dc7c","caller":"x509:email:admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4210.076257] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:48.037985Z","level":"INFO","message":"start","id":"5be20c693e5c0b60e3f85779794dfb86","flakelet":"other","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4210.076791] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:48.038615Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4210.122961] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [ 4210.153973] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [ 4210.158226] agent flakelet[3873]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4210.158724] agent flakelet[3873]: other: up to date container-test-run-flakelet-relay> agent # [ 4210.161341] 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 # [ 4210.702454] relay flakelet-relay[933]: {"timestamp":"2026-09-06T08:14:48.664207Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4210.716833] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [ 4210.752506] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4210.752969] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [ 4210.753021] relay systemd[1]: flakelet-relay.service: Consumed 2.183s CPU time over 9.308s wall clock time. container-test-run-flakelet-relay> relay # [ 4210.789295] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [ 4210.701192] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:48.662929Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4210.717262] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:48.679054Z","level":"INFO","message":"disconnected: websocket closed","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4211.720215] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:49.682000Z","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.64 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 # [ 4212.346142] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:50.307919Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [ 4212.346713] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:50.308284Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [ 4212.346560] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [ 4213.729425] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:51.691170Z","level":"INFO","message":"agent connected","host":"agent","version":"0.1.0","flakelets":"[Named { name: \"app\", generation: Some(9), revision: Some(\"prebuilt:app\") }, Named { name: \"other\", generation: Some(1), revision: Some(\"prebuilt:other\") }]","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [ 4213.729315] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:51.691059Z","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.05 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | 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.05 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4Mjc5MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDkyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJLRVpCQ1RYM0hZQzVXPT09IiwibmJmIjoxNzg4NjgyNDkyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Ah3eJRZPsyKvgBIkjWvRNz0yVpUkLQjVEuVhAORCmsjCEIjPPv264dRyz3dGvu8yyl_PG4qHMbykxwsbTTWuBA' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY4Mjc5MiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjgyNDkyLCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJLRVpCQ1RYM0hZQzVXPT09IiwibmJmIjoxNzg4NjgyNDkyLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.Ah3eJRZPsyKvgBIkjWvRNz0yVpUkLQjVEuVhAORCmsjCEIjPPv264dRyz3dGvu8yyl_PG4qHMbykxwsbTTWuBA' push --relay https://relay:7443 jobs, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: job history comes from the agents and survives a relay restart, in 4.43 seconds) container-test-run-flakelet-relay> subtest: dashboard login via authorization code flow container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login, in 0.09 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other', in 0.03 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 30 https://relay:7443/ui/jobs/3a2ab41ad18d8ce95a0d91a1e85e30fb/events || true container-test-run-flakelet-relay> relay # [ 4214.547941] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 08:14:52] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=qcWJYkseVZY-63KFXYx2QX3g2YK7-gmaQkuvdw3-3-A&code_challenge=qEm-aD62vfFZ82Zr_DIpeEhcUYBm8INB0cEs4a6GuJU&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> relay # [ 4214.599167] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[186]: 127.0.0.1 - - [06/Sep/2026 08:14:52] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [ 4214.600429] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:52.562222Z","level":"INFO","message":"login","name":"someone","principals":"[\"oidc:mock:someone\", \"oidc:mock:groups:wheel\"]","target":"flakelet_relay::relay::login"} container-test-run-flakelet-relay> relay # [ 4214.662432] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:52.624187Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4214.712929] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:52.674718Z","level":"INFO","message":"deploy accepted","job":"696e7f7b5cdb3fb1ce529806b9dcd8b3","caller":"oidc:mock:someone\noidc:mock:groups:wheel","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [ 4214.734468] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:52.696263Z","level":"INFO","message":"job reattached","job":"696e7f7b5cdb3fb1ce529806b9dcd8b3","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [ 4214.713207] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:52.674948Z","level":"INFO","message":"start","id":"866b175e4b19a280ca2b9a39e3c39ab2","flakelet":"other","rule":"admins","relay":"relay","caller":"Some(\"oidc:mock:someone\\noidc:mock:groups:wheel\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4214.713470] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:52.675297Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"866b175e4b19a280ca2b9a39e3c39ab2\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4214.768954] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [ 4214.798964] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [ 4214.803315] agent flakelet[3921]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4214.803864] agent flakelet[3921]: other: up to date container-test-run-flakelet-relay> agent # [ 4214.805817] 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/3a2ab41ad18d8ce95a0d91a1e85e30fb/events || true, in 0.65 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/3a2ab41ad18d8ce95a0d91a1e85e30fb 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/3a2ab41ad18d8ce95a0d91a1e85e30fb, 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=3a2ab41ad18d8ce95a0d91a1e85e30fb' | 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=3a2ab41ad18d8ce95a0d91a1e85e30fb' | grep -q 400, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 15 'https://relay:7443/ui/events?path=jobs' > /tmp/ev.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 15 'https://relay:7443/ui/events?path=jobs' > /tmp/ev.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other container-test-run-flakelet-relay> » job 38796a7ba508eadfe82a1cd5def000bc via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/other | Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent/other | Started flakelet update other (via relay). container-test-run-flakelet-relay> agent/other | other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent/other | other: up to date container-test-run-flakelet-relay> agent # [ 4215.358972] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:53.320720Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4215.502430] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:53.464208Z","level":"INFO","message":"start","id":"5e317fc57863c2a7c03ebe1bdacd1356","flakelet":"other","rule":"admins","relay":"relay","caller":"Some(\"x509:email:admin@example.org\")","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [ 4215.502808] agent flakelet-agent[3171]: {"timestamp":"2026-09-06T08:14:53.464631Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [ 4215.545422] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [ 4215.551904] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [ 4215.556282] agent flakelet[3959]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [ 4215.556809] agent flakelet[3959]: other: up to date container-test-run-flakelet-relay> agent/otheragent # [ 4215.558705] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> | flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [ 4215.502173] relay flakelet-relay[1323]: {"timestamp":"2026-09-06T08:14:53.463918Z","level":"INFO","message":"deploy accepted","job":"38796a7ba508eadfe82a1cd5def000bc","caller":"x509:email:admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> » agent/other: unchanged (generation 1) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other, in 0.63 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q live1 /tmp/ev.out container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q live1 /tmp/ev.out, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -X POST -o /dev/null https://relay:7443/ui/logout, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' https://relay:7443/ui/ | grep -q 303, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: dashboard login via authorization code flow, in 1.67 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 87.79 seconds) container-test-run-flakelet-relay> test script finished in 87.83s container-test-run-flakelet-relay> cleanup container-test-run-flakelet-relay> kill NspawnMachine (pid 52) container-test-run-flakelet-relay> kill NspawnMachine (pid 53) container-test-run-flakelet-relay> kill NspawnMachine (pid 54) container-test-run-flakelet-relay> Container agent terminated by signal KILL. container-test-run-flakelet-relay> Container client terminated by signal KILL. container-test-run-flakelet-relay> Container relay terminated by signal KILL. container-test-run-flakelet-relay> (finished: cleanup, in 0.34 seconds) container-test-run-flakelet-relay> additionally exposed symbols: container-test-run-flakelet-relay> agent, client, relay, container-test-run-flakelet-relay> vlan1, container-test-run-flakelet-relay> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh container-test-run-flakelet-relay> » job 1f66c3bae45a2f68de24222f8b7c61c0 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 9464e5a4500d6c0b96581a60fee2a085 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 e5872690f4e85631c914f77294b64844 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 ab8cf24c009f46afd81990281eb21a12 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 5675950775baa32ac3f81982dde7ec7f 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 d01120429d41f4d1a4f86e8004fb7908 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 5675950775baa32ac3f81982dde7ec7f 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> 1788682488 hist1 x509:email:admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788682478 d01120429d41f4d1a4f86e8004fb7908 x509:email:admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788682469 41dc29f586598b72c97791471caebe43 x509:email:admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788682452 fe8ec926b44f3388c9f3a2ac05f2272d x509:email:admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788682443 84b3d241fce6506271e8569d32c33a28 x509:email:admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788682432 9dd914928014a2e180987fd1cb162812 x509:email:admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788682431 a6069200e180ece1b4974ad375928119 x509:email:admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788682430 3192f9b524a6129b321f0217cd42919b x509:email:admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788682430 69d04a0614c884d2b1d3b48c5f4c0be9 x509:email:admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788682425 208c5e9f4300937a14e44e648c377dca oidc:mock:groups:wheel agent/other:unchanged container-test-run-flakelet-relay> 1788682425 72e84fe196b8119d4b8bec55951ccfbe x509:email:admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1788682423 ddf9b677e30fc7663a77712775da037d oidc:mock:groups:wheel agent/other:unchanged container-test-run-flakelet-relay> 1788682420 0bea5338cca19affae23d17cc7698b63 oidc:mock:groups:wheel agent/other:unchanged container-test-run-flakelet-relay> 1788682417 98cf90b026952e873d18b963702c377d oidc:mock:repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1788682414 93fad2136c00882fe213752fe0053161 x509:email:admin@example.org agent/app: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