these 53 derivations will be built: /nix/store/08clgbdjv39af357is5ysrnmgagg1d3i-dm.toml.drv /nix/store/gfl7r3hjf5cjfwj1pv94sy781kzfp7zg-decrypt-age-secrets.drv /nix/store/lj6f4xkcx3zpirvz2zj09ga5cbcnpxvw-users-groups.json.drv /nix/store/d8vwaxr6qgqjgmi1756vl3w4zfp0injn-dry-activate.drv /nix/store/hg57hfj0p8rixz49kxdgqf40dmlh9slg-system-path.drv /nix/store/rk4irqfsg9n9xsqnzx0zpp16cyhg4b6i-dm.toml.drv /nix/store/5xdfy9d7i803il3z4rrwlx308vmbh7qd-X-Restart-Triggers-data-mesher.drv /nix/store/ib1yv29njhpvlinkjx6f1rfbb0b7mcxc-unit-data-mesher.service.drv /nix/store/sm5hm41x31p3m9y15g3lahd4zpmkbxvk-unit-firewall.service.drv /nix/store/a4sn96r44hd4mwb5qr99magz1dsljlcw-dbus-1.drv /nix/store/jp5hdhwdlf162422qym9gydqggl3481j-X-Restart-Triggers-dbus-broker.drv /nix/store/xvvkndys60x7pmvyvpvacn9y2n1fbj86-unit-dbus-broker.service.drv /nix/store/7r9h4n5p2mb3x2r57i7rharq6fg32xbf-system-units.drv /nix/store/fbxw8rswmjm3hkmkb591rf4p30pfqqii-vars-check-data-mesher.drv /nix/store/42g2qfq41ffjf24kz8r8hsy8njnzcz7f-extra-hosts.drv /nix/store/ai1al4my03z202qjrwd61cavmwkwsgbs-string-hosts.drv /nix/store/hkilqnqaay028nabf1w3wi5fnzmnn967-hosts.drv /nix/store/ad7991kkf56z5lxwhnpva5fy86i5xclr-unit-dbus-broker.service.drv /nix/store/l7qw2c8k8mgirhkhb2yl61xr1nnsy09v-user-units.drv /nix/store/xq0h49xns9ma0c2w1ja6l54yvfgcm8ic-etc-hostname.drv /nix/store/pa3b9sz81frg2sszn2kmmwskwdh973fy-etc.drv /nix/store/jxry12lhw3vb4ilp2qwlvwhpchwqplhk-activate.drv /nix/store/1a46zlm93i4znanp1laggllh3zj0q6gi-nixos-system-alpha-test.drv /nix/store/cisgcdwy9lqz65kzvs57ijjj8x2rxd3q-decrypt-age-secrets.drv /nix/store/nd46awzz5x8f3jib8f6pp2i5d5bsyrmc-dry-activate.drv /nix/store/d91z2ry908ymq468g8qfpbn30ifa583a-X-Restart-Triggers-data-mesher.drv /nix/store/drw2bl8fix80y4fq9vfziw4b38ppml4s-unit-data-mesher.service.drv /nix/store/s226in376jghp9i61wisr0gnbmv5j8l0-system-units.drv /nix/store/sz1dnpmnw7mh125bfrq3ra6fzhslvlya-string-hosts.drv /nix/store/wlag9jhl0vkhpa5c7wq5zvrr4hc7zrp7-hosts.drv /nix/store/zbs1rk6wnics7a8cwzr0xfam8n24qhfd-etc-hostname.drv /nix/store/z38ck7sg3yx8jryrr565mk3dfvvmqikx-etc.drv /nix/store/z76sga4vwnzmydydjndyz0kqgl7kh96g-activate.drv /nix/store/hajr7cxxhmv1m0sxvfc5g5x0qiyffzs2-nixos-system-beta-test.drv /nix/store/60m11r9gzb64nqjlwmaqaj6wk7n9092c-run-beta-nspawn.drv /nix/store/7jni5m6wxjs6q9p6jgdvz4mlcyp7yina-dm.toml.drv /nix/store/hnkizsm5pp43p7fm1vq55m072cy7hgag-decrypt-age-secrets.drv /nix/store/giq07wg234jsdqhp3wlpmcn06hci1pc0-X-Restart-Triggers-data-mesher.drv /nix/store/j7lywm82xnx94kvwsbgnnkj2pl9ygabr-unit-data-mesher.service.drv /nix/store/c5ymkm23zk7bac8r0x9sqq862nvpi01r-system-units.drv /nix/store/cajf7vybihsxdfk79hz0m583b8r1xa8a-etc-hostname.drv /nix/store/gizss1bfqarsmi4sl8nbbpsjjikf24mb-string-hosts.drv /nix/store/wc3rw48h30xvn017zbf4ysqraxb64n8i-hosts.drv /nix/store/lgfg9k6l38kz2a38jqzvrzgnd5nr78lh-etc.drv /nix/store/bj401sjmsgm5hj88mn834smaijc2cjya-activate.drv /nix/store/gipyi115fd76fybqdwg13xfr8priv33j-dry-activate.drv /nix/store/c2fz6vqjghn3q5l7ja92bli07sqi8wlf-nixos-system-gamma-test.drv /nix/store/pgapvh2d3xan0k5sp4g4rd8ga988hmnk-run-gamma-nspawn.drv /nix/store/r0lyn4a4jbgvcbhyzqfsk3lz2alvdcy1-run-alpha-nspawn.drv /nix/store/x1f5nll6d8bharklyvg72xabb94rvxp7-test-script.drv /nix/store/hdkmvchh9kk9cfq33p1n967pkqgfdq5j-driverConfiguration.json.drv /nix/store/xpknklkk7fjr5k93hniyll42nkl27ckp-nixos-test-driver-data-mesher.drv /nix/store/vbp4ygvipv804rlfq71l9zq6ln1nvkkb-container-test-run-data-mesher.drv building '/nix/store/x1f5nll6d8bharklyvg72xabb94rvxp7-test-script.drv' building '/nix/store/hg57hfj0p8rixz49kxdgqf40dmlh9slg-system-path.drv' building '/nix/store/cajf7vybihsxdfk79hz0m583b8r1xa8a-etc-hostname.drv' building '/nix/store/xq0h49xns9ma0c2w1ja6l54yvfgcm8ic-etc-hostname.drv' building '/nix/store/zbs1rk6wnics7a8cwzr0xfam8n24qhfd-etc-hostname.drv' building '/nix/store/42g2qfq41ffjf24kz8r8hsy8njnzcz7f-extra-hosts.drv' building '/nix/store/ai1al4my03z202qjrwd61cavmwkwsgbs-string-hosts.drv' building '/nix/store/gizss1bfqarsmi4sl8nbbpsjjikf24mb-string-hosts.drv' building '/nix/store/sz1dnpmnw7mh125bfrq3ra6fzhslvlya-string-hosts.drv' system-path> structuredAttrs is enabled system-path> created 1723 symlinks in user environment building '/nix/store/hkilqnqaay028nabf1w3wi5fnzmnn967-hosts.drv' building '/nix/store/wc3rw48h30xvn017zbf4ysqraxb64n8i-hosts.drv' building '/nix/store/wlag9jhl0vkhpa5c7wq5zvrr4hc7zrp7-hosts.drv' building '/nix/store/fbxw8rswmjm3hkmkb591rf4p30pfqqii-vars-check-data-mesher.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/08clgbdjv39af357is5ysrnmgagg1d3i-dm.toml.drv' building '/nix/store/7jni5m6wxjs6q9p6jgdvz4mlcyp7yina-dm.toml.drv' building '/nix/store/rk4irqfsg9n9xsqnzx0zpp16cyhg4b6i-dm.toml.drv' building '/nix/store/lj6f4xkcx3zpirvz2zj09ga5cbcnpxvw-users-groups.json.drv' dm.toml> structuredAttrs is enabled dm.toml> structuredAttrs is enabled dm.toml> structuredAttrs is enabled building '/nix/store/a4sn96r44hd4mwb5qr99magz1dsljlcw-dbus-1.drv' building '/nix/store/5xdfy9d7i803il3z4rrwlx308vmbh7qd-X-Restart-Triggers-data-mesher.drv' building '/nix/store/d91z2ry908ymq468g8qfpbn30ifa583a-X-Restart-Triggers-data-mesher.drv' building '/nix/store/giq07wg234jsdqhp3wlpmcn06hci1pc0-X-Restart-Triggers-data-mesher.drv' building '/nix/store/jp5hdhwdlf162422qym9gydqggl3481j-X-Restart-Triggers-dbus-broker.drv' building '/nix/store/cisgcdwy9lqz65kzvs57ijjj8x2rxd3q-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/gfl7r3hjf5cjfwj1pv94sy781kzfp7zg-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/hnkizsm5pp43p7fm1vq55m072cy7hgag-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/drw2bl8fix80y4fq9vfziw4b38ppml4s-unit-data-mesher.service.drv' building '/nix/store/ib1yv29njhpvlinkjx6f1rfbb0b7mcxc-unit-data-mesher.service.drv' building '/nix/store/j7lywm82xnx94kvwsbgnnkj2pl9ygabr-unit-data-mesher.service.drv' building '/nix/store/ad7991kkf56z5lxwhnpva5fy86i5xclr-unit-dbus-broker.service.drv' building '/nix/store/xvvkndys60x7pmvyvpvacn9y2n1fbj86-unit-dbus-broker.service.drv' unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/l7qw2c8k8mgirhkhb2yl61xr1nnsy09v-user-units.drv' unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/7r9h4n5p2mb3x2r57i7rharq6fg32xbf-system-units.drv' building '/nix/store/c5ymkm23zk7bac8r0x9sqq862nvpi01r-system-units.drv' building '/nix/store/s226in376jghp9i61wisr0gnbmv5j8l0-system-units.drv' building '/nix/store/fbxw8rswmjm3hkmkb591rf4p30pfqqii-vars-check-data-mesher.drv' vars-check-data-mesher> Running vars check using Nix-based executor... vars-check-data-mesher> ✓ All vars checks completed successfully building '/nix/store/lgfg9k6l38kz2a38jqzvrzgnd5nr78lh-etc.drv' building '/nix/store/pa3b9sz81frg2sszn2kmmwskwdh973fy-etc.drv' building '/nix/store/z38ck7sg3yx8jryrr565mk3dfvvmqikx-etc.drv' building '/nix/store/cisgcdwy9lqz65kzvs57ijjj8x2rxd3q-decrypt-age-secrets.drv' building '/nix/store/nd46awzz5x8f3jib8f6pp2i5d5bsyrmc-dry-activate.drv' building '/nix/store/gfl7r3hjf5cjfwj1pv94sy781kzfp7zg-decrypt-age-secrets.drv' building '/nix/store/hnkizsm5pp43p7fm1vq55m072cy7hgag-decrypt-age-secrets.drv' building '/nix/store/d8vwaxr6qgqjgmi1756vl3w4zfp0injn-dry-activate.drv' building '/nix/store/bj401sjmsgm5hj88mn834smaijc2cjya-activate.drv' building '/nix/store/gipyi115fd76fybqdwg13xfr8priv33j-dry-activate.drv' building '/nix/store/jxry12lhw3vb4ilp2qwlvwhpchwqplhk-activate.drv' building '/nix/store/z76sga4vwnzmydydjndyz0kqgl7kh96g-activate.drv' building '/nix/store/c2fz6vqjghn3q5l7ja92bli07sqi8wlf-nixos-system-gamma-test.drv' building '/nix/store/1a46zlm93i4znanp1laggllh3zj0q6gi-nixos-system-alpha-test.drv' building '/nix/store/hajr7cxxhmv1m0sxvfc5g5x0qiyffzs2-nixos-system-beta-test.drv' nixos-system-alpha-test> structuredAttrs is enabled nixos-system-gamma-test> structuredAttrs is enabled building '/nix/store/r0lyn4a4jbgvcbhyzqfsk3lz2alvdcy1-run-alpha-nspawn.drv' building '/nix/store/pgapvh2d3xan0k5sp4g4rd8ga988hmnk-run-gamma-nspawn.drv' nixos-system-beta-test> structuredAttrs is enabled building '/nix/store/60m11r9gzb64nqjlwmaqaj6wk7n9092c-run-beta-nspawn.drv' building '/nix/store/hdkmvchh9kk9cfq33p1n967pkqgfdq5j-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/xpknklkk7fjr5k93hniyll42nkl27ckp-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! building '/nix/store/vbp4ygvipv804rlfq71l9zq6ln1nvkkb-container-test-run-data-mesher.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/vbp4ygvipv804rlfq71l9zq6ln1nvkkb-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> alpha: systemd-nspawn running (pid 53) container-test-run-data-mesher> beta: systemd-nspawn running (pid 54) container-test-run-data-mesher> gamma: systemd-nspawn running (pid 55) 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: Waiting for journal at /build/vm-state-alpha/var/log/journal... container-test-run-data-mesher> (finished: start all VMs, in 0.00 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(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> 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> 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> 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 gamma on /build/vm-state-gamma. container-test-run-data-mesher> ░ Spawning container beta on /build/vm-state-beta. container-test-run-data-mesher> gamma # [8085815.267545] gamma systemd-journald[87]: Journal started container-test-run-data-mesher> alpha # [8085815.272542] alpha systemd-journald[87]: Journal started container-test-run-data-mesher> gamma # [8085815.267593] gamma systemd-journald[87]: Runtime Journal (/run/log/journal/c599b5d5374b4ec0b30db536201e76ef) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> alpha # [8085815.272581] alpha systemd-journald[87]: Runtime Journal (/run/log/journal/8a0aec05a04f47fb95f9b8c8ac8bbfe4) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> gamma # [8085815.268417] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [8085815.274755] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> gamma # [8085815.274944] gamma systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> alpha # [8085815.279720] alpha systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> gamma # [8085815.275500] gamma systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> alpha # [8085815.282057] alpha systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> gamma # [8085815.275905] gamma systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> alpha # [8085815.283116] alpha systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> gamma # [8085815.282379] gamma systemd-journald[87]: Time spent on flushing to /var/log/journal/c599b5d5374b4ec0b30db536201e76ef is 1.181ms for 6 entries. container-test-run-data-mesher> alpha # [8085815.286091] alpha systemd-journald[87]: Time spent on flushing to /var/log/journal/8a0aec05a04f47fb95f9b8c8ac8bbfe4 is 2.088ms for 6 entries. container-test-run-data-mesher> gamma # [8085815.282379] gamma systemd-journald[87]: System Journal (/var/log/journal/c599b5d5374b4ec0b30db536201e76ef) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [8085815.286091] alpha systemd-journald[87]: System Journal (/var/log/journal/8a0aec05a04f47fb95f9b8c8ac8bbfe4) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> gamma # [8085815.286774] gamma systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> alpha # [8085815.296526] alpha systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> gamma # [8085815.287681] gamma systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> beta # [8085815.262765] beta systemd-journald[87]: Journal started container-test-run-data-mesher> gamma # [8085815.287843] gamma systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [8085815.296652] alpha systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> gamma # [8085815.288561] gamma systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> alpha # [8085815.296724] alpha systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> gamma # [8085815.288604] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [8085815.289348] gamma systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> gamma # [8085815.289373] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> gamma # [8085815.303908] gamma systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [8085815.262812] beta systemd-journald[87]: Runtime Journal (/run/log/journal/fca6c7a48944473c935cd7585f3d449f) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> gamma # [8085815.304758] gamma systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> beta # [8085815.269360] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [8085815.297345] alpha systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> beta # [8085815.276386] beta systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> gamma # [8085815.322505] gamma systemd-tmpfiles[140]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> beta # [8085815.276851] beta systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> gamma # [8085815.322717] gamma systemd-tmpfiles[140]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [8085815.297378] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [8085815.277464] beta systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> gamma # [8085815.322854] gamma systemd-tmpfiles[140]: fchmod() of /var/log/journal/c599b5d5374b4ec0b30db536201e76ef failed: Operation not permitted container-test-run-data-mesher> beta # [8085815.284849] beta systemd-journald[87]: Time spent on flushing to /var/log/journal/fca6c7a48944473c935cd7585f3d449f is 2.903ms for 6 entries. container-test-run-data-mesher> alpha # [8085815.297949] alpha systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> gamma # [8085815.323071] gamma systemd-tmpfiles[140]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [8085815.284849] beta systemd-journald[87]: System Journal (/var/log/journal/fca6c7a48944473c935cd7585f3d449f) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> gamma # [8085815.327892] gamma systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> beta # [8085815.291808] beta systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> alpha # [8085815.297971] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> beta # [8085815.292414] beta systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [8085815.309684] alpha systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [8085815.292490] beta systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> gamma # [8085815.329042] gamma systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> alpha # [8085815.310956] alpha systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> gamma # [8085815.330204] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> beta # [8085815.293195] beta systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> gamma # [8085815.334704] gamma systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> alpha # [8085815.329458] alpha systemd-tmpfiles[137]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [8085815.340139] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> beta # [8085815.293233] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [8085815.345351] gamma systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> beta # [8085815.293787] beta systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> alpha # [8085815.329662] alpha systemd-tmpfiles[137]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [8085815.293808] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> alpha # [8085815.330192] alpha systemd-tmpfiles[137]: fchmod() of /var/log/journal/8a0aec05a04f47fb95f9b8c8ac8bbfe4 failed: Operation not permitted container-test-run-data-mesher> gamma # [8085815.346302] gamma systemd[1]: Starting Update is Completed... container-test-run-data-mesher> beta # [8085815.309582] beta systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> gamma # [8085815.352314] gamma systemd[1]: Finished Update is Completed. container-test-run-data-mesher> alpha # [8085815.330468] alpha systemd-tmpfiles[137]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [8085815.310427] beta systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> gamma # [8085815.376373] gamma systemd[1]: Finished Firewall. container-test-run-data-mesher> alpha # [8085815.332946] alpha systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> beta # [8085815.329716] beta systemd-tmpfiles[141]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [8085815.333231] alpha systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> beta # [8085815.330217] beta systemd-tmpfiles[141]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [8085815.335208] alpha systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [8085815.376488] gamma systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> beta # [8085815.330424] beta systemd-tmpfiles[141]: fchmod() of /var/log/journal/fca6c7a48944473c935cd7585f3d449f failed: Operation not permitted container-test-run-data-mesher> alpha # [8085815.336069] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> gamma # [8085815.376652] gamma systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [8085815.346070] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> beta # [8085815.330654] beta systemd-tmpfiles[141]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [8085815.352189] alpha systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [8085815.379104] gamma systemd[1]: Starting Network Management... container-test-run-data-mesher> alpha # [8085815.352954] alpha systemd[1]: Starting Update is Completed... container-test-run-data-mesher> beta # [8085815.332139] beta systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> beta # [8085815.333708] beta systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> alpha # [8085815.358816] alpha systemd[1]: Finished Update is Completed. container-test-run-data-mesher> beta # [8085815.334511] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> alpha # [8085815.404209] alpha systemd[1]: Finished Firewall. container-test-run-data-mesher> beta # [8085815.336011] beta systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> beta # [8085815.341953] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> beta # [8085815.351171] beta systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> beta # [8085815.351749] beta systemd[1]: Starting Update is Completed... container-test-run-data-mesher> beta # [8085815.356770] beta systemd[1]: Finished Update is Completed. container-test-run-data-mesher> alpha # [8085815.404433] alpha systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> alpha # [8085815.404643] alpha systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [8085815.405641] alpha systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [8085815.404206] beta systemd[1]: Finished Firewall. container-test-run-data-mesher> beta # [8085815.404430] beta systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> beta # [8085815.404644] beta systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> beta # [8085815.405676] beta systemd[1]: Starting Network Management... container-test-run-data-mesher> alpha # [8085815.761236] alpha systemd-networkd[205]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [8085815.761311] alpha systemd-networkd[205]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [8085815.766955] alpha systemd-networkd[205]: /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 # [8085815.767128] alpha systemd-networkd[205]: /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 # [8085815.767197] alpha systemd-networkd[205]: lo: Link UP container-test-run-data-mesher> alpha # [8085815.767200] alpha systemd-networkd[205]: lo: Gained carrier container-test-run-data-mesher> alpha # [8085815.767345] alpha systemd-networkd[205]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> alpha # [8085815.767614] alpha systemd[1]: Started Network Management. container-test-run-data-mesher> alpha # [8085815.767655] alpha systemd-networkd[205]: eth1: Link UP container-test-run-data-mesher> alpha # [8085815.767780] alpha systemd-networkd[205]: eth1: Gained carrier container-test-run-data-mesher> alpha # [8085815.768452] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> alpha # [8085815.795731] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> alpha # [8085815.905290] alpha systemd-resolved[108]: Positive Trust Anchors: container-test-run-data-mesher> alpha # [8085815.905298] alpha systemd-resolved[108]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> alpha # [8085815.905301] alpha systemd-resolved[108]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> alpha # [8085815.905317] alpha systemd-resolved[108]: 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 # [8085815.915668] alpha systemd-resolved[108]: Using system hostname 'alpha'. container-test-run-data-mesher> alpha # [8085815.916572] alpha systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> alpha # [8085815.916642] alpha systemd[1]: Reached target Network. container-test-run-data-mesher> alpha # [8085815.916690] alpha systemd[1]: Reached target System Initialization. container-test-run-data-mesher> alpha # [8085815.916733] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [8085815.916755] alpha systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> alpha # [8085815.916771] alpha systemd[1]: Reached target Timer Units. container-test-run-data-mesher> alpha # [8085815.916875] alpha systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> alpha # [8085815.916965] alpha systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> alpha # [8085815.917068] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> alpha # [8085815.917087] alpha systemd[1]: Reached target Socket Units. container-test-run-data-mesher> alpha # [8085815.917118] alpha systemd[1]: Reached target Basic System. container-test-run-data-mesher> alpha # [8085815.918101] alpha systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> alpha # [8085815.918443] alpha systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> alpha # [8085815.918841] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> alpha # [8085815.919511] alpha systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> alpha # [8085815.959714] alpha systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> alpha # [8085816.021941] alpha nsncd[212]: Sep 02 00:04:33.387 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> alpha # [8085816.021879] alpha systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> alpha # [8085816.021910] alpha systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> alpha # [8085816.021943] alpha systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> gamma # [8085815.778322] gamma systemd-networkd[205]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [8085815.778392] gamma systemd-networkd[205]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [8085815.783259] gamma systemd-networkd[205]: /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 # [8085815.783407] gamma systemd-networkd[205]: /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 # [8085815.783469] gamma systemd-networkd[205]: lo: Link UP container-test-run-data-mesher> gamma # [8085815.783473] gamma systemd-networkd[205]: lo: Gained carrier container-test-run-data-mesher> gamma # [8085815.783587] gamma systemd-networkd[205]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> gamma # [8085815.783798] gamma systemd[1]: Started Network Management. container-test-run-data-mesher> gamma # [8085815.790412] gamma systemd-networkd[205]: eth1: Link UP container-test-run-data-mesher> gamma # [8085815.790435] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> gamma # [8085815.790562] gamma systemd-networkd[205]: eth1: Gained carrier container-test-run-data-mesher> gamma # [8085815.805080] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> gamma # [8085815.905316] gamma systemd-resolved[111]: Positive Trust Anchors: container-test-run-data-mesher> gamma # [8085815.905323] gamma systemd-resolved[111]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> gamma # [8085815.905328] gamma systemd-resolved[111]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> gamma # [8085815.905361] gamma systemd-resolved[111]: 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 # [8085815.916607] gamma systemd-resolved[111]: Using system hostname 'gamma'. container-test-run-data-mesher> gamma # [8085815.917705] gamma systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> gamma # [8085815.917752] gamma systemd[1]: Reached target Network. container-test-run-data-mesher> gamma # [8085815.917788] gamma systemd[1]: Reached target System Initialization. container-test-run-data-mesher> gamma # [8085815.917820] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [8085815.917841] gamma systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> gamma # [8085815.917852] gamma systemd[1]: Reached target Timer Units. container-test-run-data-mesher> gamma # [8085815.917925] gamma systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> gamma # [8085815.917985] gamma systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> gamma # [8085815.918091] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> gamma # [8085815.918109] gamma systemd[1]: Reached target Socket Units. container-test-run-data-mesher> gamma # [8085815.918131] gamma systemd[1]: Reached target Basic System. container-test-run-data-mesher> gamma # [8085815.918935] gamma systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> gamma # [8085815.919631] gamma systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> gamma # [8085815.947245] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> gamma # [8085815.948439] gamma systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> gamma # [8085815.957992] gamma systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> gamma # [8085816.028656] gamma nsncd[212]: Sep 02 00:04:33.394 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [8085816.028720] gamma systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> gamma # [8085816.028778] gamma systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> gamma # [8085816.028819] gamma systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> beta # [8085815.762255] beta systemd-networkd[205]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [8085815.762319] beta systemd-networkd[205]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [8085815.767522] beta systemd-networkd[205]: /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 # [8085815.767704] beta systemd-networkd[205]: /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 # [8085815.767824] beta systemd-networkd[205]: lo: Link UP container-test-run-data-mesher> beta # [8085815.767828] beta systemd-networkd[205]: lo: Gained carrier container-test-run-data-mesher> beta # [8085815.767959] beta systemd-networkd[205]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> beta # [8085815.768206] beta systemd[1]: Started Network Management. container-test-run-data-mesher> beta # [8085815.768256] beta systemd-networkd[205]: eth1: Link UP container-test-run-data-mesher> beta # [8085815.768394] beta systemd-networkd[205]: eth1: Gained carrier container-test-run-data-mesher> beta # [8085815.768788] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> beta # [8085815.794553] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> beta # [8085815.910276] beta systemd-resolved[110]: Positive Trust Anchors: container-test-run-data-mesher> beta # [8085815.910283] beta systemd-resolved[110]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> beta # [8085815.910286] beta systemd-resolved[110]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> beta # [8085815.910301] 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 # [8085815.920690] beta systemd-resolved[110]: Using system hostname 'beta'. container-test-run-data-mesher> beta # [8085815.921511] beta systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> beta # [8085815.921556] beta systemd[1]: Reached target Network. container-test-run-data-mesher> beta # [8085815.921594] beta systemd[1]: Reached target System Initialization. container-test-run-data-mesher> beta # [8085815.921626] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [8085815.921640] beta systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> beta # [8085815.921650] beta systemd[1]: Reached target Timer Units. container-test-run-data-mesher> beta # [8085815.921729] beta systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> beta # [8085815.921810] beta systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> beta # [8085815.921896] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> beta # [8085815.921906] beta systemd[1]: Reached target Socket Units. container-test-run-data-mesher> beta # [8085815.921927] beta systemd[1]: Reached target Basic System. container-test-run-data-mesher> beta # [8085815.947277] beta systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> beta # [8085815.947911] beta systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> beta # [8085815.948456] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> beta # [8085815.949309] beta systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> beta # [8085815.959771] beta systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> beta # [8085816.037728] beta nsncd[212]: Sep 02 00:04:33.403 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> beta # [8085816.037794] beta systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> beta # [8085816.037850] beta systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> beta # [8085816.037897] beta systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> beta # [8085816.049257] beta systemd[1]: Starting User Login Management... container-test-run-data-mesher> beta # [8085816.049944] beta systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> beta # [8085816.055708] beta systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> beta # [8085816.056524] beta systemd[1]: Started Console Getty. container-test-run-data-mesher> beta # [8085816.056551] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> beta # [8085816.056564] beta systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [8085816.084223] beta dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [8085816.084711] beta dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [8085816.084711] beta dbus-broker-launch[213]: Invalid user-name in /nix/store/bihprg36rzal1i9hiclzrgz5rl5ywlls-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> beta # [8085816.085135] beta systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> beta # [8085816.091180] beta dbus-broker-launch[213]: Ready container-test-run-data-mesher> beta # [8085816.253787] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> gamma # [8085816.049517] gamma systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [8085816.050262] gamma systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> gamma # [8085816.057231] gamma systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> gamma # [8085816.058062] gamma systemd[1]: Started Console Getty. container-test-run-data-mesher> alpha # [8085816.022543] alpha systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [8085816.058088] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> alpha # [8085816.022981] alpha systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> gamma # [8085816.058099] gamma systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> alpha # [8085816.054016] alpha systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> gamma # [8085816.097018] gamma dbus-broker-launch[214]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> alpha # [8085816.054630] alpha systemd[1]: Started Console Getty. container-test-run-data-mesher> gamma # [8085816.097547] gamma dbus-broker-launch[214]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> alpha # [8085816.054656] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> gamma # [8085816.097547] gamma dbus-broker-launch[214]: Invalid user-name in /nix/store/bihprg36rzal1i9hiclzrgz5rl5ywlls-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> alpha # [8085816.054670] alpha systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> gamma # [8085816.097879] gamma systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> alpha # [8085816.097009] alpha dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> alpha # [8085816.097526] alpha dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> gamma # [8085816.102415] gamma dbus-broker-launch[214]: Ready container-test-run-data-mesher> alpha # [8085816.097526] alpha dbus-broker-launch[213]: Invalid user-name in /nix/store/bihprg36rzal1i9hiclzrgz5rl5ywlls-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> gamma # [8085816.253967] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> alpha # [8085816.097837] alpha systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> alpha # [8085816.101917] alpha dbus-broker-launch[213]: Ready container-test-run-data-mesher> alpha # [8085816.262671] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> beta # [8085816.301512] beta data-mesher[210]: time=2026-09-02T00:04:33.667Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> alpha # [8085816.322966] alpha data-mesher[210]: time=2026-09-02T00:04:33.688Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [8085816.301828] beta data-mesher[210]: time=2026-09-02T00:04:33.667Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems: [/dns/alpha.clan/tcp/7946]} {12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085816.323320] alpha data-mesher[210]: time=2026-09-02T00:04:33.688Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems: [/dns/alpha.clan/tcp/7946]} {12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085816.301860] beta data-mesher[210]: time=2026-09-02T00:04:33.667Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> alpha # [8085816.323345] alpha data-mesher[210]: time=2026-09-02T00:04:33.689Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> beta # [8085816.378189] beta data-mesher[210]: time=2026-09-02T00:04:33.743Z level=INFO msg="checking file integrity" container-test-run-data-mesher> gamma # [8085816.322928] gamma data-mesher[210]: time=2026-09-02T00:04:33.688Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [8085816.378274] beta data-mesher[210]: time=2026-09-02T00:04:33.743Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> gamma # [8085816.323214] gamma data-mesher[210]: time=2026-09-02T00:04:33.688Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems: [/dns/alpha.clan/tcp/7946]} {12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> alpha # [8085816.378281] alpha data-mesher[210]: time=2026-09-02T00:04:33.743Z level=INFO msg="checking file integrity" container-test-run-data-mesher> beta # [8085816.380588] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="libp2p host created" peer_id=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp 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> alpha # [8085816.378357] alpha data-mesher[210]: time=2026-09-02T00:04:33.744Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> beta # [8085816.380642] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [8085816.380926] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="libp2p host created" peer_id=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems 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 # [8085816.380961] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [8085816.380961] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> beta # [8085816.380642] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> alpha # [8085816.380961] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> beta # [8085816.380642] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> gamma # [8085816.323214] gamma data-mesher[210]: time=2026-09-02T00:04:33.688Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> beta # [8085816.380642] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [8085816.380961] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="starting server" container-test-run-data-mesher> gamma # [8085816.378293] gamma data-mesher[210]: time=2026-09-02T00:04:33.743Z level=INFO msg="checking file integrity" container-test-run-data-mesher> beta # [8085816.380730] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [8085816.378391] gamma data-mesher[210]: time=2026-09-02T00:04:33.744Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> beta # [8085816.380746] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> gamma # [8085816.381333] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="libp2p host created" peer_id=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt 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> beta # [8085816.380772] beta data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> alpha # [8085816.381054] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [8085816.381366] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [8085816.381180] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> gamma # [8085816.381366] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> beta # [8085816.383146] beta data-mesher[210]: time=2026-09-02T00:04:33.748Z level=INFO msg="peer connected" peer_id=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> alpha # [8085816.381265] alpha data-mesher[210]: time=2026-09-02T00:04:33.746Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [8085816.383333] beta data-mesher[210]: time=2026-09-02T00:04:33.749Z level=INFO msg="peer connected" peer_id=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems remote_addr=/ip4/192.168.1.1/tcp/40916 container-test-run-data-mesher> alpha # [8085816.383263] alpha data-mesher[210]: time=2026-09-02T00:04:33.748Z level=INFO msg="peer connected" peer_id=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> gamma # [8085816.381366] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> alpha # [8085816.383958] alpha data-mesher[210]: time=2026-09-02T00:04:33.749Z level=INFO msg="peer connected" peer_id=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> beta # [8085816.383605] beta data-mesher[210]: time=2026-09-02T00:04:33.749Z level=INFO msg="peer connected" peer_id=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> beta # [8085816.398544] beta systemd-logind[229]: New seat seat0. container-test-run-data-mesher> gamma # [8085816.381366] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [8085816.386180] alpha data-mesher[210]: time=2026-09-02T00:04:33.751Z level=INFO msg="peer connected" peer_id=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> gamma # [8085816.381446] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> beta # [8085816.398693] beta systemd[1]: Started User Login Management. container-test-run-data-mesher> alpha # [8085816.387032] alpha data-mesher[210]: time=2026-09-02T00:04:33.752Z level=INFO msg="peer connected" peer_id=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> beta # [8085816.399679] beta systemd[1]: Starting linger-users.service... container-test-run-data-mesher> gamma # [8085816.381484] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> beta # [8085816.426602] beta systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> gamma # [8085816.381501] gamma data-mesher[210]: time=2026-09-02T00:04:33.747Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [8085816.427019] beta systemd[1]: Finished linger-users.service. container-test-run-data-mesher> gamma # [8085816.383414] gamma data-mesher[210]: time=2026-09-02T00:04:33.749Z level=INFO msg="peer connected" peer_id=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> alpha # [8085816.417717] alpha systemd-logind[229]: New seat seat0. container-test-run-data-mesher> gamma # [8085816.385507] gamma data-mesher[210]: time=2026-09-02T00:04:33.751Z level=INFO msg="peer connected" peer_id=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> alpha # [8085816.417816] alpha systemd[1]: Started User Login Management. container-test-run-data-mesher> gamma # [8085816.387239] gamma data-mesher[210]: time=2026-09-02T00:04:33.752Z level=INFO msg="peer connected" peer_id=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems remote_addr=/ip4/192.168.1.1/tcp/34672 container-test-run-data-mesher> alpha # [8085816.421516] alpha systemd[1]: Starting linger-users.service... container-test-run-data-mesher> gamma # [8085816.411461] gamma systemd-logind[229]: New seat seat0. container-test-run-data-mesher> alpha # [8085816.427735] alpha systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> gamma # [8085816.411634] gamma systemd[1]: Started User Login Management. container-test-run-data-mesher> alpha # [8085816.427802] alpha systemd[1]: Finished linger-users.service. container-test-run-data-mesher> gamma # [8085816.421338] gamma systemd[1]: Starting linger-users.service... container-test-run-data-mesher> gamma # [8085816.428600] gamma systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> gamma # [8085816.428660] gamma systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [8085817.149106] beta systemd-networkd[205]: eth1: Gained IPv6LL container-test-run-data-mesher> gamma # [8085817.213092] gamma systemd-networkd[205]: eth1: Gained IPv6LL container-test-run-data-mesher> alpha # [8085817.342094] alpha systemd-networkd[205]: eth1: Gained IPv6LL container-test-run-data-mesher> alpha: still waiting for container 'alpha' to reach ready state... container-test-run-data-mesher> beta # [8085826.381821] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> beta # [8085826.381821] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085826.382536] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="received state sync from peer" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085826.382536] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085826.382536] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085826.382536] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="state exchange complete" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085826.382536] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="server started" container-test-run-data-mesher> beta # [8085826.382536] beta data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> beta # [8085826.382238] beta systemd[1]: Started data mesher daemon. container-test-run-data-mesher> beta # [8085826.382419] beta systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> beta # [8085826.382536] beta systemd[1]: Startup finished in 11.454s. container-test-run-data-mesher> beta # [8085826.383257] beta data-mesher[210]: time=2026-09-02T00:04:43.748Z level=INFO msg="received state sync from peer" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> beta # [8085826.383257] beta data-mesher[210]: time=2026-09-02T00:04:43.748Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> gamma # [8085826.383065] gamma data-mesher[210]: time=2026-09-02T00:04:43.748Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> gamma # [8085826.383065] gamma data-mesher[210]: time=2026-09-02T00:04:43.748Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> gamma # [8085826.383376] gamma data-mesher[210]: time=2026-09-02T00:04:43.749Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> gamma # [8085826.383376] gamma data-mesher[210]: time=2026-09-02T00:04:43.749Z level=INFO msg="state exchange complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> gamma # [8085826.383376] gamma data-mesher[210]: time=2026-09-02T00:04:43.749Z level=INFO msg="server started" container-test-run-data-mesher> gamma # [8085826.383437] gamma data-mesher[210]: time=2026-09-02T00:04:43.749Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [8085826.383476] gamma systemd[1]: Started data mesher daemon. container-test-run-data-mesher> gamma # [8085826.383610] gamma systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> gamma # [8085826.383686] gamma systemd[1]: Startup finished in 11.438s. container-test-run-data-mesher> alpha # [8085826.381434] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> alpha # [8085826.381724] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> alpha # [8085826.381998] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085826.381998] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="state exchange complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> alpha # [8085826.381998] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="received state sync from peer" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085826.381998] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085826.381998] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="server started" container-test-run-data-mesher> alpha # [8085826.382206] alpha data-mesher[210]: time=2026-09-02T00:04:43.747Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> alpha # [8085826.382236] alpha systemd[1]: Started data mesher daemon. container-test-run-data-mesher> alpha # [8085826.382485] alpha systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> alpha # [8085826.382604] alpha systemd[1]: Startup finished in 11.455s. container-test-run-data-mesher> alpha: (finished: waiting for unit data-mesher.service, in 12.15 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.00 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/dh99p5gb229myy49zzqk1q688rj1j0k4-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/dh99p5gb229myy49zzqk1q688rj1j0k4-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.09 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/wsnxjqf86imlxfmxxxf02lp1kvcib7xs-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/wsnxjqf86imlxfmxxxf02lp1kvcib7xs-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.00 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 # [8085826.874571] alpha data-mesher[210]: time=2026-09-02T00:04:44.240Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> beta # [8085831.384118] beta data-mesher[210]: time=2026-09-02T00:04:48.749Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [8085831.384118] beta data-mesher[210]: time=2026-09-02T00:04:48.749Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085831.384719] beta data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085831.384776] beta data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="new file detected" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems name=test_file name=test_file container-test-run-data-mesher> beta # [8085831.384776] beta data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="state exchange complete" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085831.384776] beta data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [8085831.384776] beta data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> beta # [8085831.384864] beta data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-02 00:04:44.158 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085831.391726] beta data-mesher[210]: time=2026-09-02T00:04:48.757Z level=INFO msg="download complete" name=test_file signed_at="2026-09-02 00:04:44.158 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems written=true elapsed=6.916437ms container-test-run-data-mesher> gamma # [8085831.384539] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="received state sync from peer" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> gamma # [8085831.384539] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [8085831.384539] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> gamma # [8085831.384883] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> gamma # [8085831.384883] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="new file detected" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems name=test_file name=test_file container-test-run-data-mesher> gamma # [8085831.384883] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> gamma # [8085831.384883] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-02 00:04:44.158 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> gamma # [8085831.384980] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> gamma # [8085831.384980] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="new file detected" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems name=test_file name=test_file container-test-run-data-mesher> gamma # [8085831.385078] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="state exchange complete" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> gamma # [8085831.385078] gamma data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [8085831.391563] gamma data-mesher[210]: time=2026-09-02T00:04:48.757Z level=INFO msg="download complete" name=test_file signed_at="2026-09-02 00:04:44.158 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems written=true elapsed=6.917718ms container-test-run-data-mesher> alpha # [8085831.384100] alpha data-mesher[210]: time=2026-09-02T00:04:48.749Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [8085831.384518] alpha data-mesher[210]: time=2026-09-02T00:04:48.749Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt timeout=5s container-test-run-data-mesher> alpha # [8085831.384518] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="received state sync from peer" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085831.384518] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085831.384713] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> alpha # [8085831.384713] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="state exchange complete" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt timeout=5s container-test-run-data-mesher> alpha # [8085831.384800] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [8085831.384858] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="received state sync from peer" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> alpha # [8085831.384891] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> alpha # [8085831.384905] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="received file request" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_file container-test-run-data-mesher> alpha # [8085831.385028] alpha data-mesher[210]: time=2026-09-02T00:04:48.750Z level=INFO msg="received file request" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_file container-test-run-data-mesher> alpha # [8085831.386008] alpha data-mesher[210]: time=2026-09-02T00:04:48.751Z level=INFO msg="file transfer complete" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_file container-test-run-data-mesher> alpha # [8085831.386075] alpha data-mesher[210]: time=2026-09-02T00:04:48.751Z level=INFO msg="file transfer complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_file 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.03 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/dh99p5gb229myy49zzqk1q688rj1j0k4-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/dh99p5gb229myy49zzqk1q688rj1j0k4-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.02 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 # [8085831.936175] beta data-mesher[210]: time=2026-09-02T00:04:49.301Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> alpha # [8085836.385309] alpha data-mesher[210]: time=2026-09-02T00:04:53.750Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [8085836.385047] beta data-mesher[210]: time=2026-09-02T00:04:53.750Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [8085836.385309] alpha data-mesher[210]: time=2026-09-02T00:04:53.750Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt timeout=5s container-test-run-data-mesher> beta # [8085836.385047] beta data-mesher[210]: time=2026-09-02T00:04:53.750Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt timeout=5s container-test-run-data-mesher> gamma # [8085836.385343] gamma data-mesher[210]: time=2026-09-02T00:04:53.751Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [8085836.385508] beta data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="received state sync from peer" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> gamma # [8085836.385343] gamma data-mesher[210]: time=2026-09-02T00:04:53.751Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> alpha # [8085836.385763] alpha data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> beta # [8085836.385508] beta data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> alpha # [8085836.385763] alpha data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="state exchange complete" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt timeout=5s container-test-run-data-mesher> beta # [8085836.461529] beta data-mesher[210]: time=2026-09-02T00:04:53.827Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> gamma # [8085836.385834] gamma data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="received state sync from peer" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> beta # [8085836.461587] beta data-mesher[210]: time=2026-09-02T00:04:53.827Z level=INFO msg="state exchange complete" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt timeout=5s container-test-run-data-mesher> gamma # [8085836.385834] gamma data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085836.385763] alpha data-mesher[210]: time=2026-09-02T00:04:53.751Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [8085836.461587] beta data-mesher[210]: time=2026-09-02T00:04:53.827Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [8085836.385834] gamma data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="received state sync from peer" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> gamma # [8085836.385834] gamma data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> gamma # [8085836.385834] gamma data-mesher[210]: time=2026-09-02T00:04:53.751Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> gamma # [8085836.461417] gamma data-mesher[210]: time=2026-09-02T00:04:53.827Z level=DEBUG msg="imported tombstone" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp name=test_file written=true container-test-run-data-mesher> gamma # [8085836.461482] gamma data-mesher[210]: time=2026-09-02T00:04:53.827Z level=DEBUG msg="imported tombstone" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp name=test_file written=false container-test-run-data-mesher> gamma # [8085836.461482] gamma data-mesher[210]: time=2026-09-02T00:04:53.827Z level=INFO msg="state exchange complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> gamma # [8085836.461537] gamma data-mesher[210]: time=2026-09-02T00:04:53.827Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [8085841.386500] beta data-mesher[210]: time=2026-09-02T00:04:58.752Z level=INFO msg="received state sync from peer" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085841.386500] beta data-mesher[210]: time=2026-09-02T00:04:58.752Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085841.462021] beta data-mesher[210]: time=2026-09-02T00:04:58.827Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [8085841.462121] beta data-mesher[210]: time=2026-09-02T00:04:58.827Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085841.462306] beta data-mesher[210]: time=2026-09-02T00:04:58.827Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085841.462306] beta data-mesher[210]: time=2026-09-02T00:04:58.828Z level=INFO msg="state exchange complete" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085841.462391] beta data-mesher[210]: time=2026-09-02T00:04:58.828Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [8085841.386180] alpha data-mesher[210]: time=2026-09-02T00:04:58.751Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [8085841.386180] alpha data-mesher[210]: time=2026-09-02T00:04:58.751Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> alpha # [8085841.386587] alpha data-mesher[210]: time=2026-09-02T00:04:58.752Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085841.394818] alpha data-mesher[210]: time=2026-09-02T00:04:58.760Z level=DEBUG msg="imported tombstone" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp name=test_file written=true container-test-run-data-mesher> alpha # [8085841.394818] alpha data-mesher[210]: time=2026-09-02T00:04:58.760Z level=INFO msg="state exchange complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> alpha # [8085841.394859] alpha data-mesher[210]: time=2026-09-02T00:04:58.760Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [8085841.462233] alpha data-mesher[210]: time=2026-09-02T00:04:58.827Z level=INFO msg="received state sync from peer" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085841.462233] alpha data-mesher[210]: time=2026-09-02T00:04:58.827Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085841.462439] alpha data-mesher[210]: time=2026-09-02T00:04:58.828Z level=INFO msg="received state sync from peer" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> alpha # [8085841.462439] alpha data-mesher[210]: time=2026-09-02T00:04:58.828Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> gamma # [8085841.462264] gamma data-mesher[210]: time=2026-09-02T00:04:58.827Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [8085841.462264] gamma data-mesher[210]: time=2026-09-02T00:04:58.827Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> gamma # [8085841.462648] gamma data-mesher[210]: time=2026-09-02T00:04:58.828Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> gamma # [8085841.462648] gamma data-mesher[210]: time=2026-09-02T00:04:58.828Z level=INFO msg="state exchange complete" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> gamma # [8085841.462648] gamma data-mesher[210]: time=2026-09-02T00:04:58.828Z 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 10.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.00 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.00 seconds) container-test-run-data-mesher> alpha: must succeed: cat /nix/store/il6s9ifwlm3fl8xc7kp8hmp39q77hm09-per-machine-alpha-data-mesher-node-identity_identity.pub container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/il6s9ifwlm3fl8xc7kp8hmp39q77hm09-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.00 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.00 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/dh99p5gb229myy49zzqk1q688rj1j0k4-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/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/dh99p5gb229myy49zzqk1q688rj1j0k4-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.01 seconds) container-test-run-data-mesher> alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y, in 0.00 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> alpha # [8085841.996871] alpha data-mesher[210]: time=2026-09-02T00:04:59.362Z level=INFO msg=http_request uri=/files/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y status=204 container-test-run-data-mesher> beta # [8085846.395962] beta data-mesher[210]: time=2026-09-02T00:05:03.761Z level=INFO msg="received state sync from peer" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085846.395962] beta data-mesher[210]: time=2026-09-02T00:05:03.761Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085846.397628] beta data-mesher[210]: time=2026-09-02T00:05:03.761Z level=DEBUG msg="new file detected" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems name=test_file name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> beta # [8085846.397628] beta data-mesher[210]: time=2026-09-02T00:05:03.761Z level=INFO msg="scheduling file download" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> beta # [8085846.397628] beta data-mesher[210]: time=2026-09-02T00:05:03.761Z level=INFO msg="downloading file" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y signed_at="2026-09-02 00:04:59.361 +0000 UTC" signed_by="sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB+vVFuxH4Y=" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085846.397845] beta data-mesher[210]: time=2026-09-02T00:05:03.763Z level=INFO msg="download complete" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y signed_at="2026-09-02 00:04:59.361 +0000 UTC" signed_by="sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB+vVFuxH4Y=" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems written=true elapsed=1.639658ms container-test-run-data-mesher> beta # [8085846.462416] beta data-mesher[210]: time=2026-09-02T00:05:03.828Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [8085846.462416] beta data-mesher[210]: time=2026-09-02T00:05:03.828Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085846.462992] beta data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="received state sync from peer" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> beta # [8085846.462992] beta data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="merging remote state" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt container-test-run-data-mesher> beta # [8085846.463101] beta data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="merging remote state" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems container-test-run-data-mesher> beta # [8085846.463181] beta data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="state exchange complete" peer=12D3KooWMgU5CFSNjPSYRcbpUNBPL3CPZJXN7jVfDmcan3Z88Ems timeout=5s container-test-run-data-mesher> beta # [8085846.463206] beta data-mesher[210]: time=2026-09-02T00:05:03.828Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [8085846.463505] beta data-mesher[210]: time=2026-09-02T00:05:03.829Z level=INFO msg="received file request" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> beta # [8085846.464243] beta data-mesher[210]: time=2026-09-02T00:05:03.829Z level=INFO msg="file transfer complete" peer=12D3KooWEnT4u2RMkkNPsjThfEeu28WurbunM9m7EtMnb3hnJENt network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> alpha # [8085846.395660] alpha data-mesher[210]: time=2026-09-02T00:05:03.761Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [8085846.395660] alpha data-mesher[210]: time=2026-09-02T00:05:03.761Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> alpha # [8085846.396212] alpha data-mesher[210]: time=2026-09-02T00:05:03.761Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085846.396252] alpha data-mesher[210]: time=2026-09-02T00:05:03.761Z level=INFO msg="state exchange complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> alpha # [8085846.396252] alpha data-mesher[210]: time=2026-09-02T00:05:03.761Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [8085846.396421] alpha data-mesher[210]: time=2026-09-02T00:05:03.762Z level=INFO msg="received file request" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> alpha # [8085846.397171] alpha data-mesher[210]: time=2026-09-02T00:05:03.762Z level=INFO msg="file transfer complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp network="TyB28VOU+zAGKrst5nvwRxkDjr3X73lwD5rct8cUNhw=" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> alpha # [8085846.462902] alpha data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="received state sync from peer" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> alpha # [8085846.462902] alpha data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> gamma # [8085846.462747] gamma data-mesher[210]: time=2026-09-02T00:05:03.828Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [8085846.462747] gamma data-mesher[210]: time=2026-09-02T00:05:03.828Z level=DEBUG msg="initiating state exchange" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> gamma # [8085846.463182] gamma data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="merging remote state" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> gamma # [8085846.463269] gamma data-mesher[210]: time=2026-09-02T00:05:03.828Z level=DEBUG msg="new file detected" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp name=test_file name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> gamma # [8085846.463269] gamma data-mesher[210]: time=2026-09-02T00:05:03.828Z level=INFO msg="state exchange complete" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp timeout=5s container-test-run-data-mesher> gamma # [8085846.463322] gamma data-mesher[210]: time=2026-09-02T00:05:03.828Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [8085846.463322] gamma data-mesher[210]: time=2026-09-02T00:05:03.829Z level=INFO msg="scheduling file download" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> gamma # [8085846.463360] gamma data-mesher[210]: time=2026-09-02T00:05:03.829Z level=INFO msg="downloading file" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y signed_at="2026-09-02 00:04:59.361 +0000 UTC" signed_by="sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB+vVFuxH4Y=" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp container-test-run-data-mesher> gamma # [8085846.464673] gamma data-mesher[210]: time=2026-09-02T00:05:03.830Z level=INFO msg="download complete" name=test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y signed_at="2026-09-02 00:04:59.361 +0000 UTC" signed_by="sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB+vVFuxH4Y=" peer=12D3KooWEaGqqXhCjWTGXSWsvYfxdydNav7irKGk3njUASxr2cRp written=true elapsed=1.339813ms container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y, in 5.02 seconds) container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y, 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.00 seconds) container-test-run-data-mesher> alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/dh99p5gb229myy49zzqk1q688rj1j0k4-shared-data-mesher-network_network.pub container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB+vVFuxH4Y= is not authorized for this file test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/dh99p5gb229myy49zzqk1q688rj1j0k4-shared-data-mesher-network_network.pub, in 0.01 seconds) container-test-run-data-mesher> (finished: run the VM test script, in 32.42 seconds) container-test-run-data-mesher> test script finished in 32.83s container-test-run-data-mesher> cleanup container-test-run-data-mesher> kill NspawnMachine (pid 53) container-test-run-data-mesher> alpha # [8085847.042634] alpha data-mesher[210]: time=2026-09-02T00:05:04.408Z level=INFO msg=http_request uri=/files/test_ns/sEZFzgMCb4OXCla0YTdaBQr5QDkDZLbQuB-vVFuxH4Y status=403 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> kill NspawnMachine (pid 55) 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.24 seconds) post-build step Upload to niks3: ok time=2026-09-02T00:05:05.945Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)" time=2026-09-02T00:05:06.938Z level=INFO msg="Uploading 1 narinfos" time=2026-09-02T00:05:07.268Z level=INFO msg="Upload complete. (1.855s)"