container-test-run-service-dummy-test-from-flake
checks.aarch64-linux.service-dummy-test-from-flake
· build #1096
· raw
1build01: building 26qxpvnlswaahc8m69q70w02c9ykjg9x-container-test-run-service-dummy-test-from-flake.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Initializing machine ID from random generator.6Test will time out and terminate in 3600.0 seconds7run the VM test script8additionally exposed symbols:9 admin1, peer1,10 vlan1,11 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_ssh12start all VMs13admin1: systemd-nspawn running (pid 52)14peer1: systemd-nspawn running (pid 53)15admin1: Waiting for journal at /build/vm-state-admin1/var/log/journal...16peer1: Waiting for journal at /build/vm-state-peer1/var/log/journal...17(finished: start all VMs, in 0.00 seconds)18admin1: waiting for unit multi-user.target19nixos-nspawn(peer1): TAP vde-tap1 not found; container will be isolated from VDE20nixos-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.21nixos-nspawn(admin1): TAP vde-tap1 not found; container will be isolated from VDE22nixos-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.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.24Note: 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.25░ Spawning container admin1 on /build/vm-state-admin1.26░ Spawning container peer1 on /build/vm-state-peer1.27admin1 # No journal boot entry found for the specified boot (+0).28peer1 # No journal boot entry found for the specified boot (+0).29admin1 # [552022.517401] admin1 systemd-journald[73]: Journal started30admin1 # [552022.517463] admin1 systemd-journald[73]: Runtime Journal (/run/log/journal/509b37e9152a4d9aa461a080930646d8) is 8M, max 2.5G, 2.4G free.31admin1 # [552022.526225] admin1 systemd[1]: Finished Apply Kernel Variables.32admin1 # [552022.539426] admin1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.33admin1 # [552022.554287] admin1 systemd[1]: Starting Flush Journal to Persistent Storage...34admin1 # [552022.555144] admin1 systemd[1]: Starting Network Name Resolution...35admin1 # [552022.555910] admin1 systemd[1]: Starting Create Static Device Nodes in /dev...36admin1 # [552022.602683] admin1 systemd-journald[73]: Time spent on flushing to /var/log/journal/509b37e9152a4d9aa461a080930646d8 is 1.969ms for 7 entries.37admin1 # [552022.602683] admin1 systemd-journald[73]: System Journal (/var/log/journal/509b37e9152a4d9aa461a080930646d8) is 8M, max 4G, 3.9G free.38peer1 # [552022.515766] peer1 systemd-journald[82]: Journal started39admin1 # [552022.621939] admin1 systemd[1]: Finished Create Static Device Nodes in /dev.40peer1 # [552022.515823] peer1 systemd-journald[82]: Runtime Journal (/run/log/journal/0bdf15daebdb494ba1542b9ffff3c1a0) is 8M, max 2.5G, 2.4G free.41admin1 # [552022.622582] admin1 systemd[1]: Reached target Preparation for Local File Systems.42peer1 # [552022.526178] peer1 systemd[1]: Finished Apply Kernel Variables.43admin1 # [552022.622693] admin1 systemd[1]: Reached target Local File Systems.44peer1 # [552022.539548] peer1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.45admin1 # [552022.623437] admin1 systemd[1]: Listening on Boot Loader Control Service Socket.46peer1 # [552022.554225] peer1 systemd[1]: Starting Flush Journal to Persistent Storage...47admin1 # [552022.623492] admin1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container48peer1 # [552022.555464] peer1 systemd[1]: Starting Network Name Resolution...49admin1 # [552022.624434] admin1 systemd[1]: Starting Save Transient machine-id to Disk...50peer1 # [552022.556399] peer1 systemd[1]: Starting Create Static Device Nodes in /dev...51admin1 # [552022.624470] admin1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys52peer1 # [552022.602856] peer1 systemd-journald[82]: Time spent on flushing to /var/log/journal/0bdf15daebdb494ba1542b9ffff3c1a0 is 1.806ms for 7 entries.53admin1 # [552022.670628] admin1 systemd[1]: Finished Flush Journal to Persistent Storage.54peer1 # [552022.602856] peer1 systemd-journald[82]: System Journal (/var/log/journal/0bdf15daebdb494ba1542b9ffff3c1a0) is 8M, max 4G, 3.9G free.55admin1 # [552022.671755] admin1 systemd[1]: Starting Create System Files and Directories...56peer1 # [552022.621963] peer1 systemd[1]: Finished Create Static Device Nodes in /dev.57admin1 # [552022.682727] admin1 systemd[1]: Finished Firewall.58peer1 # [552022.622595] peer1 systemd[1]: Reached target Preparation for Local File Systems.59admin1 # [552022.682890] admin1 systemd[1]: Reached target Preparation for Network.60peer1 # [552022.622702] peer1 systemd[1]: Reached target Local File Systems.61admin1 # [552022.683204] admin1 systemd[1]: Listening on Network Management Resolve Hook Socket.62peer1 # [552022.623446] peer1 systemd[1]: Listening on Boot Loader Control Service Socket.63admin1 # [552022.684326] admin1 systemd[1]: Starting Network Management...64peer1 # [552022.623496] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container65admin1 # [552022.688241] admin1 systemd-tmpfiles[173]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted66peer1 # [552022.624437] peer1 systemd[1]: Starting Save Transient machine-id to Disk...67admin1 # [552022.688441] admin1 systemd-tmpfiles[173]: fchmod() of /var/log/journal failed: Operation not permitted68peer1 # [552022.624477] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys69admin1 # [552022.688572] admin1 systemd-tmpfiles[173]: fchmod() of /var/log/journal/509b37e9152a4d9aa461a080930646d8 failed: Operation not permitted70peer1 # [552022.662716] peer1 systemd[1]: Finished Flush Journal to Persistent Storage.71admin1 # [552022.688768] admin1 systemd-tmpfiles[173]: fchmod() of /run/log/journal failed: Operation not permitted72peer1 # [552022.664612] peer1 systemd[1]: Starting Create System Files and Directories...73admin1 # [552022.690223] admin1 systemd[1]: Finished Create System Files and Directories.74peer1 # [552022.679676] peer1 systemd-tmpfiles[178]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted75admin1 # [552022.691254] admin1 systemd[1]: Starting Rebuild Journal Catalog...76peer1 # [552022.679844] peer1 systemd-tmpfiles[178]: fchmod() of /var/log/journal failed: Operation not permitted77admin1 # [552022.691950] admin1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...78peer1 # [552022.679955] peer1 systemd-tmpfiles[178]: fchmod() of /var/log/journal/0bdf15daebdb494ba1542b9ffff3c1a0 failed: Operation not permitted79admin1 # [552022.704518] admin1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.80peer1 # [552022.680143] peer1 systemd-tmpfiles[178]: fchmod() of /run/log/journal failed: Operation not permitted81admin1 # [552022.715437] admin1 systemd[1]: Finished Rebuild Journal Catalog.82peer1 # [552022.681423] peer1 systemd[1]: Finished Create System Files and Directories.83admin1 # [552022.716847] admin1 systemd[1]: Starting Update is Completed...84peer1 # [552022.681675] peer1 systemd[1]: Finished Firewall.85admin1 # [552022.729367] admin1 systemd[1]: Finished Update is Completed.86peer1 # [552022.682337] peer1 systemd[1]: Reached target Preparation for Network.87admin1 # [552023.393897] admin1 systemd-networkd[179]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted88peer1 # [552022.682612] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket.89admin1 # [552023.393986] admin1 systemd-networkd[179]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted90peer1 # [552022.683709] peer1 systemd[1]: Starting Rebuild Journal Catalog...91admin1 # [552023.403948] admin1 systemd-networkd[179]: /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.92peer1 # [552022.684752] peer1 systemd[1]: Starting Network Management...93admin1 # [552023.404124] admin1 systemd-networkd[179]: /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.94peer1 # [552022.685492] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...95admin1 # [552023.404276] admin1 systemd-networkd[179]: lo: Link UP96peer1 # [552022.703748] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.97admin1 # [552023.404282] admin1 systemd-networkd[179]: lo: Gained carrier98peer1 # [552022.708557] peer1 systemd[1]: Finished Rebuild Journal Catalog.99admin1 # [552023.404452] admin1 systemd-networkd[179]: eth1: Configuring with /etc/systemd/network/40-eth1.network.100peer1 # [552022.710345] peer1 systemd[1]: Starting Update is Completed...101admin1 # [552023.404962] admin1 systemd[1]: Started Network Management.102peer1 # [552022.722510] peer1 systemd[1]: Finished Update is Completed.103admin1 # [552023.424337] admin1 systemd-networkd[179]: eth1: Link UP104peer1 # [552023.382923] peer1 systemd-networkd[190]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted105admin1 # [552023.424631] admin1 systemd-networkd[179]: eth1: Gained carrier106peer1 # [552023.383020] peer1 systemd-networkd[190]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted107admin1 # [552023.424729] admin1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...108peer1 # [552023.393552] peer1 systemd-networkd[190]: /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.109admin1 # [552023.486281] admin1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.110peer1 # [552023.393723] peer1 systemd-networkd[190]: /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.111peer1 # [552023.393892] peer1 systemd-networkd[190]: lo: Link UP112peer1 # [552023.393897] peer1 systemd-networkd[190]: lo: Gained carrier113peer1 # [552023.394093] peer1 systemd-networkd[190]: eth1: Configuring with /etc/systemd/network/40-eth1.network.114peer1 # [552023.394792] peer1 systemd-networkd[190]: eth1: Link UP115peer1 # [552023.394879] peer1 systemd[1]: Started Network Management.116peer1 # [552023.395047] peer1 systemd-networkd[190]: eth1: Gained carrier117peer1 # [552023.396408] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...118peer1 # [552023.446428] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.119peer1 # [552023.794345] peer1 systemd-resolved[119]: Positive Trust Anchors:120peer1 # [552023.794368] peer1 systemd-resolved[119]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d121peer1 # [552023.794370] peer1 systemd-resolved[119]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16122peer1 # [552023.794406] peer1 systemd-resolved[119]: 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 test123peer1 # [552023.796038] peer1 systemd-resolved[119]: Using system hostname 'peer1'.124peer1 # [552023.797814] peer1 systemd[1]: Started Network Name Resolution.125peer1 # [552023.797887] peer1 systemd[1]: Reached target Network.126peer1 # [552023.797975] peer1 systemd[1]: Reached target System Initialization.127peer1 # [552023.798025] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container128peer1 # [552023.798048] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories.129peer1 # [552023.798067] peer1 systemd[1]: Reached target Timer Units.130peer1 # [552023.798219] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket.131peer1 # [552023.798345] peer1 systemd[1]: Listening on Nix Daemon Socket.132peer1 # [552023.798507] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.133peer1 # [552023.798526] peer1 systemd[1]: Reached target Socket Units.134peer1 # [552023.798574] peer1 systemd[1]: Reached target Basic System.135peer1 # [552023.800229] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database...136peer1 # [552023.801229] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...137peer1 # [552023.802526] peer1 systemd[1]: Starting D-Bus System Message Bus...138peer1 # [552023.849382] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database.139admin1 # [552023.794382] admin1 systemd-resolved[110]: Positive Trust Anchors:140admin1 # [552023.794397] admin1 systemd-resolved[110]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d141admin1 # [552023.794400] admin1 systemd-resolved[110]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16142admin1 # [552023.794436] 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 test143admin1 # [552023.795373] admin1 systemd-resolved[110]: Using system hostname 'admin1'.144admin1 # [552023.797076] admin1 systemd[1]: Started Network Name Resolution.145admin1 # [552023.797166] admin1 systemd[1]: Reached target Network.146admin1 # [552023.797243] admin1 systemd[1]: Reached target System Initialization.147admin1 # [552023.797293] admin1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container148admin1 # [552023.797325] admin1 systemd[1]: Started Daily Cleanup of Temporary Directories.149admin1 # [552023.797348] admin1 systemd[1]: Reached target Timer Units.150admin1 # [552023.797500] admin1 systemd[1]: Listening on D-Bus System Message Bus Socket.151admin1 # [552023.797626] admin1 systemd[1]: Listening on Nix Daemon Socket.152admin1 # [552023.797747] admin1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.153admin1 # [552023.797778] admin1 systemd[1]: Reached target Socket Units.154admin1 # [552023.797828] admin1 systemd[1]: Reached target Basic System.155admin1 # [552023.799417] admin1 systemd[1]: Starting Import lastlog data into lastlog2 database...156admin1 # [552023.800410] admin1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...157admin1 # [552023.801928] admin1 systemd[1]: Starting D-Bus System Message Bus...158admin1 # [552023.849600] admin1 systemd[1]: Finished Import lastlog data into lastlog2 database.159admin1 # [552024.037225] admin1 systemd[1]: Started Name Service Cache Daemon (nsncd).160admin1 # [552024.038686] admin1 nsncd[192]: Oct 22 18:43:49.009 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"161admin1 # [552024.037316] admin1 systemd[1]: Reached target Host and Network Name Lookups.162admin1 # [552024.037386] admin1 systemd[1]: Reached target User and Group Name Lookups.163admin1 # [552024.039037] admin1 systemd[1]: Starting User Login Management...164admin1 # [552024.040038] admin1 systemd[1]: Starting Permit User Sessions...165peer1 # [552024.049541] peer1 nsncd[201]: Oct 22 18:43:49.021 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"166peer1 # [552024.049523] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd).167peer1 # [552024.049605] peer1 systemd[1]: Reached target Host and Network Name Lookups.168peer1 # [552024.049681] peer1 systemd[1]: Reached target User and Group Name Lookups.169peer1 # [552024.084445] peer1 systemd[1]: Starting User Login Management...170peer1 # [552024.085417] peer1 systemd[1]: Starting Permit User Sessions...171peer1 # [552024.098662] peer1 systemd[1]: Finished Permit User Sessions.172peer1 # [552024.099879] peer1 systemd[1]: Started Console Getty.173peer1 # [552024.099929] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0174peer1 # [552024.099952] peer1 systemd[1]: Reached target Login Prompts.175admin1 # [552024.091837] admin1 systemd[1]: Finished Permit User Sessions.176admin1 # [552024.093656] admin1 systemd[1]: Started Console Getty.177admin1 # [552024.093711] admin1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0178admin1 # [552024.093738] admin1 systemd[1]: Reached target Login Prompts.179admin1 # [552024.331507] admin1 dbus-broker-launch[193]: Looking up NSS user entry for 'systemd-timesync'...180admin1 # [552024.332400] admin1 dbus-broker-launch[193]: NSS returned no entry for 'systemd-timesync'181admin1 # [552024.332400] admin1 dbus-broker-launch[193]: Invalid user-name in /nix/store/fg5gslm2mdh87d4rgkfkpyb7i3hmbmwa-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"182admin1 # [552024.335262] admin1 systemd[1]: Started D-Bus System Message Bus.183peer1 # [552024.332909] peer1 dbus-broker-launch[202]: Looking up NSS user entry for 'systemd-timesync'...184peer1 # [552024.333810] peer1 dbus-broker-launch[202]: NSS returned no entry for 'systemd-timesync'185peer1 # [552024.333810] peer1 dbus-broker-launch[202]: Invalid user-name in /nix/store/fg5gslm2mdh87d4rgkfkpyb7i3hmbmwa-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"186peer1 # [552024.335277] peer1 systemd[1]: Started D-Bus System Message Bus.187peer1 # [552024.343265] peer1 dbus-broker-launch[202]: Ready188admin1 # [552024.342747] admin1 dbus-broker-launch[193]: Ready189admin1 # [552024.991444] admin1 systemd-logind[206]: New seat seat0.190admin1 # [552024.991704] admin1 systemd[1]: Started User Login Management.191admin1 # [552025.020838] admin1 systemd[1]: Starting linger-users.service...192admin1 # [552025.034654] admin1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available193admin1 # [552025.034682] admin1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available194admin1 # [552025.034719] admin1 systemd[1]: linger-users.service: Deactivated successfully.195admin1 # [552025.034829] admin1 systemd[1]: Finished linger-users.service.196admin1 # [552025.035395] admin1 systemd[1]: Reached target Multi-User System.197admin1 # [552025.116159] admin1 systemd-networkd[179]: eth1: Gained IPv6LL198peer1 # [552024.982394] peer1 systemd-logind[217]: New seat seat0.199peer1 # [552024.982721] peer1 systemd[1]: Started User Login Management.200peer1 # [552024.984103] peer1 systemd[1]: Starting linger-users.service...201peer1 # [552025.030535] peer1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available202peer1 # [552025.030642] peer1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available203peer1 # [552025.030707] peer1 systemd[1]: linger-users.service: Deactivated successfully.204peer1 # [552025.030997] peer1 systemd[1]: Finished linger-users.service.205peer1 # [552025.031920] peer1 systemd[1]: Reached target Multi-User System.206peer1 # [552025.084272] peer1 systemd-networkd[190]: eth1: Gained IPv6LL207admin1: (finished: waiting for unit multi-user.target, in 4.17 seconds)208peer1: waiting for unit multi-user.target209peer1: (finished: waiting for unit multi-user.target, in 0.04 seconds)210peer1: must succeed: cat /nix/store/z61c0lalzvfahapklpif5sc0cd4x5g4b-per-machine-peer1-new-service_not-a-secret211peer1: (finished: must succeed: cat /nix/store/z61c0lalzvfahapklpif5sc0cd4x5g4b-per-machine-peer1-new-service_not-a-secret, in 0.01 seconds)212peer1: must succeed: ls -la /run/secrets/per-machine/peer1/new-service/a-secret213peer1: (finished: must succeed: ls -la /run/secrets/per-machine/peer1/new-service/a-secret, in 0.01 seconds)214admin1 # [552025.753694] admin1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.215admin1 # [552025.754920] admin1 systemd[1]: Finished Save Transient machine-id to Disk.216admin1 # [552025.756197] admin1 systemd[1]: Startup finished in 3.653s.217peer1 # [552025.758231] peer1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.218peer1 # [552025.759533] peer1 systemd[1]: Finished Save Transient machine-id to Disk.219peer1 # [552025.760075] peer1 systemd[1]: Startup finished in 3.636s.220admin1221peer1222(finished: run the VM test script, in 10.33 seconds)223test script finished in 11.60s224cleanup225kill NspawnMachine (pid 52)226kill NspawnMachine (pid 53)227Container admin1 terminated by signal KILL.228(finished: cleanup, in 0.33 seconds)229Container peer1 terminated by signal KILL.