container-test-run-service-dummy-test-from-flake
checks.aarch64-linux.service-dummy-test-from-flake
· build #664
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)45Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 admin1, peer1,9 vlan1,10 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_ssh11start all VMs12admin1: systemd-nspawn running (pid 52)13peer1: systemd-nspawn running (pid 53)14admin1: Waiting for journal at /build/vm-state-admin1/var/log/journal...15peer1: Waiting for journal at /build/vm-state-peer1/var/log/journal...16(finished: start all VMs, in 0.00 seconds)17admin1: waiting for unit multi-user.target18nixos-nspawn(peer1): TAP vde-tap1 not found; container will be isolated from VDE19nixos-nspawn(peer1): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.20nixos-nspawn(admin1): TAP vde-tap1 not found; container will be isolated from VDE21nixos-nspawn(admin1): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths.22Note: 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.23Note: 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.24░ Spawning container peer1 on /build/vm-state-peer1.25░ Spawning container admin1 on /build/vm-state-admin1.26admin1 # No journal files were found.27admin1 # No journal boot entry found for the specified boot (+0).28peer1 # No journal files were found.29peer1 # No journal boot entry found for the specified boot (+0).30peer1 # [976531.453546] peer1 systemd-journald[78]: Journal started31peer1 # [976531.453604] peer1 systemd-journald[78]: Runtime Journal (/run/log/journal/f93286b1a626415db2d9903003f4e269) is 8M, max 2.5G, 2.4G free.32peer1 # [976531.464144] peer1 systemd[1]: Starting Flush Journal to Persistent Storage...33peer1 # [976531.465122] peer1 systemd[1]: Starting Network Name Resolution...34peer1 # [976531.465974] peer1 systemd[1]: Starting Create Static Device Nodes in /dev...35peer1 # [976531.475727] peer1 systemd-journald[78]: Time spent on flushing to /var/log/journal/f93286b1a626415db2d9903003f4e269 is 6.355ms for 5 entries.36peer1 # [976531.475727] peer1 systemd-journald[78]: System Journal (/var/log/journal/f93286b1a626415db2d9903003f4e269) is 8M, max 4G, 3.9G free.37peer1 # [976531.484086] peer1 systemd[1]: Finished Create Static Device Nodes in /dev.38peer1 # [976531.484348] peer1 systemd[1]: Reached target Preparation for Local File Systems.39peer1 # [976531.484439] peer1 systemd[1]: Reached target Local File Systems.40peer1 # [976531.485187] peer1 systemd[1]: Listening on Boot Loader Control Service Socket.41peer1 # [976531.485234] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container42peer1 # [976531.486262] peer1 systemd[1]: Starting Save Transient machine-id to Disk...43peer1 # [976531.486305] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys44peer1 # [976531.668355] peer1 systemd[1]: Finished Firewall.45peer1 # [976531.668553] peer1 systemd[1]: Reached target Preparation for Network.46peer1 # [976531.668796] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket.47peer1 # [976531.669881] peer1 systemd[1]: Starting Network Management...48peer1 # [976532.148578] peer1 systemd-networkd[182]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted49peer1 # [976532.148675] peer1 systemd-networkd[182]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted50peer1 # [976532.156096] peer1 systemd-networkd[182]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.51peer1 # [976532.156268] peer1 systemd-networkd[182]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.52admin1 # [976531.454188] admin1 systemd-journald[69]: Journal started53peer1 # [976532.156448] peer1 systemd-networkd[182]: lo: Link UP54admin1 # [976531.454244] admin1 systemd-journald[69]: Runtime Journal (/run/log/journal/d0b345cead2f40b99c9e9eede9e55244) is 8M, max 2.5G, 2.4G free.55peer1 # [976532.156452] peer1 systemd-networkd[182]: lo: Gained carrier56admin1 # [976531.464303] admin1 systemd[1]: Starting Flush Journal to Persistent Storage...57peer1 # [976532.156680] peer1 systemd-networkd[182]: eth1: Configuring with /etc/systemd/network/40-eth1.network.58admin1 # [976531.465223] admin1 systemd[1]: Starting Network Name Resolution...59peer1 # [976532.157141] peer1 systemd[1]: Started Network Management.60admin1 # [976531.466117] admin1 systemd[1]: Starting Create Static Device Nodes in /dev...61peer1 # [976532.220610] peer1 systemd-networkd[182]: eth1: Link UP62admin1 # [976531.475725] admin1 systemd-journald[69]: Time spent on flushing to /var/log/journal/d0b345cead2f40b99c9e9eede9e55244 is 5.743ms for 5 entries.63peer1 # [976532.221041] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...64admin1 # [976531.475725] admin1 systemd-journald[69]: System Journal (/var/log/journal/d0b345cead2f40b99c9e9eede9e55244) is 8M, max 4G, 3.9G free.65peer1 # [976532.221439] peer1 systemd-networkd[182]: eth1: Gained carrier66peer1 # [976532.228923] peer1 systemd-resolved[102]: Positive Trust Anchors:67admin1 # [976531.484242] admin1 systemd[1]: Finished Create Static Device Nodes in /dev.68peer1 # [976532.228930] peer1 systemd-resolved[102]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d69peer1 # [976532.228933] peer1 systemd-resolved[102]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b1670peer1 # [976532.228968] peer1 systemd-resolved[102]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test71peer1 # [976532.252537] peer1 systemd-resolved[102]: Using system hostname 'peer1'.72peer1 # [976532.253886] peer1 systemd[1]: Started Network Name Resolution.73peer1 # [976532.254005] peer1 systemd[1]: Reached target Network.74admin1 # [976531.484476] admin1 systemd[1]: Reached target Preparation for Local File Systems.75admin1 # [976531.484573] admin1 systemd[1]: Reached target Local File Systems.76peer1 # [976532.331473] peer1 systemd[1]: Finished Flush Journal to Persistent Storage.77admin1 # [976531.485298] admin1 systemd[1]: Listening on Boot Loader Control Service Socket.78peer1 # [976532.332626] peer1 systemd[1]: Starting Create System Files and Directories...79admin1 # [976531.485342] admin1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container80peer1 # [976532.354992] peer1 systemd-tmpfiles[187]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted81peer1 # [976532.355226] peer1 systemd-tmpfiles[187]: fchmod() of /var/log/journal failed: Operation not permitted82admin1 # [976531.486272] admin1 systemd[1]: Starting Save Transient machine-id to Disk...83peer1 # [976532.355389] peer1 systemd-tmpfiles[187]: fchmod() of /var/log/journal/f93286b1a626415db2d9903003f4e269 failed: Operation not permitted84admin1 # [976531.486311] admin1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys85peer1 # [976532.355628] peer1 systemd-tmpfiles[187]: fchmod() of /run/log/journal failed: Operation not permitted86admin1 # [976531.609994] admin1 systemd[1]: Finished Firewall.87peer1 # [976532.357946] peer1 systemd[1]: Finished Create System Files and Directories.88admin1 # [976531.611001] admin1 systemd[1]: Reached target Preparation for Network.89peer1 # [976532.359667] peer1 systemd[1]: Starting Rebuild Journal Catalog...90admin1 # [976531.611556] admin1 systemd[1]: Listening on Network Management Resolve Hook Socket.91peer1 # [976532.360951] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...92admin1 # [976531.613613] admin1 systemd[1]: Starting Network Management...93peer1 # [976532.373162] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.94admin1 # [976532.101598] admin1 systemd-networkd[172]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted95peer1 # [976532.380264] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.96admin1 # [976532.101693] admin1 systemd-networkd[172]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted97peer1 # [976532.385059] peer1 systemd[1]: Finished Rebuild Journal Catalog.98peer1 # [976532.386234] peer1 systemd[1]: Starting Update is Completed...99admin1 # [976532.110783] admin1 systemd-networkd[172]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.100peer1 # [976532.397688] peer1 systemd[1]: Finished Update is Completed.101peer1 # [976532.397806] peer1 systemd[1]: Reached target System Initialization.102admin1 # [976532.110951] admin1 systemd-networkd[172]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.103peer1 # [976532.397885] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container104peer1 # [976532.397919] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories.105peer1 # [976532.397937] peer1 systemd[1]: Reached target Timer Units.106peer1 # [976532.398052] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket.107admin1 # [976532.111433] admin1 systemd-networkd[172]: lo: Link UP108peer1 # [976532.398186] peer1 systemd[1]: Listening on Nix Daemon Socket.109admin1 # [976532.111437] admin1 systemd-networkd[172]: lo: Gained carrier110peer1 # [976532.398301] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.111admin1 # [976532.111818] admin1 systemd-networkd[172]: eth1: Configuring with /etc/systemd/network/40-eth1.network.112peer1 # [976532.398324] peer1 systemd[1]: Reached target Socket Units.113admin1 # [976532.112228] admin1 systemd[1]: Started Network Management.114peer1 # [976532.398365] peer1 systemd[1]: Reached target Basic System.115admin1 # [976532.112332] admin1 systemd-networkd[172]: eth1: Link UP116peer1 # [976532.399612] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database...117peer1 # [976532.400459] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...118peer1 # [976532.402300] peer1 systemd[1]: Starting D-Bus System Message Bus...119admin1 # [976532.113078] admin1 systemd-networkd[172]: eth1: Gained carrier120admin1 # [976532.114477] admin1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...121admin1 # [976532.201050] admin1 systemd-resolved[93]: Positive Trust Anchors:122admin1 # [976532.201060] admin1 systemd-resolved[93]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d123admin1 # [976532.201064] admin1 systemd-resolved[93]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16124admin1 # [976532.201098] admin1 systemd-resolved[93]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test125admin1 # [976532.224922] admin1 systemd-resolved[93]: Using system hostname 'admin1'.126admin1 # [976532.226254] admin1 systemd[1]: Started Network Name Resolution.127admin1 # [976532.226321] admin1 systemd[1]: Reached target Network.128admin1 # [976532.248864] admin1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.129admin1 # [976532.331231] admin1 systemd[1]: Finished Flush Journal to Persistent Storage.130admin1 # [976532.334402] admin1 systemd[1]: Starting Create System Files and Directories...131admin1 # [976532.354005] admin1 systemd-tmpfiles[179]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted132admin1 # [976532.354230] admin1 systemd-tmpfiles[179]: fchmod() of /var/log/journal failed: Operation not permitted133admin1 # [976532.354382] admin1 systemd-tmpfiles[179]: fchmod() of /var/log/journal/d0b345cead2f40b99c9e9eede9e55244 failed: Operation not permitted134admin1 # [976532.354610] admin1 systemd-tmpfiles[179]: fchmod() of /run/log/journal failed: Operation not permitted135admin1 # [976532.356291] admin1 systemd[1]: Finished Create System Files and Directories.136admin1 # [976532.357620] admin1 systemd[1]: Starting Rebuild Journal Catalog...137admin1 # [976532.358404] admin1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...138admin1 # [976532.372184] admin1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.139admin1 # [976532.381253] admin1 systemd[1]: Finished Rebuild Journal Catalog.140admin1 # [976532.382475] admin1 systemd[1]: Starting Update is Completed...141admin1 # [976532.396053] admin1 systemd[1]: Finished Update is Completed.142admin1 # [976532.396241] admin1 systemd[1]: Reached target System Initialization.143admin1 # [976532.396329] admin1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container144admin1 # [976532.396365] admin1 systemd[1]: Started Daily Cleanup of Temporary Directories.145admin1 # [976532.396382] admin1 systemd[1]: Reached target Timer Units.146admin1 # [976532.396503] admin1 systemd[1]: Listening on D-Bus System Message Bus Socket.147admin1 # [976532.396633] admin1 systemd[1]: Listening on Nix Daemon Socket.148admin1 # [976532.396744] admin1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.149admin1 # [976532.396765] admin1 systemd[1]: Reached target Socket Units.150admin1 # [976532.396804] admin1 systemd[1]: Reached target Basic System.151admin1 # [976532.397968] admin1 systemd[1]: Starting Import lastlog data into lastlog2 database...152admin1 # [976532.399078] admin1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...153admin1 # [976532.400518] admin1 systemd[1]: Starting D-Bus System Message Bus...154peer1 # [976532.421853] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database.155peer1 # [976532.511148] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd).156peer1 # [976532.511217] peer1 systemd[1]: Reached target Host and Network Name Lookups.157peer1 # [976532.511288] peer1 systemd[1]: Reached target User and Group Name Lookups.158peer1 # [976532.512104] peer1 nsncd[197]: Sep 15 14:42:32.497 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"159peer1 # [976532.513023] peer1 systemd[1]: Starting User Login Management...160peer1 # [976532.514027] peer1 systemd[1]: Starting Permit User Sessions...161peer1 # [976532.527191] peer1 systemd[1]: Finished Permit User Sessions.162peer1 # [976532.528369] peer1 systemd[1]: Started Console Getty.163peer1 # [976532.528416] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0164peer1 # [976532.528436] peer1 systemd[1]: Reached target Login Prompts.165admin1 # [976532.421558] admin1 systemd[1]: Finished Import lastlog data into lastlog2 database.166admin1 # [976532.511482] admin1 systemd[1]: Started Name Service Cache Daemon (nsncd).167admin1 # [976532.511900] admin1 systemd[1]: Reached target Host and Network Name Lookups.168admin1 # [976532.512591] admin1 nsncd[188]: Sep 15 14:42:32.498 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"169admin1 # [976532.512023] admin1 systemd[1]: Reached target User and Group Name Lookups.170admin1 # [976532.515004] admin1 systemd[1]: Starting User Login Management...171admin1 # [976532.516060] admin1 systemd[1]: Starting Permit User Sessions...172admin1 # [976532.527217] admin1 systemd[1]: Finished Permit User Sessions.173admin1 # [976532.528847] admin1 systemd[1]: Started Console Getty.174admin1 # [976532.528897] admin1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0175admin1 # [976532.528923] admin1 systemd[1]: Reached target Login Prompts.176peer1 # [976532.612913] peer1 dbus-broker-launch[198]: Looking up NSS user entry for 'systemd-timesync'...177peer1 # [976532.613633] peer1 dbus-broker-launch[198]: NSS returned no entry for 'systemd-timesync'178peer1 # [976532.613633] peer1 dbus-broker-launch[198]: Invalid user-name in /nix/store/5xsyadnlhlwnyvziab02f3n7ak7gk87b-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"179peer1 # [976532.615077] peer1 systemd[1]: Started D-Bus System Message Bus.180peer1 # [976532.623485] peer1 dbus-broker-launch[198]: Ready181admin1 # [976532.618847] admin1 dbus-broker-launch[189]: Looking up NSS user entry for 'systemd-timesync'...182admin1 # [976532.620124] admin1 dbus-broker-launch[189]: NSS returned no entry for 'systemd-timesync'183admin1 # [976532.620124] admin1 dbus-broker-launch[189]: Invalid user-name in /nix/store/5xsyadnlhlwnyvziab02f3n7ak7gk87b-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"184admin1 # [976532.620617] admin1 systemd[1]: Started D-Bus System Message Bus.185admin1 # [976532.631125] admin1 dbus-broker-launch[189]: Ready186admin1 # [976533.003176] admin1 systemd-logind[204]: New seat seat0.187admin1 # [976533.003404] admin1 systemd[1]: Started User Login Management.188admin1 # [976533.005634] admin1 systemd[1]: Starting linger-users.service...189admin1 # [976533.072542] admin1 systemd[1]: linger-users.service: Deactivated successfully.190admin1 # [976533.072683] admin1 systemd[1]: Finished linger-users.service.191admin1 # [976533.073261] admin1 systemd[1]: Reached target Multi-User System.192peer1 # [976532.998063] peer1 systemd-logind[213]: New seat seat0.193peer1 # [976532.998297] peer1 systemd[1]: Started User Login Management.194peer1 # [976533.000404] peer1 systemd[1]: Starting linger-users.service...195peer1 # [976533.072264] peer1 systemd[1]: linger-users.service: Deactivated successfully.196peer1 # [976533.072541] peer1 systemd[1]: Finished linger-users.service.197peer1 # [976533.072993] peer1 systemd[1]: Reached target Multi-User System.198admin1 # [976533.476195] admin1 systemd-networkd[172]: eth1: Gained IPv6LL199peer1 # [976533.920141] peer1 systemd-networkd[182]: eth1: Gained IPv6LL200admin1: still waiting for container 'admin1' to reach ready state...201admin1: still waiting for container 'admin1' to reach ready state...202admin1: still waiting for container 'admin1' to reach ready state...203admin1: still waiting for container 'admin1' to reach ready state...204admin1: still waiting for container 'admin1' to reach ready state...205admin1: still waiting for container 'admin1' to reach ready state...206admin1: still waiting for container 'admin1' to reach ready state...207admin1: still waiting for container 'admin1' to reach ready state...208admin1: still waiting for container 'admin1' to reach ready state...209admin1 # [976621.532238] admin1 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.210peer1 # [976621.644304] peer1 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.211admin1: still waiting for container 'admin1' to reach ready state...212admin1: still waiting for container 'admin1' to reach ready state...213admin1: still waiting for container 'admin1' to reach ready state...214admin1: still waiting for container 'admin1' to reach ready state...215admin1: still waiting for container 'admin1' to reach ready state...216admin1: still waiting for container 'admin1' to reach ready state...217admin1: still waiting for container 'admin1' to reach ready state...218admin1: still waiting for container 'admin1' to reach ready state...219admin1: still waiting for container 'admin1' to reach ready state...220admin1 # [976711.532337] admin1 systemd[1]: systemd-machine-id-commit.service: State 'stop-sigterm' timed out. Killing.221admin1 # [976711.532406] admin1 systemd[1]: systemd-machine-id-commit.service: Killing process 108 (systemd-machine) with signal SIGKILL.222peer1 # [976711.894182] peer1 systemd[1]: systemd-machine-id-commit.service: State 'stop-sigterm' timed out. Killing.223peer1 # [976711.894273] peer1 systemd[1]: systemd-machine-id-commit.service: Killing process 116 (systemd-machine) with signal SIGKILL.224admin1: still waiting for container 'admin1' to reach ready state...225admin1: still waiting for container 'admin1' to reach ready state...226admin1: still waiting for container 'admin1' to reach ready state...227admin1: still waiting for container 'admin1' to reach ready state...228admin1: still waiting for container 'admin1' to reach ready state...229admin1: still waiting for container 'admin1' to reach ready state...230admin1: still waiting for container 'admin1' to reach ready state...231admin1: still waiting for container 'admin1' to reach ready state...232admin1: still waiting for container 'admin1' to reach ready state...233admin1 # [976801.782242] admin1 systemd[1]: systemd-machine-id-commit.service: Processes still around after SIGKILL. Ignoring.234peer1 # [976802.144205] peer1 systemd[1]: systemd-machine-id-commit.service: Processes still around after SIGKILL. Ignoring.235admin1: still waiting for container 'admin1' to reach ready state...236admin1: still waiting for container 'admin1' to reach ready state...237admin1: still waiting for container 'admin1' to reach ready state...238admin1: still waiting for container 'admin1' to reach ready state...239admin1: still waiting for container 'admin1' to reach ready state...240admin1: still waiting for container 'admin1' to reach ready state...241admin1: still waiting for container 'admin1' to reach ready state...242admin1: still waiting for container 'admin1' to reach ready state...243admin1: still waiting for container 'admin1' to reach ready state...244admin1 # [976891.890838] admin1 systemd[1]: systemd-machine-id-commit.service: State 'final-sigterm' timed out. Killing.245admin1 # [976891.890892] admin1 systemd[1]: systemd-machine-id-commit.service: Killing process 108 (systemd-machine) with signal SIGKILL.246peer1 # [976892.394177] peer1 systemd[1]: systemd-machine-id-commit.service: State 'final-sigterm' timed out. Killing.247peer1 # [976892.394258] peer1 systemd[1]: systemd-machine-id-commit.service: Killing process 116 (systemd-machine) with signal SIGKILL.248admin1: still waiting for container 'admin1' to reach ready state...249admin1: still waiting for container 'admin1' to reach ready state...250admin1: still waiting for container 'admin1' to reach ready state...251admin1: still waiting for container 'admin1' to reach ready state...252admin1: still waiting for container 'admin1' to reach ready state...253admin1: still waiting for container 'admin1' to reach ready state...254admin1: still waiting for container 'admin1' to reach ready state...255admin1 # [976969.772218] admin1 systemd[1]: systemd-machine-id-commit.service: Main process exited, code=killed, status=15/TERM256admin1 # [976969.772238] admin1 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.257admin1 # [976969.773715] admin1 systemd[1]: Failed to start Save Transient machine-id to Disk.258admin1 # [976969.774038] admin1 systemd[1]: Startup finished in 7min 18.824s.259admin1 # [976969.774061] admin1 systemd[1]: systemd-machine-id-commit.service: Consumed 1.981s CPU time over 7min 18.286s wall clock time.260peer1 # [976969.772183] peer1 systemd[1]: systemd-machine-id-commit.service: Main process exited, code=killed, status=15/TERM261peer1 # [976969.772199] peer1 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.262peer1 # [976969.773743] peer1 systemd[1]: Failed to start Save Transient machine-id to Disk.263peer1 # [976969.774098] peer1 systemd[1]: Startup finished in 7min 18.815s.264peer1 # [976969.774127] peer1 systemd[1]: systemd-machine-id-commit.service: Consumed 1.981s CPU time over 7min 18.286s wall clock time.265admin1: (finished: waiting for unit multi-user.target, in 439.78 seconds)266peer1: waiting for unit multi-user.target267peer1: (finished: waiting for unit multi-user.target, in 0.03 seconds)268peer1: must succeed: cat /nix/store/z61c0lalzvfahapklpif5sc0cd4x5g4b-per-machine-peer1-new-service_not-a-secret269peer1: (finished: must succeed: cat /nix/store/z61c0lalzvfahapklpif5sc0cd4x5g4b-per-machine-peer1-new-service_not-a-secret, in 0.01 seconds)270peer1: must succeed: ls -la /run/secrets/per-machine/peer1/new-service/a-secret271peer1: (finished: must succeed: ls -la /run/secrets/per-machine/peer1/new-service/a-secret, in 0.01 seconds)272admin1273peer1274(finished: run the VM test script, in 456.08 seconds)275test script finished in 473.65s276cleanup277kill NspawnMachine (pid 52)278kill NspawnMachine (pid 53)279Container admin1 terminated by signal KILL.280Container peer1 terminated by signal KILL.281(finished: cleanup, in 0.43 seconds)