these 35 derivations will be built: /nix/store/0h0zh9sxhrq4skf7xrlbfpf68mdwg3px-unit-nix-optimise.service.drv /nix/store/vjxsc2pfsmhrxafhn57lw52g2r2j82q0-system-path.drv /nix/store/mikc1qhlm6a031v1vy40dnndb6lyqi36-dbus-1.drv /nix/store/b4xs0dh1b3fgl9qzlmqr7w25vi42bv0g-X-Restart-Triggers-dbus-broker.drv /nix/store/ki400k8im92sykb497kzfp6hyc3axkd8-unit-dbus-broker.service.drv /nix/store/a1gwibnh81y8fyljq2w6nxhs5n0s0wlx-user-units.drv /nix/store/r8fhz27xd0l66xr72gkaka9navxlsqg9-tmpfiles.d.drv /nix/store/sxr2lzfh7l53v509mxilk22wyjnbs743-nix.conf.drv /nix/store/jbshx5qyrvn9cpssjwl13flglklg15sj-unit-script-nix-gc-start.drv /nix/store/90yard373v99f02ghjm179dw0jyra3jq-unit-nix-gc.service.drv /nix/store/b3iw9278b4ikn28bqlpica54q2c22msm-unit-dbus-broker.service.drv /nix/store/lxkn1msxrap3j472dyw6hq1lk55dml8p-X-Restart-Triggers-nix-daemon.drv /nix/store/p59vc11z3qpirajbvf8fbyilmywpig7p-unit-nix-daemon.service.drv /nix/store/sl5znvf0apy7ym92giyfbi95qqf7z9in-X-Restart-Triggers-systemd-tmpfiles-resetup.drv /nix/store/vkpiaym4725622gh4zq7x9vzcay622dk-unit-systemd-tmpfiles-resetup.service.drv /nix/store/zmy83yn4bvggnkgz7sfij95rwrr2hmla-system-units.drv /nix/store/7cgr20nii74jnbqn922pw6b8gc30jzpr-etc.drv /nix/store/7vcsswrcjb5fni2k6fgkyr33djdfam32-activate.drv /nix/store/4x4yvigkll4dwfl1rnqlqwb3rchhphns-nixos-system-gamma-test.drv /nix/store/nnsjz5ayxyrwzcpdixlksh2aiwi8im3r-system-units.drv /nix/store/rj13r52vxf6gzy3x57dpjymyhi127m63-etc.drv /nix/store/6vqvxa0svsf6p50bar5aq9dy1y70yh9q-activate.drv /nix/store/6lrjwbacv31pj1anrpp56jrl4zdkxn4k-nixos-system-beta-test.drv /nix/store/xc9nzh0xv0i0wnnazggpj9vhi5yhnw7c-python3.14-nixos-test-lib-1.0.0.drv /nix/store/9sy4aq8563wrwfl6ygyi2rdqvqrvm8jk-nixos-test-driver-1.1.drv /nix/store/d8qf5d74ddhizd5zppgrpc2vabr4prhy-system-units.drv /nix/store/dcvzvrb4xrb5f1lp2nqbqgwky8ip5sz5-run-gamma-nspawn.drv /nix/store/h32gp07zwfgnzanzibpaf6jrqsldak4z-run-beta-nspawn.drv /nix/store/milirj9szp14gpk95s5zavk9qvhf23lx-etc.drv /nix/store/pishspsbb2kp9hp2zj6vz5400479vl6w-activate.drv /nix/store/ms16731jk03lnxkc66q0dm44iihrc9c7-nixos-system-alpha-test.drv /nix/store/jzjrysrnsyn891lq0x2dly41ld61ibxr-run-alpha-nspawn.drv /nix/store/j3krmvfayyc0w8z2jw24wmv0sbw0jyiq-driverConfiguration.json.drv /nix/store/ikfrrq7wy8bmb6v96bama0hbs40ax2kr-nixos-test-driver-data-mesher.drv /nix/store/vxmbsgzwmpca5ym1s16di1vyp4rxaw7j-container-test-run-data-mesher.drv building '/nix/store/vjxsc2pfsmhrxafhn57lw52g2r2j82q0-system-path.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/vjxsc2pfsmhrxafhn57lw52g2r2j82q0-system-path.drv' system-path> structuredAttrs is enabled system-path> created 1718 symlinks in user environment building '/nix/store/mikc1qhlm6a031v1vy40dnndb6lyqi36-dbus-1.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/mikc1qhlm6a031v1vy40dnndb6lyqi36-dbus-1.drv' building '/nix/store/b4xs0dh1b3fgl9qzlmqr7w25vi42bv0g-X-Restart-Triggers-dbus-broker.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/b4xs0dh1b3fgl9qzlmqr7w25vi42bv0g-X-Restart-Triggers-dbus-broker.drv' building '/nix/store/b3iw9278b4ikn28bqlpica54q2c22msm-unit-dbus-broker.service.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/ki400k8im92sykb497kzfp6hyc3axkd8-unit-dbus-broker.service.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/b3iw9278b4ikn28bqlpica54q2c22msm-unit-dbus-broker.service.drv' unit-dbus-broker.service> structuredAttrs is enabled warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/nnsjz5ayxyrwzcpdixlksh2aiwi8im3r-system-units.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/ki400k8im92sykb497kzfp6hyc3axkd8-unit-dbus-broker.service.drv' unit-dbus-broker.service> structuredAttrs is enabled warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/a1gwibnh81y8fyljq2w6nxhs5n0s0wlx-user-units.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/d8qf5d74ddhizd5zppgrpc2vabr4prhy-system-units.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/zmy83yn4bvggnkgz7sfij95rwrr2hmla-system-units.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/nnsjz5ayxyrwzcpdixlksh2aiwi8im3r-system-units.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/zmy83yn4bvggnkgz7sfij95rwrr2hmla-system-units.drv' building '/nix/store/a1gwibnh81y8fyljq2w6nxhs5n0s0wlx-user-units.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/rj13r52vxf6gzy3x57dpjymyhi127m63-etc.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/d8qf5d74ddhizd5zppgrpc2vabr4prhy-system-units.drv' building '/nix/store/7cgr20nii74jnbqn922pw6b8gc30jzpr-etc.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/milirj9szp14gpk95s5zavk9qvhf23lx-etc.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/rj13r52vxf6gzy3x57dpjymyhi127m63-etc.drv' building '/nix/store/6vqvxa0svsf6p50bar5aq9dy1y70yh9q-activate.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/7cgr20nii74jnbqn922pw6b8gc30jzpr-etc.drv' building '/nix/store/6vqvxa0svsf6p50bar5aq9dy1y70yh9q-activate.drv' building '/nix/store/milirj9szp14gpk95s5zavk9qvhf23lx-etc.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/6lrjwbacv31pj1anrpp56jrl4zdkxn4k-nixos-system-beta-test.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/7vcsswrcjb5fni2k6fgkyr33djdfam32-activate.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/pishspsbb2kp9hp2zj6vz5400479vl6w-activate.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/6lrjwbacv31pj1anrpp56jrl4zdkxn4k-nixos-system-beta-test.drv' nixos-system-beta-test> structuredAttrs is enabled building '/nix/store/7vcsswrcjb5fni2k6fgkyr33djdfam32-activate.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/pishspsbb2kp9hp2zj6vz5400479vl6w-activate.drv' building '/nix/store/ms16731jk03lnxkc66q0dm44iihrc9c7-nixos-system-alpha-test.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/h32gp07zwfgnzanzibpaf6jrqsldak4z-run-beta-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/4x4yvigkll4dwfl1rnqlqwb3rchhphns-nixos-system-gamma-test.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/ms16731jk03lnxkc66q0dm44iihrc9c7-nixos-system-alpha-test.drv' nixos-system-alpha-test> structuredAttrs is enabled warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/jzjrysrnsyn891lq0x2dly41ld61ibxr-run-alpha-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/4x4yvigkll4dwfl1rnqlqwb3rchhphns-nixos-system-gamma-test.drv' nixos-system-gamma-test> structuredAttrs is enabled building '/nix/store/jzjrysrnsyn891lq0x2dly41ld61ibxr-run-alpha-nspawn.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/dcvzvrb4xrb5f1lp2nqbqgwky8ip5sz5-run-gamma-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/dcvzvrb4xrb5f1lp2nqbqgwky8ip5sz5-run-gamma-nspawn.drv' building '/nix/store/h32gp07zwfgnzanzibpaf6jrqsldak4z-run-beta-nspawn.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/j3krmvfayyc0w8z2jw24wmv0sbw0jyiq-driverConfiguration.json.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/j3krmvfayyc0w8z2jw24wmv0sbw0jyiq-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/ikfrrq7wy8bmb6v96bama0hbs40ax2kr-nixos-test-driver-data-mesher.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/ikfrrq7wy8bmb6v96bama0hbs40ax2kr-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/vxmbsgzwmpca5ym1s16di1vyp4rxaw7j-container-test-run-data-mesher.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/vxmbsgzwmpca5ym1s16di1vyp4rxaw7j-container-test-run-data-mesher.drv' container-test-run-data-mesher> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-data-mesher> start all VLans container-test-run-data-mesher> (finished: start all VLans, in 0.00 seconds) container-test-run-data-mesher> container-test-run-data-mesher> Test will time out and terminate in 3600.0 seconds container-test-run-data-mesher> run the VM test script container-test-run-data-mesher> additionally exposed symbols: container-test-run-data-mesher> alpha, beta, gamma, container-test-run-data-mesher> vlan1, container-test-run-data-mesher> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh container-test-run-data-mesher> start all VMs container-test-run-data-mesher> alpha: systemd-nspawn running (pid 53) container-test-run-data-mesher> alpha: Waiting for journal at /build/vm-state-alpha/var/log/journal... container-test-run-data-mesher> beta: systemd-nspawn running (pid 54) container-test-run-data-mesher> gamma: systemd-nspawn running (pid 56) container-test-run-data-mesher> gamma: Waiting for journal at /build/vm-state-gamma/var/log/journal... container-test-run-data-mesher> beta: Waiting for journal at /build/vm-state-beta/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(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> nixos-nspawn(alpha): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-data-mesher> nixos-nspawn(alpha): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-data-mesher> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-data-mesher> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-data-mesher> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-data-mesher> ░ Spawning container gamma on /build/vm-state-gamma. container-test-run-data-mesher> ░ Spawning container beta on /build/vm-state-beta. container-test-run-data-mesher> ░ Spawning container alpha on /build/vm-state-alpha. container-test-run-data-mesher> alpha # [6518471.261082] alpha systemd-journald[88]: Journal started container-test-run-data-mesher> alpha # [6518471.261142] alpha systemd-journald[88]: Runtime Journal (/run/log/journal/701ed93ce9374eeca00f1d87c0ede7bd) is 8M, max 2.5G, 2.4G free. container-test-run-data-mesher> alpha # [6518471.265716] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [6518471.274130] alpha systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> alpha # [6518471.275038] alpha systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> alpha # [6518471.275757] alpha systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> alpha # [6518471.285253] alpha systemd-journald[88]: Time spent on flushing to /var/log/journal/701ed93ce9374eeca00f1d87c0ede7bd is 984us for 6 entries. container-test-run-data-mesher> alpha # [6518471.285253] alpha systemd-journald[88]: System Journal (/var/log/journal/701ed93ce9374eeca00f1d87c0ede7bd) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [6518471.291074] alpha systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> alpha # [6518471.291346] alpha systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [6518471.291450] alpha systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [6518471.292321] alpha systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> alpha # [6518471.292368] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [6518471.293311] alpha systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> alpha # [6518471.293350] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> alpha # [6518471.318736] alpha systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> alpha # [6518471.320112] alpha systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> alpha # [6518471.338023] alpha systemd-tmpfiles[140]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [6518471.338219] alpha systemd-tmpfiles[140]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [6518471.338359] alpha systemd-tmpfiles[140]: fchmod() of /var/log/journal/701ed93ce9374eeca00f1d87c0ede7bd failed: Operation not permitted container-test-run-data-mesher> alpha # [6518471.338570] alpha systemd-tmpfiles[140]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [6518471.340299] alpha systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> alpha # [6518471.341374] alpha systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> alpha # [6518471.342134] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> alpha # [6518471.352834] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> alpha # [6518471.360034] alpha systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> alpha # [6518471.361783] alpha systemd[1]: Starting Update is Completed... container-test-run-data-mesher> gamma # [6518471.262464] gamma systemd-journald[87]: Journal started container-test-run-data-mesher> gamma # [6518471.262542] gamma systemd-journald[87]: Runtime Journal (/run/log/journal/b2d09d8534914725a22da20908e3cd36) is 8M, max 2.5G, 2.4G free. container-test-run-data-mesher> gamma # [6518471.272125] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> gamma # [6518471.282953] gamma systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> beta # [6518471.275492] beta systemd-journald[87]: Journal started container-test-run-data-mesher> gamma # [6518471.283830] gamma systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> beta # [6518471.275551] beta systemd-journald[87]: Runtime Journal (/run/log/journal/3f87c3cba01b47b8b4784846f77c0336) is 8M, max 2.5G, 2.4G free. container-test-run-data-mesher> gamma # [6518471.284583] gamma systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [6518471.282770] beta systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> gamma # [6518471.291720] gamma systemd-journald[87]: Time spent on flushing to /var/log/journal/b2d09d8534914725a22da20908e3cd36 is 1ms for 6 entries. container-test-run-data-mesher> beta # [6518471.283728] beta systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> gamma # [6518471.291720] gamma systemd-journald[87]: System Journal (/var/log/journal/b2d09d8534914725a22da20908e3cd36) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> beta # [6518471.285233] beta systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> gamma # [6518471.300420] gamma systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> beta # [6518471.291890] beta systemd-journald[87]: Time spent on flushing to /var/log/journal/3f87c3cba01b47b8b4784846f77c0336 is 942us for 5 entries. container-test-run-data-mesher> gamma # [6518471.301035] gamma systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> beta # [6518471.291890] beta systemd-journald[87]: System Journal (/var/log/journal/3f87c3cba01b47b8b4784846f77c0336) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> gamma # [6518471.301142] gamma systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> beta # [6518471.300746] beta systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> gamma # [6518471.301958] gamma systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> beta # [6518471.301315] beta systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> gamma # [6518471.302001] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [6518471.301419] beta systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> gamma # [6518471.302814] gamma systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> beta # [6518471.302197] beta systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> gamma # [6518471.302849] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> gamma # [6518471.317989] gamma systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> gamma # [6518471.319751] gamma systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> beta # [6518471.302238] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [6518471.335213] gamma systemd-tmpfiles[137]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> beta # [6518471.303177] beta systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> gamma # [6518471.335382] gamma systemd-tmpfiles[137]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [6518471.303211] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> gamma # [6518471.335493] gamma systemd-tmpfiles[137]: fchmod() of /var/log/journal/b2d09d8534914725a22da20908e3cd36 failed: Operation not permitted container-test-run-data-mesher> beta # [6518471.318736] beta systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> gamma # [6518471.335662] gamma systemd-tmpfiles[137]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [6518471.320074] beta systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> gamma # [6518471.337288] gamma systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> beta # [6518471.334923] 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 # [6518471.338308] gamma systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> beta # [6518471.335098] beta systemd-tmpfiles[135]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [6518471.339014] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> beta # [6518471.335219] beta systemd-tmpfiles[135]: fchmod() of /var/log/journal/3f87c3cba01b47b8b4784846f77c0336 failed: Operation not permitted container-test-run-data-mesher> gamma # [6518471.352836] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> beta # [6518471.335402] beta systemd-tmpfiles[135]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [6518471.356342] gamma systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> beta # [6518471.336680] beta systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> gamma # [6518471.357803] gamma systemd[1]: Starting Update is Completed... container-test-run-data-mesher> beta # [6518471.337758] beta systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [6518471.368023] gamma systemd[1]: Finished Update is Completed. container-test-run-data-mesher> beta # [6518471.338593] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> beta # [6518471.349988] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> beta # [6518471.362720] beta systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> beta # [6518471.363753] beta systemd[1]: Starting Update is Completed... container-test-run-data-mesher> alpha # [6518471.373545] alpha systemd[1]: Finished Update is Completed. container-test-run-data-mesher> alpha # [6518471.421312] alpha systemd[1]: Finished Firewall. container-test-run-data-mesher> alpha # [6518471.421703] alpha systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> alpha # [6518471.422000] alpha systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [6518471.423205] alpha systemd[1]: Starting Network Management... container-test-run-data-mesher> gamma # [6518471.421962] gamma systemd[1]: Finished Firewall. container-test-run-data-mesher> gamma # [6518471.422102] gamma systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> gamma # [6518471.422312] gamma systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> gamma # [6518471.423341] gamma systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [6518471.373254] beta systemd[1]: Finished Update is Completed. container-test-run-data-mesher> beta # [6518471.422973] beta systemd[1]: Finished Firewall. container-test-run-data-mesher> beta # [6518471.423121] beta systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> beta # [6518471.423334] beta systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> beta # [6518471.424343] beta systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [6518471.818437] beta systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [6518471.818533] beta systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [6518471.825471] 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 # [6518471.825636] 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 # [6518471.825792] beta systemd-networkd[204]: lo: Link UP container-test-run-data-mesher> beta # [6518471.825795] beta systemd-networkd[204]: lo: Gained carrier container-test-run-data-mesher> beta # [6518471.825990] beta systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> beta # [6518471.826381] beta systemd[1]: Started Network Management. container-test-run-data-mesher> beta # [6518471.826457] beta systemd-networkd[204]: eth1: Link UP container-test-run-data-mesher> beta # [6518471.826740] beta systemd-networkd[204]: eth1: Gained carrier container-test-run-data-mesher> beta # [6518471.827572] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> beta # [6518471.913964] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> beta # [6518471.929933] beta systemd-resolved[108]: Positive Trust Anchors: container-test-run-data-mesher> beta # [6518471.929943] beta systemd-resolved[108]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> beta # [6518471.929947] beta systemd-resolved[108]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> beta # [6518471.929983] beta 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> beta # [6518471.952559] beta systemd-resolved[108]: Using system hostname 'beta'. container-test-run-data-mesher> beta # [6518471.953869] beta systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> beta # [6518471.953947] beta systemd[1]: Reached target Network. container-test-run-data-mesher> beta # [6518471.954012] beta systemd[1]: Reached target System Initialization. container-test-run-data-mesher> beta # [6518471.954056] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [6518471.954078] beta systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> beta # [6518471.954095] beta systemd[1]: Reached target Timer Units. container-test-run-data-mesher> beta # [6518471.954211] beta systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> beta # [6518471.954313] beta systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> beta # [6518471.954422] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> beta # [6518471.954449] beta systemd[1]: Reached target Socket Units. container-test-run-data-mesher> beta # [6518471.954487] beta systemd[1]: Reached target Basic System. container-test-run-data-mesher> beta # [6518471.955613] beta systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> beta # [6518471.956291] beta systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> beta # [6518471.996334] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> beta # [6518471.997934] beta systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> beta # [6518472.011172] beta systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> beta # [6518472.079558] beta systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> alpha # [6518471.833077] alpha systemd-networkd[205]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [6518471.833165] alpha systemd-networkd[205]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [6518471.839811] alpha systemd-networkd[205]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> alpha # [6518471.839974] alpha systemd-networkd[205]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> alpha # [6518471.840134] alpha systemd-networkd[205]: lo: Link UP container-test-run-data-mesher> alpha # [6518471.840139] alpha systemd-networkd[205]: lo: Gained carrier container-test-run-data-mesher> alpha # [6518471.840338] alpha systemd-networkd[205]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> alpha # [6518471.840722] alpha systemd[1]: Started Network Management. container-test-run-data-mesher> alpha # [6518471.840792] alpha systemd-networkd[205]: eth1: Link UP container-test-run-data-mesher> alpha # [6518471.841007] alpha systemd-networkd[205]: eth1: Gained carrier container-test-run-data-mesher> alpha # [6518471.841852] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> alpha # [6518471.925926] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> alpha # [6518471.941679] alpha systemd-resolved[110]: Positive Trust Anchors: container-test-run-data-mesher> alpha # [6518471.941689] alpha systemd-resolved[110]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> alpha # [6518471.941693] alpha systemd-resolved[110]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> alpha # [6518471.941728] 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 # [6518471.963484] alpha systemd-resolved[110]: Using system hostname 'alpha'. container-test-run-data-mesher> alpha # [6518471.964801] alpha systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> alpha # [6518471.964876] alpha systemd[1]: Reached target Network. container-test-run-data-mesher> alpha # [6518471.964939] alpha systemd[1]: Reached target System Initialization. container-test-run-data-mesher> alpha # [6518471.964986] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [6518471.965011] alpha systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> alpha # [6518471.965027] alpha systemd[1]: Reached target Timer Units. container-test-run-data-mesher> alpha # [6518471.965147] alpha systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> alpha # [6518471.965263] alpha systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> alpha # [6518471.965373] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> alpha # [6518471.965393] alpha systemd[1]: Reached target Socket Units. container-test-run-data-mesher> alpha # [6518471.965432] alpha systemd[1]: Reached target Basic System. container-test-run-data-mesher> alpha # [6518471.996552] alpha systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> alpha # [6518471.997777] alpha systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> alpha # [6518471.998666] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> alpha # [6518471.999922] alpha systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> alpha # [6518472.015448] alpha systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> alpha # [6518472.081305] alpha systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> alpha # [6518472.117077] alpha systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> alpha # [6518472.117140] alpha systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> alpha # [6518472.117200] alpha systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> alpha # [6518472.117357] alpha nsncd[212]: Aug 23 10:04:58.170 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [6518471.828982] gamma systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [6518471.829073] gamma systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [6518471.835715] 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 # [6518471.835881] 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 # [6518471.836048] gamma systemd-networkd[204]: lo: Link UP container-test-run-data-mesher> gamma # [6518471.836052] gamma systemd-networkd[204]: lo: Gained carrier container-test-run-data-mesher> gamma # [6518471.836226] gamma systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> gamma # [6518471.836620] gamma systemd[1]: Started Network Management. container-test-run-data-mesher> gamma # [6518471.836695] gamma systemd-networkd[204]: eth1: Link UP container-test-run-data-mesher> gamma # [6518471.836908] gamma systemd-networkd[204]: eth1: Gained carrier container-test-run-data-mesher> gamma # [6518471.837625] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> gamma # [6518471.927501] gamma systemd-resolved[111]: Positive Trust Anchors: container-test-run-data-mesher> gamma # [6518471.927512] gamma systemd-resolved[111]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> gamma # [6518471.927515] gamma systemd-resolved[111]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> gamma # [6518471.927551] gamma systemd-resolved[111]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test container-test-run-data-mesher> gamma # [6518471.929815] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> gamma # [6518471.949752] gamma systemd-resolved[111]: Using system hostname 'gamma'. container-test-run-data-mesher> gamma # [6518471.951109] gamma systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> gamma # [6518471.951183] gamma systemd[1]: Reached target Network. container-test-run-data-mesher> gamma # [6518471.951252] gamma systemd[1]: Reached target System Initialization. container-test-run-data-mesher> gamma # [6518471.951299] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [6518471.951326] gamma systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> gamma # [6518471.951342] gamma systemd[1]: Reached target Timer Units. container-test-run-data-mesher> gamma # [6518471.951459] gamma systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> gamma # [6518471.951577] gamma systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> gamma # [6518471.951673] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> gamma # [6518471.951695] gamma systemd[1]: Reached target Socket Units. container-test-run-data-mesher> gamma # [6518471.951732] gamma systemd[1]: Reached target Basic System. container-test-run-data-mesher> gamma # [6518471.952946] gamma systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> gamma # [6518471.953785] gamma systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> gamma # [6518471.954528] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> gamma # [6518471.955636] gamma systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> gamma # [6518472.011626] gamma systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> gamma # [6518472.077345] gamma systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> gamma # [6518472.118105] gamma systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> gamma # [6518472.118163] gamma systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> gamma # [6518472.118218] gamma systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> gamma # [6518472.118652] gamma nsncd[211]: Aug 23 10:04:58.171 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [6518472.119504] gamma systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [6518472.120233] gamma systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> gamma # [6518472.173449] gamma systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> gamma # [6518472.174532] gamma systemd[1]: Started Console Getty. container-test-run-data-mesher> gamma # [6518472.174578] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> gamma # [6518472.174593] gamma systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> gamma # [6518472.207325] gamma dbus-broker-launch[212]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> gamma # [6518472.208013] gamma dbus-broker-launch[212]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> gamma # [6518472.208013] gamma dbus-broker-launch[212]: Invalid user-name in /nix/store/k50rh6sxisc74iknrsp9ni7ysv6j17qb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> gamma # [6518472.208437] gamma systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> gamma # [6518472.215124] gamma dbus-broker-launch[212]: Ready container-test-run-data-mesher> gamma # [6518472.251628] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> beta # [6518472.117582] beta nsncd[211]: Aug 23 10:04:58.170 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> beta # [6518472.117640] beta systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> beta # [6518472.117697] beta systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> beta # [6518472.117748] beta systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> beta # [6518472.118768] beta systemd[1]: Starting User Login Management... container-test-run-data-mesher> beta # [6518472.119423] beta systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> alpha # [6518472.118367] alpha systemd[1]: Starting User Login Management... container-test-run-data-mesher> beta # [6518472.172990] beta systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> alpha # [6518472.119685] alpha systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> beta # [6518472.173955] beta systemd[1]: Started Console Getty. container-test-run-data-mesher> alpha # [6518472.171322] alpha systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> beta # [6518472.173993] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> alpha # [6518472.172333] alpha systemd[1]: Started Console Getty. container-test-run-data-mesher> beta # [6518472.174014] beta systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> alpha # [6518472.172374] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> beta # [6518472.225484] beta dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> alpha # [6518472.172391] alpha systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [6518472.226107] beta dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> alpha # [6518472.207517] alpha dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [6518472.226107] beta dbus-broker-launch[213]: Invalid user-name in /nix/store/k50rh6sxisc74iknrsp9ni7ysv6j17qb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> alpha # [6518472.208782] alpha dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [6518472.226475] beta systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> alpha # [6518472.208782] alpha dbus-broker-launch[213]: Invalid user-name in /nix/store/k50rh6sxisc74iknrsp9ni7ysv6j17qb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> beta # [6518472.234000] beta dbus-broker-launch[213]: Ready container-test-run-data-mesher> alpha # [6518472.209143] alpha systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> beta # [6518472.262205] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> alpha # [6518472.216205] alpha dbus-broker-launch[213]: Ready container-test-run-data-mesher> alpha # [6518472.251610] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> beta # [6518472.465534] beta data-mesher[209]: time=2026-08-23T10:04:58.518Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [6518472.466609] beta data-mesher[209]: time=2026-08-23T10:04:58.519Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6: [/dns/alpha.clan/tcp/7946]} {12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> beta # [6518472.466609] beta data-mesher[209]: time=2026-08-23T10:04:58.519Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> beta # [6518472.478124] beta data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="checking file integrity" container-test-run-data-mesher> beta # [6518472.478230] beta data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> beta # [6518472.482108] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="libp2p host created" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.2/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::2/tcp/7946]" container-test-run-data-mesher> beta # [6518472.482145] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> beta # [6518472.482145] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> beta # [6518472.482145] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> beta # [6518472.482199] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="starting server" container-test-run-data-mesher> beta # [6518472.482237] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> beta # [6518472.482335] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> beta # [6518472.482370] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [6518472.486741] beta data-mesher[209]: time=2026-08-23T10:04:58.539Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> beta # [6518472.487983] beta data-mesher[209]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> beta # [6518472.489259] beta data-mesher[209]: time=2026-08-23T10:04:58.542Z level=INFO msg="peer connected" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> beta # [6518472.626605] beta systemd-logind[229]: New seat seat0. container-test-run-data-mesher> beta # [6518472.627110] beta systemd[1]: Started User Login Management. container-test-run-data-mesher> beta # [6518472.629116] beta systemd[1]: Starting linger-users.service... container-test-run-data-mesher> beta # [6518472.694161] beta systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [6518472.694418] beta systemd[1]: Finished linger-users.service. container-test-run-data-mesher> alpha # [6518472.465091] alpha data-mesher[210]: time=2026-08-23T10:04:58.518Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> alpha # [6518472.466183] alpha data-mesher[210]: time=2026-08-23T10:04:58.519Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6: [/dns/alpha.clan/tcp/7946]} {12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> alpha # [6518472.466183] alpha data-mesher[210]: time=2026-08-23T10:04:58.519Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> alpha # [6518472.478109] alpha data-mesher[210]: time=2026-08-23T10:04:58.531Z level=INFO msg="checking file integrity" container-test-run-data-mesher> alpha # [6518472.478225] alpha data-mesher[210]: time=2026-08-23T10:04:58.531Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> alpha # [6518472.482088] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="libp2p host created" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.1/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::1/tcp/7946]" container-test-run-data-mesher> alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [6518472.482342] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> alpha # [6518472.482342] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> alpha # [6518472.482342] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> alpha # [6518472.488203] alpha data-mesher[210]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> alpha # [6518472.488203] alpha data-mesher[210]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 remote_addr=/ip4/192.168.1.2/tcp/39776 container-test-run-data-mesher> alpha # [6518472.494544] alpha data-mesher[210]: time=2026-08-23T10:04:58.547Z level=INFO msg="peer connected" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> alpha # [6518472.495284] alpha data-mesher[210]: time=2026-08-23T10:04:58.548Z level=INFO msg="peer connected" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> alpha # [6518472.622498] alpha systemd-logind[230]: New seat seat0. container-test-run-data-mesher> alpha # [6518472.622810] alpha systemd[1]: Started User Login Management. container-test-run-data-mesher> alpha # [6518472.624618] alpha systemd[1]: Starting linger-users.service... container-test-run-data-mesher> alpha # [6518472.695982] alpha systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> alpha # [6518472.696133] alpha systemd[1]: Finished linger-users.service. container-test-run-data-mesher> gamma # [6518472.468037] gamma data-mesher[209]: time=2026-08-23T10:04:58.521Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> gamma # [6518472.469122] gamma data-mesher[209]: time=2026-08-23T10:04:58.522Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6: [/dns/alpha.clan/tcp/7946]} {12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> gamma # [6518472.469122] gamma data-mesher[209]: time=2026-08-23T10:04:58.522Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> gamma # [6518472.478234] gamma data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="checking file integrity" container-test-run-data-mesher> gamma # [6518472.478341] gamma data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> gamma # [6518472.482061] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="libp2p host created" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.3/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::3/tcp/7946]" container-test-run-data-mesher> gamma # [6518472.482100] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> gamma # [6518472.482100] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> gamma # [6518472.482100] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> gamma # [6518472.482154] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="starting server" container-test-run-data-mesher> gamma # [6518472.482203] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [6518472.482336] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> gamma # [6518472.482381] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> gamma # [6518472.488591] gamma data-mesher[209]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> gamma # [6518472.494498] gamma data-mesher[209]: time=2026-08-23T10:04:58.547Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> gamma # [6518472.495479] gamma data-mesher[209]: time=2026-08-23T10:04:58.548Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/54490 container-test-run-data-mesher> gamma # [6518472.648039] gamma systemd-logind[229]: New seat seat0. container-test-run-data-mesher> gamma # [6518472.648228] gamma systemd[1]: Started User Login Management. container-test-run-data-mesher> gamma # [6518472.684533] gamma systemd[1]: Starting linger-users.service... container-test-run-data-mesher> gamma # [6518472.698723] gamma systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> gamma # [6518472.698828] gamma systemd[1]: Finished linger-users.service. container-test-run-data-mesher> gamma # [6518472.960199] gamma systemd-networkd[204]: eth1: Gained IPv6LL container-test-run-data-mesher> beta # [6518473.220539] beta systemd-networkd[204]: eth1: Gained IPv6LL container-test-run-data-mesher> alpha # [6518473.092374] alpha systemd-networkd[205]: eth1: Gained IPv6LL container-test-run-data-mesher> alpha: still waiting for container 'alpha' to reach ready state... container-test-run-data-mesher> alpha: (finished: waiting for unit data-mesher.service, in 12.18 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.02 seconds) container-test-run-data-mesher> gamma: waiting for unit data-mesher.service container-test-run-data-mesher> gamma: (finished: waiting for unit data-mesher.service, in 0.01 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'hello world' > /tmp/test_file container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'hello world' > /tmp/test_file, in 0.01 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-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/i662g5nc00nm69g46rz14s8lpx978m49-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> ??? 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/fbgzqsxpqkgkhszk3qisyi1jhy0lk9g4-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/fbgzqsxpqkgkhszk3qisyi1jhy0lk9g4-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> beta # [6518482.482589] beta data-mesher[209]: time=2026-08-23T10:05:08.535Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> beta # [6518482.483301] beta data-mesher[209]: time=2026-08-23T10:05:08.535Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> beta # [6518482.483301] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518482.483301] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518482.483457] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518482.483457] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> beta # [6518482.483457] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="server started" container-test-run-data-mesher> beta # [6518482.483589] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> beta # [6518482.483657] beta systemd[1]: Started data mesher daemon. container-test-run-data-mesher> beta # [6518482.483979] beta systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> beta # [6518482.484353] beta systemd[1]: Startup finished in 11.591s. container-test-run-data-mesher> alpha # [6518482.482685] alpha data-mesher[210]: time=2026-08-23T10:05:08.535Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> alpha # [6518482.483386] alpha data-mesher[210]: time=2026-08-23T10:05:08.535Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> alpha # [6518482.483386] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518482.483386] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518482.483791] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518482.483791] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> alpha # [6518482.483898] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> alpha # [6518482.483898] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> alpha # [6518482.483999] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="server started" container-test-run-data-mesher> alpha # [6518482.484082] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> alpha # [6518482.484211] alpha systemd[1]: Started data mesher daemon. container-test-run-data-mesher> alpha # [6518482.484723] alpha systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> alpha # [6518482.486954] alpha systemd[1]: Startup finished in 11.580s. container-test-run-data-mesher> alpha # [6518482.618634] alpha data-mesher[210]: time=2026-08-23T10:05:08.671Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.536Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> gamma # [6518482.484911] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="server started" container-test-run-data-mesher> gamma # [6518482.484911] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [6518482.484389] gamma systemd[1]: Started data mesher daemon. container-test-run-data-mesher> gamma # [6518482.484693] gamma systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> gamma # [6518482.484883] gamma systemd[1]: Startup finished in 11.590s. 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.04 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/i662g5nc00nm69g46rz14s8lpx978m49-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/i662g5nc00nm69g46rz14s8lpx978m49-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 # [6518487.486281] beta data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [6518487.486681] beta data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> beta # [6518487.487326] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518487.487367] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518487.487740] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518487.487775] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_file container-test-run-data-mesher> beta # [6518487.487801] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> beta # [6518487.487841] beta data-mesher[209]: time=2026-08-23T10:05:13.541Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [6518487.487870] beta data-mesher[209]: time=2026-08-23T10:05:13.541Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> beta # [6518487.487925] beta data-mesher[209]: time=2026-08-23T10:05:13.541Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518487.514284] beta data-mesher[209]: time=2026-08-23T10:05:13.567Z level=INFO msg="download complete" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 written=true elapsed=26.374364ms container-test-run-data-mesher> beta # [6518487.724456] beta data-mesher[209]: time=2026-08-23T10:05:13.777Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> alpha # [6518487.486410] alpha data-mesher[210]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [6518487.486410] alpha data-mesher[210]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> alpha # [6518487.487119] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518487.487119] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518487.487619] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> alpha # [6518487.487619] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> alpha # [6518487.487750] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [6518487.488191] alpha data-mesher[210]: time=2026-08-23T10:05:13.541Z level=INFO msg="received file request" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file container-test-run-data-mesher> alpha # [6518487.488327] alpha data-mesher[210]: time=2026-08-23T10:05:13.541Z level=INFO msg="received file request" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file container-test-run-data-mesher> alpha # [6518487.490039] alpha data-mesher[210]: time=2026-08-23T10:05:13.543Z level=INFO msg="file transfer complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file container-test-run-data-mesher> alpha # [6518487.490157] alpha data-mesher[210]: time=2026-08-23T10:05:13.543Z level=INFO msg="file transfer complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file container-test-run-data-mesher> gamma # [6518487.486792] gamma data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [6518487.486792] gamma data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_file container-test-run-data-mesher> gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [6518487.514351] gamma data-mesher[209]: time=2026-08-23T10:05:13.567Z level=INFO msg="download complete" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 written=true elapsed=26.83133ms container-test-run-data-mesher> alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.04 seconds) container-test-run-data-mesher> beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds) container-test-run-data-mesher> gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds) container-test-run-data-mesher> alpha: must succeed: cat /nix/store/hw6512jcgmq95kz2zrg7yi21w3zia2rx-per-machine-alpha-data-mesher-node-identity_identity.pub container-test-run-data-mesher> alpha # [6518492.488483] alpha data-mesher[210]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [6518492.488688] gamma data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [6518492.488945] alpha data-mesher[210]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> gamma # [6518492.488688] gamma data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> alpha # [6518492.489071] alpha data-mesher[210]: time=2026-08-23T10:05:18.542Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518492.488679] beta data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [6518492.489071] alpha data-mesher[210]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518492.489229] beta data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> alpha # [6518492.489345] alpha data-mesher[210]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> beta # [6518492.489229] beta data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> alpha # [6518492.494563] alpha data-mesher[210]: time=2026-08-23T10:05:18.547Z level=DEBUG msg="imported tombstone" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 name=test_file written=true container-test-run-data-mesher> beta # [6518492.489229] beta data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> alpha # [6518492.494563] alpha data-mesher[210]: time=2026-08-23T10:05:18.547Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> beta # [6518492.495371] beta data-mesher[209]: time=2026-08-23T10:05:18.548Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> alpha # [6518492.494646] alpha data-mesher[210]: time=2026-08-23T10:05:18.547Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [6518492.495489] beta data-mesher[209]: time=2026-08-23T10:05:18.548Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> gamma # [6518492.489170] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> beta # [6518492.495489] beta data-mesher[209]: time=2026-08-23T10:05:18.548Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [6518492.489170] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> gamma # [6518492.489629] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> gamma # [6518492.489672] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> gamma # [6518492.489731] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [6518492.495107] gamma data-mesher[209]: time=2026-08-23T10:05:18.548Z level=DEBUG msg="imported tombstone" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 name=test_file written=true container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/hw6512jcgmq95kz2zrg7yi21w3zia2rx-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.01 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.01 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-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/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU, in 0.01 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> alpha # [6518492.810637] alpha data-mesher[210]: time=2026-08-23T10:05:18.863Z level=INFO msg=http_request uri=/files/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU status=204 container-test-run-data-mesher> beta # [6518497.492190] beta data-mesher[209]: time=2026-08-23T10:05:23.545Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518497.493055] beta data-mesher[209]: time=2026-08-23T10:05:23.545Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="scheduling file download" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [6518497.497322] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="downloading file" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518497.498963] beta data-mesher[209]: time=2026-08-23T10:05:23.552Z level=INFO msg="download complete" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 written=true elapsed=1.955066ms container-test-run-data-mesher> gamma # [6518497.490615] gamma data-mesher[209]: time=2026-08-23T10:05:23.543Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [6518497.491028] gamma data-mesher[209]: time=2026-08-23T10:05:23.543Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> gamma # [6518497.493068] gamma data-mesher[209]: time=2026-08-23T10:05:23.546Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> gamma # [6518497.493113] gamma data-mesher[209]: time=2026-08-23T10:05:23.546Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> gamma # [6518497.493165] gamma data-mesher[209]: time=2026-08-23T10:05:23.546Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [6518497.496678] gamma data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> gamma # [6518497.496713] gamma data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518497.495560] alpha data-mesher[210]: time=2026-08-23T10:05:23.548Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [6518497.495560] alpha data-mesher[210]: time=2026-08-23T10:05:23.548Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> alpha # [6518497.497179] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518497.497257] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> alpha # [6518497.497257] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [6518497.497708] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=INFO msg="received file request" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> alpha # [6518497.498012] alpha data-mesher[210]: time=2026-08-23T10:05:23.551Z level=INFO msg="file transfer complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU, in 5.05 seconds) container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> beta # [6518502.494840] beta data-mesher[209]: time=2026-08-23T10:05:28.547Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518502.494840] beta data-mesher[209]: time=2026-08-23T10:05:28.548Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> beta # [6518502.496626] beta data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="received file request" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> beta # [6518502.497447] beta data-mesher[209]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [6518502.497545] beta data-mesher[209]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> beta # [6518502.497582] beta data-mesher[209]: time=2026-08-23T10:05:28.550Z level=INFO msg="file transfer complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> beta # [6518502.499761] beta data-mesher[209]: time=2026-08-23T10:05:28.552Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> beta # [6518502.499761] beta data-mesher[209]: time=2026-08-23T10:05:28.552Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s container-test-run-data-mesher> beta # [6518502.499761] beta data-mesher[209]: time=2026-08-23T10:05:28.552Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [6518502.497517] alpha data-mesher[210]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [6518502.497517] alpha data-mesher[210]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> alpha # [6518502.498326] alpha data-mesher[210]: time=2026-08-23T10:05:28.551Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518502.498326] alpha data-mesher[210]: time=2026-08-23T10:05:28.551Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> alpha # [6518502.500032] alpha data-mesher[210]: time=2026-08-23T10:05:28.552Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq container-test-run-data-mesher> alpha # [6518502.500032] alpha data-mesher[210]: time=2026-08-23T10:05:28.552Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s container-test-run-data-mesher> alpha # [6518502.500032] alpha data-mesher[210]: time=2026-08-23T10:05:28.552Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU, in 5.04 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'no_cert' > /tmp/ns_nocert container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'no_cert' > /tmp/ns_nocert, in 0.01 seconds) container-test-run-data-mesher> alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub container-test-run-data-mesher> gamma # [6518502.494230] gamma data-mesher[209]: time=2026-08-23T10:05:28.547Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [6518502.494751] gamma data-mesher[209]: time=2026-08-23T10:05:28.547Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> gamma # [6518502.495238] gamma data-mesher[209]: time=2026-08-23T10:05:28.548Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> gamma # [6518502.495867] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=DEBUG msg="new file detected" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 name=test_file name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> gamma # [6518502.495902] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s container-test-run-data-mesher> gamma # [6518502.495950] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [6518502.495978] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="scheduling file download" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> gamma # [6518502.496104] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="downloading file" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 container-test-run-data-mesher> gamma # [6518502.498069] gamma data-mesher[209]: time=2026-08-23T10:05:28.551Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> gamma # [6518502.498094] gamma data-mesher[209]: time=2026-08-23T10:05:28.551Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 container-test-run-data-mesher> gamma # [6518502.498704] gamma data-mesher[209]: time=2026-08-23T10:05:28.551Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> gamma # [6518502.499134] gamma data-mesher[209]: time=2026-08-23T10:05:28.552Z level=INFO msg="download complete" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 written=true elapsed=3.117123ms container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU= is not authorized for this file test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub, in 0.03 seconds) container-test-run-data-mesher> (finished: run the VM test script, in 32.58 seconds) container-test-run-data-mesher> alpha # [6518502.942874] alpha data-mesher[210]: time=2026-08-23T10:05:28.995Z level=INFO msg=http_request uri=/files/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU status=403 container-test-run-data-mesher> test script finished in 33.36s container-test-run-data-mesher> cleanup container-test-run-data-mesher> kill NspawnMachine (pid 53) container-test-run-data-mesher> kill NspawnMachine (pid 54) container-test-run-data-mesher> Container alpha terminated by signal KILL. container-test-run-data-mesher> Container beta terminated by signal KILL. container-test-run-data-mesher> kill NspawnMachine (pid 56) container-test-run-data-mesher> Container gamma terminated by signal KILL. container-test-run-data-mesher> (finished: cleanup, in 0.64 seconds) post-build step Upload to niks3: ok time=2026-08-23T10:05:30.861Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)" time=2026-08-23T10:05:31.131Z level=INFO msg="Uploading 1 narinfos" time=2026-08-23T10:05:31.403Z level=INFO msg="Upload complete. (605ms)"