these 52 derivations will be built: /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/5rhy7kafasbmzci6jpf7q12671frhxi0-dm.toml.drv /nix/store/jmlajzvbzcyqndv3krw1qpmgp6mv597k-X-Restart-Triggers-data-mesher.drv /nix/store/in7jqzx1imam059r3hq41mcq3bnicwyb-unit-data-mesher.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/4shlibsvv19haxlr0z7nw5kb2bzibi0b-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/sgjwi0508wrjcvqngsjicjc52m6zr0mn-etc.drv /nix/store/j3n3b9xqsg04yiv83fdjis0wgd5zjkkm-activate.drv /nix/store/21dw2adkvx4wrxc4xaf254pwgw171a18-nixos-system-alpha-test.drv /nix/store/f9q27l4j422brszpjrpfhfsckykk9ffi-dm.toml.drv /nix/store/c04l7nw0bd4ak0dxbfli7sh46821ah2l-X-Restart-Triggers-data-mesher.drv /nix/store/lr8i4wfcczm0fx6kk9wijk6p5glbgr23-unit-data-mesher.service.drv /nix/store/54dg7xqwrsc7zxcgicj95kbwqammcnfr-system-units.drv /nix/store/sz1dnpmnw7mh125bfrq3ra6fzhslvlya-string-hosts.drv /nix/store/wlag9jhl0vkhpa5c7wq5zvrr4hc7zrp7-hosts.drv /nix/store/zbs1rk6wnics7a8cwzr0xfam8n24qhfd-etc-hostname.drv /nix/store/2skb2ic5q1vippxjva4hlv9cx16h3nam-etc.drv /nix/store/sww1pr828v7qhb98bhcn96m85fxlayhk-test-script.drv /nix/store/cisgcdwy9lqz65kzvs57ijjj8x2rxd3q-decrypt-age-secrets.drv /nix/store/hxwxasspywzfnlqb0jmh6l2idq0mjjsn-activate.drv /nix/store/nd46awzz5x8f3jib8f6pp2i5d5bsyrmc-dry-activate.drv /nix/store/h9awslfk0kigxmb559rwh5xhgpcm2s45-nixos-system-beta-test.drv /nix/store/ahazd7nw90fh6rq0yb03biyjmwm91z1z-run-beta-nspawn.drv /nix/store/cajf7vybihsxdfk79hz0m583b8r1xa8a-etc-hostname.drv /nix/store/rxg9jwiw7190jjgpkpw6amzgiap06k1g-dm.toml.drv /nix/store/gizss1bfqarsmi4sl8nbbpsjjikf24mb-string-hosts.drv /nix/store/wc3rw48h30xvn017zbf4ysqraxb64n8i-hosts.drv /nix/store/n82hjywkc236rmgf0d789z7ppbrcl6vh-X-Restart-Triggers-data-mesher.drv /nix/store/96dwmbavg1dw6saq9cms20rav077hcr1-unit-data-mesher.service.drv /nix/store/wpd5fidsjdrxssp2b5bj75rjp8cdkk1m-system-units.drv /nix/store/dd2i189gsrmcr9pili0nqqnc77zcwx84-etc.drv /nix/store/hnkizsm5pp43p7fm1vq55m072cy7hgag-decrypt-age-secrets.drv /nix/store/gipyi115fd76fybqdwg13xfr8priv33j-dry-activate.drv /nix/store/vzw98ph61ws9d2l958xbzp52r6qhb3n0-activate.drv /nix/store/g2a1dz141y1bd4vh92j6256vwdhp5zqg-nixos-system-gamma-test.drv /nix/store/clqdgr1ds54bfs9wy45bpiymvp6xwvz7-run-gamma-nspawn.drv /nix/store/gyzcypylgl1b4mm5aal5ilqkfnf125fm-run-alpha-nspawn.drv /nix/store/wvrpwisidd6cds46lb5nn262q47askyq-driverConfiguration.json.drv /nix/store/6qx68s2yr1cispmq8rp8a8ymn6ip7dr8-nixos-test-driver-data-mesher.drv /nix/store/9fmvcgn1pfw4misnhm3fxy0040zrrdmp-container-test-run-data-mesher.drv building '/nix/store/sww1pr828v7qhb98bhcn96m85fxlayhk-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/a4sn96r44hd4mwb5qr99magz1dsljlcw-dbus-1.drv' building '/nix/store/fbxw8rswmjm3hkmkb591rf4p30pfqqii-vars-check-data-mesher.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/5rhy7kafasbmzci6jpf7q12671frhxi0-dm.toml.drv' building '/nix/store/f9q27l4j422brszpjrpfhfsckykk9ffi-dm.toml.drv' building '/nix/store/rxg9jwiw7190jjgpkpw6amzgiap06k1g-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/jp5hdhwdlf162422qym9gydqggl3481j-X-Restart-Triggers-dbus-broker.drv' building '/nix/store/c04l7nw0bd4ak0dxbfli7sh46821ah2l-X-Restart-Triggers-data-mesher.drv' building '/nix/store/jmlajzvbzcyqndv3krw1qpmgp6mv597k-X-Restart-Triggers-data-mesher.drv' building '/nix/store/n82hjywkc236rmgf0d789z7ppbrcl6vh-X-Restart-Triggers-data-mesher.drv' building '/nix/store/ad7991kkf56z5lxwhnpva5fy86i5xclr-unit-dbus-broker.service.drv' building '/nix/store/xvvkndys60x7pmvyvpvacn9y2n1fbj86-unit-dbus-broker.service.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' unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/96dwmbavg1dw6saq9cms20rav077hcr1-unit-data-mesher.service.drv' building '/nix/store/in7jqzx1imam059r3hq41mcq3bnicwyb-unit-data-mesher.service.drv' building '/nix/store/lr8i4wfcczm0fx6kk9wijk6p5glbgr23-unit-data-mesher.service.drv' unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled building '/nix/store/l7qw2c8k8mgirhkhb2yl61xr1nnsy09v-user-units.drv' unit-data-mesher.service> structuredAttrs is enabled building '/nix/store/4shlibsvv19haxlr0z7nw5kb2bzibi0b-system-units.drv' building '/nix/store/wpd5fidsjdrxssp2b5bj75rjp8cdkk1m-system-units.drv' building '/nix/store/54dg7xqwrsc7zxcgicj95kbwqammcnfr-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/2skb2ic5q1vippxjva4hlv9cx16h3nam-etc.drv' building '/nix/store/dd2i189gsrmcr9pili0nqqnc77zcwx84-etc.drv' building '/nix/store/sgjwi0508wrjcvqngsjicjc52m6zr0mn-etc.drv' building '/nix/store/cisgcdwy9lqz65kzvs57ijjj8x2rxd3q-decrypt-age-secrets.drv' building '/nix/store/hxwxasspywzfnlqb0jmh6l2idq0mjjsn-activate.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/h9awslfk0kigxmb559rwh5xhgpcm2s45-nixos-system-beta-test.drv' building '/nix/store/j3n3b9xqsg04yiv83fdjis0wgd5zjkkm-activate.drv' building '/nix/store/vzw98ph61ws9d2l958xbzp52r6qhb3n0-activate.drv' building '/nix/store/d8vwaxr6qgqjgmi1756vl3w4zfp0injn-dry-activate.drv' building '/nix/store/gipyi115fd76fybqdwg13xfr8priv33j-dry-activate.drv' nixos-system-beta-test> structuredAttrs is enabled building '/nix/store/ahazd7nw90fh6rq0yb03biyjmwm91z1z-run-beta-nspawn.drv' building '/nix/store/21dw2adkvx4wrxc4xaf254pwgw171a18-nixos-system-alpha-test.drv' building '/nix/store/g2a1dz141y1bd4vh92j6256vwdhp5zqg-nixos-system-gamma-test.drv' nixos-system-alpha-test> structuredAttrs is enabled nixos-system-gamma-test> structuredAttrs is enabled building '/nix/store/gyzcypylgl1b4mm5aal5ilqkfnf125fm-run-alpha-nspawn.drv' building '/nix/store/clqdgr1ds54bfs9wy45bpiymvp6xwvz7-run-gamma-nspawn.drv' building '/nix/store/wvrpwisidd6cds46lb5nn262q47askyq-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/6qx68s2yr1cispmq8rp8a8ymn6ip7dr8-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/9fmvcgn1pfw4misnhm3fxy0040zrrdmp-container-test-run-data-mesher.drv' container-test-run-data-mesher> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-data-mesher> start all VLans container-test-run-data-mesher> (finished: start all VLans, in 0.00 seconds) container-test-run-data-mesher> container-test-run-data-mesher> Test will time out and terminate in 3600.0 seconds container-test-run-data-mesher> run the VM test script container-test-run-data-mesher> additionally exposed symbols: container-test-run-data-mesher> alpha, beta, gamma, container-test-run-data-mesher> vlan1, container-test-run-data-mesher> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh container-test-run-data-mesher> start all VMs container-test-run-data-mesher> beta: systemd-nspawn running (pid 53) container-test-run-data-mesher> alpha: systemd-nspawn running (pid 52) container-test-run-data-mesher> beta: Waiting for journal at /build/vm-state-beta/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> gamma: systemd-nspawn running (pid 59) container-test-run-data-mesher> gamma: Waiting for journal at /build/vm-state-gamma/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(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> 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> 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> 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 beta on /build/vm-state-beta. container-test-run-data-mesher> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-data-mesher> ░ Spawning container gamma on /build/vm-state-gamma. container-test-run-data-mesher> beta # [2180257.110980] beta systemd-journald[87]: Journal started container-test-run-data-mesher> beta # [2180257.111023] beta systemd-journald[87]: Runtime Journal (/run/log/journal/3a6ed0e1c04c44cdbbe5b8f721e37f77) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> beta # [2180257.111994] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> beta # [2180257.121766] beta systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> alpha # [2180257.123493] alpha systemd-journald[87]: Journal started container-test-run-data-mesher> beta # [2180257.122845] beta systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> alpha # [2180257.123541] alpha systemd-journald[87]: Runtime Journal (/run/log/journal/aae54fd3a0f94f09a434d52b08ac5c4d) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> beta # [2180257.123297] beta systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> alpha # [2180257.134182] alpha systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> beta # [2180257.133047] beta systemd-journald[87]: Time spent on flushing to /var/log/journal/3a6ed0e1c04c44cdbbe5b8f721e37f77 is 1.509ms for 6 entries. container-test-run-data-mesher> alpha # [2180257.134761] alpha systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> beta # [2180257.133047] beta systemd-journald[87]: System Journal (/var/log/journal/3a6ed0e1c04c44cdbbe5b8f721e37f77) is 512B, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [2180257.135338] alpha systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [2180257.139734] beta systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> alpha # [2180257.140926] alpha systemd-journald[87]: Time spent on flushing to /var/log/journal/aae54fd3a0f94f09a434d52b08ac5c4d is 1.867ms for 5 entries. container-test-run-data-mesher> beta # [2180257.139896] beta systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [2180257.140926] alpha systemd-journald[87]: System Journal (/var/log/journal/aae54fd3a0f94f09a434d52b08ac5c4d) is 512B, max 4G, 3.9G free. container-test-run-data-mesher> beta # [2180257.139949] beta systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [2180257.155103] alpha systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> beta # [2180257.140573] beta systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> alpha # [2180257.156491] alpha systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> beta # [2180257.140615] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [2180257.109321] gamma systemd-journald[87]: Journal started container-test-run-data-mesher> alpha # [2180257.156549] alpha systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> gamma # [2180257.109358] gamma systemd-journald[87]: Runtime Journal (/run/log/journal/4cb426c4d7ac4e7f807077d58ba90277) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [2180257.157144] alpha systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> gamma # [2180257.113573] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> beta # [2180257.141255] beta systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> gamma # [2180257.128703] gamma systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> beta # [2180257.141282] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> gamma # [2180257.129203] gamma systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> alpha # [2180257.157180] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [2180257.129639] gamma systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [2180257.162498] beta systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> gamma # [2180257.137957] gamma systemd-journald[87]: Time spent on flushing to /var/log/journal/4cb426c4d7ac4e7f807077d58ba90277 is 1.747ms for 6 entries. container-test-run-data-mesher> beta # [2180257.163291] beta systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> alpha # [2180257.159134] alpha systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> beta # [2180257.178712] beta systemd-tmpfiles[135]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [2180257.137957] gamma systemd-journald[87]: System Journal (/var/log/journal/4cb426c4d7ac4e7f807077d58ba90277) is 512B, max 4G, 3.9G free. container-test-run-data-mesher> beta # [2180257.178918] beta systemd-tmpfiles[135]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [2180257.155160] gamma systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> beta # [2180257.179070] beta systemd-tmpfiles[135]: fchmod() of /var/log/journal/3a6ed0e1c04c44cdbbe5b8f721e37f77 failed: Operation not permitted container-test-run-data-mesher> gamma # [2180257.156554] gamma systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [2180257.159164] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> gamma # [2180257.156609] gamma systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [2180257.167299] alpha systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [2180257.179273] beta systemd-tmpfiles[135]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [2180257.157271] gamma systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> beta # [2180257.180689] beta systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> alpha # [2180257.168525] alpha systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> beta # [2180257.181664] beta systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [2180257.157305] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [2180257.183162] alpha systemd-tmpfiles[136]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [2180257.158064] gamma systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> alpha # [2180257.183371] alpha systemd-tmpfiles[136]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [2180257.158086] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> alpha # [2180257.183512] alpha systemd-tmpfiles[136]: fchmod() of /var/log/journal/aae54fd3a0f94f09a434d52b08ac5c4d failed: Operation not permitted container-test-run-data-mesher> gamma # [2180257.163110] gamma systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> alpha # [2180257.183717] alpha systemd-tmpfiles[136]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [2180257.164205] gamma systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> alpha # [2180257.184802] alpha systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> gamma # [2180257.179911] gamma systemd-tmpfiles[133]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [2180257.185455] alpha systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [2180257.180132] gamma systemd-tmpfiles[133]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [2180257.185888] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> gamma # [2180257.180281] gamma systemd-tmpfiles[133]: fchmod() of /var/log/journal/4cb426c4d7ac4e7f807077d58ba90277 failed: Operation not permitted container-test-run-data-mesher> alpha # [2180257.195196] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> gamma # [2180257.180489] gamma systemd-tmpfiles[133]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [2180257.202318] alpha systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [2180257.181874] gamma systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> alpha # [2180257.203053] alpha systemd[1]: Starting Update is Completed... container-test-run-data-mesher> gamma # [2180257.182587] gamma systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> alpha # [2180257.212968] alpha systemd[1]: Finished Update is Completed. container-test-run-data-mesher> gamma # [2180257.183095] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> alpha # [2180257.267962] alpha systemd[1]: Finished Firewall. container-test-run-data-mesher> gamma # [2180257.192014] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> alpha # [2180257.268128] alpha systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> gamma # [2180257.199569] gamma systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> beta # [2180257.182349] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> gamma # [2180257.200233] gamma systemd[1]: Starting Update is Completed... container-test-run-data-mesher> beta # [2180257.192011] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> gamma # [2180257.207636] gamma systemd[1]: Finished Update is Completed. container-test-run-data-mesher> beta # [2180257.199060] beta systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [2180257.271730] gamma systemd[1]: Finished Firewall. container-test-run-data-mesher> beta # [2180257.199789] beta systemd[1]: Starting Update is Completed... container-test-run-data-mesher> alpha # [2180257.268381] alpha systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> gamma # [2180257.271888] gamma systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> beta # [2180257.207685] beta systemd[1]: Finished Update is Completed. container-test-run-data-mesher> gamma # [2180257.272125] gamma systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> beta # [2180257.267157] beta systemd[1]: Finished Firewall. container-test-run-data-mesher> gamma # [2180257.290481] gamma systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [2180257.267232] beta systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> gamma # [2180257.352984] gamma systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> beta # [2180257.267424] beta systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [2180257.269357] alpha systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [2180257.268210] beta systemd[1]: Starting Network Management... container-test-run-data-mesher> alpha # [2180257.352245] alpha systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> beta # [2180257.352562] beta systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> alpha # [2180257.854613] alpha systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [2180257.854721] alpha systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [2180257.866569] alpha systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> alpha # [2180257.866790] alpha systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> alpha # [2180257.866916] alpha systemd-networkd[204]: lo: Link UP container-test-run-data-mesher> alpha # [2180257.866920] alpha systemd-networkd[204]: lo: Gained carrier container-test-run-data-mesher> alpha # [2180257.867129] alpha systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> alpha # [2180257.867455] alpha systemd[1]: Started Network Management. container-test-run-data-mesher> alpha # [2180257.867505] alpha systemd-networkd[204]: eth1: Link UP container-test-run-data-mesher> alpha # [2180257.867711] alpha systemd-networkd[204]: eth1: Gained carrier container-test-run-data-mesher> alpha # [2180257.868226] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> alpha # [2180257.906371] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> gamma # [2180257.867703] gamma systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [2180257.867795] gamma systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [2180257.877662] gamma systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> gamma # [2180257.877863] gamma systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> gamma # [2180257.877982] gamma systemd-networkd[204]: lo: Link UP container-test-run-data-mesher> gamma # [2180257.877985] gamma systemd-networkd[204]: lo: Gained carrier container-test-run-data-mesher> gamma # [2180257.878188] gamma systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> gamma # [2180257.878511] gamma systemd[1]: Started Network Management. container-test-run-data-mesher> gamma # [2180257.899327] gamma systemd-networkd[204]: eth1: Link UP container-test-run-data-mesher> gamma # [2180257.899351] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> gamma # [2180257.899515] gamma systemd-networkd[204]: eth1: Gained carrier container-test-run-data-mesher> gamma # [2180257.919878] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> gamma # [2180258.104410] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> beta # [2180257.899504] beta systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [2180257.899592] beta systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [2180257.911703] beta systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> beta # [2180257.911911] beta systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> beta # [2180257.912029] beta systemd-networkd[204]: lo: Link UP container-test-run-data-mesher> beta # [2180257.912034] beta systemd-networkd[204]: lo: Gained carrier container-test-run-data-mesher> beta # [2180257.912200] beta systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> beta # [2180257.912509] beta systemd[1]: Started Network Management. container-test-run-data-mesher> beta # [2180257.912723] beta systemd-networkd[204]: eth1: Link UP container-test-run-data-mesher> beta # [2180257.912922] beta systemd-networkd[204]: eth1: Gained carrier container-test-run-data-mesher> beta # [2180257.914225] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> beta # [2180257.938837] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> beta # [2180258.104760] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> alpha # [2180258.110715] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> alpha # [2180258.127863] alpha systemd-resolved[110]: Positive Trust Anchors: container-test-run-data-mesher> alpha # [2180258.127872] alpha systemd-resolved[110]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> alpha # [2180258.127877] alpha systemd-resolved[110]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> alpha # [2180258.127897] alpha 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> alpha # [2180258.144097] alpha systemd-resolved[110]: Using system hostname 'alpha'. container-test-run-data-mesher> alpha # [2180258.145468] alpha systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> alpha # [2180258.145529] alpha systemd[1]: Reached target Network. container-test-run-data-mesher> alpha # [2180258.145597] alpha systemd[1]: Reached target System Initialization. container-test-run-data-mesher> alpha # [2180258.145644] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [2180258.145665] alpha systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> alpha # [2180258.145676] alpha systemd[1]: Reached target Timer Units. container-test-run-data-mesher> alpha # [2180258.145840] alpha systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> alpha # [2180258.145999] alpha systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> alpha # [2180258.146198] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> alpha # [2180258.146213] alpha systemd[1]: Reached target Socket Units. container-test-run-data-mesher> alpha # [2180258.146247] alpha systemd[1]: Reached target Basic System. container-test-run-data-mesher> alpha # [2180258.147350] alpha systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> alpha # [2180258.147915] alpha systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> alpha # [2180258.149088] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> alpha # [2180258.149884] alpha systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> alpha # [2180258.190278] alpha systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> alpha # [2180258.343418] alpha nsncd[212]: Aug 29 15:32:48.566 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> alpha # [2180258.343472] alpha systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> alpha # [2180258.343519] alpha systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> alpha # [2180258.343555] alpha systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> alpha # [2180258.345412] alpha systemd[1]: Starting User Login Management... container-test-run-data-mesher> alpha # [2180258.345875] alpha systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> alpha # [2180258.357518] alpha systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> alpha # [2180258.358335] alpha systemd[1]: Started Console Getty. container-test-run-data-mesher> alpha # [2180258.358368] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> alpha # [2180258.358385] alpha systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [2180258.173365] beta systemd-resolved[106]: Positive Trust Anchors: container-test-run-data-mesher> beta # [2180258.173375] beta systemd-resolved[106]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> beta # [2180258.173378] beta systemd-resolved[106]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> beta # [2180258.173399] beta systemd-resolved[106]: 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 # [2180258.187831] beta systemd-resolved[106]: Using system hostname 'beta'. container-test-run-data-mesher> beta # [2180258.189016] beta systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> beta # [2180258.189076] beta systemd[1]: Reached target Network. container-test-run-data-mesher> beta # [2180258.189118] beta systemd[1]: Reached target System Initialization. container-test-run-data-mesher> beta # [2180258.189154] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [2180258.189173] beta systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> beta # [2180258.189183] beta systemd[1]: Reached target Timer Units. container-test-run-data-mesher> beta # [2180258.189282] beta systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> beta # [2180258.189400] beta systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> beta # [2180258.189496] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> beta # [2180258.189509] beta systemd[1]: Reached target Socket Units. container-test-run-data-mesher> beta # [2180258.189536] beta systemd[1]: Reached target Basic System. container-test-run-data-mesher> beta # [2180258.190672] beta systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> beta # [2180258.191163] beta systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> beta # [2180258.191760] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> beta # [2180258.192877] beta systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> beta # [2180258.205824] beta systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> beta # [2180258.329788] beta nsncd[212]: Aug 29 15:32:48.552 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> beta # [2180258.329890] beta systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> beta # [2180258.329940] beta systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> beta # [2180258.329996] beta systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> beta # [2180258.331034] beta systemd[1]: Starting User Login Management... container-test-run-data-mesher> beta # [2180258.331807] beta systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> beta # [2180258.351846] beta systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> beta # [2180258.353666] beta systemd[1]: Started Console Getty. container-test-run-data-mesher> beta # [2180258.353702] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> beta # [2180258.353720] beta systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [2180258.471743] beta dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [2180258.472669] beta dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [2180258.472669] 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> gamma # [2180258.158544] gamma systemd-resolved[108]: Positive Trust Anchors: container-test-run-data-mesher> gamma # [2180258.158554] gamma systemd-resolved[108]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> gamma # [2180258.158559] gamma systemd-resolved[108]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> gamma # [2180258.158579] gamma 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> gamma # [2180258.173638] gamma systemd-resolved[108]: Using system hostname 'gamma'. container-test-run-data-mesher> gamma # [2180258.174802] gamma systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> gamma # [2180258.174866] gamma systemd[1]: Reached target Network. container-test-run-data-mesher> gamma # [2180258.174910] gamma systemd[1]: Reached target System Initialization. container-test-run-data-mesher> gamma # [2180258.174945] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [2180258.174962] gamma systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> gamma # [2180258.174974] gamma systemd[1]: Reached target Timer Units. container-test-run-data-mesher> gamma # [2180258.175083] gamma systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> gamma # [2180258.175196] gamma systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> gamma # [2180258.175291] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> gamma # [2180258.175302] gamma systemd[1]: Reached target Socket Units. container-test-run-data-mesher> gamma # [2180258.175327] gamma systemd[1]: Reached target Basic System. container-test-run-data-mesher> gamma # [2180258.177328] gamma systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> gamma # [2180258.177988] gamma systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> gamma # [2180258.178642] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> gamma # [2180258.179382] gamma systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> gamma # [2180258.192875] gamma systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> gamma # [2180258.327629] gamma nsncd[212]: Aug 29 15:32:48.550 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [2180258.327789] gamma systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> gamma # [2180258.327851] gamma systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> gamma # [2180258.327976] gamma systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> gamma # [2180258.328975] gamma systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [2180258.329466] gamma systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> gamma # [2180258.350773] gamma systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> gamma # [2180258.351824] gamma systemd[1]: Started Console Getty. container-test-run-data-mesher> gamma # [2180258.351869] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> gamma # [2180258.351881] gamma systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> gamma # [2180258.485410] gamma dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [2180258.473251] beta systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> gamma # [2180258.486835] gamma dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [2180258.478601] beta dbus-broker-launch[213]: Ready container-test-run-data-mesher> gamma # [2180258.486835] gamma 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 # [2180258.487615] gamma systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> gamma # [2180258.492508] gamma dbus-broker-launch[213]: Ready container-test-run-data-mesher> alpha # [2180258.491497] alpha dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> alpha # [2180258.492055] alpha dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> alpha # [2180258.492055] 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> alpha # [2180258.492431] alpha systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> alpha # [2180258.496802] alpha dbus-broker-launch[213]: Ready container-test-run-data-mesher> gamma # [2180258.833354] gamma data-mesher[210]: time=2026-08-29T15:32:49.056Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [2180258.824187] beta data-mesher[210]: time=2026-08-29T15:32:49.046Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> gamma # [2180258.833766] gamma data-mesher[210]: time=2026-08-29T15:32:49.056Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU: [/dns/alpha.clan/tcp/7946]} {12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180258.838713] alpha data-mesher[210]: time=2026-08-29T15:32:49.061Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> gamma # [2180258.833836] gamma data-mesher[210]: time=2026-08-29T15:32:49.056Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> alpha # [2180258.839145] alpha data-mesher[210]: time=2026-08-29T15:32:49.061Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU: [/dns/alpha.clan/tcp/7946]} {12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> beta # [2180258.824594] beta data-mesher[210]: time=2026-08-29T15:32:49.047Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU: [/dns/alpha.clan/tcp/7946]} {12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180258.839145] alpha data-mesher[210]: time=2026-08-29T15:32:49.061Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> gamma # [2180258.834885] gamma data-mesher[210]: time=2026-08-29T15:32:49.057Z level=INFO msg="checking file integrity" container-test-run-data-mesher> alpha # [2180258.840204] alpha data-mesher[210]: time=2026-08-29T15:32:49.063Z level=INFO msg="checking file integrity" container-test-run-data-mesher> gamma # [2180258.835166] gamma data-mesher[210]: time=2026-08-29T15:32:49.058Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> alpha # [2180258.840474] alpha data-mesher[210]: time=2026-08-29T15:32:49.063Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> gamma # [2180258.837808] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="libp2p host created" peer_id=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS 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> alpha # [2180258.842846] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="libp2p host created" peer_id=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU 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> gamma # [2180258.837848] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> beta # [2180258.824594] beta data-mesher[210]: time=2026-08-29T15:32:49.047Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> gamma # [2180258.837848] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> beta # [2180258.827894] beta data-mesher[210]: time=2026-08-29T15:32:49.050Z level=INFO msg="checking file integrity" container-test-run-data-mesher> gamma # [2180258.837848] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> beta # [2180258.828472] beta data-mesher[210]: time=2026-08-29T15:32:49.051Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> gamma # [2180258.837848] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="starting server" container-test-run-data-mesher> beta # [2180258.831204] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="libp2p host created" peer_id=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b 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> gamma # [2180258.838008] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> alpha # [2180258.842921] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> gamma # [2180258.838033] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> alpha # [2180258.842921] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> gamma # [2180258.838033] gamma data-mesher[210]: time=2026-08-29T15:32:49.060Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> alpha # [2180258.842921] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> gamma # [2180258.841702] gamma data-mesher[210]: time=2026-08-29T15:32:49.064Z level=INFO msg="peer connected" peer_id=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> alpha # [2180258.842921] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="starting server" container-test-run-data-mesher> gamma # [2180258.845161] gamma data-mesher[210]: time=2026-08-29T15:32:49.067Z level=INFO msg="peer connected" peer_id=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> alpha # [2180258.843029] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [2180258.957360] gamma systemd-logind[229]: New seat seat0. container-test-run-data-mesher> alpha # [2180258.843054] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> gamma # [2180258.957502] gamma systemd[1]: Started User Login Management. container-test-run-data-mesher> alpha # [2180258.843091] alpha data-mesher[210]: time=2026-08-29T15:32:49.065Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> gamma # [2180258.976496] gamma systemd[1]: Starting linger-users.service... container-test-run-data-mesher> alpha # [2180258.845412] alpha data-mesher[210]: time=2026-08-29T15:32:49.068Z level=INFO msg="peer connected" peer_id=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> gamma # [2180258.987878] gamma systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> alpha # [2180258.845902] alpha data-mesher[210]: time=2026-08-29T15:32:49.068Z level=INFO msg="peer connected" peer_id=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> gamma # [2180258.987986] gamma systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [2180258.831239] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> alpha # [2180258.948937] alpha systemd-logind[225]: New seat seat0. container-test-run-data-mesher> beta # [2180258.831239] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [2180258.949092] alpha systemd[1]: Started User Login Management. container-test-run-data-mesher> beta # [2180258.831239] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> alpha # [2180258.975615] alpha systemd[1]: Starting linger-users.service... container-test-run-data-mesher> beta # [2180258.831239] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [2180258.989212] alpha systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [2180258.831326] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> alpha # [2180258.989301] alpha systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [2180258.831420] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> beta # [2180258.831449] beta data-mesher[210]: time=2026-08-29T15:32:49.054Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [2180258.841940] beta data-mesher[210]: time=2026-08-29T15:32:49.064Z level=INFO msg="peer connected" peer_id=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> beta # [2180258.846181] beta data-mesher[210]: time=2026-08-29T15:32:49.069Z level=INFO msg="peer connected" peer_id=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> beta # [2180258.938144] beta systemd-logind[229]: New seat seat0. container-test-run-data-mesher> beta # [2180258.938274] beta systemd[1]: Started User Login Management. container-test-run-data-mesher> beta # [2180258.939465] beta systemd[1]: Starting linger-users.service... container-test-run-data-mesher> beta # [2180258.986715] beta systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [2180258.986937] beta systemd[1]: Finished linger-users.service. container-test-run-data-mesher> alpha # [2180259.317083] alpha systemd-networkd[204]: eth1: Gained IPv6LL container-test-run-data-mesher> gamma # [2180259.510091] gamma systemd-networkd[204]: eth1: Gained IPv6LL container-test-run-data-mesher> beta # [2180259.701100] beta systemd-networkd[204]: eth1: Gained IPv6LL container-test-run-data-mesher> alpha: still waiting for container 'alpha' to reach ready state... container-test-run-data-mesher> alpha: (finished: waiting for unit data-mesher.service, in 12.65 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/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-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/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-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> ??? 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/y5iz7dc0kz6hbr148qpw2853k0hygs26-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/y5iz7dc0kz6hbr148qpw2853k0hygs26-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 0.01 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> alpha # [2180268.845078] alpha data-mesher[210]: time=2026-08-29T15:32:59.067Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> beta # [2180268.833185] beta data-mesher[210]: time=2026-08-29T15:32:59.055Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> gamma # [2180268.833736] gamma data-mesher[210]: time=2026-08-29T15:32:59.056Z level=INFO msg="received state sync from peer" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180268.845078] alpha data-mesher[210]: time=2026-08-29T15:32:59.067Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> gamma # [2180268.833736] gamma data-mesher[210]: time=2026-08-29T15:32:59.056Z level=INFO msg="merging remote state" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180268.845668] alpha data-mesher[210]: time=2026-08-29T15:32:59.068Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> gamma # [2180268.838195] gamma data-mesher[210]: time=2026-08-29T15:32:59.061Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> alpha # [2180268.845668] alpha data-mesher[210]: time=2026-08-29T15:32:59.068Z level=INFO msg="state exchange complete" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> gamma # [2180268.838229] gamma data-mesher[210]: time=2026-08-29T15:32:59.061Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b timeout=5s container-test-run-data-mesher> alpha # [2180268.845711] alpha data-mesher[210]: time=2026-08-29T15:32:59.068Z level=INFO msg="server started" container-test-run-data-mesher> gamma # [2180268.838616] gamma data-mesher[210]: time=2026-08-29T15:32:59.061Z level=INFO msg="merging remote state" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180268.845779] alpha data-mesher[210]: time=2026-08-29T15:32:59.068Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [2180268.838616] gamma data-mesher[210]: time=2026-08-29T15:32:59.061Z level=INFO msg="state exchange complete" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b timeout=5s container-test-run-data-mesher> alpha # [2180268.845835] alpha systemd[1]: Started data mesher daemon. container-test-run-data-mesher> gamma # [2180268.838616] gamma data-mesher[210]: time=2026-08-29T15:32:59.061Z level=INFO msg="server started" container-test-run-data-mesher> alpha # [2180268.846062] alpha systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> beta # [2180268.833185] beta data-mesher[210]: time=2026-08-29T15:32:59.056Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> alpha # [2180268.846170] alpha systemd[1]: Startup finished in 12.064s. container-test-run-data-mesher> gamma # [2180268.838851] gamma data-mesher[210]: time=2026-08-29T15:32:59.061Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> alpha # [2180269.059849] alpha data-mesher[210]: time=2026-08-29T15:32:59.282Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> gamma # [2180268.838851] gamma systemd[1]: Started data mesher daemon. container-test-run-data-mesher> beta # [2180268.833804] beta data-mesher[210]: time=2026-08-29T15:32:59.056Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> gamma # [2180268.839104] gamma systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> beta # [2180268.833804] beta data-mesher[210]: time=2026-08-29T15:32:59.056Z level=INFO msg="state exchange complete" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> gamma # [2180268.839286] gamma systemd[1]: Startup finished in 12.066s. container-test-run-data-mesher> beta # [2180268.833838] beta data-mesher[210]: time=2026-08-29T15:32:59.056Z level=INFO msg="server started" container-test-run-data-mesher> gamma # [2180268.845559] gamma data-mesher[210]: time=2026-08-29T15:32:59.068Z level=INFO msg="received state sync from peer" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> beta # [2180268.833921] beta data-mesher[210]: time=2026-08-29T15:32:59.056Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [2180268.845586] gamma data-mesher[210]: time=2026-08-29T15:32:59.068Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> beta # [2180268.833992] beta systemd[1]: Started data mesher daemon. container-test-run-data-mesher> beta # [2180268.834185] beta systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> beta # [2180268.834297] beta systemd[1]: Startup finished in 12.058s. container-test-run-data-mesher> beta # [2180268.838388] beta data-mesher[210]: time=2026-08-29T15:32:59.061Z level=INFO msg="received state sync from peer" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> beta # [2180268.838388] beta data-mesher[210]: time=2026-08-29T15:32:59.061Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> beta # [2180273.834087] beta data-mesher[210]: time=2026-08-29T15:33:04.056Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2180273.834439] gamma data-mesher[210]: time=2026-08-29T15:33:04.057Z level=INFO msg="received state sync from peer" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> beta # [2180273.834087] beta data-mesher[210]: time=2026-08-29T15:33:04.056Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> alpha # [2180273.839212] alpha data-mesher[210]: time=2026-08-29T15:33:04.062Z level=INFO msg="received state sync from peer" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> beta # [2180273.834533] beta data-mesher[210]: time=2026-08-29T15:33:04.057Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180273.839212] alpha data-mesher[210]: time=2026-08-29T15:33:04.062Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> beta # [2180273.834533] beta data-mesher[210]: time=2026-08-29T15:33:04.057Z level=INFO msg="state exchange complete" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> alpha # [2180273.841488] alpha data-mesher[210]: time=2026-08-29T15:33:04.064Z level=INFO msg="received file request" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_file container-test-run-data-mesher> beta # [2180273.834592] beta data-mesher[210]: time=2026-08-29T15:33:04.057Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [2180273.843444] alpha data-mesher[210]: time=2026-08-29T15:33:04.066Z level=INFO msg="file transfer complete" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_file container-test-run-data-mesher> beta # [2180273.846876] beta data-mesher[210]: time=2026-08-29T15:33:04.069Z level=INFO msg="received state sync from peer" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> alpha # [2180273.846335] alpha data-mesher[210]: time=2026-08-29T15:33:04.069Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [2180273.846876] beta data-mesher[210]: time=2026-08-29T15:33:04.069Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> alpha # [2180273.846378] alpha data-mesher[210]: time=2026-08-29T15:33:04.069Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b timeout=5s container-test-run-data-mesher> beta # [2180273.846876] beta data-mesher[210]: time=2026-08-29T15:33:04.069Z level=DEBUG msg="new file detected" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU name=test_file name=test_file container-test-run-data-mesher> alpha # [2180273.847060] alpha data-mesher[210]: time=2026-08-29T15:33:04.069Z level=INFO msg="merging remote state" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> beta # [2180273.847027] beta data-mesher[210]: time=2026-08-29T15:33:04.069Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> alpha # [2180273.847060] alpha data-mesher[210]: time=2026-08-29T15:33:04.069Z level=INFO msg="state exchange complete" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b timeout=5s container-test-run-data-mesher> beta # [2180273.847027] beta data-mesher[210]: time=2026-08-29T15:33:04.069Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-29 15:32:59.28 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> alpha # [2180273.847119] alpha data-mesher[210]: time=2026-08-29T15:33:04.069Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [2180273.848507] beta data-mesher[210]: time=2026-08-29T15:33:04.071Z level=INFO msg="download complete" name=test_file signed_at="2026-08-29 15:32:59.28 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU written=true elapsed=1.532334ms container-test-run-data-mesher> alpha # [2180273.847205] alpha data-mesher[210]: time=2026-08-29T15:33:04.070Z level=INFO msg="received file request" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_file container-test-run-data-mesher> gamma # [2180273.834439] gamma data-mesher[210]: time=2026-08-29T15:33:04.057Z level=INFO msg="merging remote state" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180273.847467] alpha data-mesher[210]: time=2026-08-29T15:33:04.070Z level=INFO msg="file transfer complete" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_file container-test-run-data-mesher> gamma # [2180273.838840] gamma data-mesher[210]: time=2026-08-29T15:33:04.061Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2180273.838883] gamma data-mesher[210]: time=2026-08-29T15:33:04.061Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> gamma # [2180273.839645] gamma data-mesher[210]: time=2026-08-29T15:33:04.062Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma # [2180273.839675] gamma data-mesher[210]: time=2026-08-29T15:33:04.062Z level=DEBUG msg="new file detected" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU name=test_file name=test_file container-test-run-data-mesher> gamma # [2180273.839675] gamma data-mesher[210]: time=2026-08-29T15:33:04.062Z level=INFO msg="state exchange complete" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> gamma # [2180273.839705] gamma data-mesher[210]: time=2026-08-29T15:33:04.062Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2180273.839948] gamma data-mesher[210]: time=2026-08-29T15:33:04.062Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> gamma # [2180273.840312] gamma data-mesher[210]: time=2026-08-29T15:33:04.062Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-29 15:32:59.28 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma # [2180273.846166] gamma data-mesher[210]: time=2026-08-29T15:33:04.068Z level=INFO msg="download complete" name=test_file signed_at="2026-08-29 15:32:59.28 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU written=true elapsed=6.189578ms 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/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-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/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.04 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 # [2180274.142322] beta data-mesher[210]: time=2026-08-29T15:33:04.365Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> beta # [2180278.834959] beta data-mesher[210]: time=2026-08-29T15:33:09.057Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [2180278.834959] beta data-mesher[210]: time=2026-08-29T15:33:09.057Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> beta # [2180278.837134] beta data-mesher[210]: time=2026-08-29T15:33:09.059Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> beta # [2180278.837194] beta data-mesher[210]: time=2026-08-29T15:33:09.060Z level=INFO msg="state exchange complete" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> beta # [2180278.837217] beta data-mesher[210]: time=2026-08-29T15:33:09.060Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.03 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/h5qyqq8s8bnns2h7hyr94s1m9l3b593f-per-machine-alpha-data-mesher-node-identity_identity.pub container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/h5qyqq8s8bnns2h7hyr94s1m9l3b593f-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.01 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.00 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert container-test-run-data-mesher> alpha # [2180278.835456] alpha data-mesher[210]: time=2026-08-29T15:33:09.058Z level=INFO msg="received state sync from peer" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180278.835456] alpha data-mesher[210]: time=2026-08-29T15:33:09.058Z level=INFO msg="merging remote state" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180278.837009] alpha data-mesher[210]: time=2026-08-29T15:33:09.059Z level=DEBUG msg="imported tombstone" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b name=test_file written=true container-test-run-data-mesher> alpha # [2180278.840072] alpha data-mesher[210]: time=2026-08-29T15:33:09.062Z level=INFO msg="received state sync from peer" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180278.840101] alpha data-mesher[210]: time=2026-08-29T15:33:09.062Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180278.847568] alpha data-mesher[210]: time=2026-08-29T15:33:09.070Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [2180278.847568] alpha data-mesher[210]: time=2026-08-29T15:33:09.070Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> alpha # [2180278.848105] alpha data-mesher[210]: time=2026-08-29T15:33:09.070Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180278.848146] alpha data-mesher[210]: time=2026-08-29T15:33:09.070Z level=INFO msg="state exchange complete" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> alpha # [2180278.848146] alpha data-mesher[210]: time=2026-08-29T15:33:09.070Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [2180279.209325] alpha data-mesher[210]: time=2026-08-29T15:33:09.432Z level=INFO msg=http_request uri=/files/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 status=204 container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.02 seconds) container-test-run-data-mesher> alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8, in 0.01 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> gamma # [2180278.839737] gamma data-mesher[210]: time=2026-08-29T15:33:09.062Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2180278.840120] gamma data-mesher[210]: time=2026-08-29T15:33:09.062Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> gamma # [2180278.840166] gamma data-mesher[210]: time=2026-08-29T15:33:09.063Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma # [2180278.841043] gamma data-mesher[210]: time=2026-08-29T15:33:09.063Z level=DEBUG msg="imported tombstone" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU name=test_file written=true container-test-run-data-mesher> gamma # [2180278.841043] gamma data-mesher[210]: time=2026-08-29T15:33:09.063Z level=INFO msg="state exchange complete" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> gamma # [2180278.841098] gamma data-mesher[210]: time=2026-08-29T15:33:09.063Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2180278.847975] gamma data-mesher[210]: time=2026-08-29T15:33:09.070Z level=INFO msg="received state sync from peer" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma # [2180278.847975] gamma data-mesher[210]: time=2026-08-29T15:33:09.070Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> beta # [2180283.837284] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [2180283.837284] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> beta # [2180283.837980] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> beta # [2180283.838101] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=DEBUG msg="new file detected" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU name=test_file name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> beta # [2180283.838101] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=INFO msg="state exchange complete" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> beta # [2180283.838132] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [2180283.838132] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=INFO msg="scheduling file download" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> beta # [2180283.838162] beta data-mesher[210]: time=2026-08-29T15:33:14.060Z level=INFO msg="downloading file" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 signed_at="2026-08-29 15:33:09.43 +0000 UTC" signed_by="Kp9z0HPMd+rWGjb0vqY25sv3H8/PvXvpqUv0QSWSx+8=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> beta # [2180283.840439] beta data-mesher[210]: time=2026-08-29T15:33:14.063Z level=INFO msg="download complete" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 signed_at="2026-08-29 15:33:09.43 +0000 UTC" signed_by="Kp9z0HPMd+rWGjb0vqY25sv3H8/PvXvpqUv0QSWSx+8=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU written=true elapsed=2.302727ms container-test-run-data-mesher> alpha # [2180283.837818] alpha data-mesher[210]: time=2026-08-29T15:33:14.060Z level=INFO msg="received state sync from peer" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180283.837818] alpha data-mesher[210]: time=2026-08-29T15:33:14.060Z level=INFO msg="merging remote state" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b container-test-run-data-mesher> alpha # [2180283.838285] alpha data-mesher[210]: time=2026-08-29T15:33:14.061Z level=INFO msg="received file request" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> alpha # [2180283.839511] alpha data-mesher[210]: time=2026-08-29T15:33:14.062Z level=INFO msg="file transfer complete" peer=12D3KooWHmqc1qnX9GAoG2mKRGaFDzPt6UsyLnMYWzfb8mSv4F6b network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> alpha # [2180283.841426] alpha data-mesher[210]: time=2026-08-29T15:33:14.064Z level=INFO msg="received state sync from peer" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180283.841457] alpha data-mesher[210]: time=2026-08-29T15:33:14.064Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180283.841861] alpha data-mesher[210]: time=2026-08-29T15:33:14.064Z level=INFO msg="received file request" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> alpha # [2180283.842239] alpha data-mesher[210]: time=2026-08-29T15:33:14.065Z level=INFO msg="file transfer complete" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS network="LKttn+X99GBv2RzbMtxFcEGw0qTwrEstXkhWBiudRPk=" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> alpha # [2180283.849176] alpha data-mesher[210]: time=2026-08-29T15:33:14.071Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [2180283.849232] alpha data-mesher[210]: time=2026-08-29T15:33:14.072Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> alpha # [2180283.849583] alpha data-mesher[210]: time=2026-08-29T15:33:14.072Z level=INFO msg="merging remote state" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS container-test-run-data-mesher> alpha # [2180283.849663] alpha data-mesher[210]: time=2026-08-29T15:33:14.072Z level=INFO msg="state exchange complete" peer=12D3KooWPquxqK9AYAdpaA5c7Ta3dJgAxU5Qgx9D3EQ8DphwSxBS timeout=5s container-test-run-data-mesher> alpha # [2180283.849684] alpha data-mesher[210]: time=2026-08-29T15:33:14.072Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8, in 5.03 seconds) container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> gamma # [2180283.841165] gamma data-mesher[210]: time=2026-08-29T15:33:14.063Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2180283.841165] gamma data-mesher[210]: time=2026-08-29T15:33:14.064Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> gamma # [2180283.841573] gamma data-mesher[210]: time=2026-08-29T15:33:14.064Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma # [2180283.841664] gamma data-mesher[210]: time=2026-08-29T15:33:14.064Z level=DEBUG msg="new file detected" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU name=test_file name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> gamma # [2180283.841664] gamma data-mesher[210]: time=2026-08-29T15:33:14.064Z level=INFO msg="state exchange complete" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU timeout=5s container-test-run-data-mesher> gamma # [2180283.841664] gamma data-mesher[210]: time=2026-08-29T15:33:14.064Z level=INFO msg="scheduling file download" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> gamma # [2180283.841788] gamma data-mesher[210]: time=2026-08-29T15:33:14.064Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2180283.841788] gamma data-mesher[210]: time=2026-08-29T15:33:14.064Z level=INFO msg="downloading file" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 signed_at="2026-08-29 15:33:09.43 +0000 UTC" signed_by="Kp9z0HPMd+rWGjb0vqY25sv3H8/PvXvpqUv0QSWSx+8=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma # [2180283.843013] gamma data-mesher[210]: time=2026-08-29T15:33:14.065Z level=INFO msg="download complete" name=test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 signed_at="2026-08-29 15:33:09.43 +0000 UTC" signed_by="Kp9z0HPMd+rWGjb0vqY25sv3H8/PvXvpqUv0QSWSx+8=" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU written=true elapsed=1.310014ms container-test-run-data-mesher> gamma # [2180283.849379] gamma data-mesher[210]: time=2026-08-29T15:33:14.072Z level=INFO msg="received state sync from peer" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma # [2180283.849379] gamma data-mesher[210]: time=2026-08-29T15:33:14.072Z level=INFO msg="merging remote state" peer=12D3KooWCgkK5vtQ5KNomyq1N4FDfEt683ixWkcXUbb2QJmYz5FU container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8, 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/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-shared-data-mesher-network_network.pub container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer Kp9z0HPMd+rWGjb0vqY25sv3H8/PvXvpqUv0QSWSx+8= is not authorized for this file test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/4ck5bmrxn6fz571z2a7v5rr31xm2xjk5-shared-data-mesher-network_network.pub, in 0.02 seconds) container-test-run-data-mesher> (finished: run the VM test script, in 27.92 seconds) container-test-run-data-mesher> test script finished in 28.27s container-test-run-data-mesher> cleanup container-test-run-data-mesher> kill NspawnMachine (pid 52) container-test-run-data-mesher> alpha # [2180284.276794] alpha data-mesher[210]: time=2026-08-29T15:33:14.499Z level=INFO msg=http_request uri=/files/test_ns/Kp9z0HPMd-rWGjb0vqY25sv3H8_PvXvpqUv0QSWSx-8 status=403 container-test-run-data-mesher> kill NspawnMachine (pid 53) container-test-run-data-mesher> Container alpha terminated by signal KILL. container-test-run-data-mesher> kill NspawnMachine (pid 59) 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.29 seconds) post-build step Upload to niks3: ok time=2026-08-29T15:33:15.480Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)" time=2026-08-29T15:33:16.208Z level=INFO msg="Uploading 1 narinfos" time=2026-08-29T15:33:16.432Z level=INFO msg="Upload complete. (1.009s)"