warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user building '/nix/store/ar3zajlxj7jbbldksnjd9viqbhczli9j-X-Restart-Triggers-sshd.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-sshd> gi-build-x86-01: building ar3zajlxj7jbbldksnjd9viqbhczli9j-X-Restart-Triggers-sshd.drv X-Restart-Triggers-sshd> structuredAttrs is enabled building '/nix/store/q92pj8sbazk67gqgm5h0qharj93hzwq3-test-script.drv' on nix-store.geninf.io:50051 test-script> gi-build-x86-02: building q92pj8sbazk67gqgm5h0qharj93hzwq3-test-script.drv test-script> structuredAttrs is enabled building '/nix/store/6jfs1ysaa6f6g3pa51kd43dal1zkhhcz-unit-sshd.service.drv' on nix-store.geninf.io:50051 unit-sshd.service> gi-build-x86-01: building 6jfs1ysaa6f6g3pa51kd43dal1zkhhcz-unit-sshd.service.drv unit-sshd.service> structuredAttrs is enabled building '/nix/store/sc36p5i9agrbxl3sjm8khkxlqji90fp8-system-path.drv' on nix-store.geninf.io:50051 system-path> web01: building sc36p5i9agrbxl3sjm8khkxlqji90fp8-system-path.drv system-path> structuredAttrs is enabled system-path> created 1660 symlinks in user environment building '/nix/store/j4dlwclzqwn04p27i8yiv5mmx6ff728n-users-groups.json.drv' on nix-store.geninf.io:50051 users-groups.json> build-x86-01: building j4dlwclzqwn04p27i8yiv5mmx6ff728n-users-groups.json.drv users-groups.json> structuredAttrs is enabled building '/nix/store/ws58vcdwcxyd2lv2f5sdvcnxzbgz5la9-dbus-1.drv' on nix-store.geninf.io:50051 dbus-1> web01: building ws58vcdwcxyd2lv2f5sdvcnxzbgz5la9-dbus-1.drv building '/nix/store/q9aq2z79yj20k328q2i73qf9gh0rvg5a-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-dbus-broker> web01: building q9aq2z79yj20k328q2i73qf9gh0rvg5a-X-Restart-Triggers-dbus-broker.drv X-Restart-Triggers-dbus-broker> structuredAttrs is enabled building '/nix/store/qpfsjidrwhw2dzc742xrvg3v3p92kxjk-nix.conf.drv' on nix-store.geninf.io:50051 nix.conf> attached to the build already running on this worker nix.conf> build-x86-01: building qpfsjidrwhw2dzc742xrvg3v3p92kxjk-nix.conf.drv nix.conf> structuredAttrs is enabled nix.conf> Validating generated nix.conf building '/nix/store/r012pcq4zfhjim8q7ffdc63a3i5y15vp-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> web01: building r012pcq4zfhjim8q7ffdc63a3i5y15vp-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/67pgbwf3glp6ppfn5q1ll56fxl1jlsfa-dry-activate.drv' on nix-store.geninf.io:50051 dry-activate> web01: building 67pgbwf3glp6ppfn5q1ll56fxl1jlsfa-dry-activate.drv dry-activate> structuredAttrs is enabled building '/nix/store/s4vij0xj7jil226zkd5yiq383jwbgs2f-X-Restart-Triggers-nix-daemon.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-nix-daemon> attached to the build already running on this worker X-Restart-Triggers-nix-daemon> build-x86-01: building s4vij0xj7jil226zkd5yiq383jwbgs2f-X-Restart-Triggers-nix-daemon.drv X-Restart-Triggers-nix-daemon> structuredAttrs is enabled building '/nix/store/mrk0b3gpvvgc9mz9bnl804kdr0cxgk8b-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build-x86-01: building mrk0b3gpvvgc9mz9bnl804kdr0cxgk8b-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/q9b0w00p3g66f4611g4rksh0z0k42gs1-unit-nix-daemon.service.drv' on nix-store.geninf.io:50051 unit-nix-daemon.service> gi-build-x86-02: building q9b0w00p3g66f4611g4rksh0z0k42gs1-unit-nix-daemon.service.drv unit-nix-daemon.service> structuredAttrs is enabled building '/nix/store/cki8qz7wp249ql9q2xjcldd69i081p2s-system-units.drv' on nix-store.geninf.io:50051 system-units> gi-build-x86-02: building cki8qz7wp249ql9q2xjcldd69i081p2s-system-units.drv building '/nix/store/mqnih18ssj2jh163ky5nh8wii5jm6f8p-system-units.drv' on nix-store.geninf.io:50051 system-units> gi-build-x86-02: building mqnih18ssj2jh163ky5nh8wii5jm6f8p-system-units.drv building '/nix/store/wi7irp0imid7lbyzmlnhd8mw2v66fj45-user-units.drv' on nix-store.geninf.io:50051 user-units> gi-build-x86-02: building wi7irp0imid7lbyzmlnhd8mw2v66fj45-user-units.drv building '/nix/store/qv2wmfc2w105nr3nww2mhcgl12w6y1rf-etc.drv' on nix-store.geninf.io:50051 etc> web01: building qv2wmfc2w105nr3nww2mhcgl12w6y1rf-etc.drv building '/nix/store/z4mjkm83pw5ymlxwd4f60qipaq4vgdg5-activate.drv' on nix-store.geninf.io:50051 activate> web01: building z4mjkm83pw5ymlxwd4f60qipaq4vgdg5-activate.drv building '/nix/store/zl7hznbbra2i9xhqwqkxz5gjf7d35gvb-etc.drv' on nix-store.geninf.io:50051 etc> gi-build-x86-02: building zl7hznbbra2i9xhqwqkxz5gjf7d35gvb-etc.drv activate> structuredAttrs is enabled building '/nix/store/7xg6bb5l4p1r03159rr2sy7v8shf4cgy-nixos-system-machine1-test.drv' on nix-store.geninf.io:50051 nixos-system-machine1-test> web01: building 7xg6bb5l4p1r03159rr2sy7v8shf4cgy-nixos-system-machine1-test.drv nixos-system-machine1-test> structuredAttrs is enabled building '/nix/store/zvqj6cz2ddxvph1985nxvb85lq7vz3gj-run-machine1-nspawn.drv' on nix-store.geninf.io:50051 run-machine1-nspawn> web01: building zvqj6cz2ddxvph1985nxvb85lq7vz3gj-run-machine1-nspawn.drv building '/nix/store/ac8qrmdak2m3f6lckkh9s5686fx9vjl0-activate.drv' on nix-store.geninf.io:50051 activate> gi-build-x86-02: building ac8qrmdak2m3f6lckkh9s5686fx9vjl0-activate.drv activate> structuredAttrs is enabled building '/nix/store/p6vjx391mcyk2fwna9vp1bzq6crgl49q-nixos-system-machine2-test.drv' on nix-store.geninf.io:50051 nixos-system-machine2-test> build-x86-01: building p6vjx391mcyk2fwna9vp1bzq6crgl49q-nixos-system-machine2-test.drv nixos-system-machine2-test> structuredAttrs is enabled building '/nix/store/0i54q33d1v1i1gavxjp9afc6dpykk43x-run-machine2-nspawn.drv' on nix-store.geninf.io:50051 run-machine2-nspawn> build-x86-01: building 0i54q33d1v1i1gavxjp9afc6dpykk43x-run-machine2-nspawn.drv building '/nix/store/3vjw4rb83hxsvr119233c9mw2a8ad0sc-driverConfiguration.json.drv' on nix-store.geninf.io:50051 driverConfiguration.json> build-x86-01: building 3vjw4rb83hxsvr119233c9mw2a8ad0sc-driverConfiguration.json.drv driverConfiguration.json> structuredAttrs is enabled building '/nix/store/1cq664psdj0cljwmjzwdkl2mx5l6rszs-nixos-test-driver-container.drv' on nix-store.geninf.io:50051 nixos-test-driver-container> gi-build-x86-02: building 1cq664psdj0cljwmjzwdkl2mx5l6rszs-nixos-test-driver-container.drv nixos-test-driver-container> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-container> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-container> All checks passed! nixos-test-driver-container> Linting test script (enable/disable: config.skipLint) nixos-test-driver-container> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-container> All checks passed! building '/nix/store/c827qpkdhbyk0qp3l2i7jika41911bhr-container-test-run-container.drv' on nix-store.geninf.io:50051 container-test-run-container> build-x86-01: building c827qpkdhbyk0qp3l2i7jika41911bhr-container-test-run-container.drv container-test-run-container> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-container> start all VLans container-test-run-container> (finished: start all VLans, in 0.00 seconds) container-test-run-container> container-test-run-container> Test will time out and terminate in 3600.0 seconds container-test-run-container> run the VM test script container-test-run-container> additionally exposed symbols: container-test-run-container> machine1, machine2, container-test-run-container> vlan1, container-test-run-container> 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-container> start all VMs container-test-run-container> machine1: systemd-nspawn running (pid 52) container-test-run-container> machine2: systemd-nspawn running (pid 53) container-test-run-container> machine1: Waiting for journal at /build/vm-state-machine1/var/log/journal... container-test-run-container> machine2: Waiting for journal at /build/vm-state-machine2/var/log/journal... container-test-run-container> (finished: start all VMs, in 0.00 seconds) container-test-run-container> machine1: must succeed: systemctl status sshd container-test-run-container> nixos-nspawn(machine1): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-container> nixos-nspawn(machine1): 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-container> nixos-nspawn(machine2): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-container> nixos-nspawn(machine2): 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-container> 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-container> ░ Spawning container machine1 on /build/vm-state-machine1. container-test-run-container> 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-container> ░ Spawning container machine2 on /build/vm-state-machine2. container-test-run-container> machine1 # [1874847.570367] machine1 systemd-journald[57]: Journal started container-test-run-container> machine2 # [1874847.572464] machine2 systemd-journald[57]: Journal started container-test-run-container> machine1 # [1874847.570393] machine1 systemd-journald[57]: Runtime Journal (/run/log/journal/facee08d7ba04266b5333226a955eae6) is 8M, max 3.7G, 3.7G free. container-test-run-container> machine2 # [1874847.572492] machine2 systemd-journald[57]: Runtime Journal (/run/log/journal/d2748de43b694f9280951cf30156e472) is 8M, max 3.7G, 3.7G free. container-test-run-container> machine2 # [1874847.574336] machine2 systemd[1]: Finished Apply Kernel Variables. container-test-run-container> machine1 # [1874847.574319] machine1 systemd[1]: Finished Apply Kernel Variables. container-test-run-container> machine2 # [1874847.580116] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-container> machine1 # [1874847.580101] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-container> machine2 # [1874847.586972] machine2 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-container> machine1 # [1874847.586895] machine1 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-container> machine2 # [1874847.587272] machine2 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-container> machine1 # [1874847.587222] machine1 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-container> machine2 # [1874847.591442] machine2 systemd-journald[57]: Time spent on flushing to /var/log/journal/d2748de43b694f9280951cf30156e472 is 1.271ms for 6 entries. container-test-run-container> machine1 # [1874847.592145] machine1 systemd-journald[57]: Time spent on flushing to /var/log/journal/facee08d7ba04266b5333226a955eae6 is 1.299ms for 6 entries. container-test-run-container> machine2 # [1874847.591442] machine2 systemd-journald[57]: System Journal (/var/log/journal/d2748de43b694f9280951cf30156e472) is 8M, max 4G, 3.9G free. container-test-run-container> machine2 # [1874847.595269] machine2 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-container> machine1 # [1874847.592145] machine1 systemd-journald[57]: System Journal (/var/log/journal/facee08d7ba04266b5333226a955eae6) is 8M, max 4G, 3.9G free. container-test-run-container> machine1 # [1874847.595248] machine1 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-container> machine2 # [1874847.595610] machine2 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-container> machine1 # [1874847.595583] machine1 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-container> machine1 # [1874847.595639] machine1 systemd[1]: Reached target Local File Systems. container-test-run-container> machine2 # [1874847.595657] machine2 systemd[1]: Reached target Local File Systems. container-test-run-container> machine1 # [1874847.596115] machine1 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-container> machine2 # [1874847.596071] machine2 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-container> machine1 # [1874847.596140] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine2 # [1874847.596098] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine1 # [1874847.596450] machine1 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-container> machine2 # [1874847.596397] machine2 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-container> machine1 # [1874847.596463] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-container> machine2 # [1874847.596411] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-container> machine1 # [1874847.597863] machine1 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-container> machine2 # [1874847.597651] machine2 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-container> machine1 # [1874847.598239] machine1 systemd[1]: Starting Create System Files and Directories... container-test-run-container> machine2 # [1874847.598015] machine2 systemd[1]: Starting Create System Files and Directories... container-test-run-container> machine1 # [1874847.610272] machine1 systemd-tmpfiles[102]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-container> machine2 # [1874847.609984] machine2 systemd-tmpfiles[102]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-container> machine1 # [1874847.610420] machine1 systemd-tmpfiles[102]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-container> machine2 # [1874847.610135] machine2 systemd-tmpfiles[102]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-container> machine1 # [1874847.610525] machine1 systemd-tmpfiles[102]: fchmod() of /var/log/journal/facee08d7ba04266b5333226a955eae6 failed: Operation not permitted container-test-run-container> machine2 # [1874847.610236] machine2 systemd-tmpfiles[102]: fchmod() of /var/log/journal/d2748de43b694f9280951cf30156e472 failed: Operation not permitted container-test-run-container> machine1 # [1874847.610673] machine1 systemd-tmpfiles[102]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-container> machine2 # [1874847.610384] machine2 systemd-tmpfiles[102]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-container> machine1 # [1874847.612012] machine1 systemd[1]: Finished Create System Files and Directories. container-test-run-container> machine2 # [1874847.611972] machine2 systemd[1]: Finished Create System Files and Directories. container-test-run-container> machine1 # [1874847.612488] machine1 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-container> machine2 # [1874847.612407] machine2 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-container> machine1 # [1874847.613042] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-container> machine2 # [1874847.612874] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-container> machine1 # [1874847.614206] machine1 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-container> machine2 # [1874847.614665] machine2 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-container> machine1 # [1874847.619268] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-container> machine2 # [1874847.619219] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-container> machine1 # [1874847.625684] machine1 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-container> machine2 # [1874847.624841] machine2 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-container> machine1 # [1874847.626152] machine1 systemd[1]: Starting Update is Completed... container-test-run-container> machine2 # [1874847.625296] machine2 systemd[1]: Starting Update is Completed... container-test-run-container> machine1 # [1874847.631263] machine1 systemd[1]: Finished Update is Completed. container-test-run-container> machine2 # [1874847.630522] machine2 systemd[1]: Finished Update is Completed. container-test-run-container> machine1 # [1874847.631319] machine1 systemd[1]: Reached target System Initialization. container-test-run-container> machine2 # [1874847.630586] machine2 systemd[1]: Reached target System Initialization. container-test-run-container> machine1 # [1874847.631363] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine2 # [1874847.630641] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine1 # [1874847.631381] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-container> machine2 # [1874847.630661] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-container> machine2 # [1874847.630670] machine2 systemd[1]: Reached target Timer Units. container-test-run-container> machine2 # [1874847.630736] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-container> machine2 # [1874847.630802] machine2 systemd[1]: Listening on Nix Daemon Socket. container-test-run-container> machine1 # [1874847.631393] machine1 systemd[1]: Reached target Timer Units. container-test-run-container> machine2 # [1874847.631334] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-container> machine2 # [1874847.631763] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-container> machine2 # [1874847.631821] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-container> machine2 # [1874847.631829] machine2 systemd[1]: Reached target Socket Units. container-test-run-container> machine2 # [1874847.631849] machine2 systemd[1]: Reached target Basic System. container-test-run-container> machine1 # [1874847.631457] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-container> machine2 # [1874847.632377] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-container> machine1 # [1874847.631517] machine1 systemd[1]: Listening on Nix Daemon Socket. container-test-run-container> machine2 # [1874847.632770] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine1 # [1874847.632043] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-container> machine2 # [1874847.633095] machine2 systemd[1]: Starting SSH Host Keys Generation... container-test-run-container> machine1 # [1874847.632484] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-container> machine1 # [1874847.632548] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-container> machine2 # [1874847.641521] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-container> machine1 # [1874847.632555] machine1 systemd[1]: Reached target Socket Units. container-test-run-container> machine2 # [1874847.657655] machine2 systemd[1]: Finished Firewall. container-test-run-container> machine1 # [1874847.632575] machine1 systemd[1]: Reached target Basic System. container-test-run-container> machine2 # [1874847.657735] machine2 systemd[1]: Reached target Preparation for Network. container-test-run-container> machine1 # [1874847.632985] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-container> machine2 # [1874847.658075] machine2 systemd[1]: Starting Address configuration of eth1... container-test-run-container> machine1 # [1874847.633324] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine2 # [1874847.658439] machine2 systemd[1]: Starting Extra networking commands.... container-test-run-container> machine2 # [1874847.666872] machine2 network-addresses-eth1-start[182]: adding address 192.168.1.2/24... done container-test-run-container> machine1 # [1874847.633609] machine1 systemd[1]: Starting SSH Host Keys Generation... container-test-run-container> machine2 # [1874847.668271] machine2 network-addresses-eth1-start[182]: adding address 2001:db8:1::2/64... done container-test-run-container> machine1 # [1874847.643600] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-container> machine2 # [1874847.670203] machine2 systemd[1]: Finished Address configuration of eth1. container-test-run-container> machine1 # [1874847.657663] machine1 systemd[1]: Finished Firewall. container-test-run-container> machine2 # [1874847.686136] machine2 systemd[1]: nscd.service: Deactivated successfully. container-test-run-container> machine1 # [1874847.657732] machine1 systemd[1]: Reached target Preparation for Network. container-test-run-container> machine2 # [1874847.686200] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-container> machine1 # [1874847.658154] machine1 systemd[1]: Starting Address configuration of eth1... container-test-run-container> machine2 # [1874847.687322] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine1 # [1874847.658500] machine1 systemd[1]: Starting Extra networking commands.... container-test-run-container> machine2 # [1874847.709092] machine2 systemd[1]: Finished Extra networking commands.. container-test-run-container> machine1 # [1874847.667071] machine1 network-addresses-eth1-start[182]: adding address 192.168.1.1/24... done container-test-run-container> machine2 # [1874847.709203] machine2 systemd[1]: Reached target Network. container-test-run-container> machine1 # [1874847.668377] machine1 network-addresses-eth1-start[182]: adding address 2001:db8:1::1/64... done container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: Generating public/private rsa key pair. container-test-run-container> machine1 # [1874847.670492] machine1 systemd[1]: Finished Address configuration of eth1. container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key container-test-run-container> machine1 # [1874847.688278] machine1 systemd[1]: nscd.service: Deactivated successfully. container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub container-test-run-container> machine1 # [1874847.688343] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: The key fingerprint is: container-test-run-container> machine1 # [1874847.709140] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: SHA256:+5ix71vz3vWa1P77PbY8RzlGH8J2wcBXFHmsD/M5NTk root@machine2 container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: The key's randomart image is: container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: +---[RSA 4096]----+ container-test-run-container> machine1 # [1874847.709226] machine1 systemd[1]: Finished Extra networking commands.. container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | ..o+*| container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | . =o| container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | . ..+| container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | ++E.| container-test-run-container> machine1 # [1874847.709652] machine1 systemd[1]: Reached target Network. container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | S . +=O| container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | . B=| container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | o o o.=| container-test-run-container> machine1 # [1874847.783102] machine1 nsncd[242]: Sep 26 00:04:22.206 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-container> machine1 # [1874847.783162] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | * . +.B=| container-test-run-container> machine1 # [1874847.783200] machine1 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: | +o=. .*=/| container-test-run-container> machine1 # [1874847.783236] machine1 systemd[1]: Reached target User and Group Name Lookups. container-test-run-container> machine1 # [1874847.783751] machine1 systemd[1]: Starting User Login Management... container-test-run-container> machine2 # [1874847.777800] machine2 sshd-keygen-start[165]: +----[SHA256]-----+ container-test-run-container> machine2 # [1874847.782946] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-container> machine1 # [1874847.784018] machine1 systemd[1]: Starting Permit User Sessions... container-test-run-container> machine1 # [1874847.812236] machine1 systemd[1]: Finished Permit User Sessions. container-test-run-container> machine2 # [1874847.782998] machine2 nsncd[241]: Sep 26 00:04:22.206 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-container> machine2 # [1874847.782973] machine2 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-container> machine1 # [1874847.812634] machine1 systemd[1]: Started Console Getty. container-test-run-container> machine2 # [1874847.783010] machine2 systemd[1]: Reached target User and Group Name Lookups. container-test-run-container> machine1 # [1874847.812651] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-container> machine2 # [1874847.783551] machine2 systemd[1]: Starting User Login Management... container-test-run-container> machine1 # [1874847.812660] machine1 systemd[1]: Reached target Login Prompts. container-test-run-container> machine2 # [1874847.783863] machine2 systemd[1]: Starting Permit User Sessions... container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: Generating public/private rsa key pair. container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: Generating public/private ed25519 key pair. container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: The key fingerprint is: container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: The key fingerprint is: container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: SHA256:V87zqPd4QYbiB5XH06Bo2Bv2q35/PFqBhxm7Oc8P9Oo root@machine2 container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: The key's randomart image is: container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: SHA256:zaoWU95A+mgoldu5vRJM3srbZYSq15qt7HlccEUzjmU root@machine1 container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: The key's randomart image is: container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: +--[ED25519 256]--+ container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: +---[RSA 4096]----+ container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | o.o | container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | o .o.+ .| container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | .E | container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | . *.o+ . | container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | . =.o | container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | ooB. O | container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | . o ... | container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | S.oo=B.o | container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | .. .*=..| container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | o o ++. | container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | .o+o+.| container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | oo.*+o| container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: | .+o.*E++| container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | . B BS=+ | container-test-run-container> machine2 # [1874847.786522] machine2 sshd-keygen-start[265]: +----[SHA256]-----+ container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | . o @.+oo | container-test-run-container> machine2 # [1874847.787277] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully. container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | . o.X..o | container-test-run-container> machine2 # [1874847.809098] machine2 systemd[1]: Finished SSH Host Keys Generation. container-test-run-container> machine2 # [1874847.809624] machine2 systemd[1]: Starting SSH Daemon... container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | oB*=o | container-test-run-container> machine2 # [1874847.813194] machine2 systemd[1]: Finished Permit User Sessions. container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: | .+X*+. | container-test-run-container> machine2 # [1874847.813783] machine2 systemd[1]: Started Console Getty. container-test-run-container> machine1 # [1874847.882462] machine1 sshd-keygen-start[166]: +----[SHA256]-----+ container-test-run-container> machine2 # [1874847.813802] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: Generating public/private ed25519 key pair. container-test-run-container> machine2 # [1874847.813811] machine2 systemd[1]: Reached target Login Prompts. container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key container-test-run-container> machine2 # [1874847.816834] machine2 sshd[269]: Server listening on 0.0.0.0 port 22. container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub container-test-run-container> machine2 # [1874847.816853] machine2 sshd[269]: Server listening on :: port 22. container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: The key fingerprint is: container-test-run-container> machine2 # [1874847.816918] machine2 systemd[1]: Started SSH Daemon. container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: SHA256:iK2IXrTl9kUbTiUHaP5Vpxz5e7/1nhhhAGQHShngO0I root@machine1 container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: The key's randomart image is: container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: +--[ED25519 256]--+ container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: | ..o=*.. . | container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: | . .+o + + . | container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: | E .o. . +o = | container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: | . o.o +..o . | container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: | o.+o S+. o .| container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: | ...=.. +.o . ...| container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: |. .o.o + . +| container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: |. . . . . o =| container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: | . . . ++| container-test-run-container> machine1 # [1874847.889800] machine1 sshd-keygen-start[274]: +----[SHA256]-----+ container-test-run-container> machine1 # [1874847.890693] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully. container-test-run-container> machine1 # [1874847.890743] machine1 systemd[1]: Finished SSH Host Keys Generation. container-test-run-container> machine1 # [1874847.891246] machine1 systemd[1]: Starting SSH Daemon... container-test-run-container> machine1 # [1874847.918599] machine1 sshd[276]: Server listening on 0.0.0.0 port 22. container-test-run-container> machine1 # [1874847.918624] machine1 sshd[276]: Server listening on :: port 22. container-test-run-container> machine1 # [1874847.918750] machine1 systemd[1]: Started SSH Daemon. container-test-run-container> machine2 # [1874848.264815] machine2 systemd-logind[264]: New seat seat0. container-test-run-container> machine2 # [1874848.280166] machine2 systemd[1]: Starting D-Bus System Message Bus... container-test-run-container> machine2 # [1874848.280202] machine2 systemd[1]: Started User Login Management. container-test-run-container> machine2 # [1874848.280501] machine2 systemd[1]: Starting linger-users.service... container-test-run-container> machine2 # [1874848.286983] machine2 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-container> machine2 # [1874848.287035] machine2 systemd[1]: Finished linger-users.service. container-test-run-container> machine2 # [1874848.287113] machine2 systemd[1]: Reached target Multi-User System. container-test-run-container> machine2 # [1874848.433132] machine2 dbus-broker-launch[277]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-container> machine2 # [1874848.433499] machine2 dbus-broker-launch[277]: NSS returned no entry for 'systemd-timesync' container-test-run-container> machine2 # [1874848.433499] machine2 dbus-broker-launch[277]: Invalid user-name in /nix/store/saf38243khk5c31fxfqk8ha5xyams2cv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-container> machine2 # [1874848.433740] machine2 systemd[1]: Started D-Bus System Message Bus. container-test-run-container> machine2 # [1874848.433891] machine2 systemd[1]: Startup finished in 1.077s. container-test-run-container> machine2 # [1874848.437112] machine2 dbus-broker-launch[277]: Ready container-test-run-container> machine2 # [1874848.567493] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-container> machine1 # [1874848.257513] machine1 systemd-logind[259]: New seat seat0. container-test-run-container> machine1 # [1874848.258039] machine1 systemd[1]: Starting D-Bus System Message Bus... container-test-run-container> machine1 # [1874848.258096] machine1 systemd[1]: Started User Login Management. container-test-run-container> machine1 # [1874848.258528] machine1 systemd[1]: Starting linger-users.service... container-test-run-container> machine1 # [1874848.285171] machine1 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-container> machine1 # [1874848.285294] machine1 systemd[1]: Finished linger-users.service. container-test-run-container> machine1 # [1874848.285430] machine1 systemd[1]: Reached target Multi-User System. container-test-run-container> machine1 # [1874848.433593] machine1 dbus-broker-launch[277]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-container> machine1 # [1874848.434101] machine1 dbus-broker-launch[277]: NSS returned no entry for 'systemd-timesync' container-test-run-container> machine1 # [1874848.434101] machine1 dbus-broker-launch[277]: Invalid user-name in /nix/store/saf38243khk5c31fxfqk8ha5xyams2cv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-container> machine1 # [1874848.434433] machine1 systemd[1]: Started D-Bus System Message Bus. container-test-run-container> machine1 # [1874848.434567] machine1 systemd[1]: Startup finished in 1.073s. container-test-run-container> machine1 # [1874848.438033] machine1 dbus-broker-launch[277]: Ready container-test-run-container> machine1: (finished: must succeed: systemctl status sshd, in 1.64 seconds) container-test-run-container> machine2: must succeed: systemctl status sshd container-test-run-container> machine2: (finished: must succeed: systemctl status sshd, in 0.01 seconds) container-test-run-container> machine1: waiting for unit sshd container-test-run-container> machine1: (finished: waiting for unit sshd, in 0.01 seconds) container-test-run-container> machine2: waiting for unit sshd container-test-run-container> machine2: (finished: waiting for unit sshd, in 0.01 seconds) container-test-run-container> machine1: must succeed: ip addr show eth1 container-test-run-container> machine1: (finished: must succeed: ip addr show eth1, in 0.00 seconds) container-test-run-container> machine2: must succeed: ip addr show eth1 container-test-run-container> machine2: (finished: must succeed: ip addr show eth1, in 0.00 seconds) container-test-run-container> machine1: must succeed: ping -c 1 machine2 container-test-run-container> machine1: (finished: must succeed: ping -c 1 machine2, in 0.00 seconds) container-test-run-container> (finished: run the VM test script, in 1.68 seconds) container-test-run-container> test script finished in 1.69s container-test-run-container> cleanup container-test-run-container> kill NspawnMachine (pid 52) container-test-run-container> kill NspawnMachine (pid 53) container-test-run-container> Container machine1 terminated by signal KILL. container-test-run-container> Container machine2 terminated by signal KILL. container-test-run-container> (finished: cleanup, in 0.14 seconds)