these 43 derivations will be built: /nix/store/gmh18z4pxysfpi659klf249xn94h89bw-flakelet-relay-0.1.0.drv /nix/store/zkc64hw3lm9qx3q34d3fpc7yrgm9r3if-flakelet-relay.json.drv /nix/store/b8imsng0hn1bsph90cqh80pl0cq6bgaq-flakelet-relay.service.drv /nix/store/ds60ldmzcapj36rrfzsyb3w2sp3lbpq1-flakelet-flakelet-relay-units.drv /nix/store/5vma2w89rh3a6plq7yxa5jx5vkpaqchw-flakelet-flakelet-relay.drv /nix/store/rpq5c3lymrhlf852z2cplgy0ln970vhr-flakelet-config.json.drv /nix/store/9b7mxcfxrj5ddfbbbwp6yp3g3pqzn3cr-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/5mrn8app1aglvidj25las8wgf9ppamzx-unit-flakelet-reconcile.service.drv /nix/store/hivfzs1glrz7yi6vsh95sk82ymcw7n3s-X-Restart-Triggers-flakelet-flakelet-relay.drv /nix/store/7c1p0zdn845m97nvfr3qyn1gpb7ab7zk-unit-flakelet-flakelet-relay.service.drv /nix/store/52fhmfp3m1jk6hc0d4nin7fjf2hqcr8q-system-units.drv /nix/store/m4c90bwvxbdanraa73bndm1gzrc5rh71-etc.drv /nix/store/dmr0k4i8fk85jgs3y71q5blr9jiyssm2-activate.drv /nix/store/1hxs4lmkvmr2li22zi7zx79wylh1jwi4-nixos-system-relay-test.drv /nix/store/31gld7x3dlzs4qdkrz7fkimwvzv84inv-flakelet-agent.service.drv /nix/store/zn3c5lgixrilnm2vyr4dvv5vcfc6rmpf-flakelet-flakelet-agent-units.drv /nix/store/ijxb12yilq7nd9ijyc220x410cyknhnh-flakelet-flakelet-agent.drv /nix/store/nxcaqqmmr9inijbkdvmiys3gwib24pm8-flakelet-config.json.drv /nix/store/gac6jdrymrdz7p21wqrgsk3zbbnkxzr5-X-Restart-Triggers-flakelet-reconcile.drv /nix/store/5r9hdbbb9xvzvffggh86nf2hq6lvx3h6-unit-flakelet-reconcile.service.drv /nix/store/l3f41ynprmgmyz6080li6vpngx0x6kvc-X-Restart-Triggers-flakelet-flakelet-agent.drv /nix/store/ql82sg4nzsaf8f4w2j664lmzflrw286w-unit-flakelet-flakelet-agent.service.drv /nix/store/dl2hbdffrk30si38rqw6kfkld8784xr7-system-units.drv /nix/store/6sb5jd06gqbw8divkrsy91fnwjqa875h-etc.drv /nix/store/db7lpfha9svjhkcvy9syygbkcmng6icn-activate.drv /nix/store/2d1cn1130371xdha5mf68giwqh15qcfy-nixos-system-agent-test.drv /nix/store/45xgp108iisqwvy57ywbvzry66gi3hgz-run-agent-nspawn.drv /nix/store/vgbs7276ncs73xd8f0jca0slh6pd31ck-push.drv /nix/store/vjw7hj4cmz3a5x9wl089bm5cd1ayihci-system-path.drv /nix/store/kxprxzwc4ncx60i5cmx4alz5dryk09sh-dbus-1.drv /nix/store/g4f6fi7qjdal3799rbmsqiwvh1bh9ds1-X-Restart-Triggers-dbus-broker.drv /nix/store/gwmfmmlzz3cmk43d64g11xd2lnfvfi3f-unit-dbus-broker.service.drv /nix/store/5ds7dzhil69vw4qdphrycfigiwllslw3-system-units.drv /nix/store/d0b36mpb950d6d57gmpdj2mflfrylnk5-unit-dbus-broker.service.drv /nix/store/rplakn3yqz7jz4hlj65cqc65rxccfiry-user-units.drv /nix/store/g7jwbc0mk4xazk5yzk0hyb78p68zdjzx-etc.drv /nix/store/myag7f0nann075qxjg0a03hl7xcdgjr8-activate.drv /nix/store/kjhnb4zajj10ap1z06pnl58ib5d9r05d-nixos-system-client-test.drv /nix/store/9l0pgn8lgygzxnz0y6qwa89srawz8gnv-run-client-nspawn.drv /nix/store/v3n7cms3ilhc0cd4w5mfc61ziygh868j-run-relay-nspawn.drv /nix/store/4hvy5z29rw7pyfn1f4hljzy4qpc31g5l-driverConfiguration.json.drv /nix/store/ygldd5c0gz4ldx30jm96mhgircpz1c7j-nixos-test-driver-flakelet-relay.drv /nix/store/lpxx7kqc85yhyq8mlm08dzvlpcgai1ha-container-test-run-flakelet-relay.drv building '/nix/store/vgbs7276ncs73xd8f0jca0slh6pd31ck-push.drv' building '/nix/store/l3f41ynprmgmyz6080li6vpngx0x6kvc-X-Restart-Triggers-flakelet-flakelet-agent.drv' building '/nix/store/hivfzs1glrz7yi6vsh95sk82ymcw7n3s-X-Restart-Triggers-flakelet-flakelet-relay.drv' X-Restart-Triggers-flakelet-flakelet-agent> tribuchet: building on jamie push> tribuchet: building on jamie X-Restart-Triggers-flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/gmh18z4pxysfpi659klf249xn94h89bw-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/5bvysp2pnv1ig9hszmn0jnrpxpnqlc69-source building '/nix/store/ql82sg4nzsaf8f4w2j664lmzflrw286w-unit-flakelet-flakelet-agent.service.drv' unit-flakelet-flakelet-agent.service> tribuchet: building on jamie building '/nix/store/7c1p0zdn845m97nvfr3qyn1gpb7ab7zk-unit-flakelet-flakelet-relay.service.drv' unit-flakelet-flakelet-relay.service> tribuchet: building on jamie flakelet-relay-0.1.0> source root is source flakelet-relay-0.1.0> Executing cargoSetupPostUnpackHook unit-flakelet-flakelet-agent.service> structuredAttrs is enabled building '/nix/store/vjw7hj4cmz3a5x9wl089bm5cd1ayihci-system-path.drv' unit-flakelet-flakelet-relay.service> structuredAttrs is enabled system-path> tribuchet: building on jamie 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 system-path> structuredAttrs is enabled flakelet-relay-0.1.0> Compiling proc-macro2 v1.0.107 flakelet-relay-0.1.0> Compiling unicode-ident v1.0.24 flakelet-relay-0.1.0> Compiling quote v1.0.47 flakelet-relay-0.1.0> Compiling libc v0.2.189 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 bytes v1.12.1 flakelet-relay-0.1.0> Compiling autocfg v1.5.1 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 thiserror v2.0.20 flakelet-relay-0.1.0> Compiling itoa v1.0.18 flakelet-relay-0.1.0> Compiling find-msvc-tools v0.1.11 flakelet-relay-0.1.0> Compiling zerocopy v0.8.56 flakelet-relay-0.1.0> Compiling getrandom v0.3.4 flakelet-relay-0.1.0> Compiling once_cell v1.21.4 flakelet-relay-0.1.0> Compiling log v0.4.34 flakelet-relay-0.1.0> Compiling minimal-lexical v0.2.1 flakelet-relay-0.1.0> Compiling num-conv v0.2.2 flakelet-relay-0.1.0> Compiling time-core v0.1.9 flakelet-relay-0.1.0> Compiling serde_core v1.0.229 flakelet-relay-0.1.0> Compiling futures-core v0.3.34 flakelet-relay-0.1.0> Compiling powerfmt v0.2.0 flakelet-relay-0.1.0> Compiling deranged v0.5.8 flakelet-relay-0.1.0> Compiling zeroize v1.9.0 flakelet-relay-0.1.0> Compiling version_check v0.9.5 flakelet-relay-0.1.0> Compiling cc v1.4.4 flakelet-relay-0.1.0> Compiling httparse v1.10.1 flakelet-relay-0.1.0> Compiling time-macros v0.2.32 flakelet-relay-0.1.0> Compiling tracing-core v0.1.36 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 untrusted v0.9.0 flakelet-relay-0.1.0> Compiling serde v1.0.229 flakelet-relay-0.1.0> Compiling utf8parse v0.2.2 flakelet-relay-0.1.0> Compiling oid-registry v0.8.1 flakelet-relay-0.1.0> Compiling colorchoice v1.0.5 flakelet-relay-0.1.0> Compiling anstyle v1.0.14 flakelet-relay-0.1.0> Compiling regex-syntax v0.8.11 flakelet-relay-0.1.0> Compiling proc-macro2-diagnostics v0.10.1 flakelet-relay-0.1.0> Compiling anstyle-parse v1.0.0 flakelet-relay-0.1.0> Compiling num-traits v0.2.19 flakelet-relay-0.1.0> Compiling anstyle-query v1.1.5 system-path> created 6399 symlinks in user environment 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 lazy_static v1.5.0 flakelet-relay-0.1.0> Compiling try-lock v0.2.5 flakelet-relay-0.1.0> Compiling nom v7.1.3 flakelet-relay-0.1.0> Compiling smallvec v1.16.0 flakelet-relay-0.1.0> Compiling serde_json v1.0.151 flakelet-relay-0.1.0> Compiling want v0.3.1 flakelet-relay-0.1.0> Compiling http v1.5.0 flakelet-relay-0.1.0> Compiling anstream v1.0.0 flakelet-relay-0.1.0> Compiling futures-channel v0.3.34 flakelet-relay-0.1.0> Compiling clap_lex v1.1.0 flakelet-relay-0.1.0> Compiling utf-8 v0.7.6 flakelet-relay-0.1.0> Compiling httpdate v1.0.3 flakelet-relay-0.1.0> Compiling slab v0.4.12 flakelet-relay-0.1.0> Compiling futures-sink v0.3.34 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 strsim v0.11.1 flakelet-relay-0.1.0> Compiling heck v0.5.0 flakelet-relay-0.1.0> Compiling futures-task v0.3.34 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 nu-ansi-term v0.50.3 flakelet-relay-0.1.0> Compiling clap_builder v4.6.6 flakelet-relay-0.1.0> Compiling futures-util v0.3.34 flakelet-relay-0.1.0> Compiling data-encoding v2.11.1 flakelet-relay-0.1.0> Compiling webpki-roots v1.0.9 flakelet-relay-0.1.0> Compiling base64 v0.23.1 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 errno v0.3.14 flakelet-relay-0.1.0> Compiling mio v1.2.2 flakelet-relay-0.1.0> Compiling socket2 v0.6.5 flakelet-relay-0.1.0> Compiling getrandom v0.2.17 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 sd-notify v0.5.0 flakelet-relay-0.1.0> Compiling signal-hook-registry v1.4.8 flakelet-relay-0.1.0> Compiling time v0.3.55 flakelet-relay-0.1.0> Compiling rand_core v0.9.5 building '/nix/store/kxprxzwc4ncx60i5cmx4alz5dryk09sh-dbus-1.drv' flakelet-relay-0.1.0> Compiling num-integer v0.1.47 flakelet-relay-0.1.0> Compiling rusticata-macros v4.1.0 dbus-1> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling num-bigint v0.4.8 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 tokio-macros v2.7.2 flakelet-relay-0.1.0> Compiling displaydoc v0.2.7 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/g4f6fi7qjdal3799rbmsqiwvh1bh9ds1-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling synstructure v0.13.2 flakelet-relay-0.1.0> Compiling ppv-lite86 v0.2.21 flakelet-relay-0.1.0> Compiling rand_chacha v0.9.0 flakelet-relay-0.1.0> Compiling rand v0.9.5 building '/nix/store/d0b36mpb950d6d57gmpdj2mflfrylnk5-unit-dbus-broker.service.drv' building '/nix/store/gwmfmmlzz3cmk43d64g11xd2lnfvfi3f-unit-dbus-broker.service.drv' 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 unit-dbus-broker.service> tribuchet: building on jamie unit-dbus-broker.service> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling tokio v1.53.1 unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled flakelet-relay-0.1.0> Compiling tungstenite v0.28.0 building '/nix/store/5ds7dzhil69vw4qdphrycfigiwllslw3-system-units.drv' building '/nix/store/rplakn3yqz7jz4hlj65cqc65rxccfiry-user-units.drv' system-units> tribuchet: building on jamie user-units> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling clap v4.6.6 flakelet-relay-0.1.0> Compiling maud v0.27.0 flakelet-relay-0.1.0> Compiling asn1-rs v0.7.2 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 building '/nix/store/g7jwbc0mk4xazk5yzk0hyb78p68zdjzx-etc.drv' etc> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling x509-parser v0.18.1 flakelet-relay-0.1.0> Compiling rustls-webpki v0.103.15 flakelet-relay-0.1.0> Compiling hyper v1.11.1 flakelet-relay-0.1.0> Compiling tokio-tungstenite v0.28.0 building '/nix/store/myag7f0nann075qxjg0a03hl7xcdgjr8-activate.drv' activate> tribuchet: building on jamie flakelet-relay-0.1.0> Compiling hyper-util v0.1.20 building '/nix/store/kjhnb4zajj10ap1z06pnl58ib5d9r05d-nixos-system-client-test.drv' nixos-system-client-test> tribuchet: building on jamie nixos-system-client-test> structuredAttrs is enabled building '/nix/store/9l0pgn8lgygzxnz0y6qwa89srawz8gnv-run-client-nspawn.drv' flakelet-relay-0.1.0> Compiling tokio-rustls v0.26.4 run-client-nspawn> tribuchet: building on jamie 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 28.27s 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 bitflags v2.13.1 flakelet-relay-0.1.0> Compiling linux-raw-sys v0.12.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.26s flakelet-relay-0.1.0> Running unittests src/lib.rs (target/x86_64-unknown-linux-gnu/release/deps/flakelet_relay-ddea05dd889c251d) flakelet-relay-0.1.0> flakelet-relay-0.1.0> running 20 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 relay::pages::tests::short_rev_uses_rev_not_nar_hash ... ok flakelet-relay-0.1.0> test auth::policy::tests::deploy_rules ... ok flakelet-relay-0.1.0> test auth::policy::tests::validate_catches_unknown_group ... ok flakelet-relay-0.1.0> test relay::pages::tests::filter_terms_words_and_toggle ... ok flakelet-relay-0.1.0> test srv::tests::parses_compressed_srv ... ok flakelet-relay-0.1.0> test relay::session::tests::roundtrip_and_tamper ... ok flakelet-relay-0.1.0> test proto::tests::target_split_rejects_malformed ... ok flakelet-relay-0.1.0> test ws::tests::rfc_example_accept_key ... ok flakelet-relay-0.1.0> test proto::tests::unknown_frame_type_is_tolerated ... ok flakelet-relay-0.1.0> test sse::tests::roundtrip_split_across_chunks ... ok flakelet-relay-0.1.0> test proto::tests::unknown_fields_and_status_are_tolerated ... 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. 20 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-6173f36b3e31ff05) 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-9147e1c7be34fa31) 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-e3f07f8167d4269d) 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/iz4lsbl5y7jc4dw9mpsfw020yn81xpaz-flakelet-relay-0.1.0 flakelet-relay-0.1.0> shrinking /nix/store/iz4lsbl5y7jc4dw9mpsfw020yn81xpaz-flakelet-relay-0.1.0/bin/flakelet-push flakelet-relay-0.1.0> shrinking /nix/store/iz4lsbl5y7jc4dw9mpsfw020yn81xpaz-flakelet-relay-0.1.0/bin/flakelet-agent flakelet-relay-0.1.0> shrinking /nix/store/iz4lsbl5y7jc4dw9mpsfw020yn81xpaz-flakelet-relay-0.1.0/bin/flakelet-relay flakelet-relay-0.1.0> checking for references to /build/ in /nix/store/iz4lsbl5y7jc4dw9mpsfw020yn81xpaz-flakelet-relay-0.1.0... flakelet-relay-0.1.0> patching script interpreter paths in /nix/store/iz4lsbl5y7jc4dw9mpsfw020yn81xpaz-flakelet-relay-0.1.0 flakelet-relay-0.1.0> stripping (with command strip and flags -S -p) in /nix/store/iz4lsbl5y7jc4dw9mpsfw020yn81xpaz-flakelet-relay-0.1.0/bin building '/nix/store/31gld7x3dlzs4qdkrz7fkimwvzv84inv-flakelet-agent.service.drv' building '/nix/store/zkc64hw3lm9qx3q34d3fpc7yrgm9r3if-flakelet-relay.json.drv' flakelet-agent.service> tribuchet: building on jamie flakelet-relay.json> tribuchet: building on jamie flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/app (expect allow) flakelet-relay.json> agent/app allowed by ci flakelet-relay.json> check: oidc:mock:repo:github:example/app:ref:refs/heads/main -> agent/other (expect deny) flakelet-relay.json> agent/other denied building '/nix/store/b8imsng0hn1bsph90cqh80pl0cq6bgaq-flakelet-relay.service.drv' flakelet-relay.service> tribuchet: building on jamie building '/nix/store/zn3c5lgixrilnm2vyr4dvv5vcfc6rmpf-flakelet-flakelet-agent-units.drv' flakelet-flakelet-agent-units> tribuchet: building on jamie building '/nix/store/ds60ldmzcapj36rrfzsyb3w2sp3lbpq1-flakelet-flakelet-relay-units.drv' flakelet-flakelet-relay-units> tribuchet: building on jamie building '/nix/store/ijxb12yilq7nd9ijyc220x410cyknhnh-flakelet-flakelet-agent.drv' flakelet-flakelet-agent> tribuchet: building on jamie building '/nix/store/5vma2w89rh3a6plq7yxa5jx5vkpaqchw-flakelet-flakelet-relay.drv' flakelet-flakelet-relay> tribuchet: building on jamie building '/nix/store/nxcaqqmmr9inijbkdvmiys3gwib24pm8-flakelet-config.json.drv' flakelet-config.json> tribuchet: building on jamie building '/nix/store/rpq5c3lymrhlf852z2cplgy0ln970vhr-flakelet-config.json.drv' flakelet-config.json> structuredAttrs is enabled flakelet-config.json> tribuchet: building on jamie flakelet-config.json> structuredAttrs is enabled building '/nix/store/gac6jdrymrdz7p21wqrgsk3zbbnkxzr5-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/9b7mxcfxrj5ddfbbbwp6yp3g3pqzn3cr-X-Restart-Triggers-flakelet-reconcile.drv' X-Restart-Triggers-flakelet-reconcile> tribuchet: building on jamie building '/nix/store/5r9hdbbb9xvzvffggh86nf2hq6lvx3h6-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie building '/nix/store/5mrn8app1aglvidj25las8wgf9ppamzx-unit-flakelet-reconcile.service.drv' unit-flakelet-reconcile.service> tribuchet: building on jamie unit-flakelet-reconcile.service> structuredAttrs is enabled building '/nix/store/dl2hbdffrk30si38rqw6kfkld8784xr7-system-units.drv' unit-flakelet-reconcile.service> structuredAttrs is enabled system-units> tribuchet: building on jamie building '/nix/store/52fhmfp3m1jk6hc0d4nin7fjf2hqcr8q-system-units.drv' system-units> tribuchet: building on jamie building '/nix/store/6sb5jd06gqbw8divkrsy91fnwjqa875h-etc.drv' etc> tribuchet: building on jamie building '/nix/store/m4c90bwvxbdanraa73bndm1gzrc5rh71-etc.drv' etc> tribuchet: building on jamie building '/nix/store/db7lpfha9svjhkcvy9syygbkcmng6icn-activate.drv' activate> tribuchet: building on jamie building '/nix/store/dmr0k4i8fk85jgs3y71q5blr9jiyssm2-activate.drv' activate> tribuchet: building on jamie building '/nix/store/2d1cn1130371xdha5mf68giwqh15qcfy-nixos-system-agent-test.drv' nixos-system-agent-test> tribuchet: building on jamie building '/nix/store/1hxs4lmkvmr2li22zi7zx79wylh1jwi4-nixos-system-relay-test.drv' nixos-system-relay-test> tribuchet: building on jamie nixos-system-agent-test> structuredAttrs is enabled nixos-system-relay-test> structuredAttrs is enabled building '/nix/store/45xgp108iisqwvy57ywbvzry66gi3hgz-run-agent-nspawn.drv' building '/nix/store/v3n7cms3ilhc0cd4w5mfc61ziygh868j-run-relay-nspawn.drv' run-agent-nspawn> tribuchet: building on jamie run-relay-nspawn> tribuchet: building on jamie building '/nix/store/4hvy5z29rw7pyfn1f4hljzy4qpc31g5l-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on jamie driverConfiguration.json> structuredAttrs is enabled building '/nix/store/ygldd5c0gz4ldx30jm96mhgircpz1c7j-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/lpxx7kqc85yhyq8mlm08dzvlpcgai1ha-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 51) container-test-run-flakelet-relay> agent: Waiting for journal at /build/vm-state-agent/var/log/journal... container-test-run-flakelet-relay> client: systemd-nspawn running (pid 53) container-test-run-flakelet-relay> relay: systemd-nspawn running (pid 56) 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.01 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(relay): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(relay): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> nixos-nspawn(client): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-flakelet-relay> nixos-nspawn(client): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-flakelet-relay> ░ Spawning container relay on /build/vm-state-relay. container-test-run-flakelet-relay> ░ Spawning container 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> ░ Spawning container client on /build/vm-state-client. container-test-run-flakelet-relay> agent # No journal files were found. container-test-run-flakelet-relay> agent # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> client # No journal files were found. container-test-run-flakelet-relay> relay # No journal files were found. container-test-run-flakelet-relay> client # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> relay # No journal boot entry found for the specified boot (+0). container-test-run-flakelet-relay> agent # [14999.781593] agent systemd-journald[57]: Journal started container-test-run-flakelet-relay> agent # [14999.781635] agent systemd-journald[57]: Runtime Journal (/run/log/journal/2a89d6dbcb7f4a1f94a35d8ed7f32cc2) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [14999.796040] agent systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> agent # [14999.809233] agent systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> agent # [14999.840711] agent systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> agent # [14999.841654] agent systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> agent # [14999.849985] agent systemd-journald[57]: Time spent on flushing to /var/log/journal/2a89d6dbcb7f4a1f94a35d8ed7f32cc2 is 1.305ms for 6 entries. container-test-run-flakelet-relay> agent # [14999.849985] agent systemd-journald[57]: System Journal (/var/log/journal/2a89d6dbcb7f4a1f94a35d8ed7f32cc2) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> agent # [14999.862295] agent systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> agent # [14999.863121] agent systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> agent # [14999.863242] agent systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> agent # [14999.874496] agent systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> agent # [14999.947110] agent systemd[1]: Finished Firewall. container-test-run-flakelet-relay> agent # [15000.804593] agent systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [14999.772201] client systemd-journald[57]: Journal started container-test-run-flakelet-relay> client # [14999.772240] client systemd-journald[57]: Runtime Journal (/run/log/journal/0c8d0696facb4f17b87e4e0d1393b352) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [14999.783517] client systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> client # [14999.795929] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> client # [14999.810827] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> client # [14999.811566] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> client # [14999.845967] client systemd-journald[57]: Time spent on flushing to /var/log/journal/0c8d0696facb4f17b87e4e0d1393b352 is 1.277ms for 6 entries. container-test-run-flakelet-relay> client # [14999.845967] client systemd-journald[57]: System Journal (/var/log/journal/0c8d0696facb4f17b87e4e0d1393b352) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> client # [14999.856928] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> client # [14999.857681] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> client # [14999.857776] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> client # [14999.868809] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> client # [14999.935826] client systemd[1]: Finished Firewall. container-test-run-flakelet-relay> client # [15000.772941] client systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> relay # [14999.783158] relay systemd-journald[57]: Journal started container-test-run-flakelet-relay> relay # [14999.783206] relay systemd-journald[57]: Runtime Journal (/run/log/journal/38b0b7f93ec7445699db5fb09cf5f2da) is 8M, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [14999.796110] relay systemd[1]: Finished Apply Kernel Variables. container-test-run-flakelet-relay> relay # [14999.809320] relay systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-flakelet-relay> relay # [14999.840563] relay systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-flakelet-relay> relay # [14999.841299] relay systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-flakelet-relay> relay # [14999.850026] relay systemd-journald[57]: Time spent on flushing to /var/log/journal/38b0b7f93ec7445699db5fb09cf5f2da is 1.441ms for 6 entries. container-test-run-flakelet-relay> relay # [14999.850026] relay systemd-journald[57]: System Journal (/var/log/journal/38b0b7f93ec7445699db5fb09cf5f2da) is 512B, max 4G, 3.9G free. container-test-run-flakelet-relay> relay # [14999.860605] relay systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-flakelet-relay> relay # [14999.861394] relay systemd[1]: Reached target Preparation for Local File Systems. container-test-run-flakelet-relay> relay # [14999.861522] relay systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-flakelet-relay> relay # [14999.876124] relay systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-flakelet-relay> relay # [14999.956312] relay systemd[1]: Finished Firewall. container-test-run-flakelet-relay> relay # [15000.804700] relay systemd[1]: Mounting /run/wrappers... container-test-run-flakelet-relay> client # [15000.824558] client systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> client # [15000.825357] client systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> client # [15000.826158] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> client # [15000.827460] client systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> client # [15000.827492] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [15000.828501] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> client # [15000.829304] client systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> client # [15000.847156] client systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> client # [15000.847593] client systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> client # [15000.847928] client systemd-tmpfiles[161]: fchmod() of /var/log/journal/0c8d0696facb4f17b87e4e0d1393b352 failed: Operation not permitted container-test-run-flakelet-relay> client # [15000.848370] client systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [15000.825923] relay systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> relay # [15000.826708] relay systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> relay # [15000.827498] relay systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> relay # [15000.828702] relay systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> relay # [15000.828761] relay systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [15000.829961] relay systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> relay # [15000.830934] relay systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> relay # [15000.849690] 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 # [15000.850149] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [15000.850520] relay systemd-tmpfiles[169]: fchmod() of /var/log/journal/38b0b7f93ec7445699db5fb09cf5f2da failed: Operation not permitted container-test-run-flakelet-relay> relay # [15000.850860] relay systemd-tmpfiles[169]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [15000.835921] agent systemd[1]: Mounted /run/wrappers. container-test-run-flakelet-relay> agent # [15000.837097] agent systemd[1]: Reached target Local File Systems. container-test-run-flakelet-relay> agent # [15000.838324] agent systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-flakelet-relay> agent # [15000.839678] agent systemd[1]: Starting Create SUID/SGID Wrappers... container-test-run-flakelet-relay> agent # [15000.839718] agent systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [15000.840878] agent systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-flakelet-relay> agent # [15000.841808] agent systemd[1]: Starting Create System Files and Directories... container-test-run-flakelet-relay> agent # [15000.859224] agent systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-flakelet-relay> agent # [15000.859738] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-flakelet-relay> agent # [15000.860066] agent systemd-tmpfiles[161]: fchmod() of /var/log/journal/2a89d6dbcb7f4a1f94a35d8ed7f32cc2 failed: Operation not permitted container-test-run-flakelet-relay> agent # [15000.860419] agent systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-flakelet-relay> relay # [15000.852817] relay systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> relay # [15000.853410] relay suid-sgid-wrappers-start[176]: chmod: changing permissions of '/run/wrappers/wrappers.wc7Rx73yP5/chsh': Operation not permitted container-test-run-flakelet-relay> relay # [15000.865610] relay systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> relay # [15000.865729] relay systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> relay # [15000.865769] relay systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> relay # [15000.868351] relay systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> relay # [15000.869694] relay systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> relay # [15000.882330] relay systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> relay # [15000.888317] relay systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> relay # [15000.889403] relay systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> relay # [15000.900326] relay systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> relay # [15000.900424] relay systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> relay # [15000.900503] relay systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> relay # [15000.900543] relay systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> relay # [15000.900559] relay systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> relay # [15000.900658] relay systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> relay # [15000.900852] relay systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> relay # [15000.900947] relay systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> relay # [15000.900961] relay systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> relay # [15000.900991] relay systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> relay # [15000.902362] relay systemd[1]: Started device-mock.service. container-test-run-flakelet-relay> relay # [15000.903330] relay systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> relay # [15000.904017] relay systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> relay # [15000.905043] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [15000.906081] relay systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> relay # [15000.917918] relay systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> relay # [15000.920475] relay systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> relay # [15000.929084] relay systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> relay # [15000.932956] relay systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> relay # [15000.976210] relay systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> relay # [15000.976352] relay systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> relay # [15000.977538] relay systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> relay # [15000.978307] relay systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> relay # [15000.998332] relay network-addresses-eth1-start[245]: adding address 192.168.1.3/24... done container-test-run-flakelet-relay> relay # [15001.001723] relay network-addresses-eth1-start[245]: adding address 2001:db8:1::3/64... done container-test-run-flakelet-relay> relay # [15001.006747] relay systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [15000.851800] client systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> client # [15000.852459] client suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.hF4e3TOQgv/chsh': Operation not permitted container-test-run-flakelet-relay> client # [15000.865461] client systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> client # [15000.865561] client systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> client # [15000.865731] client systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> client # [15000.868166] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> client # [15000.869642] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> client # [15000.882307] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> client # [15000.889526] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> client # [15000.890643] client systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> client # [15000.901902] client systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> client # [15000.902017] client systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> client # [15000.902087] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> client # [15000.902114] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> client # [15000.902128] client systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> client # [15000.902233] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> client # [15000.902453] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> client # [15000.902553] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> client # [15000.902570] client systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> client # [15000.902601] client systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> client # [15000.903949] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> client # [15000.905063] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [15000.906640] client systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> client # [15000.925609] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> client # [15000.986729] client systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> client # [15000.986875] client systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> client # [15000.988129] client systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> client # [15000.989343] client systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> client # [15001.009873] client network-addresses-eth1-start[232]: adding address 192.168.1.2/24... done container-test-run-flakelet-relay> client # [15001.012948] client network-addresses-eth1-start[232]: adding address 2001:db8:1::2/64... done container-test-run-flakelet-relay> client # [15001.018470] client systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> agent # [15000.861218] agent suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.MtoYG1fPiB/chsh': Operation not permitted container-test-run-flakelet-relay> agent # [15000.867166] agent systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [15000.867204] agent systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [15000.867258] agent systemd[1]: Failed to start Create SUID/SGID Wrappers. container-test-run-flakelet-relay> agent # [15000.867843] agent systemd[1]: Finished Create System Files and Directories. container-test-run-flakelet-relay> agent # [15000.881631] agent systemd[1]: Starting Rebuild Journal Catalog... container-test-run-flakelet-relay> agent # [15000.882441] agent systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-flakelet-relay> agent # [15000.895304] agent systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-flakelet-relay> agent # [15000.899293] agent systemd[1]: Finished Rebuild Journal Catalog. container-test-run-flakelet-relay> agent # [15000.900231] agent systemd[1]: Starting Update is Completed... container-test-run-flakelet-relay> agent # [15000.910506] agent systemd[1]: Finished Update is Completed. container-test-run-flakelet-relay> agent # [15000.910647] agent systemd[1]: Reached target System Initialization. container-test-run-flakelet-relay> agent # [15000.910720] agent systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-flakelet-relay> agent # [15000.910744] agent systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-flakelet-relay> agent # [15000.910760] agent systemd[1]: Reached target Timer Units. container-test-run-flakelet-relay> agent # [15000.910857] agent systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-flakelet-relay> agent # [15000.911050] agent systemd[1]: Listening on Nix Daemon Socket. container-test-run-flakelet-relay> agent # [15000.911149] agent systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-flakelet-relay> agent # [15000.911162] agent systemd[1]: Reached target Socket Units. container-test-run-flakelet-relay> agent # [15000.911193] agent systemd[1]: Reached target Basic System. container-test-run-flakelet-relay> agent # [15000.912377] agent systemd[1]: Starting Re-link flakelet services at boot... container-test-run-flakelet-relay> agent # [15000.912957] agent systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-flakelet-relay> agent # [15000.913896] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [15000.914470] agent systemd[1]: Starting resolvconf update... container-test-run-flakelet-relay> agent # [15000.927411] agent systemd[1]: Finished Re-link flakelet services at boot. container-test-run-flakelet-relay> agent # [15000.928353] agent systemd[1]: Starting Reconcile flakelet services with the host configuration... container-test-run-flakelet-relay> agent # [15000.932332] agent systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-flakelet-relay> agent # [15000.940027] agent systemd[1]: Finished Reconcile flakelet services with the host configuration. container-test-run-flakelet-relay> agent # [15000.988278] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15000.988421] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [15000.990513] agent systemd[1]: Finished resolvconf update. container-test-run-flakelet-relay> agent # [15000.991998] agent systemd[1]: Reached target Preparation for Network. container-test-run-flakelet-relay> agent # [15000.992974] agent systemd[1]: Starting Address configuration of eth1... container-test-run-flakelet-relay> agent # [15000.993680] agent systemd[1]: Starting Extra networking commands.... container-test-run-flakelet-relay> agent # [15000.994518] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [15001.012188] agent network-addresses-eth1-start[239]: adding address 192.168.1.1/24... done container-test-run-flakelet-relay> agent # [15001.014931] agent network-addresses-eth1-start[239]: adding address 2001:db8:1::1/64... done container-test-run-flakelet-relay> agent # [15001.022903] agent systemd[1]: Finished Address configuration of eth1. container-test-run-flakelet-relay> client # [15001.064382] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [15001.066808] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [15001.224150] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> client # [15001.225395] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> client # [15001.241031] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [15001.244464] client systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> client # [15001.244642] client systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [15001.247881] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> client # [15001.279271] client systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> client # [15001.279652] client systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [15001.066771] relay systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> relay # [15001.076622] relay systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15001.077733] relay systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [15001.083496] relay systemd[1]: Reached target Network. container-test-run-flakelet-relay> relay # [15001.085021] relay systemd[1]: Starting Dnsmasq Daemon... container-test-run-flakelet-relay> relay # [15001.086141] relay systemd[1]: Starting Nginx Web Server... container-test-run-flakelet-relay> relay # [15001.087395] relay systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> relay # [15001.088440] relay systemd[1]: Starting Update flakelet service flakelet-relay... container-test-run-flakelet-relay> relay # [15001.125313] relay flakelet[309]: flakelet-relay: using prebuilt artifact /nix/store/bpb2mhfrqsvpql2mf2508y44zck75g5s-flakelet-flakelet-relay container-test-run-flakelet-relay> relay # [15001.125961] relay flakelet[309]: flakelet-relay: activating generation 1 container-test-run-flakelet-relay> relay # [15001.128623] relay systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> relay # [15001.130099] relay systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> relay # [15001.132598] relay systemd[1]: Reload requested from client PID 315 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [15001.132639] relay systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15001.223037] agent systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-flakelet-relay> agent # [15001.224340] agent systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-flakelet-relay> agent # [15001.250244] agent systemd[1]: nscd.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15001.250393] agent systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [15001.279487] agent systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-flakelet-relay> agent # [15001.279639] agent systemd[1]: Finished Extra networking commands.. container-test-run-flakelet-relay> agent # [15001.280419] agent systemd[1]: Reached target Network. container-test-run-flakelet-relay> agent # [15001.281642] agent systemd[1]: Starting Update flakelet service app... container-test-run-flakelet-relay> agent # [15001.282444] agent systemd[1]: Starting Update flakelet service flakelet-agent... container-test-run-flakelet-relay> agent # [15001.283347] agent systemd[1]: Starting Update flakelet service other... container-test-run-flakelet-relay> agent # [15001.293735] agent flakelet[308]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [15001.294380] agent flakelet[308]: app: activating generation 1 container-test-run-flakelet-relay> agent # [15001.295151] agent flakelet[310]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15001.295675] agent flakelet[310]: other: activating generation 1 container-test-run-flakelet-relay> agent # [15001.296317] agent flakelet[309]: flakelet-agent: using prebuilt artifact /nix/store/y4sqgafd50j7yscbm9616bg2bini5d4v-flakelet-flakelet-agent container-test-run-flakelet-relay> agent # [15001.297345] agent flakelet[309]: flakelet-agent: activating generation 1 container-test-run-flakelet-relay> agent # [15001.297606] agent systemd[1]: Reload requested from client PID 312 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [15001.297640] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15001.455539] relay nsncd[308]: Sep 06 11:14:39.417 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> relay # [15001.496121] relay systemd[1]: Reloading finished in 363 ms. container-test-run-flakelet-relay> relay # [15001.588492] relay systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> relay # [15001.589518] relay systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> relay # [15001.589609] relay systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> relay # [15001.590980] relay systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> relay # [15001.591987] relay systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> relay # [15001.602262] relay systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> relay # [15001.603211] relay systemd[1]: Reload requested from client PID 358 ('systemctl') (unit flakelet-flakelet-relay.service)... container-test-run-flakelet-relay> relay # [15001.603252] relay systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15001.543717] agent nsncd[306]: Sep 06 11:14:39.505 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> agent # [15001.640494] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [15001.726292] agent systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> agent # [15001.729398] agent systemd[1]: Reload requested from client PID 313 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [15001.729445] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [15001.548647] client nsncd[293]: Sep 06 11:14:39.510 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-flakelet-relay> client # [15001.548808] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-flakelet-relay> client # [15001.548866] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> client # [15001.548932] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> client # [15001.550417] client systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> client # [15001.551215] client systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> client # [15001.588734] client systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> client # [15001.589986] client systemd[1]: Started Console Getty. container-test-run-flakelet-relay> client # [15001.590020] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> client # [15001.590031] client systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> relay # [15001.818058] relay dnsmasq-pre-start[395]: dnsmasq: syntax check OK. container-test-run-flakelet-relay> relay # [15001.959520] relay systemd[1]: Reloading finished in 355 ms. container-test-run-flakelet-relay> relay # [15002.040931] relay systemd[1]: Started Console Getty. container-test-run-flakelet-relay> relay # [15002.040958] relay systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> relay # [15002.040971] relay systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [15002.076066] agent systemd[1]: Reloading finished in 346 ms. container-test-run-flakelet-relay> agent # [15002.154580] agent systemd[1]: Reload requested from client PID 314 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [15002.154631] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15002.069312] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [15002.487851] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [15002.573112] agent systemd[1]: Reached target Host and Network Name Lookups. container-test-run-flakelet-relay> agent # [15002.573205] agent systemd[1]: Reached target User and Group Name Lookups. container-test-run-flakelet-relay> agent # [15002.574316] agent systemd[1]: Starting User Login Management... container-test-run-flakelet-relay> agent # [15002.575287] agent systemd[1]: Starting Permit User Sessions... container-test-run-flakelet-relay> agent # [15002.578542] agent systemd[1]: Reload requested from client PID 405 ('systemctl') (unit flakelet-other.service)... container-test-run-flakelet-relay> agent # [15002.578574] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15002.608082] relay systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> relay # [15003.021270] relay nginx-pre-start[404]: nginx: the configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf syntax is ok container-test-run-flakelet-relay> relay # [15003.021270] relay nginx-pre-start[404]: nginx: configuration file /nix/store/01avjj26wcihp926xgasszcj5s0k7cbs-nginx.conf test is successful container-test-run-flakelet-relay> relay # [15003.037777] relay systemd[1]: Started Nginx Web Server. container-test-run-flakelet-relay> relay # [15003.253172] relay dbus-broker-launch[403]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> relay # [15003.254491] relay dbus-broker-launch[403]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> relay # [15003.254491] relay dbus-broker-launch[403]: 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 # [15003.255540] relay systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> relay # [15003.260434] relay dbus-broker-launch[403]: Ready container-test-run-flakelet-relay> relay # [15003.263809] relay systemd[1]: Started Dnsmasq Daemon. container-test-run-flakelet-relay> relay # [15003.265970] relay dnsmasq[396]: started, version 2.93 cachesize 150 container-test-run-flakelet-relay> relay # [15003.265980] relay dnsmasq[396]: 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 # [15003.265985] relay dnsmasq[396]: DBus support enabled: connected to system bus container-test-run-flakelet-relay> relay # [15003.265991] relay dnsmasq[396]: no upstream servers configured - please set them from DBus container-test-run-flakelet-relay> relay # [15003.266151] relay dnsmasq[396]: read /etc/hosts - 9 names container-test-run-flakelet-relay> agent # [15002.963209] agent systemd[1]: Reloading finished in 384 ms. container-test-run-flakelet-relay> agent # [15003.055572] agent systemd[1]: Finished Permit User Sessions. container-test-run-flakelet-relay> agent # [15003.060787] agent systemd[1]: Reload requested from client PID 409 ('systemctl') (unit flakelet-app.service)... container-test-run-flakelet-relay> agent # [15003.060825] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [15003.010147] client systemd-logind[313]: New seat seat0. container-test-run-flakelet-relay> client # [15003.010548] client systemd[1]: Started User Login Management. container-test-run-flakelet-relay> client # [15003.012414] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> client # [15003.014069] client systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> client # [15003.046609] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> client # [15003.046981] client systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> client # [15003.047335] client systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [15003.286533] relay systemd-logind[354]: New seat seat0. container-test-run-flakelet-relay> relay # [15003.286783] relay systemd[1]: Started User Login Management. container-test-run-flakelet-relay> relay # [15003.289315] relay systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> relay # [15003.337226] relay systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15003.337581] relay systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [15003.416839] agent systemd[1]: Reloading finished in 355 ms. container-test-run-flakelet-relay> agent # [15003.502820] agent systemd[1]: Started Console Getty. container-test-run-flakelet-relay> agent # [15003.502934] agent systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-flakelet-relay> agent # [15003.503088] agent systemd[1]: Reached target Login Prompts. container-test-run-flakelet-relay> agent # [15003.504013] agent systemd[1]: Starting other v1... container-test-run-flakelet-relay> agent # [15003.506116] agent systemd[1]: Reload requested from client PID 444 ('systemctl') (unit flakelet-flakelet-agent.service)... container-test-run-flakelet-relay> agent # [15003.506145] agent systemd[1]: Reloading... container-test-run-flakelet-relay> client # [15003.508879] client dbus-broker-launch[323]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> client # [15003.510057] client dbus-broker-launch[323]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> client # [15003.510057] client dbus-broker-launch[323]: Invalid user-name in /nix/store/l5kd2gsbxrgi6dcxkf32qp9f3s2fbcb8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-flakelet-relay> client # [15003.510821] client systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> client # [15003.511341] client systemd[1]: Startup finished in 4.180s. container-test-run-flakelet-relay> client # [15003.516230] client dbus-broker-launch[323]: Ready container-test-run-flakelet-relay> agent # [15003.842349] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [15003.920908] agent systemd[1]: Started other v1. container-test-run-flakelet-relay> agent # [15003.926680] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [15003.930372] agent systemd-logind[407]: New seat seat0. container-test-run-flakelet-relay> agent # [15003.930877] agent systemd[1]: Started User Login Management. container-test-run-flakelet-relay> agent # [15003.959550] agent systemd[1]: Starting D-Bus System Message Bus... container-test-run-flakelet-relay> agent # [15003.960990] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [15003.962167] agent systemd[1]: Starting linger-users.service... container-test-run-flakelet-relay> agent # [15003.963549] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [15003.966456] agent flakelet[310]: other: updated to generation 1 container-test-run-flakelet-relay> agent # [15003.968308] agent systemd[1]: Finished Update flakelet service other. container-test-run-flakelet-relay> agent # [15003.979049] agent flakelet[308]: app: updated to generation 1 container-test-run-flakelet-relay> agent # [15003.981541] agent systemd[1]: Finished Update flakelet service app. container-test-run-flakelet-relay> agent # [15003.985706] agent systemd[1]: linger-users.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15003.985874] agent systemd[1]: Finished linger-users.service. container-test-run-flakelet-relay> agent # [15004.078061] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> agent # [15004.081091] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:42.042833Z","level":"WARN","message":"connect failed: connect relay:7443: Connection refused (os error 111)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15004.092845] agent flakelet[309]: flakelet-agent: updated to generation 1 container-test-run-flakelet-relay> relay # [15004.115170] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:42.076776Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [15004.116077] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:42.077327Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [15004.115747] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [15004.125563] relay systemd[1]: Starting health for flakelet-relay... container-test-run-flakelet-relay> agent # [15004.094676] agent systemd[1]: Finished Update flakelet service flakelet-agent. container-test-run-flakelet-relay> agent # [15004.096053] agent systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> agent # [15004.096144] agent systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> agent # [15004.429736] agent dbus-broker-launch[506]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-flakelet-relay> agent # [15004.431061] agent dbus-broker-launch[506]: NSS returned no entry for 'systemd-timesync' container-test-run-flakelet-relay> agent # [15004.431061] agent dbus-broker-launch[506]: 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 # [15004.431575] agent systemd[1]: Started D-Bus System Message Bus. container-test-run-flakelet-relay> agent # [15004.431862] agent systemd[1]: Startup finished in 5.096s. container-test-run-flakelet-relay> agent # [15004.437423] agent dbus-broker-launch[506]: Ready container-test-run-flakelet-relay> relay # [15004.410870] relay systemd[1]: flakelet-relay-health.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15004.411160] relay systemd[1]: Finished health for flakelet-relay. container-test-run-flakelet-relay> relay # [15004.441655] relay flakelet[309]: flakelet-relay: updated to generation 1 container-test-run-flakelet-relay> relay # [15004.453175] relay systemd[1]: Finished Update flakelet service flakelet-relay. container-test-run-flakelet-relay> relay # [15004.453467] relay systemd[1]: Reached target flakelet managed services. container-test-run-flakelet-relay> relay # [15004.453555] relay systemd[1]: Reached target Multi-User System. container-test-run-flakelet-relay> relay # [15004.455150] relay systemd[1]: Startup finished in 5.120s. container-test-run-flakelet-relay> relay: (finished: waiting for unit flakelet-relay.service, in 6.16 seconds) container-test-run-flakelet-relay> relay: waiting for unit nginx.service container-test-run-flakelet-relay> relay: (finished: waiting for unit nginx.service, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet.target container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet.target, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for unit flakelet-agent.service container-test-run-flakelet-relay> agent: (finished: waiting for unit flakelet-agent.service, in 0.01 seconds) container-test-run-flakelet-relay> client: waiting for unit multi-user.target container-test-run-flakelet-relay> client: (finished: waiting for unit multi-user.target, in 0.02 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1' container-test-run-flakelet-relay> agent # [15006.096134] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:44.057885Z","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 # [15006.096281] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:44.058027Z","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> 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.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1 container-test-run-flakelet-relay> agent # [15007.114415] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:45.076191Z","level":"INFO","message":"start","id":"da426651919e3a648c678ca7c1ee0d20","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15007.115285] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:45.076618Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"da426651919e3a648c678ca7c1ee0d20\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15007.179570] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15007.209118] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15007.214209] agent flakelet[959]: app: using prebuilt artifact /nix/store/6ili1vxjlag9d7dy0bxrbxk6bpi5qh9p-flakelet-app-v2 container-test-run-flakelet-relay> agent # [15007.215507] agent flakelet[959]: app: activating generation 2 container-test-run-flakelet-relay> agent # [15007.224686] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [15007.225399] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15007.225531] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [15007.234780] agent systemd[1]: Reload requested from client PID 966 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15007.234816] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15007.113828] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:45.075589Z","level":"INFO","message":"deploy accepted","job":"0af2fc6b6b2f9e17d70c64f51f21e800","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15007.568702] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [15007.654418] agent systemd[1]: Reload requested from client PID 996 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15007.654457] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15007.976637] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [15008.063561] agent systemd[1]: Reload requested from client PID 1025 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15008.063597] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15008.384158] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [15008.474379] agent systemd[1]: Reload requested from client PID 1059 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15008.474414] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15008.800264] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [15008.893746] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [15008.929764] agent systemd[1]: Started app v2. container-test-run-flakelet-relay> agent # [15008.945223] agent flakelet[959]: app: updated to generation 2 container-test-run-flakelet-relay> agent # [15008.945767] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay-srv test --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app 2>&1, in 2.95 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl show app.service -p Description | grep -q 'app v2' container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl show app.service -p Description | grep -q 'app v2', in 0.02 seconds) container-test-run-flakelet-relay> agent: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2' container-test-run-flakelet-relay> agent: (finished: must succeed: journalctl -u flakelet-relay-job-app.service | grep -q 'generation 2', in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with client certificate, relay found via SRV, in 2.99 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzU4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMjg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMT1VMRkpBSktWRDNDPT09IiwibmJmIjoxNzg4NjkzMjg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.ahC4q5hf2OqJdmKo0b1m05gHJO7U4YdEqi94H8zc04G8zWLuWtzyAwgB5dLWQG8CNLMXb80Q6v9i0GZVdo53AA' push --relay https://relay:7443 deploy agent/app 2>&1 container-test-run-flakelet-relay> relay # [15010.037037] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:47.998774Z","level":"INFO","message":"deploy finished","job":"0af2fc6b6b2f9e17d70c64f51f21e800","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15010.166990] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:48.128784Z","level":"INFO","message":"deploy accepted","job":"d9f98daa689ebecd3633565eb84db433","caller":"repo:github:example/app:ref:refs/heads/main","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15010.035357] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:47.997106Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(2)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15010.167196] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:48.128992Z","level":"INFO","message":"start","id":"90a61e368153cc938ad8177e3a71c53f","flakelet":"app","rule":"ci","relay":"relay","caller_name":"\"repo:github:example/app:ref:refs/heads/main\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15010.167435] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:48.129267Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"90a61e368153cc938ad8177e3a71c53f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15010.210206] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15010.252503] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15010.256785] agent flakelet[1160]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [15010.257466] agent flakelet[1160]: app: activating generation 3 container-test-run-flakelet-relay> agent # [15010.266072] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [15010.266772] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15010.266906] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [15010.277942] agent systemd[1]: Reload requested from client PID 1167 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15010.277977] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15010.606203] agent systemd[1]: Reloading finished in 327 ms. container-test-run-flakelet-relay> agent # [15010.697023] agent systemd[1]: Reload requested from client PID 1197 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15010.697060] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15011.026489] agent systemd[1]: Reloading finished in 329 ms. container-test-run-flakelet-relay> agent # [15011.108558] agent systemd[1]: Reload requested from client PID 1226 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15011.108596] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15011.440524] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [15011.534377] agent systemd[1]: Reload requested from client PID 1257 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15011.534415] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15011.859692] agent systemd[1]: Reloading finished in 324 ms. container-test-run-flakelet-relay> agent # [15011.940166] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [15011.971848] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [15011.986435] agent flakelet[1160]: app: updated to generation 3 container-test-run-flakelet-relay> agent # [15011.988561] 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzU4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMjg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMT1VMRkpBSktWRDNDPT09IiwibmJmIjoxNzg4NjkzMjg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.ahC4q5hf2OqJdmKo0b1m05gHJO7U4YdEqi94H8zc04G8zWLuWtzyAwgB5dLWQG8CNLMXb80Q6v9i0GZVdo53AA' push --relay https://relay:7443 deploy agent/app 2>&1, in 2.96 seconds) container-test-run-flakelet-relay> (finished: subtest: deploy with OIDC token, sub principal, in 3.03 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzU4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMjg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMT1VMRkpBSktWRDNDPT09IiwibmJmIjoxNzg4NjkzMjg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.ahC4q5hf2OqJdmKo0b1m05gHJO7U4YdEqi94H8zc04G8zWLuWtzyAwgB5dLWQG8CNLMXb80Q6v9i0GZVdo53AA' 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.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzU4OCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMjg4LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJMT1VMRkpBSktWRDNDPT09IiwibmJmIjoxNzg4NjkzMjg4LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.ahC4q5hf2OqJdmKo0b1m05gHJO7U4YdEqi94H8zc04G8zWLuWtzyAwgB5dLWQG8CNLMXb80Q6v9i0GZVdo53AA' 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.08 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzU5MSwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc4ODY5MzI5MSwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiSEpLT1NSWDVEQzZEQz09PSIsIm5iZiI6MTc4ODY5MzI5MSwic3ViIjoic29tZW9uZSJ9.p5aBB7I8mfl1ty7JX9e26MgrXZfH714JLHk8z3fGU3p1BlvXJ-kfTNjlUSxSRr-z6smfZkELu1S7MqE-Ar56BQ' push --relay https://relay:7443 deploy agent/other 2>&1 container-test-run-flakelet-relay> agent # [15013.097483] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:51.059252Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15013.228547] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:51.190343Z","level":"INFO","message":"start","id":"b1c2a8f8b8dffc9680e9df943dfac74c","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"someone\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15013.228839] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:51.190669Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"b1c2a8f8b8dffc9680e9df943dfac74c\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15013.290673] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [15013.330375] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [15013.336310] agent flakelet[1338]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15013.337340] agent flakelet[1338]: other: up to date container-test-run-flakelet-relay> agent # [15013.338449] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15013.098925] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:51.060648Z","level":"INFO","message":"deploy finished","job":"d9f98daa689ebecd3633565eb84db433","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15013.228271] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:51.190061Z","level":"INFO","message":"deploy accepted","job":"c6c41040efb1b9ad80a0f685d900fec4","caller":"someone","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzU5MSwiZ3JvdXBzIjpbIndoZWVsIl0sImlhdCI6MTc4ODY5MzI5MSwiaXNzIjoiaHR0cHM6Ly9yZWxheTo4NDQzIiwianRpIjoiSEpLT1NSWDVEQzZEQz09PSIsIm5iZiI6MTc4ODY5MzI5MSwic3ViIjoic29tZW9uZSJ9.p5aBB7I8mfl1ty7JX9e26MgrXZfH714JLHk8z3fGU3p1BlvXJ-kfTNjlUSxSRr-z6smfZkELu1S7MqE-Ar56BQ' push --relay https://relay:7443 deploy agent/other 2>&1, in 1.71 seconds) container-test-run-flakelet-relay> (finished: subtest: claim principal from groups, unchanged counts as success, in 1.79 seconds) container-test-run-flakelet-relay> subtest: push login via device flow, cached token used afterwards container-test-run-flakelet-relay> client: must succeed: push login --issuer https://relay:8443 --client-id flakelet-relay 2>&1 container-test-run-flakelet-relay> agent # [15014.914197] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:52.875954Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [15014.915529] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:52.877279Z","level":"INFO","message":"deploy finished","job":"c6c41040efb1b9ad80a0f685d900fec4","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15014.937991] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [06/Sep/2026 11:14:52] "POST /device HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [15015.944081] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [06/Sep/2026 11:14:53] "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 # [15016.996631] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [06/Sep/2026 11:14:54] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [15017.030193] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:54.991991Z","level":"INFO","message":"deploy accepted","job":"4048ca3efa85b3724f84dde67c67b4d4","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15017.030685] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:54.992453Z","level":"INFO","message":"start","id":"0a07f5e7b33d338cbfb14d29df558c41","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15017.031636] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:54.992994Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"0a07f5e7b33d338cbfb14d29df558c41\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15017.097659] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [15017.131047] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [15017.135255] agent flakelet[1403]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15017.135801] agent flakelet[1403]: other: up to date container-test-run-flakelet-relay> agent # [15017.137754] 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.70 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 # [15017.705789] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:55.667539Z","level":"INFO","message":"deploy finished","job":"4048ca3efa85b3724f84dde67c67b4d4","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15017.722754] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:55.684576Z","level":"INFO","message":"deploy accepted","job":"e8d7427a14e8b7c3322a070af17047a5","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15017.704878] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:55.666652Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15017.723104] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:55.684845Z","level":"INFO","message":"start","id":"291b6586239553eaab55020b31c443fd","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15017.723518] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:55.685340Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"291b6586239553eaab55020b31c443fd\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15017.769660] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [15017.800092] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [15017.805279] agent flakelet[1437]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15017.805762] agent flakelet[1437]: other: up to date container-test-run-flakelet-relay> agent # [15017.806838] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 deploy agent/other 2>&1, in 0.65 seconds) container-test-run-flakelet-relay> (finished: subtest: push login via device flow, cached token used afterwards, in 3.44 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> agent # [15018.355270] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:56.317032Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15018.387048] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:56.348792Z","level":"INFO","message":"start","id":"6a0db58640ebc6551c78c12eda1ea93f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15018.387433] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:14:56.349256Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"6a0db58640ebc6551c78c12eda1ea93f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15018.429606] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15018.458993] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15018.463400] agent flakelet[1492]: app: using prebuilt artifact /nix/store/8282rnbvyk847q4l4zby3zwcq3jpzrvw-flakelet-app-broken container-test-run-flakelet-relay> agent # [15018.464112] agent flakelet[1492]: app: activating generation 4 container-test-run-flakelet-relay> agent # [15018.473851] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [15018.475204] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15018.475424] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [15018.488644] agent systemd[1]: Reload requested from client PID 1499 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15018.488698] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15018.356649] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:56.318382Z","level":"INFO","message":"deploy finished","job":"e8d7427a14e8b7c3322a070af17047a5","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15018.386704] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:14:56.348503Z","level":"INFO","message":"deploy accepted","job":"63b9d9e8ab9fa669d4e32843169a6556","caller":"admin@example.org","targets":"[\"agent/app\", \"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15018.830978] agent systemd[1]: Reloading finished in 341 ms. container-test-run-flakelet-relay> agent # [15018.926334] agent systemd[1]: Reload requested from client PID 1529 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15018.926378] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15019.258677] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [15019.341216] agent systemd[1]: Reload requested from client PID 1558 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15019.341253] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15019.664807] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent # [15019.741352] agent systemd[1]: Reload requested from client PID 1589 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15019.741383] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15020.061793] agent systemd[1]: Reloading finished in 320 ms. container-test-run-flakelet-relay> agent # [15020.151073] agent systemd[1]: Starting app broken... container-test-run-flakelet-relay> agent # [15020.182172] agent (nonexistent)[1622]: app.service: Unable to locate executable '/nonexistent': No such file or directory container-test-run-flakelet-relay> agent # [15020.182193] agent (nonexistent)[1622]: app.service: Failed at step EXEC spawning /nonexistent: No such file or directory container-test-run-flakelet-relay> agent # [15020.184060] agent systemd[1]: app.service: Main process exited, code=exited, status=203/EXEC container-test-run-flakelet-relay> agent # [15020.184153] agent systemd[1]: app.service: Failed with result 'exit-code'. container-test-run-flakelet-relay> agent # [15020.184307] agent systemd[1]: Failed to start app broken. container-test-run-flakelet-relay> agent # [15020.215462] agent systemd[1]: Reload requested from client PID 1639 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15020.215501] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15020.535239] agent systemd[1]: Reloading finished in 319 ms. container-test-run-flakelet-relay> agent # [15020.633760] agent systemd[1]: Reload requested from client PID 1670 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15020.633798] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15020.955580] agent systemd[1]: Reloading finished in 321 ms. container-test-run-flakelet-relay> agent # [15021.050025] agent systemd[1]: Reload requested from client PID 1700 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15021.050062] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15021.385886] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [15021.465021] agent systemd[1]: Reload requested from client PID 1730 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15021.465062] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15021.797251] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [15021.874092] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [15021.906964] agent systemd[1]: Started app v1. container-test-run-flakelet-relay> agent # [15021.907902] agent flakelet[1492]: app: deploy failed, rolled back: systemctl start app.service failed: container-test-run-flakelet-relay> agent # [15021.907902] agent flakelet[1492]: failed units: app.service. See journalctl -u app.service container-test-run-flakelet-relay> agent # [15021.910169] agent systemd[1]: flakelet-relay-job-app.service: Main process exited, code=exited, status=1/FAILURE container-test-run-flakelet-relay> agent # [15021.910268] 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.26 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.28 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 # [15022.622824] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:00.584576Z","level":"INFO","message":"update finished","flakelet":"app","status":"RolledBack","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15022.675013] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:00.636808Z","level":"INFO","message":"start","id":"166ee89c378d8dc449ddb1ba2b9a6326","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15022.675595] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:00.637418Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"166ee89c378d8dc449ddb1ba2b9a6326\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15022.731730] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15022.763825] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15022.768364] agent flakelet[1816]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [15022.768905] agent flakelet[1816]: app: up to date container-test-run-flakelet-relay> agent # [15022.770759] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15022.624348] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:00.586080Z","level":"INFO","message":"deploy finished","job":"63b9d9e8ab9fa669d4e32843169a6556","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15022.674727] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:00.636492Z","level":"INFO","message":"deploy accepted","job":"e96a65e0a8a031ddeec0e79db585b2ef","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/app' 2>&1, in 0.68 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1 container-test-run-flakelet-relay> agent # [15023.333856] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:01.295606Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15023.357690] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:01.319495Z","level":"INFO","message":"start","id":"e3b9d2b131c39e2fd243eef0757f91f8","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15023.358090] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:01.319911Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"e3b9d2b131c39e2fd243eef0757f91f8\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15023.409647] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15023.446116] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15023.450851] agent flakelet[1851]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [15023.451436] agent flakelet[1851]: app: up to date container-test-run-flakelet-relay> agent # [15023.451933] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15023.335198] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:01.296941Z","level":"INFO","message":"deploy finished","job":"e96a65e0a8a031ddeec0e79db585b2ef","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15023.357369] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:01.319183Z","level":"INFO","message":"deploy accepted","job":"96cda8c2c2684d100031d85103b3beaa","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '*/app' 2>&1, in 1.70 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 # [15025.031393] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:02.993101Z","level":"INFO","message":"deploy finished","job":"96cda8c2c2684d100031d85103b3beaa","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15025.054546] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:03.016354Z","level":"INFO","message":"deploy accepted","job":"daaafb1313b31f9bf077569495af472e","caller":"admin@example.org","targets":"[\"agent/app\", \"ghost/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15025.029704] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:02.991489Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15025.054827] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:03.016632Z","level":"INFO","message":"start","id":"09017326608ccc7974977f6e5b7b8b9f","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15025.055268] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:03.017092Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"09017326608ccc7974977f6e5b7b8b9f\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15025.129038] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15025.164164] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15025.169419] agent flakelet[1903]: app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> agent # [15025.170474] agent flakelet[1903]: app: up to date container-test-run-flakelet-relay> agent # [15025.171929] 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.71 seconds) container-test-run-flakelet-relay> client: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1 container-test-run-flakelet-relay> client: (finished: must fail: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy '@all/nope' 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: host patterns expand on the relay, in 3.12 seconds) container-test-run-flakelet-relay> subtest: detach returns once the job is accepted container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: timeout 20 push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --detach agent/app 2>&1 container-test-run-flakelet-relay> client: (finished: must succeed: timeout 20 push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --detach agent/app 2>&1, in 0.02 seconds) container-test-run-flakelet-relay> agent: waiting for success: systemctl is-active flakelet-relay-job-app.service container-test-run-flakelet-relay> relay # [15025.740519] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:03.702263Z","level":"INFO","message":"deploy finished","job":"daaafb1313b31f9bf077569495af472e","ok":false,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15025.797518] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:03.759281Z","level":"INFO","message":"deploy accepted","job":"61d6739c4a30b3e4dbc488e17ec13163","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15025.739277] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:03.701074Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(3)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15025.797816] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:03.759620Z","level":"INFO","message":"start","id":"3ef131740a620572edc95894771f5e20","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15025.798166] agent flakelet-agent[507]: {"timestamp":"2026-09-06T11:15:03.759999Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"3ef131740a620572edc95894771f5e20\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15025.842687] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15025.882981] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15025.888107] agent flakelet[1943]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [15025.889415] agent flakelet[1943]: app: activating generation 4 container-test-run-flakelet-relay> agent # [15025.898360] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [15025.899069] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15025.899199] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [15025.908623] agent systemd[1]: Reload requested from client PID 1950 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15025.908659] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15026.242940] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [15026.342773] agent systemd[1]: Reload requested from client PID 1984 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15026.342808] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15026.681382] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [15026.800449] agent systemd[1]: Reload requested from client PID 2013 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15026.800493] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: systemctl is-active flakelet-relay-job-app.service, in 1.40 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 # [15027.143321] agent systemd[1]: Reloading finished in 342 ms. container-test-run-flakelet-relay> agent # [15027.204883] agent systemd[1]: Reload requested from client PID 2046 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15027.204918] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15027.533220] agent systemd[1]: Reloading finished in 327 ms. container-test-run-flakelet-relay> agent # [15027.585437] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [15033.647134] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [15033.669343] agent flakelet[1943]: app: updated to generation 4 container-test-run-flakelet-relay> agent # [15033.672825] 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.48 seconds) container-test-run-flakelet-relay> (finished: subtest: detach returns once the job is accepted, in 8.92 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.07 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> client: (finished: waiting for success: grep -q 'agent_unavailable.*retrying' /tmp/retry.out, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl start flakelet-agent container-test-run-flakelet-relay> agent # [15034.717147] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [15034.746144] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15034.746599] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent # [15034.747083] agent systemd[1]: flakelet-agent.service: Consumed 2.528s CPU time over 30.785s wall clock time. container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl start flakelet-agent, in 0.16 seconds) container-test-run-flakelet-relay> agent # [15034.827511] agent systemd[1]: Starting flakelet-agent... 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> agent # [15034.872212] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:12.833923Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"3ef131740a620572edc95894771f5e20\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out container-test-run-flakelet-relay> agent # [15034.977748] agent systemd[1]: Started flakelet-agent. container-test-run-flakelet-relay> relay # [15034.717100] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:12.678780Z","level":"INFO","message":"agent disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> relay # [15034.988665] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:12.950314Z","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 # [15034.988471] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:12.950272Z","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 # [15035.447640] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:13.409292Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(4)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15035.816358] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:13.778120Z","level":"INFO","message":"start","id":"4da65076f9530fc04715b524035451ee","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15035.816690] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:13.778515Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"4da65076f9530fc04715b524035451ee\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15035.881435] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [15035.913016] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [15035.918384] agent flakelet[2615]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15035.919401] agent flakelet[2615]: other: up to date container-test-run-flakelet-relay> agent # [15035.920123] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15035.815959] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:13.777721Z","level":"INFO","message":"deploy accepted","job":"d918dc4e0aa0f78fb57b2544757f6a10","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15037.505167] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:15.466938Z","level":"INFO","message":"deploy finished","job":"d918dc4e0aa0f78fb57b2544757f6a10","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15037.503128] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:15.464913Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q 'agent/other: unchanged' /tmp/retry.out, in 3.04 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem agents, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": []}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.06 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzYxNiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMzE2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiI1Tkc0TU1OSDVJVDJXPT09IiwibmJmIjoxNzg4NjkzMzE2LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.gMurNKol2rIamQsQegCvX6bZKjW3-cgwdEGHuM1cHr5PrttOm9kaiVBb7-K-iWkQXTT1fDepmbmyZFV-QrIJBA' push --relay https://relay:7443 agents container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzYxNiwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMzE2LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiI1Tkc0TU1OSDVJVDJXPT09IiwibmJmIjoxNzg4NjkzMzE2LCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.gMurNKol2rIamQsQegCvX6bZKjW3-cgwdEGHuM1cHr5PrttOm9kaiVBb7-K-iWkQXTT1fDepmbmyZFV-QrIJBA' 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 3.43 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.06 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 # [15038.215836] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [15038.216386] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15038.216653] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [15038.233422] agent systemd[1]: Reload requested from client PID 2676 ('systemctl')... container-test-run-flakelet-relay> agent # [15038.233488] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15038.582944] agent systemd[1]: Reloading finished in 348 ms. container-test-run-flakelet-relay> agent # [15038.632651] agent systemd[1]: Reload requested from client PID 2705 ('systemctl')... container-test-run-flakelet-relay> agent # [15038.632686] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15038.969538] agent systemd[1]: Reloading finished in 336 ms. container-test-run-flakelet-relay> agent # [15039.069582] agent systemd[1]: Reload requested from client PID 2735 ('systemctl')... container-test-run-flakelet-relay> agent # [15039.069627] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15039.403467] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [15039.480876] agent systemd[1]: Reload requested from client PID 2767 ('systemctl')... container-test-run-flakelet-relay> agent # [15039.480913] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.76 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 # [15039.810498] agent systemd[1]: Reloading finished in 329 ms. container-test-run-flakelet-relay> agent # [15039.896735] agent systemd[1]: Starting app v2... container-test-run-flakelet-relay> agent # [15039.939938] 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 2.06 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.01 seconds) container-test-run-flakelet-relay> agent: must succeed: flakelet update app container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/hysydfr96ds875vr0jgw5rjxi4p39h2j-flakelet-app-v1 container-test-run-flakelet-relay> app: activating generation 6 container-test-run-flakelet-relay> agent # [15042.056210] agent systemd[1]: Stopping app v2... container-test-run-flakelet-relay> agent # [15042.057303] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15042.057505] agent systemd[1]: Stopped app v2. container-test-run-flakelet-relay> agent # [15042.067256] agent systemd[1]: Reload requested from client PID 2833 ('systemctl')... container-test-run-flakelet-relay> agent # [15042.067292] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15042.405902] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [15042.505431] agent systemd[1]: Reload requested from client PID 2862 ('systemctl')... container-test-run-flakelet-relay> agent # [15042.505469] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15042.849190] agent systemd[1]: Reloading finished in 343 ms. container-test-run-flakelet-relay> agent # [15042.896979] agent systemd[1]: Reload requested from client PID 2890 ('systemctl')... container-test-run-flakelet-relay> agent # [15042.897020] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15043.233534] agent systemd[1]: Reloading finished in 336 ms. container-test-run-flakelet-relay> agent # [15043.321333] agent systemd[1]: Reload requested from client PID 2922 ('systemctl')... container-test-run-flakelet-relay> agent # [15043.321369] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15043.645068] agent systemd[1]: Reloading finished in 323 ms. container-test-run-flakelet-relay> agent: (finished: must succeed: flakelet update app, in 1.70 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 # [15043.691727] agent systemd[1]: Starting app v1... container-test-run-flakelet-relay> agent # [15043.720733] 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.68 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.02 seconds) container-test-run-flakelet-relay> subtest: agent link drop mid-run replays missed lines once container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> agent: must succeed: date +%s container-test-run-flakelet-relay> agent: (finished: must succeed: date +%s, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/slow.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788693323 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [15045.874735] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:23.836467Z","level":"INFO","message":"start","id":"6467bf1315622d7d31721829addef6ea","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15045.875679] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:23.837356Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"6467bf1315622d7d31721829addef6ea\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15045.950437] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15045.978097] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15045.983553] agent flakelet[2996]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [15045.984818] agent flakelet[2996]: app: activating generation 7 container-test-run-flakelet-relay> agent # [15045.994309] agent systemd[1]: Stopping app v1... container-test-run-flakelet-relay> agent # [15045.995017] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15045.995143] agent systemd[1]: Stopped app v1. container-test-run-flakelet-relay> agent # [15046.005856] agent systemd[1]: Reload requested from client PID 3003 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15046.005892] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15045.818443] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:23.780185Z","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 # [15045.874306] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:23.836067Z","level":"INFO","message":"deploy accepted","job":"cd23c78f1c6d5b1c8ca1a39948295a42","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15046.340535] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [15046.406905] agent systemd[1]: Reload requested from client PID 3033 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15046.406943] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788693323 | grep -q 'app-slow', in 1.02 seconds) container-test-run-flakelet-relay> agent: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done container-test-run-flakelet-relay> agent: (finished: must succeed: for a in $(getent ahosts relay | cut -d' ' -f1 | sort -u); do ip route add unreachable $a; done, in 0.02 seconds) container-test-run-flakelet-relay> relay: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done container-test-run-flakelet-relay> relay: (finished: must succeed: for a in $(getent ahosts agent | cut -d' ' -f1 | sort -u); do ss -K dst "[$a]"; done, in 0.07 seconds) container-test-run-flakelet-relay> agent: must succeed: ss -K dport = 7443 container-test-run-flakelet-relay> agent # [15046.732981] agent systemd[1]: Reloading finished in 325 ms. container-test-run-flakelet-relay> agent # [15046.809534] agent systemd[1]: Reload requested from client PID 3062 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15046.809571] 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=@1788693323 | grep -q 'updated to generation' container-test-run-flakelet-relay> relay # [15046.966860] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:24.928615Z","level":"INFO","message":"agent disconnected: IO error: Software caused connection abort (os error 103)","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [15047.000069] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:24.961637Z","level":"INFO","message":"disconnected: IO error: Software caused connection abort (os error 103)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15047.148696] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [15047.246422] agent systemd[1]: Reload requested from client PID 3110 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15047.246457] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15047.574134] agent systemd[1]: Reloading finished in 327 ms. container-test-run-flakelet-relay> agent # [15047.645577] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [15048.003798] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:25.965546Z","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 # [15050.005918] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:27.967661Z","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 # [15053.713120] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [15053.730749] agent flakelet[2996]: app: updated to generation 7 container-test-run-flakelet-relay> agent # [15053.733734] 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=@1788693323 | grep -q 'updated to generation', in 7.09 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 # [15054.009163] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:31.970740Z","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 # [15054.853698] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:32.815470Z","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.37 seconds) container-test-run-flakelet-relay> subtest: agent restart mid-run reattaches to the unit container-test-run-flakelet-relay> agent: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json container-test-run-flakelet-relay> agent: (finished: must succeed: jq '.services.app.prebuilt="/nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2"' /etc/flakelet/config.json > /tmp/config.json && cp --remove-destination /tmp/config.json /etc/flakelet/config.json, in 0.01 seconds) container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/restart.out 2>&1 & container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy agent/app > /tmp/restart.out 2>&1 &, in 0.01 seconds) container-test-run-flakelet-relay> agent: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2' container-test-run-flakelet-relay> agent # [15062.013792] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:39.975557Z","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 # [15062.014319] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:39.975736Z","level":"INFO","message":"start","id":"6467bf1315622d7d31721829addef6ea","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15062.237128] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:40.198844Z","level":"INFO","message":"start","id":"832be432c4595e8d936405066ee829a6","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15062.237679] agent flakelet-agent[2166]: {"timestamp":"2026-09-06T11:15:40.199498Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"832be432c4595e8d936405066ee829a6\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> relay # [15062.013866] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:39.975624Z","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 # [15062.014556] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:39.976341Z","level":"INFO","message":"deploy finished","job":"cd23c78f1c6d5b1c8ca1a39948295a42","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15062.236664] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:40.198422Z","level":"INFO","message":"deploy accepted","job":"d0b2151d40c8ac20bd7002eb9cda5b02","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15062.283684] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15062.320256] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15062.324775] agent flakelet[3329]: app: using prebuilt artifact /nix/store/ln47rsd5km8a04hd5zlkz4q1v352zqh3-flakelet-app-slow2 container-test-run-flakelet-relay> agent # [15062.325475] agent flakelet[3329]: app: activating generation 8 container-test-run-flakelet-relay> agent # [15062.333682] agent systemd[1]: Stopping app slow... container-test-run-flakelet-relay> agent # [15062.334386] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15062.334512] agent systemd[1]: Stopped app slow. container-test-run-flakelet-relay> agent # [15062.344092] agent systemd[1]: Reload requested from client PID 3336 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15062.344131] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15062.676990] agent systemd[1]: Reloading finished in 332 ms. container-test-run-flakelet-relay> agent # [15062.772691] agent systemd[1]: Reload requested from client PID 3366 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15062.772740] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since -20s | grep -q 'app-slow2', in 1.02 seconds) container-test-run-flakelet-relay> agent: must succeed: systemctl restart flakelet-agent container-test-run-flakelet-relay> agent # [15063.106991] agent systemd[1]: Reloading finished in 333 ms. container-test-run-flakelet-relay> agent # [15063.198106] agent systemd[1]: Reload requested from client PID 3397 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15063.198142] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15063.532571] agent systemd[1]: Reloading finished in 334 ms. container-test-run-flakelet-relay> agent # [15063.630880] agent systemd[1]: Stopping flakelet-agent... container-test-run-flakelet-relay> agent # [15063.632866] agent systemd[1]: Reload requested from client PID 3433 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15063.632902] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15063.631330] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:41.593049Z","level":"INFO","message":"agent disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","host":"agent","target":"flakelet_relay::relay::agent_conn"} container-test-run-flakelet-relay> agent # [15063.969537] agent systemd[1]: Reloading finished in 335 ms. container-test-run-flakelet-relay> agent # [15064.061403] agent systemd[1]: flakelet-agent.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15064.061601] agent systemd[1]: Stopped flakelet-agent. container-test-run-flakelet-relay> agent: (finished: must succeed: systemctl restart flakelet-agent, in 1.00 seconds) container-test-run-flakelet-relay> agent # [15064.061615] agent systemd[1]: flakelet-agent.service: Consumed 1.832s CPU time over 29.233s wall clock time. container-test-run-flakelet-relay> agent: must succeed: test -n "$(ls /var/lib/flakelet-agent/jobs)" container-test-run-flakelet-relay> agent # [15064.080172] agent systemd[1]: Starting app slow2... container-test-run-flakelet-relay> agent # [15064.081473] agent systemd[1]: Starting flakelet-agent... container-test-run-flakelet-relay> agent # [15064.157230] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:42.119021Z","level":"INFO","message":"reattaching to running unit","flakelet":"app","ids":"[\"832be432c4595e8d936405066ee829a6\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15064.246245] agent systemd[1]: Started flakelet-agent. 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> relay # [15064.260717] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:42.222484Z","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 # [15064.260602] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:42.222402Z","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 # [15064.261846] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:42.223669Z","level":"INFO","message":"start","id":"832be432c4595e8d936405066ee829a6","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15070.176018] agent systemd[1]: Started app slow2. container-test-run-flakelet-relay> agent # [15070.196446] agent flakelet[3329]: app: updated to generation 8 container-test-run-flakelet-relay> agent # [15070.199480] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15070.771228] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:48.732982Z","level":"INFO","message":"deploy finished","job":"d0b2151d40c8ac20bd7002eb9cda5b02","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15070.769660] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:48.731420Z","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.16 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=@1788693349 | grep -q 'app-slow' container-test-run-flakelet-relay> agent # [15071.404807] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:49.366514Z","level":"INFO","message":"start","id":"c8aa90f824c00b3baf56b4eccf27ae96","flakelet":"app","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15071.405493] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:49.367312Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"c8aa90f824c00b3baf56b4eccf27ae96\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15071.471238] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15071.504999] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15071.509360] agent flakelet[3978]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> agent # [15071.510023] agent flakelet[3978]: app: activating generation 9 container-test-run-flakelet-relay> agent # [15071.523154] agent systemd[1]: Stopping app slow2... container-test-run-flakelet-relay> agent # [15071.523597] agent systemd[1]: app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15071.523853] agent systemd[1]: Stopped app slow2. container-test-run-flakelet-relay> agent # [15071.541689] agent systemd[1]: Reload requested from client PID 3985 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15071.541757] agent systemd[1]: Reloading... container-test-run-flakelet-relay> relay # [15071.404271] relay flakelet-relay[401]: {"timestamp":"2026-09-06T11:15:49.366061Z","level":"INFO","message":"deploy accepted","job":"5c883a8b1f56858583b5e21e8d09fc8a","caller":"admin@example.org","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15071.881080] agent systemd[1]: Reloading finished in 338 ms. container-test-run-flakelet-relay> agent # [15071.974287] agent systemd[1]: Reload requested from client PID 4015 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15071.974325] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent: (finished: waiting for success: journalctl -u flakelet-relay-job-app.service --since=@1788693349 | grep -q 'app-slow', in 1.02 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> agent # [15072.305609] agent systemd[1]: Reloading finished in 330 ms. container-test-run-flakelet-relay> agent # [15072.388379] agent systemd[1]: Reload requested from client PID 4046 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15072.388414] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15072.427604] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:50.389394Z","level":"INFO","message":"disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay # [15072.427186] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [15072.483665] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15072.483967] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [15072.483993] relay systemd[1]: flakelet-relay.service: Consumed 2.440s CPU time over 1min 10.414s wall clock time. container-test-run-flakelet-relay> relay # [15072.502474] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [15072.744580] agent systemd[1]: Reloading finished in 355 ms. container-test-run-flakelet-relay> agent # [15072.844953] agent systemd[1]: Reload requested from client PID 4081 ('systemctl') (unit flakelet-relay-job-app.service)... container-test-run-flakelet-relay> agent # [15072.844989] agent systemd[1]: Reloading... container-test-run-flakelet-relay> agent # [15073.176836] agent systemd[1]: Reloading finished in 331 ms. container-test-run-flakelet-relay> agent # [15073.273409] agent systemd[1]: Starting app slow... container-test-run-flakelet-relay> agent # [15073.430351] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:51.392029Z","level":"WARN","message":"connect failed: connect relay:7443: Connection refused (os error 111)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: must succeed: systemctl restart flakelet-relay, in 1.55 seconds) container-test-run-flakelet-relay> client: waiting for success: grep -q '» ok' /tmp/resume.out container-test-run-flakelet-relay> relay # [15073.960072] relay flakelet-relay[935]: {"timestamp":"2026-09-06T11:15:51.921830Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [15073.960764] relay flakelet-relay[935]: {"timestamp":"2026-09-06T11:15:51.922351Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [15073.960686] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> agent # [15075.444829] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:53.406599Z","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 # [15075.445081] relay flakelet-relay[935]: {"timestamp":"2026-09-06T11:15:53.406808Z","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 # [15075.446813] relay flakelet-relay[935]: {"timestamp":"2026-09-06T11:15:53.408633Z","level":"INFO","message":"job reattached","job":"5c883a8b1f56858583b5e21e8d09fc8a","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15079.367350] agent systemd[1]: Started app slow. container-test-run-flakelet-relay> agent # [15079.386703] agent flakelet[3978]: app: updated to generation 9 container-test-run-flakelet-relay> agent # [15079.390240] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15080.455156] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:58.416841Z","level":"INFO","message":"update finished","flakelet":"app","status":"Updated","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> client: (finished: waiting for success: grep -q '» ok' /tmp/resume.out, in 7.08 seconds) container-test-run-flakelet-relay> client: must succeed: cat /tmp/resume.out container-test-run-flakelet-relay> client: (finished: must succeed: cat /tmp/resume.out, in 0.01 seconds) container-test-run-flakelet-relay> (finished: subtest: relay restart mid-run, push resumes via /v1/jobs, in 9.69 seconds) container-test-run-flakelet-relay> subtest: job history comes from the agents and survives a relay restart container-test-run-flakelet-relay> client: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1 container-test-run-flakelet-relay> agent # [15081.074803] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:59.036561Z","level":"INFO","message":"start","id":"5be20c693e5c0b60e3f85779794dfb86","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15081.075226] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:15:59.037053Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5be20c693e5c0b60e3f85779794dfb86\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15081.138007] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [15081.176142] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [15081.182529] agent flakelet[4223]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15081.183560] agent flakelet[4223]: other: up to date container-test-run-flakelet-relay> agent # [15081.186015] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15081.074382] relay flakelet-relay[935]: {"timestamp":"2026-09-06T11:15:59.036132Z","level":"INFO","message":"deploy accepted","job":"188b06c4636b65849b3ba8daac22dc7c","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id hist1 agent/other 2>&1, in 1.71 seconds) container-test-run-flakelet-relay> relay: must succeed: systemctl restart flakelet-relay container-test-run-flakelet-relay> relay # [15082.758221] relay flakelet-relay[935]: {"timestamp":"2026-09-06T11:16:00.719990Z","level":"INFO","message":"deploy finished","job":"188b06c4636b65849b3ba8daac22dc7c","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15082.772526] relay systemd[1]: Stopping flakelet-relay... container-test-run-flakelet-relay> relay # [15082.829083] relay systemd[1]: flakelet-relay.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15082.829488] relay systemd[1]: Stopped flakelet-relay. container-test-run-flakelet-relay> relay # [15082.829527] relay systemd[1]: flakelet-relay.service: Consumed 1.970s CPU time over 10.326s wall clock time. container-test-run-flakelet-relay> relay # [15082.866469] relay systemd[1]: Starting flakelet-relay... container-test-run-flakelet-relay> agent # [15082.756470] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:00.718239Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15082.772937] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:00.734749Z","level":"INFO","message":"disconnected: IO error: peer closed connection without sending TLS close_notify: https://docs.rs/rustls/latest/rustls/manual/_03_howto/index.html#unexpected-eof","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15083.776369] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:01.738105Z","level":"WARN","message":"connect failed: connect relay:7443: Connection refused (os error 111)","relay":"https://relay:7443","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> relay: (finished: must succeed: systemctl restart flakelet-relay, in 1.51 seconds) container-test-run-flakelet-relay> relay: waiting for success: curl -sf http://127.0.0.1:7400/metrics | grep -q 'agent_up{host="agent"} 1' container-test-run-flakelet-relay> relay # [15084.265028] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:02.226819Z","level":"INFO","message":"listening on 127.0.0.1:7400","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [15084.265516] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:02.227335Z","level":"INFO","message":"listening on [::]:7443","target":"flakelet_relay::relay::server"} container-test-run-flakelet-relay> relay # [15084.265588] relay systemd[1]: Started flakelet-relay. container-test-run-flakelet-relay> relay # [15085.788733] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:03.750479Z","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 # [15085.788644] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:03.750385Z","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": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32) container-test-run-flakelet-relay> client: (finished: must succeed: echo '{"groups": [], "repository": "example/app"}' | step crypto jwt sign --key /nix/store/r7sclamg09v434w8zjlfnrcrn1w79wh6-flakelet-relay-test-issuer/jwk.json --iss https://relay:8443 --aud flakelet-relay --sub 'repo:github:example/app:ref:refs/heads/main' --exp $(( $(date +%s) + 300 )) --jti $(head -c8 /dev/urandom | base32), in 0.05 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzY2NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMzY0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPTFRWQ0JJWFdETkZHPT09IiwibmJmIjoxNzg4NjkzMzY0LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2Rm5dzm-FwU-9OOEhC5qnUglOpYv1b7HUflx_Ga63Ia1OJkYEezVfa0DYM6dNyyf8hiO0vF2uX6CPy5P07TiAA' push --relay https://relay:7443 deploy --id hist2 agent/app container-test-run-flakelet-relay> » job 6a239dbf87cfec796e49404c351d787f via relay 0.1.0 (agents: agent 0.1.0) container-test-run-flakelet-relay> » wave 0 container-test-run-flakelet-relay> agent/app | Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent/app | Started flakelet update app (via relay). container-test-run-flakelet-relay> agent # [15086.407189] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:04.368936Z","level":"INFO","message":"start","id":"dce6faec8455f85321e72ee634888126","flakelet":"app","rule":"ci","relay":"relay","caller_name":"\"example/app\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15086.407506] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:04.369339Z","level":"INFO","message":"update starting","flakelet":"app","ids":"[\"dce6faec8455f85321e72ee634888126\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15086.447921] agent systemd[1]: Starting flakelet update app (via relay)... container-test-run-flakelet-relay> agent # [15086.478928] agent systemd[1]: Started flakelet update app (via relay). container-test-run-flakelet-relay> agent/appagent # [15086.484544] agent flakelet[4302]: app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slow container-test-run-flakelet-relay> | agent # [15086.485407] agent flakelet[4302]: app: up to date container-test-run-flakelet-relay> app: using prebuilt artifact /nix/store/c67jj8kx3m50nyj874aqmdqf21w5iznd-flakelet-app-slowagent # [15086.486021] agent systemd[1]: flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> container-test-run-flakelet-relay> agent/app | app: up to date container-test-run-flakelet-relay> agent/app | flakelet-relay-job-app.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15086.406832] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:04.368588Z","level":"INFO","message":"deploy accepted","job":"6a239dbf87cfec796e49404c351d787f","caller":"example/app","targets":"[\"agent/app\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> » agent/app: unchanged (generation 9) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzY2NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMzY0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPTFRWQ0JJWFdETkZHPT09IiwibmJmIjoxNzg4NjkzMzY0LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2Rm5dzm-FwU-9OOEhC5qnUglOpYv1b7HUflx_Ga63Ia1OJkYEezVfa0DYM6dNyyf8hiO0vF2uX6CPy5P07TiAA' push --relay https://relay:7443 deploy --id hist2 agent/app, in 0.66 seconds) container-test-run-flakelet-relay> client: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzY2NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMzY0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPTFRWQ0JJWFdETkZHPT09IiwibmJmIjoxNzg4NjkzMzY0LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2Rm5dzm-FwU-9OOEhC5qnUglOpYv1b7HUflx_Ga63Ia1OJkYEezVfa0DYM6dNyyf8hiO0vF2uX6CPy5P07TiAA' push --relay https://relay:7443 jobs container-test-run-flakelet-relay> client: (finished: must succeed: FLAKELET_RELAY_TOKEN_COMMAND='echo eyJhbGciOiJFZERTQSIsImtpZCI6ImsxIiwidHlwIjoiSldUIn0.eyJhdWQiOiJmbGFrZWxldC1yZWxheSIsImV4cCI6MTc4ODY5MzY2NCwiZ3JvdXBzIjpbXSwiaWF0IjoxNzg4NjkzMzY0LCJpc3MiOiJodHRwczovL3JlbGF5Ojg0NDMiLCJqdGkiOiJPTFRWQ0JJWFdETkZHPT09IiwibmJmIjoxNzg4NjkzMzY0LCJyZXBvc2l0b3J5IjoiZXhhbXBsZS9hcHAiLCJzdWIiOiJyZXBvOmdpdGh1YjpleGFtcGxlL2FwcDpyZWY6cmVmcy9oZWFkcy9tYWluIn0.2Rm5dzm-FwU-9OOEhC5qnUglOpYv1b7HUflx_Ga63Ia1OJkYEezVfa0DYM6dNyyf8hiO0vF2uX6CPy5P07TiAA' push --relay https://relay:7443 jobs, in 0.02 seconds) container-test-run-flakelet-relay> (finished: subtest: job history comes from the agents and survives a relay restart, in 6.02 seconds) container-test-run-flakelet-relay> subtest: dashboard login via authorization code flow container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code} %{redirect_url}' https://relay:7443/ui/ | grep -q '303 https://relay:7443/ui/login', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -L https://relay:7443/ui/login, in 0.08 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar https://relay:7443/ui/jobs, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -f https://relay:7443/v1/jobs | grep -q hist1, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 10 https://relay:7443/ui/jobs/hist1/events || true, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403 container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -o /dev/null -w '%{http_code}' -X POST 'https://relay:7443/ui/deploy?arg=other' | grep -q 403, in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other' container-test-run-flakelet-relay> client: (finished: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -D - -o /dev/null -H 'HX-Request: true' -X POST 'https://relay:7443/ui/deploy?arg=other', in 0.02 seconds) container-test-run-flakelet-relay> client: must succeed: curl -sS --cacert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/ca.pem -b /tmp/jar -c /tmp/jar -N --max-time 30 https://relay:7443/ui/jobs/f3883cc97973af6ad92badeb32451fe1/events || true container-test-run-flakelet-relay> relay # [15087.049071] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:05.010795Z","level":"INFO","message":"deploy finished","job":"6a239dbf87cfec796e49404c351d787f","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15087.125809] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [06/Sep/2026 11:16:05] "GET /authorize?response_type=code&client_id=dashboard&redirect_uri=https%3A%2F%2Frelay%3A7443%2Fui%2Fcallback&scope=openid%20profile%20email%20groups&state=nxD29AMgZim17IelhqxT_MNg6_x3l9GhsbUoIuHJ_9Q&code_challenge=as7gdWWXYafptcYk3m0J6dOnX9g3SLRc5XHoZgYi5hU&code_challenge_method=S256 HTTP/1.1" 302 - container-test-run-flakelet-relay> relay # [15087.171572] relay 93sn3sv24fj26ksccpppzwg6kbf10s4w-device-mock[185]: 127.0.0.1 - - [06/Sep/2026 11:16:05] "POST /token HTTP/1.1" 200 - container-test-run-flakelet-relay> relay # [15087.172611] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:05.134408Z","level":"INFO","message":"login","name":"dev@example.org","principals":"[\"oidc:mock:someone\", \"oidc:mock:groups:wheel\"]","target":"flakelet_relay::relay::login"} container-test-run-flakelet-relay> relay # [15087.233731] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:05.195530Z","level":"INFO","message":"job reattached","job":"188b06c4636b65849b3ba8daac22dc7c","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15087.270703] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:05.232518Z","level":"INFO","message":"deploy accepted","job":"ab3d6a4cf6ec8ad9fbc83b781f745fd8","caller":"dev@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> relay # [15087.292180] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:05.253997Z","level":"INFO","message":"job reattached","job":"ab3d6a4cf6ec8ad9fbc83b781f745fd8","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15087.047616] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:05.009397Z","level":"INFO","message":"update finished","flakelet":"app","status":"Unchanged","generation":"Some(9)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15087.270989] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:05.232768Z","level":"INFO","message":"start","id":"7cafe5b3d64a53dbf1f8bdee514391c2","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"dev@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15087.271362] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:05.233193Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"7cafe5b3d64a53dbf1f8bdee514391c2\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15087.336677] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [15087.369855] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [15087.374391] agent flakelet[4338]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15087.374937] agent flakelet[4338]: other: up to date container-test-run-flakelet-relay> agent # [15087.376496] 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/f3883cc97973af6ad92badeb32451fe1/events || true, in 0.67 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/f3883cc97973af6ad92badeb32451fe1 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/f3883cc97973af6ad92badeb32451fe1, 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=f3883cc97973af6ad92badeb32451fe1' | 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=f3883cc97973af6ad92badeb32451fe1' | 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/other | flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> agent # [15087.940935] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:05.902702Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15088.097769] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:06.059256Z","level":"INFO","message":"start","id":"5e317fc57863c2a7c03ebe1bdacd1356","flakelet":"other","rule":"admins","relay":"relay","caller_name":"\"admin@example.org\"","target":"flakelet_relay::agent::conn"} container-test-run-flakelet-relay> agent # [15088.098373] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:06.059834Z","level":"INFO","message":"update starting","flakelet":"other","ids":"[\"5e317fc57863c2a7c03ebe1bdacd1356\"]","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> agent # [15088.146096] agent systemd[1]: Starting flakelet update other (via relay)... container-test-run-flakelet-relay> agent # [15088.176983] agent systemd[1]: Started flakelet update other (via relay). container-test-run-flakelet-relay> agent # [15088.181446] agent flakelet[4374]: other: using prebuilt artifact /nix/store/hmr990n0b4v6rpzrcpyyw738r9xi7z95-flakelet-other-v1 container-test-run-flakelet-relay> agent # [15088.181970] agent flakelet[4374]: other: up to date container-test-run-flakelet-relay> agent # [15088.184787] agent systemd[1]: flakelet-relay-job-other.service: Deactivated successfully. container-test-run-flakelet-relay> relay # [15088.097082] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:06.058840Z","level":"INFO","message":"deploy accepted","job":"38796a7ba508eadfe82a1cd5def000bc","caller":"admin@example.org","targets":"[\"agent/other\"]","target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> » agent/other: unchanged (generation 1) container-test-run-flakelet-relay> » ok container-test-run-flakelet-relay> client: (finished: must succeed: push --relay https://relay:7443 --cert /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin.pem --key /nix/store/ydql3jgw8j7khsad67k605wlnywsd36n-flakelet-relay-test-certs/admin-key.pem deploy --id live1 agent/other, in 0.67 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.74 seconds) container-test-run-flakelet-relay> (finished: run the VM test script, in 90.01 seconds) container-test-run-flakelet-relay> relay # [15088.743306] relay flakelet-relay[1325]: {"timestamp":"2026-09-06T11:16:06.705055Z","level":"INFO","message":"deploy finished","job":"38796a7ba508eadfe82a1cd5def000bc","ok":true,"target":"flakelet_relay::relay::api"} container-test-run-flakelet-relay> agent # [15088.742000] agent flakelet-agent[3466]: {"timestamp":"2026-09-06T11:16:06.703765Z","level":"INFO","message":"update finished","flakelet":"other","status":"Unchanged","generation":"Some(1)","target":"flakelet_relay::agent::jobs"} container-test-run-flakelet-relay> test script finished in 92.81s container-test-run-flakelet-relay> cleanup container-test-run-flakelet-relay> kill NspawnMachine (pid 51) container-test-run-flakelet-relay> kill NspawnMachine (pid 53) container-test-run-flakelet-relay> Container agent terminated by signal KILL. container-test-run-flakelet-relay> kill NspawnMachine (pid 56) 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.39 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 0af2fc6b6b2f9e17d70c64f51f21e800 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 63b9d9e8ab9fa669d4e32843169a6556 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 cd23c78f1c6d5b1c8ca1a39948295a42 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 d0b2151d40c8ac20bd7002eb9cda5b02 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 5c883a8b1f56858583b5e21e8d09fc8a 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 92e839008eed504efa0451d0396c7e5f 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 5c883a8b1f56858583b5e21e8d09fc8a 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> 1788693359 hist1 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788693349 92e839008eed504efa0451d0396c7e5f admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788693340 4fe79655bd948a98b211915e32ec54be admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788693323 bb7bc6750c818571bb0818f7d1112abb admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788693313 485029a98a72f1003c092dd2ea586505 admin@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788693303 9d5068b07d1fd8a4f67fc423410f8d53 admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788693303 abc5f582b46be0d8ca4b341794621218 admin@example.org agent/app:updated container-test-run-flakelet-relay> 1788693301 75604609acb8f28c5c73e2d45291ce7f admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788693300 bee893718114903fc8e39ed7557f24be admin@example.org agent/app:unchanged container-test-run-flakelet-relay> 1788693296 6b58b247a5aaab6b7f773424873fe280 admin@example.org agent/app:rolled-back container-test-run-flakelet-relay> 1788693295 20963a584d319e1706e22a4a628f26da dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788693294 0fc0e6d2d531614e4749094257b450f8 dev@example.org agent/other:unchanged container-test-run-flakelet-relay> 1788693291 f0c65349b6192a5f1bb9f6f863b8d72f someone agent/other:unchanged container-test-run-flakelet-relay> 1788693288 63b42a4b8d2106d0674982f0369b5f27 repo:github:example/app:ref:refs/heads/main agent/app:updated container-test-run-flakelet-relay> 1788693285 5984162a4809d5f23f43028f00eacecd 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