don't know how to build these paths: /nix/store/dndbjh6fpwr2cv94db1jsva3a0rac8jf-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/jjzzra8nssr2hdfzhb6aac2v7slyxy1v-system-path.drv' on nix-store.geninf.io:50051 system-path> build01: building jjzzra8nssr2hdfzhb6aac2v7slyxy1v-system-path.drv system-path> structuredAttrs is enabled system-path> created 1655 symlinks in user environment building '/nix/store/lvkj5spp7pmavmwbkw8m37rz25n90jja-dbus-1.drv' on nix-store.geninf.io:50051 dbus-1> build01: building lvkj5spp7pmavmwbkw8m37rz25n90jja-dbus-1.drv building '/nix/store/n6sh0wrpzz6q2d9j1nwwrfdf16w9jnd8-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-dbus-broker> build01: building n6sh0wrpzz6q2d9j1nwwrfdf16w9jnd8-X-Restart-Triggers-dbus-broker.drv X-Restart-Triggers-dbus-broker> structuredAttrs is enabled bnv03fd6ihla73ch2fdn6dsw4x3c2cj3-unit-dbus-broker.service.drv: build01: not scheduled here: bnv03fd6ihla73ch2fdn6dsw4x3c2cj3-unit-dbus-broker.service.drv, asking the scheduler again an5lnigp01vgjj3lg7ynwd4na2hy47i1-unit-dbus-broker.service.drv: build01: not scheduled here: an5lnigp01vgjj3lg7ynwd4na2hy47i1-unit-dbus-broker.service.drv, asking the scheduler again building '/nix/store/an5lnigp01vgjj3lg7ynwd4na2hy47i1-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build01: building an5lnigp01vgjj3lg7ynwd4na2hy47i1-unit-dbus-broker.service.drv building '/nix/store/bnv03fd6ihla73ch2fdn6dsw4x3c2cj3-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build01: building bnv03fd6ihla73ch2fdn6dsw4x3c2cj3-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/d9j5dq6jc5g78z5y9a9v3nww4ya3vhb0-user-units.drv' on nix-store.geninf.io:50051 user-units> build01: building d9j5dq6jc5g78z5y9a9v3nww4ya3vhb0-user-units.drv building '/nix/store/d3whajyab57jnkcmi7sqwv3gan55lhan-system-units.drv' on nix-store.geninf.io:50051 system-units> build01: building d3whajyab57jnkcmi7sqwv3gan55lhan-system-units.drv building '/nix/store/3yrvwfv84azgz84k63xvq7i4snn6aqv8-system-units.drv' on nix-store.geninf.io:50051 system-units> build01: building 3yrvwfv84azgz84k63xvq7i4snn6aqv8-system-units.drv 9m5zl43ac6xl9jhkgnkp9y6j1jggjjp0-etc.drv: build01: not scheduled here: 9m5zl43ac6xl9jhkgnkp9y6j1jggjjp0-etc.drv, asking the scheduler again x1ycrsp8gn8v6jzidrq2gnmldc6n4aj4-etc.drv: build01: not scheduled here: x1ycrsp8gn8v6jzidrq2gnmldc6n4aj4-etc.drv, asking the scheduler again building '/nix/store/9m5zl43ac6xl9jhkgnkp9y6j1jggjjp0-etc.drv' on nix-store.geninf.io:50051 etc> build01: building 9m5zl43ac6xl9jhkgnkp9y6j1jggjjp0-etc.drv building '/nix/store/x1ycrsp8gn8v6jzidrq2gnmldc6n4aj4-etc.drv' on nix-store.geninf.io:50051 etc> build01: building x1ycrsp8gn8v6jzidrq2gnmldc6n4aj4-etc.drv 5fx6vh608f63ks7imp1y3yfmcp5mxq61-activate.drv: build01: not scheduled here: 5fx6vh608f63ks7imp1y3yfmcp5mxq61-activate.drv, asking the scheduler again building '/nix/store/5fx6vh608f63ks7imp1y3yfmcp5mxq61-activate.drv' on nix-store.geninf.io:50051 activate> build01: building 5fx6vh608f63ks7imp1y3yfmcp5mxq61-activate.drv activate> structuredAttrs is enabled q0fpcg35c1mjlhdw5m8jd7xzjb6y01rj-activate.drv: build01: not scheduled here: q0fpcg35c1mjlhdw5m8jd7xzjb6y01rj-activate.drv, asking the scheduler again building '/nix/store/q0fpcg35c1mjlhdw5m8jd7xzjb6y01rj-activate.drv' on nix-store.geninf.io:50051 activate> build01: building q0fpcg35c1mjlhdw5m8jd7xzjb6y01rj-activate.drv activate> structuredAttrs is enabled 39l8csp94p9w5s1gyfkqwc1a25vdkvja-nixos-system-machine2-test.drv: build01: not scheduled here: 39l8csp94p9w5s1gyfkqwc1a25vdkvja-nixos-system-machine2-test.drv, asking the scheduler again building '/nix/store/39l8csp94p9w5s1gyfkqwc1a25vdkvja-nixos-system-machine2-test.drv' on nix-store.geninf.io:50051 nixos-system-machine2-test> build01: building 39l8csp94p9w5s1gyfkqwc1a25vdkvja-nixos-system-machine2-test.drv nixos-system-machine2-test> structuredAttrs is enabled 6j6ak1lpn3vlgz9clcwik8jsi1bi6a7j-nixos-system-machine1-test.drv: build01: not scheduled here: 6j6ak1lpn3vlgz9clcwik8jsi1bi6a7j-nixos-system-machine1-test.drv, asking the scheduler again building '/nix/store/6j6ak1lpn3vlgz9clcwik8jsi1bi6a7j-nixos-system-machine1-test.drv' on nix-store.geninf.io:50051 nixos-system-machine1-test> build01: building 6j6ak1lpn3vlgz9clcwik8jsi1bi6a7j-nixos-system-machine1-test.drv nixos-system-machine1-test> structuredAttrs is enabled bld70fb3ysaq9qsrn123ivr1b374xdvx-run-machine2-nspawn.drv: build01: not scheduled here: bld70fb3ysaq9qsrn123ivr1b374xdvx-run-machine2-nspawn.drv, asking the scheduler again x4cr6ivw6al8jbxnzacj6p44z5a4lji3-run-machine1-nspawn.drv: build01: not scheduled here: x4cr6ivw6al8jbxnzacj6p44z5a4lji3-run-machine1-nspawn.drv, asking the scheduler again building '/nix/store/bld70fb3ysaq9qsrn123ivr1b374xdvx-run-machine2-nspawn.drv' on nix-store.geninf.io:50051 run-machine2-nspawn> build01: building bld70fb3ysaq9qsrn123ivr1b374xdvx-run-machine2-nspawn.drv building '/nix/store/x4cr6ivw6al8jbxnzacj6p44z5a4lji3-run-machine1-nspawn.drv' on nix-store.geninf.io:50051 run-machine1-nspawn> build01: building x4cr6ivw6al8jbxnzacj6p44z5a4lji3-run-machine1-nspawn.drv 9s5d6502r5hbg0a6xvvlij1ck6psknmz-driverConfiguration.json.drv: build01: not scheduled here: 9s5d6502r5hbg0a6xvvlij1ck6psknmz-driverConfiguration.json.drv, asking the scheduler again building '/nix/store/9s5d6502r5hbg0a6xvvlij1ck6psknmz-driverConfiguration.json.drv' on nix-store.geninf.io:50051 driverConfiguration.json> build01: building 9s5d6502r5hbg0a6xvvlij1ck6psknmz-driverConfiguration.json.drv driverConfiguration.json> structuredAttrs is enabled 3yjwfkmfxrz0hh9kas92zfc8q4819qgy-nixos-test-driver-container.drv: build01: not scheduled here: 3yjwfkmfxrz0hh9kas92zfc8q4819qgy-nixos-test-driver-container.drv, asking the scheduler again building '/nix/store/3yjwfkmfxrz0hh9kas92zfc8q4819qgy-nixos-test-driver-container.drv' on nix-store.geninf.io:50051 nixos-test-driver-container> build01: building 3yjwfkmfxrz0hh9kas92zfc8q4819qgy-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! dndbjh6fpwr2cv94db1jsva3a0rac8jf-container-test-run-container.drv: build01: not scheduled here: dndbjh6fpwr2cv94db1jsva3a0rac8jf-container-test-run-container.drv, asking the scheduler again building '/nix/store/dndbjh6fpwr2cv94db1jsva3a0rac8jf-container-test-run-container.drv' on nix-store.geninf.io:50051 container-test-run-container> build01: building dndbjh6fpwr2cv94db1jsva3a0rac8jf-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> 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> ░ Spawning container machine1 on /build/vm-state-machine1. container-test-run-container> machine1 # [2170626.370472] machine1 systemd-journald[57]: Journal started container-test-run-container> machine1 # [2170626.370529] machine1 systemd-journald[57]: Runtime Journal (/run/log/journal/6a55c176a6a248c2971b26e7584fbb92) is 8M, max 2.5G, 2.4G free. container-test-run-container> machine1 # [2170626.372971] machine1 systemd[1]: Finished Apply Kernel Variables. container-test-run-container> machine1 # [2170626.383928] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-container> machine1 # [2170626.396774] machine1 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-container> machine1 # [2170626.397483] machine1 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-container> machine1 # [2170626.405504] machine1 systemd-journald[57]: Time spent on flushing to /var/log/journal/6a55c176a6a248c2971b26e7584fbb92 is 1.206ms for 6 entries. container-test-run-container> machine1 # [2170626.405504] machine1 systemd-journald[57]: System Journal (/var/log/journal/6a55c176a6a248c2971b26e7584fbb92) is 8M, max 4G, 3.9G free. container-test-run-container> machine1 # [2170626.414610] machine1 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-container> machine1 # [2170626.415248] machine1 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-container> machine1 # [2170626.415366] machine1 systemd[1]: Reached target Local File Systems. container-test-run-container> machine1 # [2170626.416195] machine1 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-container> machine1 # [2170626.416246] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine1 # [2170626.417053] machine1 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-container> machine1 # [2170626.417087] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-container> machine1 # [2170626.417544] machine1 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-container> machine1 # [2170626.418798] machine1 systemd[1]: Starting Create System Files and Directories... container-test-run-container> machine1 # [2170626.433537] machine1 systemd-tmpfiles[103]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-container> machine1 # [2170626.433714] machine1 systemd-tmpfiles[103]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-container> machine1 # [2170626.433828] machine1 systemd-tmpfiles[103]: fchmod() of /var/log/journal/6a55c176a6a248c2971b26e7584fbb92 failed: Operation not permitted container-test-run-container> machine1 # [2170626.434000] machine1 systemd-tmpfiles[103]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-container> machine1 # [2170626.436527] machine1 systemd[1]: Finished Create System Files and Directories. container-test-run-container> machine1 # [2170626.437914] machine1 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-container> machine1 # [2170626.438746] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-container> machine1 # [2170626.440672] machine1 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-container> machine1 # [2170626.452440] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-container> machine1 # [2170626.458309] machine1 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-container> machine1 # [2170626.459444] machine1 systemd[1]: Starting Update is Completed... container-test-run-container> machine1 # [2170626.470992] machine1 systemd[1]: Finished Update is Completed. container-test-run-container> machine1 # [2170626.471173] machine1 systemd[1]: Reached target System Initialization. container-test-run-container> machine1 # [2170626.471266] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine1 # [2170626.471305] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-container> machine1 # [2170626.471323] machine1 systemd[1]: Reached target Timer Units. container-test-run-container> machine1 # [2170626.471446] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-container> machine1 # [2170626.471584] machine1 systemd[1]: Listening on Nix Daemon Socket. container-test-run-container> machine1 # [2170626.472766] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-container> machine1 # [2170626.473759] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-container> machine1 # [2170626.473868] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-container> machine1 # [2170626.473891] machine1 systemd[1]: Reached target Socket Units. container-test-run-container> machine1 # [2170626.473939] machine1 systemd[1]: Reached target Basic System. container-test-run-container> machine1 # [2170626.475027] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-container> machine1 # [2170626.476072] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine1 # [2170626.476752] machine1 systemd[1]: Starting SSH Host Keys Generation... container-test-run-container> machine1 # [2170626.496286] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-container> machine2 # [2170626.317856] machine2 systemd-journald[57]: Journal started container-test-run-container> machine2 # [2170626.317913] machine2 systemd-journald[57]: Runtime Journal (/run/log/journal/8ca740977c5d4b7bb0b7672eeab22772) is 8M, max 2.5G, 2.4G free. container-test-run-container> machine2 # [2170626.325518] machine2 systemd[1]: Finished Apply Kernel Variables. container-test-run-container> machine2 # [2170626.337815] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-container> machine2 # [2170626.351410] machine2 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-container> machine2 # [2170626.352264] machine2 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-container> machine2 # [2170626.362163] machine2 systemd-journald[57]: Time spent on flushing to /var/log/journal/8ca740977c5d4b7bb0b7672eeab22772 is 1.193ms for 6 entries. container-test-run-container> machine2 # [2170626.362163] machine2 systemd-journald[57]: System Journal (/var/log/journal/8ca740977c5d4b7bb0b7672eeab22772) is 8M, max 4G, 3.9G free. container-test-run-container> machine2 # [2170626.369063] machine2 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-container> machine2 # [2170626.369416] machine2 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-container> machine2 # [2170626.370394] machine2 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-container> machine2 # [2170626.370505] machine2 systemd[1]: Reached target Local File Systems. container-test-run-container> machine2 # [2170626.371316] machine2 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-container> machine2 # [2170626.371361] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine2 # [2170626.372189] machine2 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-container> machine2 # [2170626.372878] machine2 systemd[1]: Starting Create System Files and Directories... container-test-run-container> machine2 # [2170626.372914] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-container> machine2 # [2170626.390702] machine2 systemd-tmpfiles[106]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-container> machine2 # [2170626.390928] machine2 systemd-tmpfiles[106]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-container> machine2 # [2170626.391092] machine2 systemd-tmpfiles[106]: fchmod() of /var/log/journal/8ca740977c5d4b7bb0b7672eeab22772 failed: Operation not permitted container-test-run-container> machine2 # [2170626.391337] machine2 systemd-tmpfiles[106]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-container> machine2 # [2170626.392784] machine2 systemd[1]: Finished Create System Files and Directories. container-test-run-container> machine2 # [2170626.393806] machine2 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-container> machine2 # [2170626.394519] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-container> machine2 # [2170626.406107] machine2 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-container> machine2 # [2170626.408275] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-container> machine2 # [2170626.416742] machine2 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-container> machine2 # [2170626.417761] machine2 systemd[1]: Starting Update is Completed... container-test-run-container> machine2 # [2170626.427524] machine2 systemd[1]: Finished Update is Completed. container-test-run-container> machine2 # [2170626.427689] machine2 systemd[1]: Reached target System Initialization. container-test-run-container> machine2 # [2170626.427767] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-container> machine2 # [2170626.427805] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-container> machine2 # [2170626.427824] machine2 systemd[1]: Reached target Timer Units. container-test-run-container> machine2 # [2170626.427933] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-container> machine2 # [2170626.428072] machine2 systemd[1]: Listening on Nix Daemon Socket. container-test-run-container> machine2 # [2170626.429098] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-container> machine2 # [2170626.429932] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-container> machine2 # [2170626.430034] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-container> machine2 # [2170626.430053] machine2 systemd[1]: Reached target Socket Units. container-test-run-container> machine2 # [2170626.430095] machine2 systemd[1]: Reached target Basic System. container-test-run-container> machine2 # [2170626.431102] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-container> machine2 # [2170626.432404] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine2 # [2170626.433097] machine2 systemd[1]: Starting SSH Host Keys Generation... container-test-run-container> machine2 # [2170626.450184] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-container> machine2 # [2170626.482035] machine2 systemd[1]: Finished Firewall. container-test-run-container> machine2 # [2170626.482186] machine2 systemd[1]: Reached target Preparation for Network. container-test-run-container> machine2 # [2170626.483264] machine2 systemd[1]: Starting Address configuration of eth1... container-test-run-container> machine2 # [2170626.484220] machine2 systemd[1]: Starting Extra networking commands.... container-test-run-container> machine2 # [2170626.504309] machine2 network-addresses-eth1-start[182]: adding address 192.168.1.2/24... done container-test-run-container> machine2 # [2170626.506782] machine2 network-addresses-eth1-start[182]: adding address 2001:db8:1::2/64... done container-test-run-container> machine2 # [2170626.511619] machine2 systemd[1]: Finished Address configuration of eth1. container-test-run-container> machine2 # [2170626.554399] machine2 systemd[1]: nscd.service: Deactivated successfully. container-test-run-container> machine2 # [2170626.554528] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-container> machine2 # [2170626.556544] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine2 # [2170626.562778] machine2 systemd[1]: Finished Extra networking commands.. container-test-run-container> machine2 # [2170626.562959] machine2 systemd[1]: Reached target Network. container-test-run-container> machine1 # [2170626.531531] machine1 systemd[1]: Finished Firewall. container-test-run-container> machine1 # [2170626.531692] machine1 systemd[1]: Reached target Preparation for Network. container-test-run-container> machine1 # [2170626.532558] machine1 systemd[1]: Starting Address configuration of eth1... container-test-run-container> machine1 # [2170626.533302] machine1 systemd[1]: Starting Extra networking commands.... container-test-run-container> machine1 # [2170626.552075] machine1 network-addresses-eth1-start[182]: adding address 192.168.1.1/24... done container-test-run-container> machine1 # [2170626.554852] machine1 network-addresses-eth1-start[182]: adding address 2001:db8:1::1/64... done container-test-run-container> machine1 # [2170626.559588] machine1 systemd[1]: Finished Address configuration of eth1. container-test-run-container> machine1 # [2170626.597087] machine1 systemd[1]: nscd.service: Deactivated successfully. container-test-run-container> machine1 # [2170626.597220] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd). container-test-run-container> machine1 # [2170626.599300] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-container> machine1 # [2170626.604745] machine1 systemd[1]: Finished Extra networking commands.. container-test-run-container> machine1 # [2170626.604907] machine1 systemd[1]: Reached target Network. container-test-run-container> machine1 # [2170626.724536] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-container> machine1 # [2170626.724646] machine1 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-container> machine1 # [2170626.724737] machine1 systemd[1]: Reached target User and Group Name Lookups. container-test-run-container> machine2 # [2170626.711738] machine2 nsncd[243]: Sep 29 10:24:06.697 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-container> machine2 # [2170626.711823] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-container> machine2 # [2170626.711928] machine2 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-container> machine2 # [2170626.712067] machine2 systemd[1]: Reached target User and Group Name Lookups. container-test-run-container> machine2 # [2170626.713978] machine2 systemd[1]: Starting User Login Management... container-test-run-container> machine2 # [2170626.715310] machine2 systemd[1]: Starting Permit User Sessions... container-test-run-container> machine2 # [2170626.772200] machine2 systemd[1]: Finished Permit User Sessions. container-test-run-container> machine2 # [2170626.773425] machine2 systemd[1]: Started Console Getty. container-test-run-container> machine2 # [2170626.773480] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-container> machine2 # [2170626.773504] machine2 systemd[1]: Reached target Login Prompts. container-test-run-container> machine1 # [2170626.725127] machine1 nsncd[244]: Sep 29 10:24:06.710 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-container> machine1 # [2170626.764693] machine1 systemd[1]: Starting User Login Management... container-test-run-container> machine1 # [2170626.766050] machine1 systemd[1]: Starting Permit User Sessions... container-test-run-container> machine1 # [2170626.780827] machine1 systemd[1]: Finished Permit User Sessions. container-test-run-container> machine1 # [2170626.782000] machine1 systemd[1]: Started Console Getty. container-test-run-container> machine1 # [2170626.782046] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-container> machine1 # [2170626.782069] machine1 systemd[1]: Reached target Login Prompts. container-test-run-container> machine2 # [2170627.324846] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-container> machine2 # [2170627.467618] machine2 systemd-logind[259]: New seat seat0. container-test-run-container> machine2 # [2170627.467908] machine2 systemd[1]: Started User Login Management. container-test-run-container> machine2 # [2170627.469010] machine2 systemd[1]: Starting D-Bus System Message Bus... container-test-run-container> machine2 # [2170627.469708] machine2 systemd[1]: Starting linger-users.service... container-test-run-container> machine2 # [2170627.522100] machine2 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-container> machine2 # [2170627.522356] machine2 systemd[1]: Finished linger-users.service. container-test-run-container> machine1 # [2170627.377961] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-container> machine1 # [2170627.488620] machine1 systemd-logind[259]: New seat seat0. container-test-run-container> machine1 # [2170627.488902] machine1 systemd[1]: Started User Login Management. container-test-run-container> machine1 # [2170627.512487] machine1 systemd[1]: Starting D-Bus System Message Bus... container-test-run-container> machine1 # [2170627.513722] machine1 systemd[1]: Starting linger-users.service... container-test-run-container> machine1 # [2170627.529679] machine1 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-container> machine1 # [2170627.529815] machine1 systemd[1]: Finished linger-users.service. container-test-run-container> machine2 # [2170627.809215] machine2 dbus-broker-launch[269]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-container> machine2 # [2170627.810568] machine2 dbus-broker-launch[269]: NSS returned no entry for 'systemd-timesync' container-test-run-container> machine2 # [2170627.810568] machine2 dbus-broker-launch[269]: Invalid user-name in /nix/store/4ckq522appv84b4qp4d8af5czsdx0lz2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-container> machine2 # [2170627.811020] machine2 systemd[1]: Started D-Bus System Message Bus. container-test-run-container> machine2 # [2170627.819696] machine2 dbus-broker-launch[269]: Ready container-test-run-container> machine1 # [2170627.795499] machine1 dbus-broker-launch[269]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-container> machine1 # [2170627.796485] machine1 dbus-broker-launch[269]: NSS returned no entry for 'systemd-timesync' container-test-run-container> machine1 # [2170627.796485] machine1 dbus-broker-launch[269]: Invalid user-name in /nix/store/4ckq522appv84b4qp4d8af5czsdx0lz2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-container> machine1 # [2170627.797221] machine1 systemd[1]: Started D-Bus System Message Bus. container-test-run-container> machine1 # [2170627.805899] machine1 dbus-broker-launch[269]: Ready container-test-run-container> machine1: (finished: must succeed: systemctl status sshd, in 2.65 seconds) container-test-run-container> machine2: must succeed: systemctl status sshd container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: Generating public/private rsa key pair. container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: The key fingerprint is: container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: SHA256:x29zXCtb8hFUOyyMgng+4XV6rJsAQt48CCQuHzMDtVY root@machine1 container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: The key's randomart image is: container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: +---[RSA 4096]----+ container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: |oo. E .| container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: |+. o . . o . o| container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: |.oB. . + o o o = | container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: |.o+=+ + o.= o .| container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: | .+ = +S.oo ..| container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: | . o ..o. . .o| container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: | . . +oo+ | container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: | . o. o* .| container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: | o . . | container-test-run-container> machine1 # [2170628.073826] machine1 sshd-keygen-start[160]: +----[SHA256]-----+ container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: Generating public/private ed25519 key pair. container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: The key fingerprint is: container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: SHA256:7HU9dAmM5lsFLcCdCXkVFtVMbE3ZlufR66zcrrnw6IU root@machine1 container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: The key's randomart image is: container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: +--[ED25519 256]--+ container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | .oBo*X#| container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | = Bo*%| container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | o . +==| container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | . . + o.| container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | S . + = | container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | . . o. + | container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | . E..o | container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | =o.. | container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: | .o =+. | container-test-run-container> machine1 # [2170628.092162] machine1 sshd-keygen-start[279]: +----[SHA256]-----+ container-test-run-container> machine1 # [2170628.093539] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully. container-test-run-container> machine1 # [2170628.093811] machine1 systemd[1]: Finished SSH Host Keys Generation. container-test-run-container> machine1 # [2170628.094266] machine1 systemd[1]: sshd-keygen.service: Consumed 3.269s CPU time over 1.616s wall clock time. container-test-run-container> machine1 # [2170628.096824] machine1 systemd[1]: Starting SSH Daemon... container-test-run-container> machine1 # [2170628.152149] machine1 sshd[281]: Server listening on 0.0.0.0 port 22. container-test-run-container> machine1 # [2170628.152191] machine1 sshd[281]: Server listening on :: port 22. container-test-run-container> machine1 # [2170628.152442] machine1 systemd[1]: Started SSH Daemon. container-test-run-container> machine1 # [2170628.152909] machine1 systemd[1]: Reached target Multi-User System. container-test-run-container> machine1 # [2170628.153266] machine1 systemd[1]: Startup finished in 2.158s. container-test-run-container> machine2: (finished: must succeed: systemctl status sshd, in 1.15 seconds) container-test-run-container> machine1: waiting for unit sshd container-test-run-container> machine1: (finished: waiting for unit sshd, in 0.02 seconds) container-test-run-container> machine2: waiting for unit sshd container-test-run-container> machine2: (finished: waiting for unit sshd, in 0.02 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.01 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.01 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.01 seconds) container-test-run-container> (finished: run the VM test script, in 3.87 seconds) container-test-run-container> test script finished in 3.91s 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> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: Generating public/private rsa key pair. container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: The key fingerprint is: container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: SHA256:zFq+vaMC1rRvBwqlQ1HaxJZx6+cZAt3s60rwruHEZnY root@machine2 container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: The key's randomart image is: container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: +---[RSA 4096]----+ container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | o+o. | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | .++o + | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | .oo o o | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | . o= . | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | . =..S + | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | *.o*.+ + | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | . +OoE.+ | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | *o=o+o | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: | o+=++o | container-test-run-container> machine2 # [2170629.136469] machine2 sshd-keygen-start[166]: +----[SHA256]-----+ container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: Generating public/private ed25519 key pair. container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: The key fingerprint is: container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: SHA256:YpY/Pqzb1rOQlCGD+K+Gmo4nseuQeaKps5DUz3Pnykc root@machine2 container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: The key's randomart image is: container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: +--[ED25519 256]--+ container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: | | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: | . . | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: | . . o . | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: | .. + o | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: | . .. = S | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: |o+ o+ + E | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: |Bo.. +.o*o | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: |O=o ..+o*+o | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: |&X .. o*=o.o | container-test-run-container> machine2 # [2170629.154868] machine2 sshd-keygen-start[279]: +----[SHA256]-----+ container-test-run-container> machine2 # [2170629.157014] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully. container-test-run-container> machine2 # [2170629.157175] machine2 systemd[1]: Finished SSH Host Keys Generation. container-test-run-container> machine2 # [2170629.159102] machine2 systemd[1]: Starting SSH Daemon... container-test-run-container> machine2 # [2170629.208719] machine2 sshd[281]: Server listening on 0.0.0.0 port 22. container-test-run-container> machine2 # [2170629.208757] machine2 sshd[281]: Server listening on :: port 22. container-test-run-container> machine2 # [2170629.209198] machine2 systemd[1]: Started SSH Daemon. container-test-run-container> machine2 # [2170629.209517] machine2 systemd[1]: Reached target Multi-User System. container-test-run-container> machine2 # [2170629.209905] machine2 systemd[1]: Startup finished in 3.263s. container-test-run-container> Container machine1 terminated by signal KILL. container-test-run-container> (finished: cleanup, in 0.28 seconds) container-test-run-container> Container machine2 terminated by signal KILL.