these 18 derivations will be built:
  /nix/store/aj2350gm1kcwl1rxiw5p2805i31vbsdi-decrypt-age-secrets.drv
  /nix/store/02gqwn2fskld96xyypkzz7vcpwm6qv8w-dry-activate.drv
  /nix/store/2zn7rxlydia06301j96aj62cm0cbdw3h-decrypt-age-secrets.drv
  /nix/store/ga0snx03k2a662898vdc1nw66hm2jkad-activate.drv
  /nix/store/sm9rvm46zx5mr238x0dvm8fcxh4bgxn6-dry-activate.drv
  /nix/store/1cpi47lgbf8501y5xxnvvyj3anxpxzq2-nixos-system-beta-test.drv
  /nix/store/vq30ihxmvbjqkk6ccb5jfqlm6liln1ja-decrypt-age-secrets.drv
  /nix/store/8db07w4zqavhlnng0q7dr2j8d6glk0s9-dry-activate.drv
  /nix/store/gfmr526sa4hsr6ri1z6q6xp56xfkw8jy-activate.drv
  /nix/store/2igryzxflq14nr5gsqa73iwdq6rjbck7-nixos-system-gamma-test.drv
  /nix/store/5k42vr0rp7658rz2sznzvsnn7xil3148-run-gamma-nspawn.drv
  /nix/store/2dkc22yh7gzw4s78xhbmpw7qsb14z8ds-activate.drv
  /nix/store/ygqcmrpagma7f2dcnjb0myncjs5lqfvz-nixos-system-alpha-test.drv
  /nix/store/kn9k2wb6iqh6n0g8mrvwr6rxgca3wp9h-run-alpha-nspawn.drv
  /nix/store/x5p1ia7p41xmn9mk1i59mkwmr8z14zif-run-beta-nspawn.drv
  /nix/store/2a1ld5qb0njcyyps7cm4xp45j0w4kzci-driverConfiguration.json.drv
  /nix/store/ycksjmfqcqsf413h4g4yxghih1llhbj4-nixos-test-driver-data-mesher.drv
  /nix/store/7ld8a5v0y78fp2g1zlfbp9ky68hp9w7y-container-test-run-data-mesher.drv
