container-test-run-service-dummy-test
default.checks.aarch64-linux.service-dummy-test
· build #289
· 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 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)13admin1: Waiting for journal at /build/vm-state-admin1/var/log/journal...14peer1: systemd-nspawn running (pid 55)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 # [5398924.819399] admin1 systemd-journald[69]: Journal started27admin1 # [5398924.819458] admin1 systemd-journald[69]: Runtime Journal (/run/log/journal/3108a404ee1b4bfba7a4c1202f8ccb40) is 8M, max 2.5G, 2.4G free.28admin1 # [5398924.821943] admin1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.29admin1 # [5398924.830826] admin1 systemd[1]: Starting Flush Journal to Persistent Storage...30admin1 # [5398924.831756] admin1 systemd[1]: Starting Network Name Resolution...31admin1 # [5398924.832512] admin1 systemd[1]: Starting Create Static Device Nodes in /dev...32admin1 # [5398924.841248] admin1 systemd-journald[69]: Time spent on flushing to /var/log/journal/3108a404ee1b4bfba7a4c1202f8ccb40 is 2.083ms for 6 entries.33admin1 # [5398924.841248] admin1 systemd-journald[69]: System Journal (/var/log/journal/3108a404ee1b4bfba7a4c1202f8ccb40) is 8M, max 4G, 3.9G free.34admin1 # [5398924.850135] admin1 systemd[1]: Finished Create Static Device Nodes in /dev.35admin1 # [5398924.851374] admin1 systemd[1]: Reached target Preparation for Local File Systems.36admin1 # [5398924.851493] admin1 systemd[1]: Reached target Local File Systems.37admin1 # [5398924.852303] admin1 systemd[1]: Listening on Boot Loader Control Service Socket.38admin1 # [5398924.852349] admin1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container39admin1 # [5398924.853150] admin1 systemd[1]: Starting Save Transient machine-id to Disk...40admin1 # [5398924.853182] admin1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys41admin1 # [5398924.888718] admin1 systemd[1]: Finished Flush Journal to Persistent Storage.42admin1 # [5398924.890187] admin1 systemd[1]: Starting Create System Files and Directories...43admin1 # [5398924.907528] admin1 systemd-tmpfiles[134]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted44admin1 # [5398924.907708] admin1 systemd-tmpfiles[134]: fchmod() of /var/log/journal failed: Operation not permitted45admin1 # [5398924.907831] admin1 systemd-tmpfiles[134]: fchmod() of /var/log/journal/3108a404ee1b4bfba7a4c1202f8ccb40 failed: Operation not permitted46admin1 # [5398924.908024] admin1 systemd-tmpfiles[134]: fchmod() of /run/log/journal failed: Operation not permitted47admin1 # [5398924.909430] admin1 systemd[1]: Finished Create System Files and Directories.48admin1 # [5398924.910616] admin1 systemd[1]: Starting Rebuild Journal Catalog...49admin1 # [5398924.911434] admin1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...50admin1 # [5398924.922428] admin1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.51admin1 # [5398924.932551] admin1 systemd[1]: Finished Rebuild Journal Catalog.52admin1 # [5398924.933667] admin1 systemd[1]: Starting Update is Completed...53admin1 # [5398924.950999] admin1 systemd[1]: Finished Update is Completed.54admin1 # [5398924.958602] admin1 systemd[1]: Finished Firewall.55admin1 # [5398924.958693] admin1 systemd[1]: Reached target Preparation for Network.56admin1 # [5398924.958912] admin1 systemd[1]: Listening on Network Management Resolve Hook Socket.57admin1 # [5398924.959980] admin1 systemd[1]: Starting Network Management...58admin1 # [5398924.999031] admin1 systemd[1]: Finished Save Transient machine-id to Disk.59peer1 # [5398924.827229] peer1 systemd-journald[78]: Journal started60peer1 # [5398924.827277] peer1 systemd-journald[78]: Runtime Journal (/run/log/journal/76e28095a65a433d827eb5431cb4fa14) is 8M, max 2.5G, 2.4G free.61peer1 # [5398924.838485] peer1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.62peer1 # [5398924.851449] peer1 systemd[1]: Starting Flush Journal to Persistent Storage...63peer1 # [5398924.852236] peer1 systemd[1]: Starting Network Name Resolution...64peer1 # [5398924.852965] peer1 systemd[1]: Starting Create Static Device Nodes in /dev...65peer1 # [5398924.860842] peer1 systemd-journald[78]: Time spent on flushing to /var/log/journal/76e28095a65a433d827eb5431cb4fa14 is 1.610ms for 6 entries.66peer1 # [5398924.860842] peer1 systemd-journald[78]: System Journal (/var/log/journal/76e28095a65a433d827eb5431cb4fa14) is 8M, max 4G, 3.9G free.67peer1 # [5398924.868861] peer1 systemd[1]: Finished Create Static Device Nodes in /dev.68peer1 # [5398924.869521] peer1 systemd[1]: Reached target Preparation for Local File Systems.69peer1 # [5398924.869624] peer1 systemd[1]: Reached target Local File Systems.70peer1 # [5398924.870414] peer1 systemd[1]: Listening on Boot Loader Control Service Socket.71peer1 # [5398924.870457] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container72peer1 # [5398924.871286] peer1 systemd[1]: Starting Save Transient machine-id to Disk...73peer1 # [5398924.871319] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys74peer1 # [5398924.888799] peer1 systemd[1]: Finished Flush Journal to Persistent Storage.75peer1 # [5398924.889890] peer1 systemd[1]: Starting Create System Files and Directories...76peer1 # [5398924.908477] peer1 systemd-tmpfiles[135]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted77peer1 # [5398924.908694] peer1 systemd-tmpfiles[135]: fchmod() of /var/log/journal failed: Operation not permitted78peer1 # [5398924.908843] peer1 systemd-tmpfiles[135]: fchmod() of /var/log/journal/76e28095a65a433d827eb5431cb4fa14 failed: Operation not permitted79peer1 # [5398924.909076] peer1 systemd-tmpfiles[135]: fchmod() of /run/log/journal failed: Operation not permitted80peer1 # [5398924.910435] peer1 systemd[1]: Finished Create System Files and Directories.81peer1 # [5398924.911517] peer1 systemd[1]: Starting Rebuild Journal Catalog...82peer1 # [5398924.912472] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...83peer1 # [5398924.923794] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.84peer1 # [5398924.930127] peer1 systemd[1]: Finished Rebuild Journal Catalog.85peer1 # [5398924.931154] peer1 systemd[1]: Starting Update is Completed...86peer1 # [5398924.941636] peer1 systemd[1]: Finished Update is Completed.87peer1 # [5398924.975368] peer1 systemd[1]: Finished Firewall.88peer1 # [5398924.975824] peer1 systemd[1]: Reached target Preparation for Network.89peer1 # [5398924.976207] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket.90peer1 # [5398924.977432] peer1 systemd[1]: Starting Network Management...91peer1 # [5398924.998514] peer1 systemd[1]: Finished Save Transient machine-id to Disk.92admin1 # [5398925.386401] admin1 systemd-networkd[182]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted93admin1 # [5398925.386497] admin1 systemd-networkd[182]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted94admin1 # [5398925.420447] admin1 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.95admin1 # [5398925.420608] admin1 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.96admin1 # [5398925.420787] admin1 systemd-networkd[182]: lo: Link UP97admin1 # [5398925.420792] admin1 systemd-networkd[182]: lo: Gained carrier98admin1 # [5398925.420991] admin1 systemd-networkd[182]: eth1: Configuring with /etc/systemd/network/40-eth1.network.99admin1 # [5398925.421370] admin1 systemd[1]: Started Network Management.100admin1 # [5398925.421476] admin1 systemd-networkd[182]: eth1: Link UP101admin1 # [5398925.421829] admin1 systemd-networkd[182]: eth1: Gained carrier102admin1 # [5398925.422512] admin1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...103admin1 # [5398925.473852] admin1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.104admin1 # [5398925.619166] admin1 systemd-resolved[95]: Positive Trust Anchors:105admin1 # [5398925.619180] admin1 systemd-resolved[95]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d106admin1 # [5398925.619182] admin1 systemd-resolved[95]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16107admin1 # [5398925.619216] admin1 systemd-resolved[95]: 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 test108admin1 # [5398925.640735] admin1 systemd-resolved[95]: Using system hostname 'admin1'.109peer1 # [5398925.405117] peer1 systemd-networkd[191]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted110peer1 # [5398925.405211] peer1 systemd-networkd[191]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted111peer1 # [5398925.422001] peer1 systemd-networkd[191]: /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.112peer1 # [5398925.422163] peer1 systemd-networkd[191]: /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.113peer1 # [5398925.422321] peer1 systemd-networkd[191]: lo: Link UP114peer1 # [5398925.422324] peer1 systemd-networkd[191]: lo: Gained carrier115peer1 # [5398925.422505] peer1 systemd-networkd[191]: eth1: Configuring with /etc/systemd/network/40-eth1.network.116peer1 # [5398925.422897] peer1 systemd[1]: Started Network Management.117peer1 # [5398925.422996] peer1 systemd-networkd[191]: eth1: Link UP118peer1 # [5398925.423260] peer1 systemd-networkd[191]: eth1: Gained carrier119peer1 # [5398925.423977] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd...120peer1 # [5398925.453965] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd.121peer1 # [5398925.619669] peer1 systemd-resolved[107]: Positive Trust Anchors:122peer1 # [5398925.619681] peer1 systemd-resolved[107]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d123peer1 # [5398925.619685] peer1 systemd-resolved[107]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16124peer1 # [5398925.619718] peer1 systemd-resolved[107]: 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 test125peer1 # [5398925.641178] peer1 systemd-resolved[107]: Using system hostname 'peer1'.126peer1 # [5398925.642585] peer1 systemd[1]: Started Network Name Resolution.127peer1 # [5398925.642721] peer1 systemd[1]: Reached target Network.128peer1 # [5398925.642829] peer1 systemd[1]: Reached target System Initialization.129peer1 # [5398925.642930] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container130peer1 # [5398925.642984] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories.131peer1 # [5398925.643027] peer1 systemd[1]: Reached target Timer Units.132peer1 # [5398925.643242] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket.133peer1 # [5398925.643451] peer1 systemd[1]: Listening on Nix Daemon Socket.134peer1 # [5398925.643658] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.135peer1 # [5398925.643704] peer1 systemd[1]: Reached target Socket Units.136peer1 # [5398925.643775] peer1 systemd[1]: Reached target Basic System.137peer1 # [5398925.645658] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database...138peer1 # [5398925.646985] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...139peer1 # [5398925.704434] peer1 systemd[1]: Starting D-Bus System Message Bus...140admin1 # [5398925.642128] admin1 systemd[1]: Started Network Name Resolution.141admin1 # [5398925.642277] admin1 systemd[1]: Reached target Network.142admin1 # [5398925.642343] admin1 systemd[1]: Reached target System Initialization.143admin1 # [5398925.642389] admin1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container144admin1 # [5398925.642614] admin1 systemd[1]: Started Daily Cleanup of Temporary Directories.145admin1 # [5398925.642635] admin1 systemd[1]: Reached target Timer Units.146admin1 # [5398925.642768] admin1 systemd[1]: Listening on D-Bus System Message Bus Socket.147admin1 # [5398925.642884] admin1 systemd[1]: Listening on Nix Daemon Socket.148admin1 # [5398925.642987] admin1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.149admin1 # [5398925.643007] admin1 systemd[1]: Reached target Socket Units.150admin1 # [5398925.643047] admin1 systemd[1]: Reached target Basic System.151admin1 # [5398925.644260] admin1 systemd[1]: Starting Import lastlog data into lastlog2 database...152admin1 # [5398925.645311] admin1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...153admin1 # [5398925.646551] admin1 systemd[1]: Starting D-Bus System Message Bus...154admin1 # [5398925.720168] admin1 systemd[1]: Finished Import lastlog data into lastlog2 database.155admin1 # [5398925.806178] admin1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.156admin1 # [5398925.839878] admin1 nsncd[189]: Aug 10 11:05:51.893 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"157admin1 # [5398925.840010] admin1 systemd[1]: Started Name Service Cache Daemon (nsncd).158admin1 # [5398925.840080] admin1 systemd[1]: Reached target Host and Network Name Lookups.159admin1 # [5398925.840139] admin1 systemd[1]: Reached target User and Group Name Lookups.160admin1 # [5398925.841549] admin1 systemd[1]: Starting User Login Management...161admin1 # [5398925.842340] admin1 systemd[1]: Starting Permit User Sessions...162admin1 # [5398925.852255] admin1 systemd[1]: Finished Permit User Sessions.163admin1 # [5398925.853498] admin1 systemd[1]: Started Console Getty.164admin1 # [5398925.853668] admin1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0165admin1 # [5398925.853684] admin1 systemd[1]: Reached target Login Prompts.166peer1 # [5398925.720219] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database.167peer1 # [5398925.819783] peer1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.168peer1 # [5398925.840249] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd).169peer1 # [5398925.840699] peer1 nsncd[198]: Aug 10 11:05:51.893 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"170peer1 # [5398925.840317] peer1 systemd[1]: Reached target Host and Network Name Lookups.171peer1 # [5398925.840379] peer1 systemd[1]: Reached target User and Group Name Lookups.172peer1 # [5398925.841769] peer1 systemd[1]: Starting User Login Management...173peer1 # [5398925.842561] peer1 systemd[1]: Starting Permit User Sessions...174peer1 # [5398925.851699] peer1 systemd[1]: Finished Permit User Sessions.175peer1 # [5398925.852702] peer1 systemd[1]: Started Console Getty.176peer1 # [5398925.852741] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0177peer1 # [5398925.852761] peer1 systemd[1]: Reached target Login Prompts.178peer1 # [5398925.928703] peer1 dbus-broker-launch[199]: Looking up NSS user entry for 'systemd-timesync'...179peer1 # [5398925.929554] peer1 dbus-broker-launch[199]: NSS returned no entry for 'systemd-timesync'180peer1 # [5398925.929554] peer1 dbus-broker-launch[199]: Invalid user-name in /nix/store/q7qmcvjk8vc599x9xyj7rqv8icm367w9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"181peer1 # [5398925.930358] peer1 systemd[1]: Started D-Bus System Message Bus.182peer1 # [5398925.937279] peer1 dbus-broker-launch[199]: Ready183admin1 # [5398925.969177] admin1 dbus-broker-launch[190]: Looking up NSS user entry for 'systemd-timesync'...184admin1 # [5398925.970945] admin1 dbus-broker-launch[190]: NSS returned no entry for 'systemd-timesync'185admin1 # [5398925.970945] admin1 dbus-broker-launch[190]: Invalid user-name in /nix/store/q7qmcvjk8vc599x9xyj7rqv8icm367w9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"186admin1 # [5398925.971351] admin1 systemd[1]: Started D-Bus System Message Bus.187admin1 # [5398925.978501] admin1 dbus-broker-launch[190]: Ready188admin1 # [5398926.360009] admin1 systemd-logind[205]: New seat seat0.189admin1 # [5398926.360244] admin1 systemd[1]: Started User Login Management.190admin1 # [5398926.361598] admin1 systemd[1]: Starting linger-users.service...191admin1 # [5398926.372613] admin1 systemd[1]: linger-users.service: Deactivated successfully.192admin1 # [5398926.372686] admin1 systemd[1]: Finished linger-users.service.193admin1 # [5398926.373070] admin1 systemd[1]: Reached target Multi-User System.194admin1 # [5398926.373315] admin1 systemd[1]: Startup finished in 1.913s.195admin1: (finished: waiting for unit multi-user.target, in 2.65 seconds)196peer1: waiting for unit multi-user.target197peer1: (finished: waiting for unit multi-user.target, in 0.02 seconds)198peer1: must succeed: cat /nix/store/z61c0lalzvfahapklpif5sc0cd4x5g4b-per-machine-peer1-new-service_not-a-secret199peer1: (finished: must succeed: cat /nix/store/z61c0lalzvfahapklpif5sc0cd4x5g4b-per-machine-peer1-new-service_not-a-secret, in 0.01 seconds)200peer1: must succeed: ls -la /run/secrets/per-machine/peer1/new-service/a-secret201peer1 # [5398926.347286] peer1 systemd-logind[214]: New seat seat0.202peer1 # [5398926.347449] peer1 systemd[1]: Started User Login Management.203peer1 # [5398926.348784] peer1 systemd[1]: Starting linger-users.service...204peer1 # [5398926.363286] peer1 systemd[1]: linger-users.service: Deactivated successfully.205peer1 # [5398926.363407] peer1 systemd[1]: Finished linger-users.service.206peer1 # [5398926.363836] peer1 systemd[1]: Reached target Multi-User System.207peer1 # [5398926.364126] peer1 systemd[1]: Startup finished in 1.903s.208peer1 # [5398926.712565] peer1 systemd-networkd[191]: eth1: Gained IPv6LL209peer1: (finished: must succeed: ls -la /run/secrets/per-machine/peer1/new-service/a-secret, in 0.01 seconds)210(finished: run the VM test script, in 2.69 seconds)211test script finished in 2.86s212cleanup213kill NspawnMachine (pid 52)214kill NspawnMachine (pid 55)215Container admin1 terminated by signal KILL.216Container peer1 terminated by signal KILL.217(finished: cleanup, in 0.48 seconds)