these 48 derivations will be built: /nix/store/74r4xs4618dydfw1l5v33fv5r8qysagd-system-path.drv /nix/store/b9mdlrmdzjdi2dai7a80fban4w6i50fl-string-hosts.drv /nix/store/cvqrdjra3cr0hjaqvb1a11yhd5izlalz-extra-hosts.drv /nix/store/9b4ahr7sd524qx5is5nzr08rn0nsg41f-hosts.drv /nix/store/yd17r5zw88qr4wg1zr9j8vbyzyfhj792-dbus-1.drv /nix/store/x7m1kmkcawaf6p23n9c0w8i1jrmdjd34-X-Restart-Triggers-dbus-broker.drv /nix/store/kvwsdypavamfd85p21jb954rfmpp7gw0-unit-dbus-broker.service.drv /nix/store/g17wjss32wkc1gzg673gm64hy8ma0j3j-user-units.drv /nix/store/dlzyl7br6wgrlmya9rgvim9qkbk8apj7-unit-dbus-broker.service.drv /nix/store/5kf5p07hw9v0zqxxn234yq3367zg24q6-firewall-start.drv /nix/store/q9nz22csb5yn22k4275lyrf8i3swdix2-firewall-reload.drv /nix/store/gr1hjxy5b94cacq6zbcll53j614bpqq3-unit-firewall.service.drv /nix/store/d497538scmbgn2bqk4jn9sj5vh766p7f-X-Restart-Triggers-data-mesher.drv /nix/store/pffpxwp467951hfnsgmlfnmyi459zm3d-unit-data-mesher.service.drv /nix/store/q4a512h0xwfc3rzzbngwp4jbnwvp1piy-system-units.drv /nix/store/zv21651kgranh5sdlbn3654fyrdzv76c-etc-hostname.drv /nix/store/kvy11y1diqzkgbyp279kb242kvg473qh-etc.drv /nix/store/nw2j5a01jxwndfcy8p2wgs6pnlxwq6xj-users-groups.json.drv /nix/store/cxfczdpn4npk4i9n3lzsyc0hh85m3i2v-activate.drv /nix/store/1p1cffhnyb2iamd9pkqdpc0idmf5k26x-nixos-system-beta-test.drv /nix/store/ascqpfxbj7rkw8bl5a9ayndj6kmjmmfm-test-script.drv /nix/store/cilvncddlvxvwvxm3xxwgifwims77n9d-run-beta-nspawn.drv /nix/store/aibd9cjgdh62c480mpj17g9sh1kkq3zs-X-Restart-Triggers-data-mesher.drv /nix/store/6iqmkhkhp1rislakyx8kd2sfv6iy954s-unit-data-mesher.service.drv /nix/store/4m58s2dfbvpqnpfiqrm9ypip6l5pg864-system-units.drv /nix/store/6j4m30a672z51h9h87hqx3ar83hrd3pk-string-hosts.drv /nix/store/g44p3ccmfmvyp1fmcxaqc9gzx0k1gyqf-hosts.drv /nix/store/p44mrhinca52l0m0wlapfcxml742243d-etc-hostname.drv /nix/store/mzkfnpkfnw4hahsfh65dd2d2y5vw8yk7-etc.drv /nix/store/jb7yp97nbygjfh263gwfb912zm03fcx2-activate.drv /nix/store/n9rqvf71z85jff888ycq0ack4sjp4q2h-nixos-system-alpha-test.drv /nix/store/rs38h7gg0x910bcx2k831sd5ggd48hnc-run-alpha-nspawn.drv /nix/store/40vdz4yflf5xyjsjg1g73d7hfj77r0b6-etc-hostname.drv /nix/store/664k9kqspgr3fbsc97adraja6qq1j8zf-unit-40-eth1.network.drv /nix/store/m764k4w0qg79pnwa3xc5ggvglwws8s1w-X-Restart-Triggers-data-mesher.drv /nix/store/kisxcrpi273pvnp60y997zz6za6zcwgz-unit-data-mesher.service.drv /nix/store/q76xn0fvifqzh836kf2p5zv1q92857wn-X-Reload-Triggers-systemd-networkd.drv /nix/store/qsdm6239ijj9b2svmazkcj4by6f4piaq-unit-systemd-networkd.service.drv /nix/store/kd7sd2g7ggisyjzirhckh50lbdc99cxn-system-units.drv /nix/store/nm1ii33lmar0iqycmh47xk6ld7lpbcyz-string-hosts.drv /nix/store/ncwx2q288vcdlkzfz6sn03lhz1791s90-hosts.drv /nix/store/6z5whjm2sl7dibksaaijqvmrhs2b55cj-etc.drv /nix/store/nw538bihf86hsg87ynm38dbpfgf2y1p6-activate.drv /nix/store/czgdbspk8bl20fwdrd528mz2ncsl97wb-nixos-system-gamma-test.drv /nix/store/sqzn4m04a2dyjn7jxf61v4q9g5a30d8l-run-gamma-nspawn.drv /nix/store/3q8y8sdfkbpq7381bgg2srnfn10r7mm7-driverConfiguration.json.drv /nix/store/5hyq6xiiyw1znxxvz13k21qwi43z3wjv-nixos-test-driver-data-mesher.drv /nix/store/ndwl2qj00bji33pg8ypvxd8a57l4r811-container-test-run-data-mesher.drv these 12 paths will be fetched (0.0 KiB download, 31.3 MiB unpacked): /nix/store/f53knq3ldlxnrcv1lx4j9hbihxvyj7xk-data-mesher-0.1.0 /nix/store/1x5jjfzkyfv520411qy4xahzx7i2w3as-decrypt-age-secrets /nix/store/i9xlm74abi9m2cxmz7g3nps9ga4vdpwn-decrypt-age-secrets /nix/store/zpwdyd7zpzh64kks749y75cx4fnhakw8-decrypt-age-secrets /nix/store/64fsmxnmvfldlxlahja2dy4sa424pycq-dm.toml /nix/store/93pn5vrk1h40isqhsk0789js7gp0qcfc-dm.toml /nix/store/pwhlmn59vgwjai8nw7ii569837cp8rp7-dm.toml /nix/store/cpnl9ifbz4l258fr4zj9rx9cdhcndk69-dry-activate /nix/store/v3w0x4gdz1h9wcapxh2fwsyqsmdalaf1-dry-activate /nix/store/vg73z4kvmbxx7ya6swdaysvh3wblyayn-dry-activate /nix/store/967h4ny69xaisf6sl52grk8gv0q95xws-users-groups.json /nix/store/qpkpykwpsafsknz1600pvq6sx8hbyii0-vars-check-data-mesher building '/nix/store/ascqpfxbj7rkw8bl5a9ayndj6kmjmmfm-test-script.drv' building '/nix/store/40vdz4yflf5xyjsjg1g73d7hfj77r0b6-etc-hostname.drv' building '/nix/store/p44mrhinca52l0m0wlapfcxml742243d-etc-hostname.drv' building '/nix/store/zv21651kgranh5sdlbn3654fyrdzv76c-etc-hostname.drv' building '/nix/store/664k9kqspgr3fbsc97adraja6qq1j8zf-unit-40-eth1.network.drv' building '/nix/store/cvqrdjra3cr0hjaqvb1a11yhd5izlalz-extra-hosts.drv' building '/nix/store/6j4m30a672z51h9h87hqx3ar83hrd3pk-string-hosts.drv' building '/nix/store/b9mdlrmdzjdi2dai7a80fban4w6i50fl-string-hosts.drv' building '/nix/store/nm1ii33lmar0iqycmh47xk6ld7lpbcyz-string-hosts.drv' building '/nix/store/5kf5p07hw9v0zqxxn234yq3367zg24q6-firewall-start.drv' etc-hostname> structuredAttrs is enabled etc-hostname> structuredAttrs is enabled etc-hostname> structuredAttrs is enabled extra-hosts> structuredAttrs is enabled string-hosts> structuredAttrs is enabled string-hosts> structuredAttrs is enabled string-hosts> structuredAttrs is enabled test-script> structuredAttrs is enabled unit-40-eth1.network> structuredAttrs is enabled firewall-start> structuredAttrs is enabled building '/nix/store/q76xn0fvifqzh836kf2p5zv1q92857wn-X-Reload-Triggers-systemd-networkd.drv' building '/nix/store/9b4ahr7sd524qx5is5nzr08rn0nsg41f-hosts.drv' building '/nix/store/g44p3ccmfmvyp1fmcxaqc9gzx0k1gyqf-hosts.drv' building '/nix/store/ncwx2q288vcdlkzfz6sn03lhz1791s90-hosts.drv' X-Reload-Triggers-systemd-networkd> structuredAttrs is enabled building '/nix/store/aibd9cjgdh62c480mpj17g9sh1kkq3zs-X-Restart-Triggers-data-mesher.drv' building '/nix/store/m764k4w0qg79pnwa3xc5ggvglwws8s1w-X-Restart-Triggers-data-mesher.drv' building '/nix/store/q9nz22csb5yn22k4275lyrf8i3swdix2-firewall-reload.drv' X-Restart-Triggers-data-mesher> structuredAttrs is enabled X-Restart-Triggers-data-mesher> structuredAttrs is enabled building '/nix/store/d497538scmbgn2bqk4jn9sj5vh766p7f-X-Restart-Triggers-data-mesher.drv' building '/nix/store/qsdm6239ijj9b2svmazkcj4by6f4piaq-unit-systemd-networkd.service.drv' X-Restart-Triggers-data-mesher> structuredAttrs is enabled firewall-reload> structuredAttrs is enabled unit-systemd-networkd.service> structuredAttrs is enabled building '/nix/store/gr1hjxy5b94cacq6zbcll53j614bpqq3-unit-firewall.service.drv' unit-firewall.service> structuredAttrs is enabled building '/nix/store/74r4xs4618dydfw1l5v33fv5r8qysagd-system-path.drv' building '/nix/store/6iqmkhkhp1rislakyx8kd2sfv6iy954s-unit-data-mesher.service.drv' building '/nix/store/kisxcrpi273pvnp60y997zz6za6zcwgz-unit-data-mesher.service.drv' building '/nix/store/pffpxwp467951hfnsgmlfnmyi459zm3d-unit-data-mesher.service.drv' system-path> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled system-path> created 1723 symlinks in user environment unit-data-mesher.service> structuredAttrs is enabled building '/nix/store/yd17r5zw88qr4wg1zr9j8vbyzyfhj792-dbus-1.drv' building '/nix/store/x7m1kmkcawaf6p23n9c0w8i1jrmdjd34-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> structuredAttrs is enabled building '/nix/store/dlzyl7br6wgrlmya9rgvim9qkbk8apj7-unit-dbus-broker.service.drv' building '/nix/store/kvwsdypavamfd85p21jb954rfmpp7gw0-unit-dbus-broker.service.drv' unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/4m58s2dfbvpqnpfiqrm9ypip6l5pg864-system-units.drv' building '/nix/store/kd7sd2g7ggisyjzirhckh50lbdc99cxn-system-units.drv' building '/nix/store/q4a512h0xwfc3rzzbngwp4jbnwvp1piy-system-units.drv' unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/g17wjss32wkc1gzg673gm64hy8ma0j3j-user-units.drv' building '/nix/store/mzkfnpkfnw4hahsfh65dd2d2y5vw8yk7-etc.drv' building '/nix/store/6z5whjm2sl7dibksaaijqvmrhs2b55cj-etc.drv' building '/nix/store/kvy11y1diqzkgbyp279kb242kvg473qh-etc.drv' building '/nix/store/jb7yp97nbygjfh263gwfb912zm03fcx2-activate.drv' activate> structuredAttrs is enabled building '/nix/store/n9rqvf71z85jff888ycq0ack4sjp4q2h-nixos-system-alpha-test.drv' nixos-system-alpha-test> structuredAttrs is enabled building '/nix/store/nw538bihf86hsg87ynm38dbpfgf2y1p6-activate.drv' building '/nix/store/cxfczdpn4npk4i9n3lzsyc0hh85m3i2v-activate.drv' building '/nix/store/rs38h7gg0x910bcx2k831sd5ggd48hnc-run-alpha-nspawn.drv' activate> structuredAttrs is enabled activate> structuredAttrs is enabled building '/nix/store/1p1cffhnyb2iamd9pkqdpc0idmf5k26x-nixos-system-beta-test.drv' building '/nix/store/czgdbspk8bl20fwdrd528mz2ncsl97wb-nixos-system-gamma-test.drv' nixos-system-beta-test> structuredAttrs is enabled nixos-system-gamma-test> structuredAttrs is enabled building '/nix/store/cilvncddlvxvwvxm3xxwgifwims77n9d-run-beta-nspawn.drv' building '/nix/store/sqzn4m04a2dyjn7jxf61v4q9g5a30d8l-run-gamma-nspawn.drv' building '/nix/store/3q8y8sdfkbpq7381bgg2srnfn10r7mm7-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/5hyq6xiiyw1znxxvz13k21qwi43z3wjv-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/ndwl2qj00bji33pg8ypvxd8a57l4r811-container-test-run-data-mesher.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/ndwl2qj00bji33pg8ypvxd8a57l4r811-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 55) container-test-run-data-mesher> beta: Waiting for journal at /build/vm-state-beta/var/log/journal... container-test-run-data-mesher> gamma: Waiting for journal at /build/vm-state-gamma/var/log/journal... container-test-run-data-mesher> (finished: start all VMs, in 0.00 seconds) container-test-run-data-mesher> alpha: waiting for unit data-mesher.service container-test-run-data-mesher> nixos-nspawn(alpha): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-data-mesher> nixos-nspawn(alpha): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-data-mesher> nixos-nspawn(gamma): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-data-mesher> nixos-nspawn(gamma): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-data-mesher> nixos-nspawn(beta): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-data-mesher> nixos-nspawn(beta): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-data-mesher> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-data-mesher> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-data-mesher> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-data-mesher> ░ Spawning container alpha on /build/vm-state-alpha. container-test-run-data-mesher> ░ Spawning container gamma on /build/vm-state-gamma. container-test-run-data-mesher> ░ Spawning container beta on /build/vm-state-beta. container-test-run-data-mesher> alpha # [1547288.396992] alpha systemd-journald[90]: Journal started container-test-run-data-mesher> alpha # [1547288.397021] alpha systemd-journald[90]: Runtime Journal (/run/log/journal/62fc0814263c4efb826d8ad0c2495be7) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> alpha # [1547288.401953] alpha systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> alpha # [1547288.408254] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [1547288.415598] alpha systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> alpha # [1547288.415938] alpha systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> alpha # [1547288.416226] alpha systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> alpha # [1547288.420160] alpha systemd-journald[90]: Time spent on flushing to /var/log/journal/62fc0814263c4efb826d8ad0c2495be7 is 1.160ms for 7 entries. container-test-run-data-mesher> alpha # [1547288.420160] alpha systemd-journald[90]: System Journal (/var/log/journal/62fc0814263c4efb826d8ad0c2495be7) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> beta # [1547288.395518] beta systemd-journald[90]: Journal started container-test-run-data-mesher> beta # [1547288.395547] beta systemd-journald[90]: Runtime Journal (/run/log/journal/3750b57d8b9a4cdebb2c284a1101e679) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> beta # [1547288.402989] beta systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> alpha # [1547288.434757] alpha systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> alpha # [1547288.435078] alpha systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [1547288.435128] alpha systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [1547288.435621] alpha systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> alpha # [1547288.435653] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [1547288.436009] alpha systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> alpha # [1547288.436025] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> beta # [1547288.409220] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [1547288.468165] alpha systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [1547288.416749] beta systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> alpha # [1547288.468657] alpha systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> beta # [1547288.417158] beta systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> gamma # [1547288.395671] gamma systemd-journald[90]: Journal started container-test-run-data-mesher> beta # [1547288.417419] beta systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> gamma # [1547288.395696] gamma systemd-journald[90]: Runtime Journal (/run/log/journal/a9db89938aab4896b9c032dc077ded65) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> beta # [1547288.423343] beta systemd-journald[90]: Time spent on flushing to /var/log/journal/3750b57d8b9a4cdebb2c284a1101e679 is 975us for 7 entries. container-test-run-data-mesher> gamma # [1547288.402909] gamma systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> beta # [1547288.423343] beta systemd-journald[90]: System Journal (/var/log/journal/3750b57d8b9a4cdebb2c284a1101e679) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> gamma # [1547288.409098] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> beta # [1547288.437826] beta systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> gamma # [1547288.416397] gamma systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> beta # [1547288.438262] beta systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> gamma # [1547288.416728] gamma systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> beta # [1547288.438318] beta systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [1547288.477858] alpha systemd-tmpfiles[185]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> beta # [1547288.438789] beta systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> alpha # [1547288.478006] alpha systemd-tmpfiles[185]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [1547288.438815] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [1547288.478107] alpha systemd-tmpfiles[185]: fchmod() of /var/log/journal/62fc0814263c4efb826d8ad0c2495be7 failed: Operation not permitted container-test-run-data-mesher> beta # [1547288.439252] beta systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> gamma # [1547288.417019] gamma systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [1547288.439269] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> alpha # [1547288.478295] alpha systemd-tmpfiles[185]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [1547288.420859] gamma systemd-journald[90]: Time spent on flushing to /var/log/journal/a9db89938aab4896b9c032dc077ded65 is 1.109ms for 7 entries. container-test-run-data-mesher> alpha # [1547288.479058] alpha systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> gamma # [1547288.420859] gamma systemd-journald[90]: System Journal (/var/log/journal/a9db89938aab4896b9c032dc077ded65) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [1547288.479554] alpha systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> beta # [1547288.472957] beta systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> alpha # [1547288.479957] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> beta # [1547288.473853] beta systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> gamma # [1547288.437226] gamma systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> beta # [1547288.482704] beta systemd[1]: Finished Firewall. container-test-run-data-mesher> alpha # [1547288.482910] alpha systemd[1]: Finished Firewall. container-test-run-data-mesher> gamma # [1547288.437611] gamma systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [1547288.483017] alpha systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> gamma # [1547288.437671] gamma systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [1547288.483176] alpha systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> beta # [1547288.482784] beta systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> alpha # [1547288.483739] alpha systemd[1]: Starting Network Management... container-test-run-data-mesher> gamma # [1547288.438176] gamma systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> alpha # [1547288.486161] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> beta # [1547288.482934] beta systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [1547288.491386] alpha systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [1547288.438206] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [1547288.491788] alpha systemd[1]: Starting Update is Completed... container-test-run-data-mesher> beta # [1547288.483522] beta systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [1547288.483590] beta systemd-tmpfiles[190]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [1547288.438613] gamma systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> beta # [1547288.483732] beta systemd-tmpfiles[190]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [1547288.497165] alpha systemd[1]: Finished Update is Completed. container-test-run-data-mesher> beta # [1547288.483831] beta systemd-tmpfiles[190]: fchmod() of /var/log/journal/3750b57d8b9a4cdebb2c284a1101e679 failed: Operation not permitted container-test-run-data-mesher> gamma # [1547288.438630] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> beta # [1547288.483978] beta systemd-tmpfiles[190]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [1547288.476271] gamma systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [1547288.484678] beta systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> gamma # [1547288.476688] gamma systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> beta # [1547288.485162] beta systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [1547288.486018] gamma systemd[1]: Finished Firewall. container-test-run-data-mesher> beta # [1547288.485471] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> gamma # [1547288.486121] gamma systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> beta # [1547288.491495] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> gamma # [1547288.486264] gamma systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> beta # [1547288.496941] beta systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [1547288.486735] gamma systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [1547288.497463] beta systemd[1]: Starting Update is Completed... container-test-run-data-mesher> gamma # [1547288.486902] gamma systemd-tmpfiles[190]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [1547288.487092] gamma systemd-tmpfiles[190]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [1547288.487219] gamma systemd-tmpfiles[190]: fchmod() of /var/log/journal/a9db89938aab4896b9c032dc077ded65 failed: Operation not permitted container-test-run-data-mesher> beta # [1547288.502733] beta systemd[1]: Finished Update is Completed. container-test-run-data-mesher> gamma # [1547288.487375] gamma systemd-tmpfiles[190]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [1547288.489801] gamma systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> gamma # [1547288.490308] gamma systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [1547288.490593] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> gamma # [1547288.497242] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> gamma # [1547288.503554] gamma systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [1547288.503968] gamma systemd[1]: Starting Update is Completed... container-test-run-data-mesher> gamma # [1547288.509691] gamma systemd[1]: Finished Update is Completed. container-test-run-data-mesher> alpha # [1547288.969992] alpha systemd-networkd[203]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [1547288.970059] alpha systemd-networkd[203]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [1547288.977015] alpha systemd-networkd[203]: /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 # [1547288.977161] alpha systemd-networkd[203]: /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 # [1547288.977211] alpha systemd-networkd[203]: lo: Link UP container-test-run-data-mesher> alpha # [1547288.977212] alpha systemd-networkd[203]: lo: Gained carrier container-test-run-data-mesher> alpha # [1547288.977324] alpha systemd-networkd[203]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> alpha # [1547288.977519] alpha systemd[1]: Started Network Management. container-test-run-data-mesher> alpha # [1547288.977569] alpha systemd-networkd[203]: eth1: Link UP container-test-run-data-mesher> alpha # [1547288.977699] alpha systemd-networkd[203]: eth1: Gained carrier container-test-run-data-mesher> alpha # [1547288.977949] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> alpha # [1547288.990974] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> gamma # [1547288.965132] gamma systemd-networkd[200]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [1547288.965195] gamma systemd-networkd[200]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [1547288.972183] gamma systemd-networkd[200]: /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 # [1547288.972328] gamma systemd-networkd[200]: /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 # [1547288.972419] gamma systemd-networkd[200]: lo: Link UP container-test-run-data-mesher> gamma # [1547288.972422] gamma systemd-networkd[200]: lo: Gained carrier container-test-run-data-mesher> gamma # [1547288.972548] gamma systemd-networkd[200]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> gamma # [1547288.972824] gamma systemd[1]: Started Network Management. container-test-run-data-mesher> gamma # [1547288.973099] gamma systemd-networkd[200]: eth1: Link UP container-test-run-data-mesher> gamma # [1547288.973213] gamma systemd-networkd[200]: eth1: Gained carrier container-test-run-data-mesher> gamma # [1547288.973673] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> gamma # [1547288.990135] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> beta # [1547288.942020] beta systemd-networkd[200]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [1547288.942089] beta systemd-networkd[200]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [1547288.949028] beta systemd-networkd[200]: /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 # [1547288.949173] beta systemd-networkd[200]: /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 # [1547288.949237] beta systemd-networkd[200]: lo: Link UP container-test-run-data-mesher> beta # [1547288.949240] beta systemd-networkd[200]: lo: Gained carrier container-test-run-data-mesher> beta # [1547288.949362] beta systemd-networkd[200]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> beta # [1547288.949581] beta systemd[1]: Started Network Management. container-test-run-data-mesher> beta # [1547288.949663] beta systemd-networkd[200]: eth1: Link UP container-test-run-data-mesher> beta # [1547288.949666] beta systemd-networkd[200]: eth1: Gained carrier container-test-run-data-mesher> beta # [1547288.950046] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> beta # [1547288.976661] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> alpha # [1547289.311881] alpha systemd-resolved[128]: Positive Trust Anchors: container-test-run-data-mesher> alpha # [1547289.311890] alpha systemd-resolved[128]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> alpha # [1547289.311893] alpha systemd-resolved[128]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> alpha # [1547289.311917] alpha systemd-resolved[128]: 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 # [1547289.322554] alpha systemd-resolved[128]: Using system hostname 'alpha'. container-test-run-data-mesher> alpha # [1547289.323400] alpha systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> alpha # [1547289.323439] alpha systemd[1]: Reached target Network. container-test-run-data-mesher> alpha # [1547289.323470] alpha systemd[1]: Reached target System Initialization. container-test-run-data-mesher> alpha # [1547289.323498] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [1547289.323514] alpha systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> alpha # [1547289.323523] alpha systemd[1]: Reached target Timer Units. container-test-run-data-mesher> alpha # [1547289.323586] alpha systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> alpha # [1547289.323654] alpha systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> alpha # [1547289.323716] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> alpha # [1547289.323726] alpha systemd[1]: Reached target Socket Units. container-test-run-data-mesher> alpha # [1547289.323745] alpha systemd[1]: Reached target Basic System. container-test-run-data-mesher> alpha # [1547289.324318] alpha systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> alpha # [1547289.324635] alpha systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> alpha # [1547289.325018] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> alpha # [1547289.325606] alpha systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> alpha # [1547289.357946] alpha systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> alpha # [1547289.477419] alpha nsncd[214]: Sep 22 05:05:03.900 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> alpha # [1547289.477504] alpha systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> alpha # [1547289.477561] alpha systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> alpha # [1547289.477594] alpha systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> alpha # [1547289.502193] alpha systemd[1]: Starting User Login Management... container-test-run-data-mesher> alpha # [1547289.502588] alpha systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> alpha # [1547289.507740] alpha systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> alpha # [1547289.508147] alpha systemd[1]: Started Console Getty. container-test-run-data-mesher> alpha # [1547289.508164] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> alpha # [1547289.508178] alpha systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> alpha # [1547289.583835] alpha dbus-broker-launch[215]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> alpha # [1547289.584274] alpha dbus-broker-launch[215]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> alpha # [1547289.584274] alpha dbus-broker-launch[215]: Invalid user-name in /nix/store/pzm8nnfsn4xh0lajvw40idv8y3jlsd1l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> gamma # [1547289.319108] gamma systemd-resolved[126]: Positive Trust Anchors: container-test-run-data-mesher> gamma # [1547289.319116] gamma systemd-resolved[126]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> gamma # [1547289.319119] gamma systemd-resolved[126]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> gamma # [1547289.319134] gamma systemd-resolved[126]: 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 # [1547289.329143] gamma systemd-resolved[126]: Using system hostname 'gamma'. container-test-run-data-mesher> gamma # [1547289.329906] gamma systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> gamma # [1547289.329956] gamma systemd[1]: Reached target Network. container-test-run-data-mesher> gamma # [1547289.329995] gamma systemd[1]: Reached target System Initialization. container-test-run-data-mesher> gamma # [1547289.330060] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [1547289.330078] gamma systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> gamma # [1547289.330092] gamma systemd[1]: Reached target Timer Units. container-test-run-data-mesher> gamma # [1547289.330162] gamma systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> gamma # [1547289.330228] gamma systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> gamma # [1547289.330294] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> gamma # [1547289.330305] gamma systemd[1]: Reached target Socket Units. container-test-run-data-mesher> gamma # [1547289.330324] gamma systemd[1]: Reached target Basic System. container-test-run-data-mesher> gamma # [1547289.349214] gamma systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> gamma # [1547289.349691] gamma systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> gamma # [1547289.350263] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> gamma # [1547289.350938] gamma systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> gamma # [1547289.359443] gamma systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> gamma # [1547289.475360] gamma nsncd[214]: Sep 22 05:05:03.898 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [1547289.475385] gamma systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> gamma # [1547289.475422] gamma systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> gamma # [1547289.475469] gamma systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> gamma # [1547289.476337] gamma systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [1547289.476636] gamma systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> gamma # [1547289.505660] gamma systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> gamma # [1547289.506161] gamma systemd[1]: Started Console Getty. container-test-run-data-mesher> gamma # [1547289.506180] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> gamma # [1547289.506189] gamma systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> gamma # [1547289.592894] gamma dbus-broker-launch[215]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [1547289.343129] beta systemd-resolved[129]: Positive Trust Anchors: container-test-run-data-mesher> beta # [1547289.343135] beta systemd-resolved[129]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> beta # [1547289.343138] beta systemd-resolved[129]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> beta # [1547289.343153] beta systemd-resolved[129]: 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 # [1547289.354101] beta systemd-resolved[129]: Using system hostname 'beta'. container-test-run-data-mesher> beta # [1547289.355082] beta systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> beta # [1547289.355157] beta systemd[1]: Reached target Network. container-test-run-data-mesher> beta # [1547289.355205] beta systemd[1]: Reached target System Initialization. container-test-run-data-mesher> beta # [1547289.355247] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [1547289.355267] beta systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> beta # [1547289.355278] beta systemd[1]: Reached target Timer Units. container-test-run-data-mesher> beta # [1547289.355363] beta systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> beta # [1547289.355424] beta systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> beta # [1547289.355494] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> beta # [1547289.355505] beta systemd[1]: Reached target Socket Units. container-test-run-data-mesher> beta # [1547289.355525] beta systemd[1]: Reached target Basic System. container-test-run-data-mesher> beta # [1547289.356215] beta systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> beta # [1547289.356517] beta systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> beta # [1547289.356870] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> beta # [1547289.357445] beta systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> beta # [1547289.367240] beta systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> beta # [1547289.472930] beta nsncd[214]: Sep 22 05:05:03.896 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> beta # [1547289.472981] beta systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> beta # [1547289.473029] beta systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> beta # [1547289.473063] beta systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> beta # [1547289.474125] beta systemd[1]: Starting User Login Management... container-test-run-data-mesher> beta # [1547289.474486] beta systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> beta # [1547289.506373] beta systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> beta # [1547289.506912] beta systemd[1]: Started Console Getty. container-test-run-data-mesher> beta # [1547289.506937] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> beta # [1547289.506952] beta systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [1547289.584720] beta dbus-broker-launch[215]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [1547289.585034] beta dbus-broker-launch[215]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [1547289.585034] beta dbus-broker-launch[215]: Invalid user-name in /nix/store/pzm8nnfsn4xh0lajvw40idv8y3jlsd1l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> beta # [1547289.585252] beta systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> beta # [1547289.588817] beta dbus-broker-launch[215]: Ready container-test-run-data-mesher> alpha # [1547289.584534] alpha systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> alpha # [1547289.588084] alpha dbus-broker-launch[215]: Ready container-test-run-data-mesher> alpha # [1547289.803487] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> alpha # [1547289.804078] alpha systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> gamma # [1547289.593387] gamma dbus-broker-launch[215]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> gamma # [1547289.593387] gamma dbus-broker-launch[215]: Invalid user-name in /nix/store/pzm8nnfsn4xh0lajvw40idv8y3jlsd1l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> gamma # [1547289.593675] gamma systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> gamma # [1547289.596995] gamma dbus-broker-launch[215]: Ready container-test-run-data-mesher> gamma # [1547289.800375] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> gamma # [1547289.800897] gamma systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> beta # [1547289.805103] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> beta # [1547289.805527] beta systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> beta # [1547289.917407] beta data-mesher[212]: time=2026-09-22T05:05:04.340Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [1547289.917745] beta data-mesher[212]: time=2026-09-22T05:05:04.341Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD: [/dns/alpha.clan/tcp/7946]} {12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> beta # [1547289.917745] beta data-mesher[212]: time=2026-09-22T05:05:04.341Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> beta # [1547289.930324] beta data-mesher[212]: time=2026-09-22T05:05:04.353Z level=INFO msg="checking file integrity" container-test-run-data-mesher> beta # [1547289.930398] beta data-mesher[212]: time=2026-09-22T05:05:04.353Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> beta # [1547289.933410] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="libp2p host created" peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V 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 # [1547289.933465] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> beta # [1547289.933465] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> beta # [1547289.933465] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> beta # [1547289.933465] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="starting server" container-test-run-data-mesher> beta # [1547289.933539] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> beta # [1547289.933539] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> beta # [1547289.933539] beta data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [1547289.935092] beta data-mesher[212]: time=2026-09-22T05:05:04.358Z level=INFO msg="peer connected" peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> beta # [1547289.939462] beta data-mesher[212]: time=2026-09-22T05:05:04.362Z level=INFO msg="peer connected" peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> gamma # [1547289.921534] gamma data-mesher[212]: time=2026-09-22T05:05:04.344Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> gamma # [1547289.921826] gamma data-mesher[212]: time=2026-09-22T05:05:04.345Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD: [/dns/alpha.clan/tcp/7946]} {12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> gamma # [1547289.921914] gamma data-mesher[212]: time=2026-09-22T05:05:04.345Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> gamma # [1547289.930393] gamma data-mesher[212]: time=2026-09-22T05:05:04.353Z level=INFO msg="checking file integrity" container-test-run-data-mesher> gamma # [1547289.930471] gamma data-mesher[212]: time=2026-09-22T05:05:04.353Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> gamma # [1547289.933052] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="libp2p host created" peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE 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 # [1547289.933081] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> gamma # [1547289.933081] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> gamma # [1547289.933081] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> gamma # [1547289.933081] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="starting server" container-test-run-data-mesher> gamma # [1547289.933139] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [1547289.933181] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> gamma # [1547289.933214] gamma data-mesher[212]: time=2026-09-22T05:05:04.356Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> gamma # [1547289.934895] gamma data-mesher[212]: time=2026-09-22T05:05:04.358Z level=INFO msg="peer connected" peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> gamma # [1547289.941963] gamma data-mesher[212]: time=2026-09-22T05:05:04.365Z level=INFO msg="peer connected" peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> gamma # [1547290.072462] gamma systemd-logind[231]: New seat seat0. container-test-run-data-mesher> gamma # [1547290.072556] gamma systemd[1]: Started User Login Management. container-test-run-data-mesher> gamma # [1547290.073226] gamma systemd[1]: Starting linger-users.service... container-test-run-data-mesher> gamma # [1547290.101700] gamma systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> gamma # [1547290.101734] gamma systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [1547290.088632] beta systemd-logind[231]: New seat seat0. container-test-run-data-mesher> beta # [1547290.088726] beta systemd[1]: Started User Login Management. container-test-run-data-mesher> beta # [1547290.095186] beta systemd[1]: Starting linger-users.service... container-test-run-data-mesher> beta # [1547290.101245] beta systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [1547290.101394] beta systemd[1]: Finished linger-users.service. container-test-run-data-mesher> alpha # [1547289.933344] alpha data-mesher[212]: time=2026-09-22T05:05:04.356Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> alpha # [1547289.933699] alpha data-mesher[212]: time=2026-09-22T05:05:04.357Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD: [/dns/alpha.clan/tcp/7946]} {12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> alpha # [1547289.933724] alpha data-mesher[212]: time=2026-09-22T05:05:04.357Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> alpha # [1547289.934858] alpha data-mesher[212]: time=2026-09-22T05:05:04.358Z level=INFO msg="checking file integrity" container-test-run-data-mesher> alpha # [1547289.934934] alpha data-mesher[212]: time=2026-09-22T05:05:04.358Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> alpha # [1547289.937729] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="libp2p host created" peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD 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 # [1547289.937762] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [1547289.937762] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> alpha # [1547289.937762] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> alpha # [1547289.937762] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [1547289.937825] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> alpha # [1547289.937845] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> alpha # [1547289.937864] alpha data-mesher[212]: time=2026-09-22T05:05:04.361Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> alpha # [1547289.939310] alpha data-mesher[212]: time=2026-09-22T05:05:04.362Z level=INFO msg="peer connected" peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> alpha # [1547289.941760] alpha data-mesher[212]: time=2026-09-22T05:05:04.365Z level=INFO msg="peer connected" peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> alpha # [1547290.048084] alpha systemd-networkd[203]: eth1: Gained IPv6LL container-test-run-data-mesher> alpha # [1547290.071697] alpha systemd-logind[231]: New seat seat0. container-test-run-data-mesher> alpha # [1547290.071821] alpha systemd[1]: Started User Login Management. container-test-run-data-mesher> alpha # [1547290.072566] alpha systemd[1]: Starting linger-users.service... container-test-run-data-mesher> alpha # [1547290.100222] alpha systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> alpha # [1547290.100299] alpha systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [1547290.816075] beta systemd-networkd[200]: eth1: Gained IPv6LL container-test-run-data-mesher> gamma # [1547290.688078] gamma systemd-networkd[200]: 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.14 seconds) container-test-run-data-mesher> beta: waiting for unit data-mesher.service container-test-run-data-mesher> beta: (finished: waiting for unit data-mesher.service, in 0.01 seconds) container-test-run-data-mesher> gamma: waiting for unit data-mesher.service container-test-run-data-mesher> gamma: (finished: waiting for unit data-mesher.service, in 0.01 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'hello world' > /tmp/test_file container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'hello world' > /tmp/test_file, in 0.00 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-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/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.07 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/v4mkgp543y0bvj1gi240ypfx69ql1qmn-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/v4mkgp543y0bvj1gi240ypfx69ql1qmn-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 0.00 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> beta # [1547299.935172] beta data-mesher[212]: time=2026-09-22T05:05:14.358Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> beta # [1547299.935172] beta data-mesher[212]: time=2026-09-22T05:05:14.358Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> beta # [1547299.935674] beta data-mesher[212]: time=2026-09-22T05:05:14.358Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547299.935674] beta data-mesher[212]: time=2026-09-22T05:05:14.358Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> beta # [1547299.935674] beta data-mesher[212]: time=2026-09-22T05:05:14.358Z level=INFO msg="server started" container-test-run-data-mesher> beta # [1547299.935776] beta data-mesher[212]: time=2026-09-22T05:05:14.359Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> beta # [1547299.935799] beta systemd[1]: Started data mesher daemon. container-test-run-data-mesher> beta # [1547299.935949] beta systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> beta # [1547299.936035] beta systemd[1]: Startup finished in 11.782s. container-test-run-data-mesher> alpha # [1547299.935572] alpha data-mesher[212]: time=2026-09-22T05:05:14.358Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> alpha # [1547299.935572] alpha data-mesher[212]: time=2026-09-22T05:05:14.358Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> alpha # [1547299.935888] alpha data-mesher[212]: time=2026-09-22T05:05:14.359Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> alpha # [1547299.935888] alpha data-mesher[212]: time=2026-09-22T05:05:14.359Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> alpha # [1547299.938000] alpha data-mesher[212]: time=2026-09-22T05:05:14.361Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> alpha # [1547299.938049] alpha data-mesher[212]: time=2026-09-22T05:05:14.361Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> alpha # [1547299.938259] alpha data-mesher[212]: time=2026-09-22T05:05:14.361Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> gamma # [1547299.935209] gamma data-mesher[212]: time=2026-09-22T05:05:14.358Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> alpha # [1547299.938259] alpha data-mesher[212]: time=2026-09-22T05:05:14.361Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> gamma # [1547299.935209] gamma data-mesher[212]: time=2026-09-22T05:05:14.358Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> alpha # [1547299.938304] alpha data-mesher[212]: time=2026-09-22T05:05:14.361Z level=INFO msg="server started" container-test-run-data-mesher> gamma # [1547299.935766] gamma data-mesher[212]: time=2026-09-22T05:05:14.359Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> alpha # [1547299.938382] alpha data-mesher[212]: time=2026-09-22T05:05:14.361Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [1547299.935766] gamma data-mesher[212]: time=2026-09-22T05:05:14.359Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> alpha # [1547299.938411] alpha systemd[1]: Started data mesher daemon. container-test-run-data-mesher> alpha # [1547299.938536] alpha systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> alpha # [1547299.938617] alpha systemd[1]: Startup finished in 11.787s. container-test-run-data-mesher> gamma # [1547299.935819] gamma data-mesher[212]: time=2026-09-22T05:05:14.359Z level=INFO msg="server started" container-test-run-data-mesher> alpha # [1547300.105107] alpha data-mesher[212]: time=2026-09-22T05:05:14.528Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> gamma # [1547299.935872] gamma data-mesher[212]: time=2026-09-22T05:05:14.359Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [1547299.935958] gamma systemd[1]: Started data mesher daemon. container-test-run-data-mesher> gamma # [1547299.936122] gamma systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> gamma # [1547299.936216] gamma systemd[1]: Startup finished in 11.783s. container-test-run-data-mesher> gamma # [1547299.938185] gamma data-mesher[212]: time=2026-09-22T05:05:14.361Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> gamma # [1547299.938185] gamma data-mesher[212]: time=2026-09-22T05:05:14.361Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD 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.02 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.00 seconds) container-test-run-data-mesher> beta: waiting for success: data-mesher file delete test_file --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-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/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-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 # [1547304.937934] beta data-mesher[212]: time=2026-09-22T05:05:19.361Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [1547304.937934] beta data-mesher[212]: time=2026-09-22T05:05:19.361Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> beta # [1547304.938780] beta data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547304.938832] beta data-mesher[212]: time=2026-09-22T05:05:19.362Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_file container-test-run-data-mesher> beta # [1547304.938832] beta data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> beta # [1547304.938832] beta data-mesher[212]: time=2026-09-22T05:05:19.362Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [1547304.938832] beta data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> beta # [1547304.938905] beta data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-22 05:05:14.469 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547304.978169] beta data-mesher[212]: time=2026-09-22T05:05:19.401Z level=INFO msg="download complete" name=test_file signed_at="2026-09-22 05:05:14.469 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=39.322592ms container-test-run-data-mesher> beta # [1547305.178500] beta data-mesher[212]: time=2026-09-22T05:05:19.601Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> alpha # [1547304.937383] alpha data-mesher[212]: time=2026-09-22T05:05:19.360Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> gamma # [1547304.937072] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [1547304.937383] alpha data-mesher[212]: time=2026-09-22T05:05:19.360Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> gamma # [1547304.937341] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> alpha # [1547304.937834] alpha data-mesher[212]: time=2026-09-22T05:05:19.361Z level=INFO msg="received file request" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file container-test-run-data-mesher> gamma # [1547304.937549] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> alpha # [1547304.938597] alpha data-mesher[212]: time=2026-09-22T05:05:19.361Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [1547304.937575] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_file container-test-run-data-mesher> alpha # [1547304.938626] alpha data-mesher[212]: time=2026-09-22T05:05:19.361Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> gamma # [1547304.937575] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> gamma # [1547304.937599] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [1547304.937637] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> gamma # [1547304.937669] gamma data-mesher[212]: time=2026-09-22T05:05:19.360Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-22 05:05:14.469 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> alpha # [1547304.938626] alpha data-mesher[212]: time=2026-09-22T05:05:19.361Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547304.938759] gamma data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> alpha # [1547304.938670] alpha data-mesher[212]: time=2026-09-22T05:05:19.361Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> alpha # [1547304.938735] alpha data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="file transfer complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file container-test-run-data-mesher> gamma # [1547304.938759] gamma data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> alpha # [1547304.938840] alpha data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> gamma # [1547304.938803] gamma data-mesher[212]: time=2026-09-22T05:05:19.362Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_file container-test-run-data-mesher> alpha # [1547304.938840] alpha data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> gamma # [1547304.978169] gamma data-mesher[212]: time=2026-09-22T05:05:19.401Z level=INFO msg="download complete" name=test_file signed_at="2026-09-22 05:05:14.469 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=40.514656ms container-test-run-data-mesher> alpha # [1547304.938899] alpha data-mesher[212]: time=2026-09-22T05:05:19.362Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [1547304.939085] alpha data-mesher[212]: time=2026-09-22T05:05:19.362Z level=INFO msg="received file request" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file container-test-run-data-mesher> alpha # [1547304.939706] alpha data-mesher[212]: time=2026-09-22T05:05:19.363Z level=INFO msg="file transfer complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file container-test-run-data-mesher> alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.02 seconds) container-test-run-data-mesher> beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.00 seconds) container-test-run-data-mesher> gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.00 seconds) container-test-run-data-mesher> alpha: must succeed: cat /nix/store/yh5m00imp0p5g1zrjprzlc089ql5nn61-per-machine-alpha-data-mesher-node-identity_identity.pub container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/yh5m00imp0p5g1zrjprzlc089ql5nn61-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.00 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.00 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert container-test-run-data-mesher> alpha # [1547309.939156] alpha data-mesher[212]: time=2026-09-22T05:05:24.362Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [1547309.939156] alpha data-mesher[212]: time=2026-09-22T05:05:24.362Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> alpha # [1547310.077413] alpha data-mesher[212]: time=2026-09-22T05:05:24.362Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> alpha # [1547310.078710] alpha data-mesher[212]: time=2026-09-22T05:05:24.502Z level=DEBUG msg="imported tombstone" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file written=true container-test-run-data-mesher> alpha # [1547310.078710] alpha data-mesher[212]: time=2026-09-22T05:05:24.502Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> alpha # [1547310.078803] alpha data-mesher[212]: time=2026-09-22T05:05:24.502Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [1547310.221865] alpha data-mesher[212]: time=2026-09-22T05:05:24.645Z level=INFO msg=http_request uri=/files/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g status=204 container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.01 seconds) container-test-run-data-mesher> alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g, in 0.00 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> beta # [1547309.938420] beta data-mesher[212]: time=2026-09-22T05:05:24.361Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547309.938420] beta data-mesher[212]: time=2026-09-22T05:05:24.361Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547309.939456] beta data-mesher[212]: time=2026-09-22T05:05:24.362Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [1547310.077019] beta data-mesher[212]: time=2026-09-22T05:05:24.362Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> beta # [1547310.077019] beta data-mesher[212]: time=2026-09-22T05:05:24.362Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547310.077019] beta data-mesher[212]: time=2026-09-22T05:05:24.362Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547310.078367] beta data-mesher[212]: time=2026-09-22T05:05:24.501Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547310.078449] beta data-mesher[212]: time=2026-09-22T05:05:24.501Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> beta # [1547310.078449] beta data-mesher[212]: time=2026-09-22T05:05:24.501Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [1547309.938051] gamma data-mesher[212]: time=2026-09-22T05:05:24.361Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [1547309.938380] gamma data-mesher[212]: time=2026-09-22T05:05:24.361Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> gamma # [1547309.938491] gamma data-mesher[212]: time=2026-09-22T05:05:24.361Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547309.939595] gamma data-mesher[212]: time=2026-09-22T05:05:24.362Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547309.939595] gamma data-mesher[212]: time=2026-09-22T05:05:24.362Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547310.078148] gamma data-mesher[212]: time=2026-09-22T05:05:24.501Z level=DEBUG msg="imported tombstone" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file written=true container-test-run-data-mesher> gamma # [1547310.078148] gamma data-mesher[212]: time=2026-09-22T05:05:24.501Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> gamma # [1547310.078252] gamma data-mesher[212]: time=2026-09-22T05:05:24.501Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [1547310.078252] gamma data-mesher[212]: time=2026-09-22T05:05:24.501Z level=DEBUG msg="imported tombstone" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file written=false container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g, in 5.02 seconds) container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> beta # [1547315.078850] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [1547315.078850] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> beta # [1547315.079173] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547315.079173] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547315.079301] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547315.079322] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547315.079322] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547315.079383] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> beta # [1547315.079383] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> beta # [1547315.079411] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s container-test-run-data-mesher> beta # [1547315.079411] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [1547315.079411] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="scheduling file download" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> beta # [1547315.079457] beta data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="downloading file" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 05:05:24.644 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> beta # [1547315.080497] beta data-mesher[212]: time=2026-09-22T05:05:29.503Z level=INFO msg="download complete" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 05:05:24.644 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=1.082599ms container-test-run-data-mesher> alpha # [1547315.079043] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [1547315.079043] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> alpha # [1547315.079439] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> alpha # [1547315.079439] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> alpha # [1547315.079484] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> alpha # [1547315.079484] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> alpha # [1547315.079484] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [1547315.079534] alpha data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="received file request" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> alpha # [1547315.080199] alpha data-mesher[212]: time=2026-09-22T05:05:29.503Z level=INFO msg="file transfer complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> gamma # [1547315.078596] gamma data-mesher[212]: time=2026-09-22T05:05:29.501Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [1547315.078596] gamma data-mesher[212]: time=2026-09-22T05:05:29.501Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> gamma # [1547315.079054] gamma data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547315.079054] gamma data-mesher[212]: time=2026-09-22T05:05:29.502Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> gamma # [1547315.079139] gamma data-mesher[212]: time=2026-09-22T05:05:29.502Z 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/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g, in 5.02 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'no_cert' > /tmp/ns_nocert container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'no_cert' > /tmp/ns_nocert, in 0.00 seconds) container-test-run-data-mesher> alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g= is not authorized for this file test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub, in 0.01 seconds) container-test-run-data-mesher> (finished: run the VM test script, in 32.41 seconds) container-test-run-data-mesher> test script finished in 32.47s container-test-run-data-mesher> cleanup container-test-run-data-mesher> kill NspawnMachine (pid 53) container-test-run-data-mesher> beta # [1547320.079817] beta data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [1547320.079817] beta data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> beta # [1547320.080142] beta data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547320.080142] beta data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547320.080280] beta data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> beta # [1547320.080314] beta data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> beta # [1547320.080314] beta data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [1547320.079786] alpha data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [1547320.079786] alpha data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> alpha # [1547320.080207] alpha data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE container-test-run-data-mesher> alpha # [1547320.080239] alpha data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s container-test-run-data-mesher> alpha # [1547320.080239] alpha data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [1547320.080442] alpha data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="received file request" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> alpha # [1547320.081106] alpha data-mesher[212]: time=2026-09-22T05:05:34.504Z level=INFO msg="file transfer complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> alpha # [1547320.278858] alpha data-mesher[212]: time=2026-09-22T05:05:34.702Z level=INFO msg=http_request uri=/files/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g status=403 container-test-run-data-mesher> kill NspawnMachine (pid 54) container-test-run-data-mesher> gamma # [1547320.079757] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [1547320.079757] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> gamma # [1547320.080142] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> gamma # [1547320.080142] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> gamma # [1547320.080142] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547320.080142] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547320.080224] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> gamma # [1547320.080224] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="new file detected" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> gamma # [1547320.080224] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="scheduling file download" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> gamma # [1547320.080224] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V container-test-run-data-mesher> gamma # [1547320.080282] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="new file detected" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g container-test-run-data-mesher> gamma # [1547320.080282] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="downloading file" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 05:05:24.644 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD container-test-run-data-mesher> gamma # [1547320.080282] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s container-test-run-data-mesher> gamma # [1547320.080322] gamma data-mesher[212]: time=2026-09-22T05:05:34.503Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [1547320.081485] gamma data-mesher[212]: time=2026-09-22T05:05:34.504Z level=INFO msg="download complete" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 05:05:24.644 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=1.26381ms container-test-run-data-mesher> Container alpha terminated by signal KILL. container-test-run-data-mesher> kill NspawnMachine (pid 55) container-test-run-data-mesher> Container beta terminated by signal KILL. container-test-run-data-mesher> Container gamma terminated by signal KILL. container-test-run-data-mesher> (finished: cleanup, in 0.26 seconds) post-build step Upload to niks3: ok time=2026-09-22T05:05:35.616Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)" time=2026-09-22T05:05:36.950Z level=INFO msg="Uploading 1 narinfos" time=2026-09-22T05:05:37.800Z level=INFO msg="Upload complete. (2.315s)"