building '/nix/store/2zn7rxlydia06301j96aj62cm0cbdw3h-decrypt-age-secrets.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/aj2350gm1kcwl1rxiw5p2805i31vbsdi-decrypt-age-secrets.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/vq30ihxmvbjqkk6ccb5jfqlm6liln1ja-decrypt-age-secrets.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/2zn7rxlydia06301j96aj62cm0cbdw3h-decrypt-age-secrets.drv'
building '/nix/store/ga0snx03k2a662898vdc1nw66hm2jkad-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/sm9rvm46zx5mr238x0dvm8fcxh4bgxn6-dry-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/vq30ihxmvbjqkk6ccb5jfqlm6liln1ja-decrypt-age-secrets.drv'
building '/nix/store/gfmr526sa4hsr6ri1z6q6xp56xfkw8jy-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/8db07w4zqavhlnng0q7dr2j8d6glk0s9-dry-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/aj2350gm1kcwl1rxiw5p2805i31vbsdi-decrypt-age-secrets.drv'
building '/nix/store/2dkc22yh7gzw4s78xhbmpw7qsb14z8ds-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/02gqwn2fskld96xyypkzz7vcpwm6qv8w-dry-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/2dkc22yh7gzw4s78xhbmpw7qsb14z8ds-activate.drv'
building '/nix/store/02gqwn2fskld96xyypkzz7vcpwm6qv8w-dry-activate.drv'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/8db07w4zqavhlnng0q7dr2j8d6glk0s9-dry-activate.drv'
building '/nix/store/ga0snx03k2a662898vdc1nw66hm2jkad-activate.drv'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/ygqcmrpagma7f2dcnjb0myncjs5lqfvz-nixos-system-alpha-test.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/sm9rvm46zx5mr238x0dvm8fcxh4bgxn6-dry-activate.drv'
building '/nix/store/gfmr526sa4hsr6ri1z6q6xp56xfkw8jy-activate.drv'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/ygqcmrpagma7f2dcnjb0myncjs5lqfvz-nixos-system-alpha-test.drv'
nixos-system-alpha-test> structuredAttrs is enabled
building '/nix/store/1cpi47lgbf8501y5xxnvvyj3anxpxzq2-nixos-system-beta-test.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/kn9k2wb6iqh6n0g8mrvwr6rxgca3wp9h-run-alpha-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/2igryzxflq14nr5gsqa73iwdq6rjbck7-nixos-system-gamma-test.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/1cpi47lgbf8501y5xxnvvyj3anxpxzq2-nixos-system-beta-test.drv'
nixos-system-beta-test> structuredAttrs is enabled
building '/nix/store/kn9k2wb6iqh6n0g8mrvwr6rxgca3wp9h-run-alpha-nspawn.drv'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/x5p1ia7p41xmn9mk1i59mkwmr8z14zif-run-beta-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/2igryzxflq14nr5gsqa73iwdq6rjbck7-nixos-system-gamma-test.drv'
nixos-system-gamma-test> structuredAttrs is enabled
building '/nix/store/5k42vr0rp7658rz2sznzvsnn7xil3148-run-gamma-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/x5p1ia7p41xmn9mk1i59mkwmr8z14zif-run-beta-nspawn.drv'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/5k42vr0rp7658rz2sznzvsnn7xil3148-run-gamma-nspawn.drv'
building '/nix/store/2a1ld5qb0njcyyps7cm4xp45j0w4kzci-driverConfiguration.json.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/2a1ld5qb0njcyyps7cm4xp45j0w4kzci-driverConfiguration.json.drv'
driverConfiguration.json> structuredAttrs is enabled
building '/nix/store/ycksjmfqcqsf413h4g4yxghih1llhbj4-nixos-test-driver-data-mesher.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/ycksjmfqcqsf413h4g4yxghih1llhbj4-nixos-test-driver-data-mesher.drv'
nixos-test-driver-data-mesher> Running type check (enable/disable: config.skipTypeCheck)
nixos-test-driver-data-mesher> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck
nixos-test-driver-data-mesher> All checks passed!
nixos-test-driver-data-mesher> Linting test script (enable/disable: config.skipLint)
nixos-test-driver-data-mesher> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint
nixos-test-driver-data-mesher> All checks passed!
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/7ld8a5v0y78fp2g1zlfbp9ky68hp9w7y-container-test-run-data-mesher.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/7ld8a5v0y78fp2g1zlfbp9ky68hp9w7y-container-test-run-data-mesher.drv'
container-test-run-data-mesher> Machine state will be reset. To keep it, pass --keep-machine-state
container-test-run-data-mesher> start all VLans
container-test-run-data-mesher> (finished: start all VLans, in 0.00 seconds)
container-test-run-data-mesher> 
container-test-run-data-mesher> Test will time out and terminate in 3600.0 seconds
container-test-run-data-mesher> run the VM test script
container-test-run-data-mesher> additionally exposed symbols:
container-test-run-data-mesher>     alpha, beta, gamma,
container-test-run-data-mesher>     vlan1,
container-test-run-data-mesher>     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-data-mesher> start all VMs
container-test-run-data-mesher> beta: systemd-nspawn running (pid 53)
container-test-run-data-mesher> gamma: systemd-nspawn running (pid 54)
container-test-run-data-mesher> beta: Waiting for journal at /build/vm-state-beta/var/log/journal...
container-test-run-data-mesher> gamma: Waiting for journal at /build/vm-state-gamma/var/log/journal...
container-test-run-data-mesher> alpha: systemd-nspawn running (pid 59)
container-test-run-data-mesher> alpha: Waiting for journal at /build/vm-state-alpha/var/log/journal...
container-test-run-data-mesher> (finished: start all VMs, in 0.01 seconds)
container-test-run-data-mesher> alpha: waiting for unit data-mesher.service
container-test-run-data-mesher> nixos-nspawn(gamma): TAP vde-tap1 not found; container will be isolated from VDE
container-test-run-data-mesher> nixos-nspawn(gamma): 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-data-mesher> nixos-nspawn(beta): TAP vde-tap1 not found; container will be isolated from VDE
container-test-run-data-mesher> nixos-nspawn(beta): 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-data-mesher> nixos-nspawn(alpha): TAP vde-tap1 not found; container will be isolated from VDE
container-test-run-data-mesher> nixos-nspawn(alpha): 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-data-mesher> 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-data-mesher> ░ Spawning container gamma on /build/vm-state-gamma.
container-test-run-data-mesher> 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-data-mesher> 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-data-mesher> ░ Spawning container alpha on /build/vm-state-alpha.
container-test-run-data-mesher> ░ Spawning container beta on /build/vm-state-beta.
container-test-run-data-mesher> gamma # No journal files were found.
container-test-run-data-mesher> gamma # No journal boot entry found for the specified boot (+0).
container-test-run-data-mesher> alpha # No journal files were found.
container-test-run-data-mesher> alpha # No journal boot entry found for the specified boot (+0).
container-test-run-data-mesher> beta # No journal files were found.
container-test-run-data-mesher> beta # No journal boot entry found for the specified boot (+0).
container-test-run-data-mesher> gamma # [7209083.794285] gamma systemd-journald[87]: Journal started
container-test-run-data-mesher> gamma # [7209083.794349] gamma systemd-journald[87]: Runtime Journal (/run/log/journal/1a70a553aaa34cc39375cca0f70fdf02) is 8M, max 2.5G, 2.4G free.
container-test-run-data-mesher> gamma # [7209083.800430] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> gamma # [7209083.810119] gamma systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> gamma # [7209083.811082] gamma systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> gamma # [7209083.811861] gamma systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> gamma # [7209083.819898] gamma systemd-journald[87]: Time spent on flushing to /var/log/journal/1a70a553aaa34cc39375cca0f70fdf02 is 1.352ms for 6 entries.
container-test-run-data-mesher> gamma # [7209083.819898] gamma systemd-journald[87]: System Journal (/var/log/journal/1a70a553aaa34cc39375cca0f70fdf02) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> gamma # [7209083.829581] gamma systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> gamma # [7209083.829872] gamma systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> gamma # [7209083.829964] gamma systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> gamma # [7209083.830814] gamma systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> gamma # [7209083.830871] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> gamma # [7209083.831791] gamma systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> gamma # [7209083.831830] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> gamma # [7209083.892278] gamma systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> gamma # [7209083.893352] gamma systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> gamma # [7209083.913605] gamma systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [7209083.913784] gamma systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> gamma # [7209083.913904] gamma systemd-tmpfiles[161]: fchmod() of /var/log/journal/1a70a553aaa34cc39375cca0f70fdf02 failed: Operation not permitted
container-test-run-data-mesher> gamma # [7209083.914098] gamma systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> gamma # [7209083.915615] gamma systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> gamma # [7209083.916787] gamma systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> gamma # [7209083.917555] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> gamma # [7209083.929324] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> gamma # [7209083.937337] gamma systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> gamma # [7209083.938591] gamma systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> gamma # [7209083.950324] gamma systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> gamma # [7209083.954301] gamma systemd[1]: Finished Firewall.
container-test-run-data-mesher> gamma # [7209083.954463] gamma systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> gamma # [7209083.954695] gamma systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> gamma # [7209083.955740] gamma systemd[1]: Starting Network Management...
container-test-run-data-mesher> gamma # [7209084.187981] gamma systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> gamma # [7209084.791396] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> alpha # [7209083.786359] alpha systemd-journald[87]: Journal started
container-test-run-data-mesher> alpha # [7209083.786428] alpha systemd-journald[87]: Runtime Journal (/run/log/journal/9268d7b4a3de4190a549efd1007133a1) is 8M, max 2.5G, 2.4G free.
container-test-run-data-mesher> alpha # [7209083.790586] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> alpha # [7209083.801735] alpha systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> alpha # [7209083.802706] alpha systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> alpha # [7209083.803556] alpha systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> alpha # [7209083.811923] alpha systemd-journald[87]: Time spent on flushing to /var/log/journal/9268d7b4a3de4190a549efd1007133a1 is 1.118ms for 6 entries.
container-test-run-data-mesher> alpha # [7209083.811923] alpha systemd-journald[87]: System Journal (/var/log/journal/9268d7b4a3de4190a549efd1007133a1) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> alpha # [7209083.820399] alpha systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> alpha # [7209083.820755] alpha systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> alpha # [7209083.820955] alpha systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> alpha # [7209083.821843] alpha systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> alpha # [7209083.821898] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> alpha # [7209083.822910] alpha systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> alpha # [7209083.822949] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> alpha # [7209083.892275] alpha systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> alpha # [7209083.893378] alpha systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> alpha # [7209083.911442] alpha systemd-tmpfiles[162]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [7209083.911646] alpha systemd-tmpfiles[162]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> alpha # [7209083.911781] alpha systemd-tmpfiles[162]: fchmod() of /var/log/journal/9268d7b4a3de4190a549efd1007133a1 failed: Operation not permitted
container-test-run-data-mesher> alpha # [7209083.911993] alpha systemd-tmpfiles[162]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> alpha # [7209083.915520] alpha systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> alpha # [7209083.918279] alpha systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> alpha # [7209083.919242] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> alpha # [7209083.931449] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> alpha # [7209083.936852] alpha systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> alpha # [7209083.938017] alpha systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> alpha # [7209083.950319] alpha systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> alpha # [7209083.961417] alpha systemd[1]: Finished Firewall.
container-test-run-data-mesher> alpha # [7209083.961596] alpha systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> alpha # [7209083.961827] alpha systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> alpha # [7209083.963578] alpha systemd[1]: Starting Network Management...
container-test-run-data-mesher> alpha # [7209084.189161] alpha systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> alpha # [7209084.788755] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> beta # [7209083.789145] beta systemd-journald[87]: Journal started
container-test-run-data-mesher> beta # [7209083.789211] beta systemd-journald[87]: Runtime Journal (/run/log/journal/3783d0ad7ffc4ad296209b14875c5171) is 8M, max 2.5G, 2.4G free.
container-test-run-data-mesher> beta # [7209083.790535] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> beta # [7209083.801979] beta systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> beta # [7209083.802985] beta systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> beta # [7209083.807053] beta systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> beta # [7209083.812054] beta systemd-journald[87]: Time spent on flushing to /var/log/journal/3783d0ad7ffc4ad296209b14875c5171 is 1.162ms for 6 entries.
container-test-run-data-mesher> beta # [7209083.812054] beta systemd-journald[87]: System Journal (/var/log/journal/3783d0ad7ffc4ad296209b14875c5171) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> beta # [7209083.821705] beta systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> beta # [7209083.822075] beta systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> beta # [7209083.822161] beta systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> beta # [7209083.822904] beta systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> beta # [7209083.822948] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> beta # [7209083.823848] beta systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> beta # [7209083.823886] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> beta # [7209083.887114] beta systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> beta # [7209083.889001] beta systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> beta # [7209083.905681] beta systemd-tmpfiles[163]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [7209083.905864] beta systemd-tmpfiles[163]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> beta # [7209083.905980] beta systemd-tmpfiles[163]: fchmod() of /var/log/journal/3783d0ad7ffc4ad296209b14875c5171 failed: Operation not permitted
container-test-run-data-mesher> beta # [7209083.906158] beta systemd-tmpfiles[163]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> beta # [7209083.907800] beta systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> beta # [7209083.909094] beta systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> beta # [7209083.910005] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> beta # [7209083.921988] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> beta # [7209083.929628] beta systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> beta # [7209083.930934] beta systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> beta # [7209083.944334] beta systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> beta # [7209083.950974] beta systemd[1]: Finished Firewall.
container-test-run-data-mesher> beta # [7209083.951143] beta systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> beta # [7209083.951373] beta systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> beta # [7209083.952515] beta systemd[1]: Starting Network Management...
container-test-run-data-mesher> beta # [7209084.196371] beta systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> beta # [7209084.788577] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> gamma # [7209084.893870] gamma systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [7209084.893975] gamma systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [7209084.900785] gamma systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.
container-test-run-data-mesher> gamma # [7209084.900953] gamma systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.
container-test-run-data-mesher> gamma # [7209084.901156] gamma systemd-networkd[204]: lo: Link UP
container-test-run-data-mesher> gamma # [7209084.901161] gamma systemd-networkd[204]: lo: Gained carrier
container-test-run-data-mesher> gamma # [7209084.901358] gamma systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> gamma # [7209084.901777] gamma systemd[1]: Started Network Management.
container-test-run-data-mesher> gamma # [7209084.901860] gamma systemd-networkd[204]: eth1: Link UP
container-test-run-data-mesher> gamma # [7209084.902265] gamma systemd-networkd[204]: eth1: Gained carrier
container-test-run-data-mesher> gamma # [7209084.903119] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> gamma # [7209084.963824] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> beta # [7209084.893875] beta systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [7209084.893985] beta systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [7209084.900848] beta systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.
container-test-run-data-mesher> beta # [7209084.901016] beta systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.
container-test-run-data-mesher> beta # [7209084.901206] beta systemd-networkd[204]: lo: Link UP
container-test-run-data-mesher> beta # [7209084.901210] beta systemd-networkd[204]: lo: Gained carrier
container-test-run-data-mesher> beta # [7209084.901376] beta systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> beta # [7209084.901761] beta systemd[1]: Started Network Management.
container-test-run-data-mesher> beta # [7209084.901935] beta systemd-networkd[204]: eth1: Link UP
container-test-run-data-mesher> beta # [7209084.902232] beta systemd-networkd[204]: eth1: Gained carrier
container-test-run-data-mesher> beta # [7209084.903116] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> beta # [7209084.962292] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> alpha # [7209084.906044] alpha systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [7209084.906139] alpha systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [7209084.912718] alpha systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.
container-test-run-data-mesher> alpha # [7209084.912878] alpha systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.
container-test-run-data-mesher> alpha # [7209084.913039] alpha systemd-networkd[204]: lo: Link UP
container-test-run-data-mesher> alpha # [7209084.913042] alpha systemd-networkd[204]: lo: Gained carrier
container-test-run-data-mesher> alpha # [7209084.913254] alpha systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> alpha # [7209084.913659] alpha systemd[1]: Started Network Management.
container-test-run-data-mesher> alpha # [7209084.952394] alpha systemd-networkd[204]: eth1: Link UP
container-test-run-data-mesher> alpha # [7209084.952471] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> alpha # [7209084.952664] alpha systemd-networkd[204]: eth1: Gained carrier
container-test-run-data-mesher> alpha # [7209085.010395] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> beta # [7209085.148217] beta systemd-resolved[110]: Positive Trust Anchors:
container-test-run-data-mesher> beta # [7209085.148234] beta systemd-resolved[110]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> beta # [7209085.148238] beta systemd-resolved[110]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> beta # [7209085.148273] beta systemd-resolved[110]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
container-test-run-data-mesher> beta # [7209085.171088] beta systemd-resolved[110]: Using system hostname 'beta'.
container-test-run-data-mesher> beta # [7209085.234874] beta systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> beta # [7209085.234989] beta systemd[1]: Reached target Network.
container-test-run-data-mesher> beta # [7209085.235056] beta systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> beta # [7209085.235108] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> beta # [7209085.235139] beta systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> beta # [7209085.235156] beta systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> beta # [7209085.235293] beta systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> beta # [7209085.235422] beta systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> beta # [7209085.235530] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> beta # [7209085.235553] beta systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> beta # [7209085.235591] beta systemd[1]: Reached target Basic System.
container-test-run-data-mesher> beta # [7209085.237253] beta systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> beta # [7209085.238310] beta systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> beta # [7209085.239202] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> beta # [7209085.240527] beta systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> beta # [7209085.300916] beta systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> alpha # [7209085.172410] alpha systemd-resolved[112]: Positive Trust Anchors:
container-test-run-data-mesher> alpha # [7209085.172422] alpha systemd-resolved[112]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> alpha # [7209085.172427] alpha systemd-resolved[112]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> alpha # [7209085.172461] alpha systemd-resolved[112]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
container-test-run-data-mesher> alpha # [7209085.194840] alpha systemd-resolved[112]: Using system hostname 'alpha'.
container-test-run-data-mesher> alpha # [7209085.237634] alpha systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> alpha # [7209085.237731] alpha systemd[1]: Reached target Network.
container-test-run-data-mesher> alpha # [7209085.237796] alpha systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> alpha # [7209085.237848] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> alpha # [7209085.237871] alpha systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> alpha # [7209085.237890] alpha systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> alpha # [7209085.238015] alpha systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> alpha # [7209085.238146] alpha systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> alpha # [7209085.238250] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> alpha # [7209085.238273] alpha systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> alpha # [7209085.238309] alpha systemd[1]: Reached target Basic System.
container-test-run-data-mesher> alpha # [7209085.239513] alpha systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> alpha # [7209085.240473] alpha systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> alpha # [7209085.241368] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> alpha # [7209085.284484] alpha systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> alpha # [7209085.300863] alpha systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> gamma # [7209085.169742] gamma systemd-resolved[113]: Positive Trust Anchors:
container-test-run-data-mesher> gamma # [7209085.169765] gamma systemd-resolved[113]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> gamma # [7209085.169770] gamma systemd-resolved[113]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> gamma # [7209085.169803] gamma systemd-resolved[113]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
container-test-run-data-mesher> gamma # [7209085.192448] gamma systemd-resolved[113]: Using system hostname 'gamma'.
container-test-run-data-mesher> gamma # [7209085.237505] gamma systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> gamma # [7209085.237611] gamma systemd[1]: Reached target Network.
container-test-run-data-mesher> gamma # [7209085.237674] gamma systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> gamma # [7209085.237723] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> gamma # [7209085.237749] gamma systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> gamma # [7209085.237768] gamma systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> gamma # [7209085.237900] gamma systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> gamma # [7209085.238032] gamma systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> gamma # [7209085.238143] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> gamma # [7209085.238162] gamma systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> gamma # [7209085.238198] gamma systemd[1]: Reached target Basic System.
container-test-run-data-mesher> gamma # [7209085.239522] gamma systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> gamma # [7209085.240415] gamma systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> gamma # [7209085.241338] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> gamma # [7209085.284483] gamma systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> gamma # [7209085.300852] gamma systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> gamma # [7209085.535788] gamma nsncd[212]: Aug 31 09:55:11.588 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> gamma # [7209085.536372] gamma systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> gamma # [7209085.536447] gamma systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> gamma # [7209085.536514] gamma systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> gamma # [7209085.564582] gamma systemd[1]: Starting User Login Management...
container-test-run-data-mesher> gamma # [7209085.565532] gamma systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> gamma # [7209085.580261] gamma systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> gamma # [7209085.582780] gamma systemd[1]: Started Console Getty.
container-test-run-data-mesher> gamma # [7209085.582865] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> gamma # [7209085.582885] gamma systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> alpha # [7209085.517649] alpha nsncd[212]: Aug 31 09:55:11.570 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> alpha # [7209085.517819] alpha systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> alpha # [7209085.517893] alpha systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> alpha # [7209085.517950] alpha systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> alpha # [7209085.519230] alpha systemd[1]: Starting User Login Management...
container-test-run-data-mesher> alpha # [7209085.520244] alpha systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> alpha # [7209085.572344] alpha systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> alpha # [7209085.573542] alpha systemd[1]: Started Console Getty.
container-test-run-data-mesher> alpha # [7209085.573585] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> alpha # [7209085.573626] alpha systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> beta # [7209085.550913] beta nsncd[212]: Aug 31 09:55:11.604 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> beta # [7209085.551062] beta systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> beta # [7209085.551137] beta systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> beta # [7209085.551196] beta systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> beta # [7209085.565692] beta systemd[1]: Starting User Login Management...
container-test-run-data-mesher> beta # [7209085.568239] beta systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> beta # [7209085.578099] beta systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> beta # [7209085.579946] beta systemd[1]: Started Console Getty.
container-test-run-data-mesher> beta # [7209085.579997] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> beta # [7209085.580033] beta systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> alpha # [7209086.112173] alpha systemd-networkd[204]: eth1: Gained IPv6LL
container-test-run-data-mesher> alpha # [7209086.297922] alpha dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> alpha # [7209086.299180] alpha dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> alpha # [7209086.299180] alpha dbus-broker-launch[213]: Invalid user-name in /nix/store/cpw251a8nnv83rza5mdsgkafc9msqh5c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> alpha # [7209086.299663] alpha systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> alpha # [7209086.307381] alpha dbus-broker-launch[213]: Ready
container-test-run-data-mesher> beta # [7209086.191449] beta dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> beta # [7209086.193525] beta dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> beta # [7209086.193525] beta dbus-broker-launch[213]: Invalid user-name in /nix/store/cpw251a8nnv83rza5mdsgkafc9msqh5c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> beta # [7209086.194063] beta systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> beta # [7209086.201216] beta dbus-broker-launch[213]: Ready
container-test-run-data-mesher> beta # [7209086.244143] beta systemd-networkd[204]: eth1: Gained IPv6LL
container-test-run-data-mesher> gamma # [7209086.253881] gamma dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> gamma # [7209086.254696] gamma dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> gamma # [7209086.254696] gamma dbus-broker-launch[213]: Invalid user-name in /nix/store/cpw251a8nnv83rza5mdsgkafc9msqh5c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> gamma # [7209086.255125] gamma systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> gamma # [7209086.262104] gamma dbus-broker-launch[213]: Ready
container-test-run-data-mesher> gamma # [7209086.720156] gamma systemd-networkd[204]: eth1: Gained IPv6LL
container-test-run-data-mesher> gamma # [7209086.806814] gamma data-mesher[210]: time=2026-08-31T09:55:12.859Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> gamma # [7209086.807914] gamma data-mesher[210]: time=2026-08-31T09:55:12.861Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g: [/dns/alpha.clan/tcp/7946]} {12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> gamma # [7209086.807960] gamma data-mesher[210]: time=2026-08-31T09:55:12.861Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> beta # [7209086.781051] beta data-mesher[210]: time=2026-08-31T09:55:12.834Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> beta # [7209086.782165] beta data-mesher[210]: time=2026-08-31T09:55:12.835Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g: [/dns/alpha.clan/tcp/7946]} {12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> beta # [7209086.782209] beta data-mesher[210]: time=2026-08-31T09:55:12.835Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> beta # [7209086.980084] beta data-mesher[210]: time=2026-08-31T09:55:13.033Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> beta # [7209086.980243] beta data-mesher[210]: time=2026-08-31T09:55:13.033Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> beta # [7209086.984582] beta data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="libp2p host created" peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.2/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::2/tcp/7946]"
container-test-run-data-mesher> beta # [7209086.984658] beta data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> beta # [7209086.984658] beta data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> beta # [7209086.984658] beta data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> beta # [7209086.984658] beta data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="starting server"
container-test-run-data-mesher> beta # [7209086.984763] beta data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> beta # [7209086.984818] beta data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> beta # [7209086.984852] beta data-mesher[210]: time=2026-08-31T09:55:13.038Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> beta # [7209086.991910] beta systemd-logind[229]: New seat seat0.
container-test-run-data-mesher> beta # [7209086.992164] beta systemd[1]: Started User Login Management.
container-test-run-data-mesher> beta # [7209086.993532] beta data-mesher[210]: time=2026-08-31T09:55:13.046Z level=INFO msg="peer connected" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r remote_addr=/ip6/2001:db8:1::3/tcp/7946
container-test-run-data-mesher> beta # [7209086.993525] beta systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> beta # [7209086.994517] beta data-mesher[210]: time=2026-08-31T09:55:13.047Z level=INFO msg="peer connected" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g remote_addr=/ip4/192.168.1.1/tcp/7946
container-test-run-data-mesher> beta # [7209087.011123] beta systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> beta # [7209087.011189] beta systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> alpha # [7209086.791284] alpha data-mesher[210]: time=2026-08-31T09:55:12.844Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> alpha # [7209086.801593] alpha data-mesher[210]: time=2026-08-31T09:55:12.845Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g: [/dns/alpha.clan/tcp/7946]} {12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> alpha # [7209086.801593] alpha data-mesher[210]: time=2026-08-31T09:55:12.845Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> alpha # [7209086.972393] alpha systemd-logind[229]: New seat seat0.
container-test-run-data-mesher> alpha # [7209086.972599] alpha systemd[1]: Started User Login Management.
container-test-run-data-mesher> alpha # [7209086.974862] alpha systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> alpha # [7209086.983719] alpha data-mesher[210]: time=2026-08-31T09:55:13.036Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> alpha # [7209086.983856] alpha data-mesher[210]: time=2026-08-31T09:55:13.037Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> alpha # [7209086.988251] alpha systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> alpha # [7209086.988474] alpha systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> alpha # [7209086.988628] alpha data-mesher[210]: time=2026-08-31T09:55:13.041Z level=INFO msg="libp2p host created" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.1/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::1/tcp/7946]"
container-test-run-data-mesher> alpha # [7209086.988676] alpha data-mesher[210]: time=2026-08-31T09:55:13.041Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> alpha # [7209086.988676] alpha data-mesher[210]: time=2026-08-31T09:55:13.041Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> alpha # [7209086.988676] alpha data-mesher[210]: time=2026-08-31T09:55:13.041Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> alpha # [7209086.988676] alpha data-mesher[210]: time=2026-08-31T09:55:13.041Z level=INFO msg="starting server"
container-test-run-data-mesher> alpha # [7209086.988795] alpha data-mesher[210]: time=2026-08-31T09:55:13.041Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> alpha # [7209086.988998] alpha data-mesher[210]: time=2026-08-31T09:55:13.042Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> alpha # [7209086.989316] alpha data-mesher[210]: time=2026-08-31T09:55:13.042Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> alpha # [7209086.993879] alpha data-mesher[210]: time=2026-08-31T09:55:13.046Z level=INFO msg="peer connected" peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-data-mesher> alpha # [7209086.999101] alpha data-mesher[210]: time=2026-08-31T09:55:13.051Z level=INFO msg="peer connected" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r remote_addr=/ip4/192.168.1.3/tcp/7946
container-test-run-data-mesher> alpha # [7209087.001294] alpha data-mesher[210]: time=2026-08-31T09:55:13.054Z level=INFO msg="peer connected" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r remote_addr=/ip6/2001:db8:1::3/tcp/7946
container-test-run-data-mesher> gamma # [7209086.982453] gamma data-mesher[210]: time=2026-08-31T09:55:13.035Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> gamma # [7209086.982730] gamma data-mesher[210]: time=2026-08-31T09:55:13.035Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> gamma # [7209086.986912] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="libp2p host created" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.3/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::3/tcp/7946]"
container-test-run-data-mesher> gamma # [7209086.988084] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> gamma # [7209086.988084] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> gamma # [7209086.988084] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> gamma # [7209086.988084] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="starting server"
container-test-run-data-mesher> gamma # [7209086.988084] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> gamma # [7209086.988084] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> gamma # [7209086.988084] gamma data-mesher[210]: time=2026-08-31T09:55:13.040Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> gamma # [7209086.991911] gamma systemd-logind[229]: New seat seat0.
container-test-run-data-mesher> gamma # [7209086.992220] gamma systemd[1]: Started User Login Management.
container-test-run-data-mesher> gamma # [7209086.992633] gamma data-mesher[210]: time=2026-08-31T09:55:13.045Z level=INFO msg="peer connected" peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 remote_addr=/ip6/2001:db8:1::2/tcp/7946
container-test-run-data-mesher> gamma # [7209086.993492] gamma systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> gamma # [7209086.999056] gamma data-mesher[210]: time=2026-08-31T09:55:13.051Z level=INFO msg="peer connected" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g remote_addr=/ip4/192.168.1.1/tcp/7946
container-test-run-data-mesher> gamma # [7209087.002252] gamma data-mesher[210]: time=2026-08-31T09:55:13.055Z level=INFO msg="peer connected" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g remote_addr=/ip6/2001:db8:1::1/tcp/46642
container-test-run-data-mesher> gamma # [7209087.006427] gamma systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> gamma # [7209087.006559] gamma systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> alpha: still waiting for container 'alpha' to reach ready state...
container-test-run-data-mesher> gamma # [7209096.985876] gamma data-mesher[210]: time=2026-08-31T09:55:23.039Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> gamma # [7209096.985876] gamma data-mesher[210]: time=2026-08-31T09:55:23.039Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> gamma # [7209096.987580] gamma data-mesher[210]: time=2026-08-31T09:55:23.040Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> gamma # [7209096.987628] gamma data-mesher[210]: time=2026-08-31T09:55:23.040Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s
container-test-run-data-mesher> gamma # [7209096.988282] gamma data-mesher[210]: time=2026-08-31T09:55:23.041Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> gamma # [7209096.988282] gamma data-mesher[210]: time=2026-08-31T09:55:23.041Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s
container-test-run-data-mesher> gamma # [7209096.988357] gamma data-mesher[210]: time=2026-08-31T09:55:23.041Z level=INFO msg="server started"
container-test-run-data-mesher> gamma # [7209096.988428] gamma data-mesher[210]: time=2026-08-31T09:55:23.041Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> gamma # [7209096.988652] gamma systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> gamma # [7209096.989175] gamma systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> gamma # [7209096.989606] gamma systemd[1]: Startup finished in 13.569s.
container-test-run-data-mesher> gamma # [7209096.989675] gamma data-mesher[210]: time=2026-08-31T09:55:23.042Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209096.989675] gamma data-mesher[210]: time=2026-08-31T09:55:23.042Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209096.985352] beta data-mesher[210]: time=2026-08-31T09:55:23.038Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> beta # [7209096.985352] beta data-mesher[210]: time=2026-08-31T09:55:23.038Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> beta # [7209096.986083] beta data-mesher[210]: time=2026-08-31T09:55:23.039Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> beta # [7209096.986083] beta data-mesher[210]: time=2026-08-31T09:55:23.039Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> beta # [7209096.986145] beta data-mesher[210]: time=2026-08-31T09:55:23.039Z level=INFO msg="server started"
container-test-run-data-mesher> beta # [7209096.986348] beta systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> beta # [7209096.986592] beta data-mesher[210]: time=2026-08-31T09:55:23.039Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> beta # [7209096.986592] beta systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> beta # [7209096.986783] beta systemd[1]: Startup finished in 13.533s.
container-test-run-data-mesher> beta # [7209096.988138] beta data-mesher[210]: time=2026-08-31T09:55:23.041Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> beta # [7209096.988138] beta data-mesher[210]: time=2026-08-31T09:55:23.041Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209096.989288] alpha data-mesher[210]: time=2026-08-31T09:55:23.042Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> alpha # [7209096.989652] alpha data-mesher[210]: time=2026-08-31T09:55:23.042Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> alpha # [7209096.990020] alpha data-mesher[210]: time=2026-08-31T09:55:23.043Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209096.990020] alpha data-mesher[210]: time=2026-08-31T09:55:23.043Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> alpha # [7209096.990089] alpha data-mesher[210]: time=2026-08-31T09:55:23.043Z level=INFO msg="server started"
container-test-run-data-mesher> alpha # [7209096.990163] alpha data-mesher[210]: time=2026-08-31T09:55:23.043Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> alpha # [7209096.990290] alpha systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> alpha # [7209096.990526] alpha systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> alpha # [7209096.990681] alpha systemd[1]: Startup finished in 13.636s.
container-test-run-data-mesher> alpha: (finished: waiting for unit data-mesher.service, in 14.68 seconds)
container-test-run-data-mesher> beta: waiting for unit data-mesher.service
container-test-run-data-mesher> beta: (finished: waiting for unit data-mesher.service, in 0.01 seconds)
container-test-run-data-mesher> gamma: waiting for unit data-mesher.service
container-test-run-data-mesher> gamma: (finished: waiting for unit data-mesher.service, in 0.01 seconds)
container-test-run-data-mesher> alpha: must succeed: echo -n 'hello world' > /tmp/test_file
container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'hello world' > /tmp/test_file, in 0.01 seconds)
container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key
container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.03 seconds)
container-test-run-data-mesher> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.
container-test-run-data-mesher>     File "/nix/store/5ji70zizd2wdp8kz2n2hzzcabdw71fwn-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39
container-test-run-data-mesher> alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.
container-test-run-data-mesher>     File "/nix/store/5ji70zizd2wdp8kz2n2hzzcabdw71fwn-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39
container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)
container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> alpha # [7209097.550203] alpha data-mesher[210]: time=2026-08-31T09:55:23.603Z level=INFO msg=http_request uri=/files/test_file status=204
container-test-run-data-mesher> gamma # [7209101.989335] gamma data-mesher[210]: time=2026-08-31T09:55:28.042Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [7209101.989722] gamma data-mesher[210]: time=2026-08-31T09:55:28.042Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> gamma # [7209101.990504] gamma data-mesher[210]: time=2026-08-31T09:55:28.043Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209101.990541] gamma data-mesher[210]: time=2026-08-31T09:55:28.043Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_file
container-test-run-data-mesher> gamma # [7209101.990563] gamma data-mesher[210]: time=2026-08-31T09:55:28.043Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> gamma # [7209101.990619] gamma data-mesher[210]: time=2026-08-31T09:55:28.043Z level=INFO msg="scheduling file download" name=test_file
container-test-run-data-mesher> gamma # [7209101.990659] gamma data-mesher[210]: time=2026-08-31T09:55:28.043Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-31 09:55:23.601 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209101.990687] gamma data-mesher[210]: time=2026-08-31T09:55:28.043Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [7209101.996123] gamma data-mesher[210]: time=2026-08-31T09:55:28.049Z level=INFO msg="download complete" name=test_file signed_at="2026-08-31 09:55:23.601 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g written=true elapsed=5.454316ms
container-test-run-data-mesher> beta # [7209101.988143] beta data-mesher[210]: time=2026-08-31T09:55:28.041Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [7209101.988143] beta data-mesher[210]: time=2026-08-31T09:55:28.041Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> alpha # [7209101.988750] alpha data-mesher[210]: time=2026-08-31T09:55:28.041Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> alpha # [7209101.988750] alpha data-mesher[210]: time=2026-08-31T09:55:28.041Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> alpha # [7209101.990054] alpha data-mesher[210]: time=2026-08-31T09:55:28.043Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209101.990054] alpha data-mesher[210]: time=2026-08-31T09:55:28.043Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209101.990256] alpha data-mesher[210]: time=2026-08-31T09:55:28.043Z level=INFO msg="received file request" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file
container-test-run-data-mesher> alpha # [7209101.990320] alpha data-mesher[210]: time=2026-08-31T09:55:28.043Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [7209101.990379] alpha data-mesher[210]: time=2026-08-31T09:55:28.043Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s
container-test-run-data-mesher> alpha # [7209101.992447] alpha data-mesher[210]: time=2026-08-31T09:55:28.045Z level=INFO msg="received file request" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file
container-test-run-data-mesher> alpha # [7209101.993508] alpha data-mesher[210]: time=2026-08-31T09:55:28.046Z level=INFO msg="file transfer complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file
container-test-run-data-mesher> alpha # [7209101.993603] alpha data-mesher[210]: time=2026-08-31T09:55:28.046Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> alpha # [7209101.993603] alpha data-mesher[210]: time=2026-08-31T09:55:28.046Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s
container-test-run-data-mesher> alpha # [7209101.993727] alpha data-mesher[210]: time=2026-08-31T09:55:28.046Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [7209101.993814] alpha data-mesher[210]: time=2026-08-31T09:55:28.046Z level=INFO msg="file transfer complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file
container-test-run-data-mesher> beta # [7209101.989430] beta data-mesher[210]: time=2026-08-31T09:55:28.042Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209101.989509] beta data-mesher[210]: time=2026-08-31T09:55:28.042Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_file
container-test-run-data-mesher> beta # [7209101.989509] beta data-mesher[210]: time=2026-08-31T09:55:28.042Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> beta # [7209101.989626] beta data-mesher[210]: time=2026-08-31T09:55:28.042Z level=INFO msg="scheduling file download" name=test_file
container-test-run-data-mesher> beta # [7209101.989626] beta data-mesher[210]: time=2026-08-31T09:55:28.042Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [7209101.989626] beta data-mesher[210]: time=2026-08-31T09:55:28.042Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-31 09:55:23.601 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209101.992966] beta data-mesher[210]: time=2026-08-31T09:55:28.046Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209101.993039] beta data-mesher[210]: time=2026-08-31T09:55:28.046Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209101.993039] beta data-mesher[210]: time=2026-08-31T09:55:28.046Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_file
container-test-run-data-mesher> beta # [7209101.996370] beta data-mesher[210]: time=2026-08-31T09:55:28.049Z level=INFO msg="download complete" name=test_file signed_at="2026-08-31 09:55:23.601 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g written=true elapsed=6.789455ms
container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 5.05 seconds)
container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)
container-test-run-data-mesher> beta: waiting for success: data-mesher file delete test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key
container-test-run-data-mesher> beta: (finished: waiting for success: data-mesher file delete test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.03 seconds)
container-test-run-data-mesher> alpha: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> beta # [7209102.650417] beta data-mesher[210]: time=2026-08-31T09:55:28.703Z level=INFO msg=http_request uri=/files/test_file status=204
container-test-run-data-mesher> gamma # [7209106.991622] gamma data-mesher[210]: time=2026-08-31T09:55:33.044Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [7209106.991979] gamma data-mesher[210]: time=2026-08-31T09:55:33.044Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s
container-test-run-data-mesher> gamma # [7209106.992556] gamma data-mesher[210]: time=2026-08-31T09:55:33.045Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> gamma # [7209106.994421] gamma data-mesher[210]: time=2026-08-31T09:55:33.047Z level=DEBUG msg="imported tombstone" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 name=test_file written=true
container-test-run-data-mesher> gamma # [7209106.994485] gamma data-mesher[210]: time=2026-08-31T09:55:33.047Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s
container-test-run-data-mesher> gamma # [7209106.994485] gamma data-mesher[210]: time=2026-08-31T09:55:33.047Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209106.994485] gamma data-mesher[210]: time=2026-08-31T09:55:33.047Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209106.994551] gamma data-mesher[210]: time=2026-08-31T09:55:33.047Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [7209106.990519] alpha data-mesher[210]: time=2026-08-31T09:55:33.043Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> alpha # [7209106.990519] alpha data-mesher[210]: time=2026-08-31T09:55:33.043Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> alpha # [7209106.993279] alpha data-mesher[210]: time=2026-08-31T09:55:33.046Z level=DEBUG msg="imported tombstone" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 name=test_file written=true
container-test-run-data-mesher> alpha # [7209106.994111] alpha data-mesher[210]: time=2026-08-31T09:55:33.047Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [7209106.994111] alpha data-mesher[210]: time=2026-08-31T09:55:33.047Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> alpha # [7209106.994794] alpha data-mesher[210]: time=2026-08-31T09:55:33.047Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209106.994886] alpha data-mesher[210]: time=2026-08-31T09:55:33.047Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> alpha # [7209106.994886] alpha data-mesher[210]: time=2026-08-31T09:55:33.048Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [7209106.989689] beta data-mesher[210]: time=2026-08-31T09:55:33.042Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [7209106.990077] beta data-mesher[210]: time=2026-08-31T09:55:33.042Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> beta # [7209106.992360] beta data-mesher[210]: time=2026-08-31T09:55:33.045Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> beta # [7209106.992360] beta data-mesher[210]: time=2026-08-31T09:55:33.045Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> beta # [7209106.993636] beta data-mesher[210]: time=2026-08-31T09:55:33.046Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209106.993819] beta data-mesher[210]: time=2026-08-31T09:55:33.046Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> beta # [7209106.993819] beta data-mesher[210]: time=2026-08-31T09:55:33.046Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.04 seconds)
container-test-run-data-mesher> beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)
container-test-run-data-mesher> gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)
container-test-run-data-mesher> alpha: must succeed: cat /nix/store/sqi97m2l87iwib6dv6y6p010s37vklzv-per-machine-alpha-data-mesher-node-identity_identity.pub
container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/sqi97m2l87iwib6dv6y6p010s37vklzv-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.01 seconds)
container-test-run-data-mesher> alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file
container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.01 seconds)
container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert
container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.03 seconds)
container-test-run-data-mesher> alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s, in 0.01 seconds)
container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> alpha # [7209107.756115] alpha data-mesher[210]: time=2026-08-31T09:55:33.809Z level=INFO msg=http_request uri=/files/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s status=204
container-test-run-data-mesher> gamma # [7209111.995512] gamma data-mesher[210]: time=2026-08-31T09:55:38.048Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [7209111.995512] gamma data-mesher[210]: time=2026-08-31T09:55:38.048Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> gamma # [7209111.995512] gamma data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209111.995512] gamma data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209111.995972] gamma data-mesher[210]: time=2026-08-31T09:55:38.048Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> gamma # [7209111.995972] gamma data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="scheduling file download" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> gamma # [7209111.995972] gamma data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="downloading file" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 09:55:33.806 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209111.996243] gamma data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> gamma # [7209111.996730] gamma data-mesher[210]: time=2026-08-31T09:55:38.049Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> gamma # [7209111.996782] gamma data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> gamma # [7209111.996805] gamma data-mesher[210]: time=2026-08-31T09:55:38.049Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [7209111.998396] gamma data-mesher[210]: time=2026-08-31T09:55:38.051Z level=INFO msg="download complete" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 09:55:33.806 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g written=true elapsed=2.613356ms
container-test-run-data-mesher> alpha # [7209111.994937] alpha data-mesher[210]: time=2026-08-31T09:55:38.048Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [7209111.994937] alpha data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> alpha # [7209111.995338] alpha data-mesher[210]: time=2026-08-31T09:55:38.048Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> alpha # [7209111.995338] alpha data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498
container-test-run-data-mesher> alpha # [7209111.995646] alpha data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209111.995646] alpha data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209111.995847] alpha data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r
container-test-run-data-mesher> alpha # [7209111.995916] alpha data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s
container-test-run-data-mesher> alpha # [7209111.995916] alpha data-mesher[210]: time=2026-08-31T09:55:38.049Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [7209111.996087] alpha data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="received file request" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> alpha # [7209111.996360] alpha data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="file transfer complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> alpha # [7209111.997181] alpha data-mesher[210]: time=2026-08-31T09:55:38.050Z level=INFO msg="received file request" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> alpha # [7209111.997612] alpha data-mesher[210]: time=2026-08-31T09:55:38.050Z level=INFO msg="file transfer complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> beta # [7209111.994398] beta data-mesher[210]: time=2026-08-31T09:55:38.047Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [7209111.995144] beta data-mesher[210]: time=2026-08-31T09:55:38.047Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> beta # [7209111.995381] beta data-mesher[210]: time=2026-08-31T09:55:38.048Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209111.995995] beta data-mesher[210]: time=2026-08-31T09:55:38.049Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> beta # [7209111.996097] beta data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s
container-test-run-data-mesher> beta # [7209111.996097] beta data-mesher[210]: time=2026-08-31T09:55:38.049Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [7209111.996196] beta data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="scheduling file download" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> beta # [7209111.996277] beta data-mesher[210]: time=2026-08-31T09:55:38.049Z level=INFO msg="downloading file" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 09:55:33.806 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g
container-test-run-data-mesher> beta # [7209111.999181] beta data-mesher[210]: time=2026-08-31T09:55:38.052Z level=INFO msg="download complete" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 09:55:33.806 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g written=true elapsed=2.8948ms
container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s, in 5.04 seconds)
container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s, in 0.01 seconds)
container-test-run-data-mesher> alpha: must succeed: echo -n 'no_cert' > /tmp/ns_nocert
container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'no_cert' > /tmp/ns_nocert, in 0.01 seconds)
container-test-run-data-mesher> alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub
container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s= is not authorized for this file test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s
container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub, in 0.03 seconds)
container-test-run-data-mesher> (finished: run the VM test script, in 30.05 seconds)
container-test-run-data-mesher> test script finished in 30.10s
container-test-run-data-mesher> cleanup
container-test-run-data-mesher> kill NspawnMachine (pid 59)
container-test-run-data-mesher> alpha # [7209112.850592] alpha data-mesher[210]: time=2026-08-31T09:55:38.903Z level=INFO msg=http_request uri=/files/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s status=403
container-test-run-data-mesher> alpha # [7209112.899861] alpha systemd-networkd[204]: eth1: Link DOWN
container-test-run-data-mesher> alpha # [7209112.899876] alpha systemd-networkd[204]: eth1: Lost carrier
container-test-run-data-mesher> alpha # [7209113.120879] alpha systemd-networkd[204]: eth1: Lost IPv6LL address fe80::7882:45ff:fef4:cc3b.
container-test-run-data-mesher> kill NspawnMachine (pid 53)
container-test-run-data-mesher> kill NspawnMachine (pid 54)
container-test-run-data-mesher> Container alpha terminated by signal KILL.
container-test-run-data-mesher> Container beta terminated by signal KILL.
container-test-run-data-mesher> Container gamma terminated by signal KILL.
container-test-run-data-mesher> (finished: cleanup, in 0.79 seconds)

post-build step Upload to niks3: ok
time=2026-08-31T09:55:40.192Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)"
time=2026-08-31T09:55:41.115Z level=INFO msg="Uploading 1 narinfos"
time=2026-08-31T09:55:41.775Z level=INFO msg="Upload complete. (1.648s)"