container-test-run-service-dummy-test-from-flake
checks.aarch64-linux.service-dummy-test-from-flake
· build #663
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.01 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(admin1): TAP vde-tap1 not found; container will be isolated from VDE19nixos-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.20nixos-nspawn(peer1): TAP vde-tap1 not found; container will be isolated from VDE21nixos-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.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 admin1 on /build/vm-state-admin1.25░ Spawning container peer1 on /build/vm-state-peer1.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).30admin1 # No journal files were found.31admin1 # No journal boot entry found for the specified boot (+0).32peer1 # No journal files were found.33peer1 # No journal boot entry found for the specified boot (+0).34peer1 # [976345.713136] peer1 systemd-journald[78]: Journal started35peer1 # [976345.713202] peer1 systemd-journald[78]: Runtime Journal (/run/log/journal/a30cbee2fbbf4f10abb1f8403bbe6b53) is 8M, max 2.5G, 2.4G free.36peer1 # [976345.718152] peer1 systemd[1]: Finished Apply Kernel Variables.37peer1 # [976345.731625] peer1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.38peer1 # [976345.746694] peer1 systemd[1]: Starting Flush Journal to Persistent Storage...39peer1 # [976345.747917] peer1 systemd[1]: Starting Network Name Resolution...40peer1 # [976345.748884] peer1 systemd[1]: Starting Create Static Device Nodes in /dev...41peer1 # [976345.758080] peer1 systemd-journald[78]: Time spent on flushing to /var/log/journal/a30cbee2fbbf4f10abb1f8403bbe6b53 is 5.774ms for 7 entries.42admin1 # [976345.713474] admin1 systemd-journald[69]: Journal started43admin1 # [976345.713529] admin1 systemd-journald[69]: Runtime Journal (/run/log/journal/8e90b0079636412787dbe183ed6961c0) is 8M, max 2.5G, 2.4G free.44admin1 # [976345.725728] admin1 systemd[1]: Finished Apply Kernel Variables.45admin1 # [976345.742499] admin1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.46admin1 # [976345.762573] admin1 systemd[1]: Starting Flush Journal to Persistent Storage...47admin1 # [976345.764081] admin1 systemd[1]: Starting Network Name Resolution...48admin1 # [976345.765627] admin1 systemd[1]: Starting Create Static Device Nodes in /dev...49admin1 # [976345.772638] admin1 systemd-journald[69]: Time spent on flushing to /var/log/journal/8e90b0079636412787dbe183ed6961c0 is 6ms for 7 entries.50admin1 # [976345.772638] admin1 systemd-journald[69]: System Journal (/var/log/journal/8e90b0079636412787dbe183ed6961c0) is 8M, max 4G, 3.9G free.51admin1 # [976345.783271] admin1 systemd[1]: Finished Create Static Device Nodes in /dev.52admin1 # [976345.784929] admin1 systemd[1]: Reached target Preparation for Local File Systems.53admin1 # [976345.785096] admin1 systemd[1]: Reached target Local File Systems.54admin1 # [976345.786367] admin1 systemd[1]: Listening on Boot Loader Control Service Socket.55admin1 # [976345.786434] admin1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container56admin1 # [976345.787471] admin1 systemd[1]: Starting Save Transient machine-id to Disk...57admin1 # [976345.787518] admin1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys58admin1 # [976345.885918] admin1 systemd[1]: Finished Firewall.59admin1 # [976345.886104] admin1 systemd[1]: Reached target Preparation for Network.60admin1 # [976345.886356] admin1 systemd[1]: Listening on Network Management Resolve Hook Socket.61admin1 # [976345.887445] admin1 systemd[1]: Starting Network Management...62admin1 # [976346.268292] admin1 systemd-networkd[172]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted63admin1 # [976346.268395] admin1 systemd-networkd[172]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted64admin1 # [976346.275412] 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.65admin1 # [976346.275576] 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.66admin1 # [976346.275748] admin1 systemd-networkd[172]: lo: Link UP67admin1 # [976346.275752] admin1 systemd-networkd[172]: lo: Gained carrier68admin1 # [976346.275942] admin1 systemd-networkd[172]: eth1: Configuring with /etc/systemd/network/40-eth1.network.69admin1 # [976346.276433] admin1 systemd[1]: Started Network Management.70admin1 # [976346.276727] admin1 systemd-networkd[172]: eth1: Link UP71admin1 # [976346.276962] admin1 systemd-networkd[172]: eth1: Gained carrier72admin1 # [976346.278215] admin1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...73admin1 # [976346.379661] admin1 systemd-resolved[110]: Positive Trust Anchors:74admin1 # [976346.379669] admin1 systemd-resolved[110]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d75admin1 # [976346.379672] admin1 systemd-resolved[110]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b1676admin1 # [976346.379706] admin1 systemd-resolved[110]: 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 test77admin1 # [976346.399550] admin1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.78admin1 # [976346.402242] admin1 systemd-resolved[110]: Using system hostname 'admin1'.79admin1 # [976346.403649] admin1 systemd[1]: Started Network Name Resolution.80admin1 # [976346.403772] admin1 systemd[1]: Reached target Network.81admin1 # [976346.476443] admin1 systemd[1]: Finished Flush Journal to Persistent Storage.82admin1 # [976346.478526] admin1 systemd[1]: Starting Create System Files and Directories...83admin1 # [976346.574526] admin1 systemd-tmpfiles[179]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted84peer1 # [976345.758080] peer1 systemd-journald[78]: System Journal (/var/log/journal/a30cbee2fbbf4f10abb1f8403bbe6b53) is 8M, max 4G, 3.9G free.85peer1 # [976345.768479] peer1 systemd[1]: Finished Create Static Device Nodes in /dev.86peer1 # [976345.768760] peer1 systemd[1]: Reached target Preparation for Local File Systems.87peer1 # [976345.768847] peer1 systemd[1]: Reached target Local File Systems.88peer1 # [976345.769603] peer1 systemd[1]: Listening on Boot Loader Control Service Socket.89peer1 # [976345.769648] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container90peer1 # [976345.770653] peer1 systemd[1]: Starting Save Transient machine-id to Disk...91peer1 # [976345.770689] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys92peer1 # [976345.882181] peer1 systemd[1]: Finished Firewall.93peer1 # [976345.882378] peer1 systemd[1]: Reached target Preparation for Network.94peer1 # [976345.882674] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket.95peer1 # [976345.884169] peer1 systemd[1]: Starting Network Management...96peer1 # [976346.308348] peer1 systemd-networkd[181]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted97peer1 # [976346.308448] peer1 systemd-networkd[181]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted98peer1 # [976346.315228] peer1 systemd-networkd[181]: /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.99peer1 # [976346.315390] peer1 systemd-networkd[181]: /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.100peer1 # [976346.315555] peer1 systemd-networkd[181]: lo: Link UP101peer1 # [976346.315558] peer1 systemd-networkd[181]: lo: Gained carrier102peer1 # [976346.315743] peer1 systemd-networkd[181]: eth1: Configuring with /etc/systemd/network/40-eth1.network.103peer1 # [976346.316218] peer1 systemd[1]: Started Network Management.104peer1 # [976346.369986] peer1 systemd-resolved[111]: Positive Trust Anchors:105peer1 # [976346.369997] peer1 systemd-resolved[111]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d106peer1 # [976346.370000] peer1 systemd-resolved[111]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16107peer1 # [976346.370034] peer1 systemd-resolved[111]: 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 test108peer1 # [976346.380625] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...109peer1 # [976346.380816] peer1 systemd-networkd[181]: eth1: Link UP110peer1 # [976346.381106] peer1 systemd-networkd[181]: eth1: Gained carrier111peer1 # [976346.392528] peer1 systemd-resolved[111]: Using system hostname 'peer1'.112peer1 # [976346.393915] peer1 systemd[1]: Started Network Name Resolution.113peer1 # [976346.394038] peer1 systemd[1]: Reached target Network.114peer1 # [976346.511725] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.115peer1 # [976346.639067] peer1 systemd[1]: Finished Flush Journal to Persistent Storage.116peer1 # [976346.640943] peer1 systemd[1]: Starting Create System Files and Directories...117peer1 # [976346.668995] peer1 systemd-tmpfiles[188]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted118peer1 # [976346.669178] peer1 systemd-tmpfiles[188]: fchmod() of /var/log/journal failed: Operation not permitted119peer1 # [976346.669303] peer1 systemd-tmpfiles[188]: fchmod() of /var/log/journal/a30cbee2fbbf4f10abb1f8403bbe6b53 failed: Operation not permitted120peer1 # [976346.669479] peer1 systemd-tmpfiles[188]: fchmod() of /run/log/journal failed: Operation not permitted121admin1 # [976346.578999] admin1 systemd-tmpfiles[179]: fchmod() of /var/log/journal failed: Operation not permitted122admin1 # [976346.581263] admin1 systemd-tmpfiles[179]: fchmod() of /var/log/journal/8e90b0079636412787dbe183ed6961c0 failed: Operation not permitted123admin1 # [976346.581466] admin1 systemd-tmpfiles[179]: fchmod() of /run/log/journal failed: Operation not permitted124admin1 # [976346.616855] admin1 systemd[1]: Finished Create System Files and Directories.125admin1 # [976346.618884] admin1 systemd[1]: Starting Rebuild Journal Catalog...126admin1 # [976346.620295] admin1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...127admin1 # [976346.634291] admin1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.128admin1 # [976346.640580] admin1 systemd[1]: Finished Rebuild Journal Catalog.129admin1 # [976346.642049] admin1 systemd[1]: Starting Update is Completed...130admin1 # [976346.667022] admin1 systemd[1]: Finished Update is Completed.131admin1 # [976346.667327] admin1 systemd[1]: Reached target System Initialization.132admin1 # [976346.667470] admin1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container133admin1 # [976346.667539] admin1 systemd[1]: Started Daily Cleanup of Temporary Directories.134admin1 # [976346.667580] admin1 systemd[1]: Reached target Timer Units.135admin1 # [976346.667813] admin1 systemd[1]: Listening on D-Bus System Message Bus Socket.136admin1 # [976346.668070] admin1 systemd[1]: Listening on Nix Daemon Socket.137admin1 # [976346.668311] admin1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.138admin1 # [976346.668368] admin1 systemd[1]: Reached target Socket Units.139admin1 # [976346.668459] admin1 systemd[1]: Reached target Basic System.140admin1 # [976346.670345] admin1 systemd[1]: Starting Import lastlog data into lastlog2 database...141admin1 # [976346.671865] admin1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...142admin1 # [976346.674207] admin1 systemd[1]: Starting D-Bus System Message Bus...143admin1 # [976346.707141] admin1 systemd[1]: Finished Import lastlog data into lastlog2 database.144peer1 # [976346.670941] peer1 systemd[1]: Finished Create System Files and Directories.145peer1 # [976346.672040] peer1 systemd[1]: Starting Rebuild Journal Catalog...146peer1 # [976346.672814] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...147peer1 # [976346.686653] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.148peer1 # [976346.696840] peer1 systemd[1]: Finished Rebuild Journal Catalog.149peer1 # [976346.698383] peer1 systemd[1]: Starting Update is Completed...150peer1 # [976346.708928] peer1 systemd[1]: Finished Update is Completed.151peer1 # [976346.709043] peer1 systemd[1]: Reached target System Initialization.152peer1 # [976346.709127] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container153peer1 # [976346.709166] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories.154peer1 # [976346.709193] peer1 systemd[1]: Reached target Timer Units.155peer1 # [976346.709314] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket.156peer1 # [976346.709439] peer1 systemd[1]: Listening on Nix Daemon Socket.157peer1 # [976346.709551] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.158peer1 # [976346.709571] peer1 systemd[1]: Reached target Socket Units.159peer1 # [976346.709621] peer1 systemd[1]: Reached target Basic System.160peer1 # [976346.710674] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database...161peer1 # [976346.720782] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...162peer1 # [976346.727622] peer1 systemd[1]: Starting D-Bus System Message Bus...163peer1 # [976346.738889] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database.164peer1 # [976346.822276] peer1 nsncd[197]: Sep 15 14:39:26.808 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"165peer1 # [976346.822522] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd).166peer1 # [976346.822602] peer1 systemd[1]: Reached target Host and Network Name Lookups.167peer1 # [976346.822678] peer1 systemd[1]: Reached target User and Group Name Lookups.168peer1 # [976346.844581] peer1 systemd[1]: Starting User Login Management...169peer1 # [976346.845617] peer1 systemd[1]: Starting Permit User Sessions...170peer1 # [976346.858204] peer1 systemd[1]: Finished Permit User Sessions.171peer1 # [976346.859375] peer1 systemd[1]: Started Console Getty.172peer1 # [976346.859426] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0173peer1 # [976346.859452] peer1 systemd[1]: Reached target Login Prompts.174admin1 # [976346.800971] admin1 nsncd[188]: Sep 15 14:39:26.785 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"175admin1 # [976346.800066] admin1 systemd[1]: Started Name Service Cache Daemon (nsncd).176admin1 # [976346.800203] admin1 systemd[1]: Reached target Host and Network Name Lookups.177admin1 # [976346.800308] admin1 systemd[1]: Reached target User and Group Name Lookups.178admin1 # [976346.805562] admin1 systemd[1]: Starting User Login Management...179admin1 # [976346.806963] admin1 systemd[1]: Starting Permit User Sessions...180admin1 # [976346.853009] admin1 systemd[1]: Finished Permit User Sessions.181admin1 # [976346.854767] admin1 systemd[1]: Started Console Getty.182admin1 # [976346.854843] admin1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0183admin1 # [976346.854883] admin1 systemd[1]: Reached target Login Prompts.184admin1 # [976346.912154] admin1 dbus-broker-launch[189]: Looking up NSS user entry for 'systemd-timesync'...185admin1 # [976346.913357] admin1 dbus-broker-launch[189]: NSS returned no entry for 'systemd-timesync'186admin1 # [976346.913357] 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"187admin1 # [976346.913917] admin1 systemd[1]: Started D-Bus System Message Bus.188admin1 # [976346.923668] admin1 dbus-broker-launch[189]: Ready189peer1 # [976346.951419] peer1 dbus-broker-launch[199]: Looking up NSS user entry for 'systemd-timesync'...190peer1 # [976346.953463] peer1 dbus-broker-launch[199]: NSS returned no entry for 'systemd-timesync'191peer1 # [976346.953463] peer1 dbus-broker-launch[199]: Invalid user-name in /nix/store/5xsyadnlhlwnyvziab02f3n7ak7gk87b-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"192peer1 # [976346.953920] peer1 systemd[1]: Started D-Bus System Message Bus.193peer1 # [976346.962007] peer1 dbus-broker-launch[199]: Ready194peer1 # [976347.369349] peer1 systemd-logind[213]: New seat seat0.195peer1 # [976347.369541] peer1 systemd[1]: Started User Login Management.196peer1 # [976347.371742] peer1 systemd[1]: Starting linger-users.service...197peer1 # [976347.524274] peer1 systemd-networkd[181]: eth1: Gained IPv6LL198admin1 # [976347.383493] admin1 systemd-logind[204]: New seat seat0.199admin1 # [976347.383738] admin1 systemd[1]: Started User Login Management.200admin1 # [976347.616229] admin1 systemd-networkd[172]: eth1: Gained IPv6LL201admin1 # [976347.617231] admin1 systemd[1]: Starting linger-users.service...202admin1 # [976347.632967] admin1 systemd[1]: linger-users.service: Deactivated successfully.203admin1 # [976347.633118] admin1 systemd[1]: Finished linger-users.service.204admin1 # [976347.633925] admin1 systemd[1]: Reached target Multi-User System.205peer1 # [976347.630609] peer1 systemd[1]: linger-users.service: Deactivated successfully.206peer1 # [976347.630831] peer1 systemd[1]: Finished linger-users.service.207peer1 # [976347.631340] peer1 systemd[1]: Reached target Multi-User System.208admin1: still waiting for container 'admin1' to reach ready state...209admin1: still waiting for container 'admin1' to reach ready state...210admin1: still waiting for container 'admin1' to reach ready state...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...217peer1 # [976435.916780] peer1 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.218admin1 # [976435.965930] admin1 systemd[1]: systemd-machine-id-commit.service: start operation timed out. Terminating.219admin1: still waiting for container 'admin1' to reach ready state...220admin1: still waiting for container 'admin1' to reach ready state...221admin1: still waiting for container 'admin1' to reach ready state...222admin1: still waiting for container 'admin1' to reach ready state...223admin1: still waiting for container 'admin1' to reach ready state...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...228peer1 # [976526.166849] peer1 systemd[1]: systemd-machine-id-commit.service: State 'stop-sigterm' timed out. Killing.229peer1 # [976526.166943] peer1 systemd[1]: systemd-machine-id-commit.service: Killing process 124 (systemd-machine) with signal SIGKILL.230admin1 # [976526.216041] admin1 systemd[1]: systemd-machine-id-commit.service: State 'stop-sigterm' timed out. Killing.231admin1 # [976526.216133] admin1 systemd[1]: systemd-machine-id-commit.service: Killing process 123 (systemd-machine) with signal SIGKILL.232admin1: still waiting for container 'admin1' to reach ready state...233admin1: still waiting for container 'admin1' to reach ready state...234admin1: still waiting for container 'admin1' to reach ready state...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...241peer1 # [976616.416807] peer1 systemd[1]: systemd-machine-id-commit.service: Processes still around after SIGKILL. Ignoring.242admin1 # [976616.465960] admin1 systemd[1]: systemd-machine-id-commit.service: Processes still around after SIGKILL. Ignoring.243admin1: still waiting for container 'admin1' to reach ready state...244admin1: still waiting for container 'admin1' to reach ready state...245admin1: still waiting for container 'admin1' to reach ready state...246admin1: still waiting for container 'admin1' to reach ready state...247admin1: still waiting for container 'admin1' to reach ready state...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...252peer1 # [976706.636159] peer1 systemd[1]: systemd-machine-id-commit.service: State 'final-sigterm' timed out. Killing.253peer1 # [976706.636199] peer1 systemd[1]: systemd-machine-id-commit.service: Killing process 124 (systemd-machine) with signal SIGKILL.254admin1 # [976706.636171] admin1 systemd[1]: systemd-machine-id-commit.service: State 'final-sigterm' timed out. Killing.255admin1 # [976706.636227] admin1 systemd[1]: systemd-machine-id-commit.service: Killing process 123 (systemd-machine) with signal SIGKILL.256admin1: still waiting for container 'admin1' to reach ready state...257admin1: still waiting for container 'admin1' to reach ready state...258admin1: still waiting for container 'admin1' to reach ready state...259admin1: still waiting for container 'admin1' to reach ready state...260admin1: still waiting for container 'admin1' to reach ready state...261admin1: still waiting for container 'admin1' to reach ready state...262admin1: still waiting for container 'admin1' to reach ready state...263admin1: still waiting for container 'admin1' to reach ready state...264admin1: still waiting for container 'admin1' to reach ready state...265admin1: (finished: waiting for unit multi-user.target, in 453.33 seconds)266peer1: waiting for unit multi-user.target267peer1: (finished: waiting for unit multi-user.target, in 0.04 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)272peer1 # [976796.666783] peer1 systemd[1]: systemd-machine-id-commit.service: Processes still around after final SIGKILL. Entering failed mode.273peer1 # [976796.666806] peer1 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.274peer1 # [976796.667017] peer1 systemd[1]: systemd-machine-id-commit.service: Unit process 124 (systemd-machine) remains running after unit stopped.275peer1 # [976796.667650] peer1 systemd[1]: Failed to start Save Transient machine-id to Disk.276peer1 # [976796.668333] peer1 systemd[1]: Startup finished in 7min 32.266s.277peer1 # [976796.668454] peer1 systemd[1]: systemd-machine-id-commit.service: Consumed 1.637s CPU time over 7min 30.896s wall clock time.278admin1 # [976796.715930] admin1 systemd[1]: systemd-machine-id-commit.service: Processes still around after final SIGKILL. Entering failed mode.279admin1 # [976796.715950] admin1 systemd[1]: systemd-machine-id-commit.service: Failed with result 'timeout'.280admin1 # [976796.716106] admin1 systemd[1]: systemd-machine-id-commit.service: Unit process 123 (systemd-machine) remains running after unit stopped.281admin1 # [976796.716554] admin1 systemd[1]: Failed to start Save Transient machine-id to Disk.282admin1 # [976796.716993] admin1 systemd[1]: Startup finished in 7min 32.338s.283admin1 # [976796.717087] admin1 systemd[1]: systemd-machine-id-commit.service: Consumed 1.637s CPU time over 7min 30.928s wall clock time.284admin1285peer1286(finished: run the VM test script, in 473.39 seconds)287test script finished in 626.64s288cleanup289kill NspawnMachine (pid 52)290Container admin1 terminated by signal KILL.291kill NspawnMachine (pid 53)292Container peer1 terminated by signal KILL.293(finished: cleanup, in 0.88 seconds)