don't know how to build these paths: /nix/store/0wckqivymyh0q24rs5npl22mvwb6wdss-container-test-run-container.drv warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user building '/nix/store/sz3535a2759pb1lcjsa2h9ka51jac2rb-X-Restart-Triggers-sshd.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-sshd> web01: building sz3535a2759pb1lcjsa2h9ka51jac2rb-X-Restart-Triggers-sshd.drv X-Restart-Triggers-sshd> structuredAttrs is enabled building '/nix/store/b16abaa1zmsh17n5j0dl7wy0iz5qfym4-unit-sshd.service.drv' on nix-store.geninf.io:50051 unit-sshd.service> web01: building b16abaa1zmsh17n5j0dl7wy0iz5qfym4-unit-sshd.service.drv unit-sshd.service> structuredAttrs is enabled building '/nix/store/m3zbda0vs8k5nn134kcwsi30r68mha16-nix.conf.drv' on nix-store.geninf.io:50051 nix.conf> gi-build-x86-02: building m3zbda0vs8k5nn134kcwsi30r68mha16-nix.conf.drv nix.conf> structuredAttrs is enabled nix.conf> Validating generated nix.conf building '/nix/store/5z4l7gz2k6b1rf0sc08lpwl8fnrrnk04-users-groups.json.drv' on nix-store.geninf.io:50051 users-groups.json> gi-build-x86-02: building 5z4l7gz2k6b1rf0sc08lpwl8fnrrnk04-users-groups.json.drv users-groups.json> structuredAttrs is enabled building '/nix/store/7awqaav0vrx35wrsargli3fx9yci6yrs-test-script.drv' on nix-store.geninf.io:50051 test-script> build-x86-01: building 7awqaav0vrx35wrsargli3fx9yci6yrs-test-script.drv test-script> structuredAttrs is enabled vyan4bichbf8m8k8jmzyzzxjsjr5cm6y-X-Restart-Triggers-nix-daemon.drv: gi-build-x86-02: not scheduled here: vyan4bichbf8m8k8jmzyzzxjsjr5cm6y-X-Restart-Triggers-nix-daemon.drv, asking the scheduler again building '/nix/store/zy5866rblmmxik6907inr4jk5y9ib82z-dry-activate.drv' on nix-store.geninf.io:50051 dry-activate> gi-build-x86-02: building zy5866rblmmxik6907inr4jk5y9ib82z-dry-activate.drv dry-activate> structuredAttrs is enabled building '/nix/store/fk3hwv4z3y7mg6m4g64w31phar141v50-system-path.drv' on nix-store.geninf.io:50051 system-path> build-x86-01: building fk3hwv4z3y7mg6m4g64w31phar141v50-system-path.drv system-path> structuredAttrs is enabled system-path> created 1659 symlinks in user environment building '/nix/store/w529w254j97032gq03nhk5vw0p0adb0b-unit-nix-daemon.service.drv' on nix-store.geninf.io:50051 unit-nix-daemon.service> gi-build-x86-02: building w529w254j97032gq03nhk5vw0p0adb0b-unit-nix-daemon.service.drv unit-nix-daemon.service> structuredAttrs is enabled building '/nix/store/kqy80sj1lxjli9qbnp0kxb6j6vazv472-dbus-1.drv' on nix-store.geninf.io:50051 dbus-1> build-x86-01: building kqy80sj1lxjli9qbnp0kxb6j6vazv472-dbus-1.drv building '/nix/store/i0fzrlgxgl9i8pdzqn5spl9vlvn710q7-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-dbus-broker> build-x86-01: building i0fzrlgxgl9i8pdzqn5spl9vlvn710q7-X-Restart-Triggers-dbus-broker.drv X-Restart-Triggers-dbus-broker> structuredAttrs is enabled building '/nix/store/2hb40fjp5jzkzirr6q7s6rg220vrbh6q-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> gi-build-x86-02: building 2hb40fjp5jzkzirr6q7s6rg220vrbh6q-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/aqvg9w1l08kqylwp6wfqsfn6mx3qjnvh-system-units.drv' on nix-store.geninf.io:50051 system-units> web01: building aqvg9w1l08kqylwp6wfqsfn6mx3qjnvh-system-units.drv building '/nix/store/5r5pccwyhm9f192sccbmmq1pv118wci9-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build-x86-01: building 5r5pccwyhm9f192sccbmmq1pv118wci9-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/2nqh3pwvcczwrha5y2y2gmg1i5q542hv-system-units.drv' on nix-store.geninf.io:50051 system-units> gi-build-x86-02: building 2nqh3pwvcczwrha5y2y2gmg1i5q542hv-system-units.drv building '/nix/store/8aah1p1zjmybns9268j38z45whcx9s97-user-units.drv' on nix-store.geninf.io:50051 user-units> build-x86-01: building 8aah1p1zjmybns9268j38z45whcx9s97-user-units.drv building '/nix/store/h6y3z1258gjbffijxdf7srr594dz5cs4-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building h6y3z1258gjbffijxdf7srr594dz5cs4-etc.drv 0871jqqpch9mp660zzfw1px1jmbnk6p2-etc.drv: build-x86-01: not scheduled here: 0871jqqpch9mp660zzfw1px1jmbnk6p2-etc.drv, asking the scheduler again building '/nix/store/0871jqqpch9mp660zzfw1px1jmbnk6p2-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building 0871jqqpch9mp660zzfw1px1jmbnk6p2-etc.drv building '/nix/store/yxlxwbnsncdj4ix4g9hj50xqib6q9iy8-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building yxlxwbnsncdj4ix4g9hj50xqib6q9iy8-activate.drv activate> structuredAttrs is enabled building '/nix/store/s49pqghbzkizs22k687a79ipmm3dhpz8-nixos-system-machine1-test.drv' on nix-store.geninf.io:50051 nixos-system-machine1-test> web01: building s49pqghbzkizs22k687a79ipmm3dhpz8-nixos-system-machine1-test.drv nixos-system-machine1-test> structuredAttrs is enabled building '/nix/store/3b7f3xm92ms6jd6q9pavf68wvgcdn132-run-machine1-nspawn.drv' on nix-store.geninf.io:50051 run-machine1-nspawn> web01: building 3b7f3xm92ms6jd6q9pavf68wvgcdn132-run-machine1-nspawn.drv building '/nix/store/ax0a504ypidvwkl7bz055blwrcrg67g0-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building ax0a504ypidvwkl7bz055blwrcrg67g0-activate.drv activate> structuredAttrs is enabled building '/nix/store/pcqdnd4daivzbl2xnw32985x4i7yl1k6-nixos-system-machine2-test.drv' on nix-store.geninf.io:50051 nixos-system-machine2-test> build-x86-01: building pcqdnd4daivzbl2xnw32985x4i7yl1k6-nixos-system-machine2-test.drv nixos-system-machine2-test> structuredAttrs is enabled building '/nix/store/5vmd3fh1jhlgv90i96pza2fp1nylyd2k-run-machine2-nspawn.drv' on nix-store.geninf.io:50051 run-machine2-nspawn> build-x86-01: building 5vmd3fh1jhlgv90i96pza2fp1nylyd2k-run-machine2-nspawn.drv building '/nix/store/zinz2i3kxf4rb0ha5q8gx5ggxaigqr3s-driverConfiguration.json.drv' on nix-store.geninf.io:50051 driverConfiguration.json> build-x86-01: building zinz2i3kxf4rb0ha5q8gx5ggxaigqr3s-driverConfiguration.json.drv driverConfiguration.json> structuredAttrs is enabled building '/nix/store/cll1nnmak15kjkw26k997dsi4h3gic8l-nixos-test-driver-container.drv' on nix-store.geninf.io:50051 nixos-test-driver-container> build-x86-01: building cll1nnmak15kjkw26k997dsi4h3gic8l-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/0wckqivymyh0q24rs5npl22mvwb6wdss-container-test-run-container.drv' on nix-store.geninf.io:50051 container-test-run-container> build-x86-01: building 0wckqivymyh0q24rs5npl22mvwb6wdss-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(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> 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> 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> 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> machine1 # [2257770.151805] machine1 systemd-journald[57]: Journal started container-test-run-container> machine1 # [2257770.151837] machine1 systemd-journald[57]: Runtime Journal (/run/log/journal/23355e7c4dca42ca9ab48ca9bb8da25f) is 8M, max 3.7G, 3.7G free. container-test-run-container> machine1 # [2257770.156654] machine1 systemd[1]: Finished Apply Kernel Variables. container-test-run-container> machine2 # [2257770.153111] machine2 systemd-journald[57]: Journal started container-test-run-container> machine1 # [2257770.162261] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-container> machine2 # [2257770.153140] machine2 systemd-journald[57]: Runtime Journal (/run/log/journal/48494f4021864788b47cd488d1f8c3cb) is 8M, max 3.7G, 3.7G free. container-test-run-container> machine1 # [2257770.168760] machine1 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-container> machine2 # [2257770.156114] machine2 systemd[1]: Finished Apply Kernel Variables. container-test-run-container> machine1 # [2257770.169036] machine1 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-container> machine2 # [2257770.161865] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-container> machine1 # [2257770.173263] machine1 systemd-journald[57]: Time spent on flushing to /var/log/journal/23355e7c4dca42ca9ab48ca9bb8da25f is 935us for 6 entries. container-test-run-container> machine2 # [2257770.168537] machine2 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-container> machine1 # [2257770.173263] machine1 systemd-journald[57]: System Journal (/var/log/journal/23355e7c4dca42ca9ab48ca9bb8da25f) is 8M, max 4G, 3.9G free. container-test-run-container> machine2 # [2257770.168843] machine2 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-container> machine1 # [2257770.177636] machine1 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-container> machine2 # [2257770.173783] machine2 systemd-journald[57]: Time spent on flushing to /var/log/journal/48494f4021864788b47cd488d1f8c3cb is 1.173ms for 6 entries. container-test-run-container> machine1 # [2257770.178009] machine1 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-container> machine2 # [2257770.173783] machine2 systemd-journald[57]: System Journal (/var/log/journal/48494f4021864788b47cd488d1f8c3cb) is 8M, max 4G, 3.9G free. container-test-run-container> machine1 # [2257770.178058] machine1 systemd[1]: Reached target Local File Systems. container-test-run-container> machine2 # [2257770.177908] machine2 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-container> machine1 # [2257770.178508] machine1 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-container> machine2 # [2257770.178244] machine2 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-container> machine1 # [2257770.178534] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine2 # [2257770.178287] machine2 systemd[1]: Reached target Local File Systems. container-test-run-container> machine1 # [2257770.178924] machine1 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-container> machine2 # [2257770.178677] machine2 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-container> machine1 # [2257770.178939] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-container> machine2 # [2257770.178697] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine1 # [2257770.180574] machine1 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-container> machine2 # [2257770.179052] machine2 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-container> machine1 # [2257770.181038] machine1 systemd[1]: Starting Create System Files and Directories... container-test-run-container> machine2 # [2257770.179066] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-container> machine1 # [2257770.196370] machine1 systemd-tmpfiles[106]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-container> machine2 # [2257770.180523] machine2 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-container> machine1 # [2257770.196509] machine1 systemd-tmpfiles[106]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-container> machine2 # [2257770.180932] machine2 systemd[1]: Starting Create System Files and Directories... container-test-run-container> machine1 # [2257770.196603] machine1 systemd-tmpfiles[106]: fchmod() of /var/log/journal/23355e7c4dca42ca9ab48ca9bb8da25f failed: Operation not permitted container-test-run-container> machine2 # [2257770.196746] machine2 systemd-tmpfiles[106]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-container> machine1 # [2257770.196746] machine1 systemd-tmpfiles[106]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-container> machine2 # [2257770.196898] machine2 systemd-tmpfiles[106]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-container> machine1 # [2257770.197468] machine1 systemd[1]: Finished Create System Files and Directories. container-test-run-container> machine2 # [2257770.196998] machine2 systemd-tmpfiles[106]: fchmod() of /var/log/journal/48494f4021864788b47cd488d1f8c3cb failed: Operation not permitted container-test-run-container> machine1 # [2257770.197909] machine1 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-container> machine2 # [2257770.197148] machine2 systemd-tmpfiles[106]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-container> machine1 # [2257770.198241] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-container> machine2 # [2257770.198050] machine2 systemd[1]: Finished Create System Files and Directories. container-test-run-container> machine1 # [2257770.205033] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-container> machine2 # [2257770.198525] machine2 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-container> machine1 # [2257770.210248] machine1 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-container> machine2 # [2257770.198797] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-container> machine1 # [2257770.210879] machine1 systemd[1]: Starting Update is Completed... container-test-run-container> machine2 # [2257770.204573] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-container> machine1 # [2257770.215873] machine1 systemd[1]: Finished Update is Completed. container-test-run-container> machine2 # [2257770.211042] machine2 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-container> machine1 # [2257770.215922] machine1 systemd[1]: Reached target System Initialization. container-test-run-container> machine2 # [2257770.211587] machine2 systemd[1]: Starting Update is Completed... container-test-run-container> machine1 # [2257770.215962] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine2 # [2257770.217188] machine2 systemd[1]: Finished Update is Completed. container-test-run-container> machine1 # [2257770.215980] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-container> machine2 # [2257770.217259] machine2 systemd[1]: Reached target System Initialization. container-test-run-container> machine1 # [2257770.215989] machine1 systemd[1]: Reached target Timer Units. container-test-run-container> machine2 # [2257770.217308] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine1 # [2257770.216060] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-container> machine2 # [2257770.217331] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-container> machine1 # [2257770.216118] machine1 systemd[1]: Listening on Nix Daemon Socket. container-test-run-container> machine2 # [2257770.217340] machine2 systemd[1]: Reached target Timer Units. container-test-run-container> machine1 # [2257770.216628] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-container> machine2 # [2257770.217406] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-container> machine1 # [2257770.217144] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-container> machine2 # [2257770.217475] machine2 systemd[1]: Listening on Nix Daemon Socket. container-test-run-container> machine1 # [2257770.217223] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-container> machine2 # [2257770.218022] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-container> machine1 # [2257770.217232] machine1 systemd[1]: Reached target Socket Units. container-test-run-container> machine2 # [2257770.218479] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-container> machine1 # [2257770.217257] machine1 systemd[1]: Reached target Basic System. container-test-run-container> machine2 # [2257770.218542] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-container> machine1 # [2257770.217878] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-container> machine2 # [2257770.218553] machine2 systemd[1]: Reached target Socket Units. container-test-run-container> machine1 # [2257770.218264] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine2 # [2257770.218572] machine2 systemd[1]: Reached target Basic System. container-test-run-container> machine1 # [2257770.218621] machine1 systemd[1]: Starting SSH Host Keys Generation... container-test-run-container> machine2 # [2257770.219084] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-container> machine1 # [2257770.227178] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-container> machine2 # [2257770.219492] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine1 # [2257770.243498] machine1 systemd[1]: Finished Firewall. container-test-run-container> machine2 # [2257770.219807] machine2 systemd[1]: Starting SSH Host Keys Generation... container-test-run-container> machine1 # [2257770.243585] machine1 systemd[1]: Reached target Preparation for Network. container-test-run-container> machine2 # [2257770.228781] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-container> machine1 # [2257770.243923] machine1 systemd[1]: Starting Address configuration of eth1... container-test-run-container> machine2 # [2257770.242911] machine2 systemd[1]: Finished Firewall. container-test-run-container> machine1 # [2257770.244280] machine1 systemd[1]: Starting Extra networking commands.... container-test-run-container> machine2 # [2257770.242990] machine2 systemd[1]: Reached target Preparation for Network. container-test-run-container> machine1 # [2257770.252592] machine1 network-addresses-eth1-start[181]: adding address 192.168.1.1/24... done container-test-run-container> machine2 # [2257770.243364] machine2 systemd[1]: Starting Address configuration of eth1... container-test-run-container> machine1 # [2257770.254006] machine1 network-addresses-eth1-start[181]: adding address 2001:db8:1::1/64... done container-test-run-container> machine2 # [2257770.243827] machine2 systemd[1]: Starting Extra networking commands.... container-test-run-container> machine1 # [2257770.256334] machine1 systemd[1]: Finished Address configuration of eth1. container-test-run-container> machine2 # [2257770.251685] machine2 network-addresses-eth1-start[181]: adding address 192.168.1.2/24... done container-test-run-container> machine1 # [2257770.276186] machine1 systemd[1]: nscd.service: Deactivated successfully. container-test-run-container> machine2 # [2257770.253186] machine2 network-addresses-eth1-start[181]: adding address 2001:db8:1::2/64... done container-test-run-container> machine1 # [2257770.292070] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-container> machine2 # [2257770.255217] machine2 systemd[1]: Finished Address configuration of eth1. container-test-run-container> machine1 # [2257770.292739] machine1 systemd[1]: Finished Extra networking commands.. container-test-run-container> machine2 # [2257770.272718] machine2 systemd[1]: nscd.service: Deactivated successfully. container-test-run-container> machine1 # [2257770.293090] machine1 systemd[1]: Reached target Network. container-test-run-container> machine2 # [2257770.272788] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-container> machine1 # [2257770.293459] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine2 # [2257770.273793] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine1 # [2257770.365895] machine1 nsncd[246]: Sep 30 10:26:24.789 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-container> machine2 # [2257770.292116] machine2 systemd[1]: Finished Extra networking commands.. container-test-run-container> machine1 # [2257770.365891] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-container> machine2 # [2257770.292253] machine2 systemd[1]: Reached target Network. container-test-run-container> machine1 # [2257770.365925] machine1 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-container> machine2 # [2257770.365143] machine2 nsncd[241]: Sep 30 10:26:24.788 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-container> machine1 # [2257770.365959] machine1 systemd[1]: Reached target User and Group Name Lookups. container-test-run-container> machine2 # [2257770.365185] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-container> machine1 # [2257770.366495] machine1 systemd[1]: Starting User Login Management... container-test-run-container> machine2 # [2257770.365228] machine2 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-container> machine1 # [2257770.366815] machine1 systemd[1]: Starting Permit User Sessions... container-test-run-container> machine2 # [2257770.365262] machine2 systemd[1]: Reached target User and Group Name Lookups. container-test-run-container> machine1 # [2257770.387315] machine1 systemd[1]: Finished Permit User Sessions. container-test-run-container> machine2 # [2257770.365896] machine2 systemd[1]: Starting User Login Management... container-test-run-container> machine1 # [2257770.387737] machine1 systemd[1]: Started Console Getty. container-test-run-container> machine2 # [2257770.366218] machine2 systemd[1]: Starting Permit User Sessions... container-test-run-container> machine1 # [2257770.387759] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-container> machine2 # [2257770.388440] machine2 systemd[1]: Finished Permit User Sessions. container-test-run-container> machine1 # [2257770.387769] machine1 systemd[1]: Reached target Login Prompts. container-test-run-container> machine2 # [2257770.388849] machine2 systemd[1]: Started Console Getty. container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: Generating public/private rsa key pair. container-test-run-container> machine2 # [2257770.388868] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key container-test-run-container> machine2 # [2257770.388877] machine2 systemd[1]: Reached target Login Prompts. container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: Generating public/private rsa key pair. container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: The key fingerprint is: container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: SHA256:0Y0VytKE0gm+7BtmIBIowi+Kfe6/pZs96TaSGpDe7aA root@machine1 container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: The key's randomart image is: container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: The key fingerprint is: container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: +---[RSA 4096]----+ container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: SHA256:26aUNbr7VRlTGeDUywBNbGtsRzx5aXAuXsEpegrkHlk root@machine2 container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: | .o o. o. | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: The key's randomart image is: container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: |o .. += = | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: +---[RSA 4096]----+ container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: |=. ..o * . | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | .==*+B| container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: |o... . . o | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | . Eo*o&o| container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: |..+.. o S | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | o o +oXo+| container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: |o+.+ + | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | = ..*oB | container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: |o o = *... | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | S = =.+ | container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: | + *oB= | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | B o . | container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: | E.+oO*oo | container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | = o . | container-test-run-container> machine1 # [2257770.393298] machine1 sshd-keygen-start[165]: +----[SHA256]-----+ container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | . + . | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: Generating public/private ed25519 key pair. container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: | +o. | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key container-test-run-container> machine2 # [2257770.644482] machine2 sshd-keygen-start[166]: +----[SHA256]-----+ container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: Generating public/private ed25519 key pair. container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: The key fingerprint is: container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: SHA256:ZfW4xaGKgTMwsOyKn6qhts7yvEKfnLp38DOtGy2QQP8 root@machine1 container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: The key's randomart image is: container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: The key fingerprint is: container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: +--[ED25519 256]--+ container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: SHA256:HFCJ0Svq4BDzmh+rERwtrMx/6RB5sgR0aJB5w0oZUdM root@machine2 container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: | ...o . . | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: The key's randomart image is: container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: |.... o . . = . | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: +--[ED25519 256]--+ container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: | .o. + . o o + | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |oB*+. o=.. | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: | .. o o = . o | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |==* .E..o | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: | .o E S . . | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |oB o .. | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: |.o .. . | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |O + . .... | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: |= o =o.. | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |oB = o .S | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: |== B =o. | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |..= * . | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: |OX@..o= | container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |.=.* o | container-test-run-container> machine1 # [2257770.399771] machine1 sshd-keygen-start[273]: +----[SHA256]-----+ container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |o..o= | container-test-run-container> machine1 # [2257770.400437] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully. container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: |.oo . | container-test-run-container> machine1 # [2257770.400506] machine1 systemd[1]: Finished SSH Host Keys Generation. container-test-run-container> machine2 # [2257770.651586] machine2 sshd-keygen-start[273]: +----[SHA256]-----+ container-test-run-container> machine1 # [2257770.400919] machine1 systemd[1]: Starting SSH Daemon... container-test-run-container> machine2 # [2257770.652308] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully. container-test-run-container> machine1 # [2257770.408468] machine1 sshd[275]: Server listening on 0.0.0.0 port 22. container-test-run-container> machine2 # [2257770.652344] machine2 systemd[1]: Finished SSH Host Keys Generation. container-test-run-container> machine1 # [2257770.408486] machine1 sshd[275]: Server listening on :: port 22. container-test-run-container> machine2 # [2257770.652735] machine2 systemd[1]: Starting SSH Daemon... container-test-run-container> machine1 # [2257770.408542] machine1 systemd[1]: Started SSH Daemon. container-test-run-container> machine2 # [2257770.675886] machine2 sshd[275]: Server listening on 0.0.0.0 port 22. container-test-run-container> machine2 # [2257770.675910] machine2 sshd[275]: Server listening on :: port 22. container-test-run-container> machine2 # [2257770.675953] machine2 systemd[1]: Started SSH Daemon. container-test-run-container> machine2 # [2257770.839762] machine2 systemd-logind[258]: New seat seat0. container-test-run-container> machine2 # [2257770.840568] machine2 systemd[1]: Starting D-Bus System Message Bus... container-test-run-container> machine2 # [2257770.840635] machine2 systemd[1]: Started User Login Management. container-test-run-container> machine2 # [2257770.841042] machine2 systemd[1]: Starting linger-users.service... container-test-run-container> machine2 # [2257770.868680] machine2 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-container> machine2 # [2257770.868771] machine2 systemd[1]: Finished linger-users.service. container-test-run-container> machine2 # [2257770.869224] machine2 systemd[1]: Reached target Multi-User System. container-test-run-container> machine1 # [2257770.846732] machine1 systemd-logind[258]: New seat seat0. container-test-run-container> machine1 # [2257770.865194] machine1 systemd[1]: Starting D-Bus System Message Bus... container-test-run-container> machine1 # [2257770.865258] machine1 systemd[1]: Started User Login Management. container-test-run-container> machine1 # [2257770.865766] machine1 systemd[1]: Starting linger-users.service... container-test-run-container> machine1 # [2257770.871779] machine1 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-container> machine1 # [2257770.871815] machine1 systemd[1]: Finished linger-users.service. container-test-run-container> machine1 # [2257770.872118] machine1 systemd[1]: Reached target Multi-User System. container-test-run-container> machine1 # [2257771.020375] machine1 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-container> machine1 # [2257771.020766] machine1 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync' container-test-run-container> machine1 # [2257771.020766] machine1 dbus-broker-launch[276]: Invalid user-name in /nix/store/7nslvjhf1f7ij7z5s4jx6qai9qhrwv9i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-container> machine1 # [2257771.020982] machine1 systemd[1]: Started D-Bus System Message Bus. container-test-run-container> machine1 # [2257771.024287] machine1 dbus-broker-launch[276]: 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.67 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> machine2 # [2257771.024923] machine2 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-container> machine2 # [2257771.025246] machine2 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync' container-test-run-container> machine2 # [2257771.025246] machine2 dbus-broker-launch[276]: Invalid user-name in /nix/store/7nslvjhf1f7ij7z5s4jx6qai9qhrwv9i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-container> machine2 # [2257771.025520] machine2 systemd[1]: Started D-Bus System Message Bus. container-test-run-container> machine2 # [2257771.028805] machine2 dbus-broker-launch[276]: Ready container-test-run-container> machine2 # [2257771.120811] machine2 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-container> machine2 # [2257771.120978] machine2 systemd[1]: Startup finished in 1.179s. container-test-run-container> machine2 # [2257771.148964] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-container> machine1 # [2257771.120421] machine1 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-container> machine1 # [2257771.120550] machine1 systemd[1]: Startup finished in 1.178s. container-test-run-container> machine1 # [2257771.148367] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. 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.18 seconds)