Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: machine, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh machine: waiting for unit multi-user.target machine: systemd-nspawn running (pid 50) machine: Waiting for journal at /build/vm-state-machine/var/log/journal... nixos-nspawn(machine): TAP vde-tap1 not found; container will be isolated from VDE nixos-nspawn(machine): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. ░ Spawning container machine on /build/vm-state-machine. machine # No journal files were found. machine # No journal boot entry found for the specified boot (+0). machine # No journal files were found. machine # No journal boot entry found for the specified boot (+0). machine # No journal files were found. machine # No journal boot entry found for the specified boot (+0). machine # No journal files were found. machine # No journal boot entry found for the specified boot (+0). machine # [1332921.933894] machine systemd-journald[57]: Journal started machine # [1332921.933969] machine systemd-journald[57]: Runtime Journal (/run/log/journal/0d3cd3179f6d45a49e44d8cfa49cd6a7) is 8M, max 2.5G, 2.5G free. machine # [1332922.532377] machine systemd[1]: Listening on Journal Log Access Socket. machine # [1332922.543955] machine systemd[1]: Finished Apply Kernel Variables. machine # [1332922.976572] machine systemd[1]: Finished Firewall. machine # [1332923.002105] machine systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [1332923.375247] machine systemd[1]: Starting Flush Journal to Persistent Storage... machine # [1332923.376969] machine systemd[1]: Starting Create Static Device Nodes in /dev... machine # [1332923.397448] machine systemd-journald[57]: Time spent on flushing to /var/log/journal/0d3cd3179f6d45a49e44d8cfa49cd6a7 is 2.277ms for 8 entries. machine # [1332923.397448] machine systemd-journald[57]: System Journal (/var/log/journal/0d3cd3179f6d45a49e44d8cfa49cd6a7) is 512B, max 4G, 3.9G free. machine # [1332923.911500] machine systemd[1]: Finished Flush Journal to Persistent Storage. machine # [1332923.943764] machine systemd[1]: Finished Create Static Device Nodes in /dev. machine # [1332924.369079] machine systemd[1]: Reached target Preparation for Local File Systems. machine # [1332924.533675] machine systemd[1]: Mounting /run/wrappers... machine # [1332924.533726] machine systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine # [1332924.582418] machine systemd[1]: Mounted /run/wrappers. machine # [1332924.585630] machine systemd[1]: Reached target Local File Systems. machine # [1332924.587464] machine systemd[1]: Listening on Boot Loader Control Service Socket. machine # [1332924.626507] machine systemd[1]: Starting Create SUID/SGID Wrappers... machine # [1332924.626564] machine systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine # [1332924.633697] machine systemd[1]: Starting Save Transient machine-id to Disk... machine # [1332924.638266] machine systemd[1]: Starting Create System Files and Directories... machine # [1332924.675679] machine systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine # [1332924.675854] machine systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted machine # [1332924.675959] machine systemd-tmpfiles[161]: fchmod() of /var/log/journal/0d3cd3179f6d45a49e44d8cfa49cd6a7 failed: Operation not permitted machine # [1332924.676116] machine systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted machine # [1332924.690356] machine suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.roCW375R56/chsh': Operation not permitted machine # [1332925.251798] machine systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [1332925.434124] machine systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE machine # [1332925.434220] machine systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. machine # [1332925.434366] machine systemd[1]: Failed to start Create SUID/SGID Wrappers. machine # [1332925.434591] machine systemd[1]: Finished Save Transient machine-id to Disk. machine # [1332925.436637] machine systemd[1]: Finished Create System Files and Directories. machine # [1332926.133200] machine systemd[1]: Starting Rebuild Journal Catalog... machine # [1332926.139111] machine systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [1332926.159052] machine systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [1332926.168512] machine systemd[1]: Finished Rebuild Journal Catalog. machine # [1332926.173142] machine systemd[1]: Starting Update is Completed... machine # [1332926.190863] machine systemd[1]: Finished Update is Completed. machine # [1332926.190971] machine systemd[1]: Reached target System Initialization. machine # [1332926.191058] machine systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine # [1332926.191090] machine systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [1332926.191110] machine systemd[1]: Reached target Timer Units. machine # [1332926.191221] machine systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [1332926.191297] machine systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [1332926.191323] machine systemd[1]: Reached target Socket Units. machine # [1332926.191349] machine systemd[1]: Reached target Basic System. machine # [1332926.193443] machine systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [1332926.195126] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [1332926.196232] machine systemd[1]: Starting resolvconf update... machine # [1332926.222765] machine systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [1332926.422651] machine systemd[1]: nscd.service: Deactivated successfully. machine # [1332926.422788] machine systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [1332926.429134] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [1332926.442351] machine resolvconf-start[235]: setfacl: /run/resolvconf: Operation not supported machine # [1332926.449889] machine systemd[1]: resolvconf.service: Main process exited, code=exited, status=1/FAILURE machine # [1332926.451284] machine systemd[1]: resolvconf.service: Failed with result 'exit-code'. machine # [1332926.459464] machine systemd[1]: Failed to start resolvconf update. machine # [1332926.460872] machine systemd[1]: Reached target Preparation for Network. machine # [1332926.462830] machine systemd[1]: Starting Address configuration of eth1... machine # [1332926.468129] machine systemd[1]: Starting Extra networking commands.... machine # [1332926.532193] machine network-addresses-eth1-start[238]: adding address 192.168.1.1/24... done machine # [1332926.548276] machine network-addresses-eth1-start[238]: adding address 2001:db8:1::1/64... done machine # [1332926.553133] machine systemd[1]: Finished Address configuration of eth1. machine # [1332926.704211] machine systemd[1]: Finished Extra networking commands.. machine # [1332926.704961] machine systemd[1]: Reached target Network. machine # [1332928.151186] machine systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [1332928.151276] machine systemd[1]: Reached target Host and Network Name Lookups. machine # [1332928.154395] machine nsncd[233]: Oct 10 09:14:58.884 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [1332928.151339] machine systemd[1]: Reached target User and Group Name Lookups. machine # [1332928.191000] machine systemd[1]: Starting User Login Management... machine # [1332928.196133] machine systemd[1]: Starting Permit User Sessions... machine # [1332928.230378] machine systemd[1]: Finished Permit User Sessions. machine # [1332928.237164] machine systemd[1]: Started Console Getty. machine # [1332928.237245] machine systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine # [1332928.237274] machine systemd[1]: Reached target Login Prompts. machine: still waiting for container 'machine' to reach ready state... machine: still waiting for container 'machine' to reach ready state... machine # [1332942.770767] machine systemd-logind[306]: New seat seat0. machine # [1332942.771393] machine systemd[1]: Starting D-Bus System Message Bus... machine # [1332942.771539] machine systemd[1]: Started User Login Management. machine # [1332942.772583] machine systemd[1]: Starting linger-users.service... machine # [1332942.868070] machine systemd[1]: linger-users.service: Deactivated successfully. machine # [1332942.868772] machine systemd[1]: Finished linger-users.service. machine # [1332942.869028] machine systemd[1]: Reached target Multi-User System. machine # [1332944.909446] machine dbus-broker-launch[316]: Looking up NSS user entry for 'systemd-timesync'... machine # [1332944.911665] machine dbus-broker-launch[316]: NSS returned no entry for 'systemd-timesync' machine # [1332944.911665] machine dbus-broker-launch[316]: Invalid user-name in /nix/store/z441alblwy32lyxiy8466qf85iyi2sdj-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [1332944.912075] machine systemd[1]: Started D-Bus System Message Bus. machine # [1332944.913347] machine systemd[1]: Startup finished in 24.229s. machine # [1332944.923023] machine dbus-broker-launch[316]: Ready machine: (finished: waiting for unit multi-user.target, in 26.24 seconds) machine: must succeed: /nix/store/hbyzr3c9k3n51a3zyb3h74dqi8a2n1p5-writable-store /nix/store/dvl2bmzr7bv3qdfirin9kwq25g30ndj3-closure-info warning: '--json' without '--json-format' is deprecated; please specify '--json-format 1' or '--json-format 2'. This will become an error in a future release. machine: (finished: must succeed: /nix/store/hbyzr3c9k3n51a3zyb3h74dqi8a2n1p5-writable-store /nix/store/dvl2bmzr7bv3qdfirin9kwq25g30ndj3-closure-info, in 78.16 seconds) machine: must succeed: systemctl start nix-daemon.socket machine: (finished: must succeed: systemctl start nix-daemon.socket, in 0.07 seconds) machine: must succeed: cp -r /nix/store/p8cscs56p6603rhnigmirb92n1swsrak-source /home/alice/iets && chmod -R u+w /home/alice/iets && chown -R alice /home/alice/iets machine # [1333023.619063] machine systemd[1]: Listening on Nix Daemon Socket. machine: (finished: must succeed: cp -r /nix/store/p8cscs56p6603rhnigmirb92n1swsrak-source /home/alice/iets && chmod -R u+w /home/alice/iets && chown -R alice /home/alice/iets, in 0.62 seconds) machine: must succeed: runuser -l alice -c 'cd iets && git init -q && git add -A && git -c user.name=e2e -c user.email=e2e@example.com commit -q -m e2e' machine # [1333024.318157] machine runuser[4868]: pam_unix(runuser-l:session): session opened for user alice(uid=1000) by (uid=0) machine: (finished: must succeed: runuser -l alice -c 'cd iets && git init -q && git add -A && git -c user.name=e2e -c user.email=e2e@example.com commit -q -m e2e', in 0.44 seconds) machine: must succeed: runuser -l alice -c 'cd iets && IETS=/nix/store/djlbargwnhm5z3wddlwvdv5j8ndb3zil-iets-0.1.0/bin/iets NIXPKGS=/nix/store/hhfnpma32czw4h3bqpag8dciax0bcmar-source E2E_OFFLINE=1 nu scripts/classic-e2e.nu' >&2 machine # [1333024.699942] machine runuser[4868]: pam_unix(runuser-l:session): session closed for user alice machine # [1333024.834941] machine runuser[4912]: pam_unix(runuser-l:session): session opened for user alice(uid=1000) by (uid=0) real nix: /nix/store/6ph2h5b0v19yihxr0id244wh83whwasq-nix-2.34.8/bin ok builtins --impure []: the same names nix has ok builtins --impure [dynamic-derivations]: the same names nix has ok builtins --impure [dynamic-derivations fetch-closure fetch-tree]: the same names nix has ok builtins --pure-eval []: the same names nix has ok builtins --pure-eval [dynamic-derivations]: the same names nix has ok builtins --pure-eval [dynamic-derivations fetch-closure fetch-tree]: the same names nix has machine # [1333028.630736] machine systemd[1]: Started Nix Daemon. machine # [1333028.735548] machine nix-daemon[5200]: accepted connection from pid 5193, user alice (trusted) machine # [1333029.820127] machine nix-daemon[5200]: accepted connection from pid 5317, user alice (trusted) ok instantiate -A hello machine # [1333031.136074] machine nix-daemon[5200]: accepted connection from pid 5338, user alice (trusted) ok instantiate -A glibc (multi-output) machine # [1333031.833026] machine nix-daemon[5200]: accepted connection from pid 5349, user alice (trusted) machine # [1333033.080957] machine nix-daemon[5200]: accepted connection from pid 5370, user alice (trusted) machine # [1333033.961024] machine nix-daemon[5200]: accepted connection from pid 5381, user alice (trusted) ok instantiate -A glibc.dev (!output suffix) machine # [1333037.946260] machine nix-daemon[5200]: accepted connection from pid 5402, user alice (trusted) machine # [1333038.562778] machine nix-daemon[5200]: accepted connection from pid 5413, user alice (trusted) ok instantiate two -A in one run machine # [1333041.697313] machine nix-daemon[5200]: accepted connection from pid 5434, user alice (trusted) machine # [1333042.152367] machine nix-daemon[5200]: accepted connection from pid 5445, user alice (trusted) ok instantiate two -A that name one derivation machine # [1333043.961598] machine nix-daemon[5200]: accepted connection from pid 5466, user alice (trusted) ok instantiate --add-root '' machine # [1333044.280165] machine nix-daemon[5200]: accepted connection from pid 5477, user alice (trusted) ok instantiate --eval --strict --json ok instantiate --eval ok instantiate --eval --raw ok instantiate --eval --raw a path ok instantiate --eval --raw an outPath ok instantiate --eval, one --arg name twice ok instantiate --eval, --arg then --argstr of one name ok instantiate --eval, a later expression throws ok instantiate --eval --argstr ok instantiate a custom drv machine # [1333047.051702] machine nix-daemon[5200]: accepted connection from pid 5732, user alice (trusted) machine # [1333047.246118] machine nix-daemon[5200]: accepted connection from pid 5744, user alice (trusted) ok drv closure follows the references of a toFile machine # [1333047.360900] machine nix-daemon[5200]: accepted connection from pid 5765, user alice (trusted) machine # [1333047.430045] machine nix-daemon[5200]: accepted connection from pid 5783, user alice (trusted) machine # [1333047.497161] machine nix-daemon[5200]: accepted connection from pid 5804, user alice (trusted) machine # [1333047.563148] machine nix-daemon[5200]: accepted connection from pid 5826, user alice (trusted) ok instantiate builtins.outputOf, once and nested ok eval builtins.outputOf placeholders ok two consumers of one dynamic producer stay apart ok instantiate --readonly-mode machine # [1333048.079562] machine nix-daemon[5200]: accepted connection from pid 5847, user alice (trusted) machine # [1333048.157034] machine nix-daemon[5200]: accepted connection from pid 5869, user alice (trusted) machine # [1333048.234283] machine nix-daemon[5200]: accepted connection from pid 5890, user alice (trusted) machine # [1333048.306453] machine nix-daemon[5200]: accepted connection from pid 5912, user alice (trusted) machine # [1333048.482797] machine nix-daemon[5200]: accepted connection from pid 5959, user alice (trusted) machine # [1333048.549281] machine nix-daemon[5200]: accepted connection from pid 5982, user alice (trusted) machine # [1333048.712756] machine nix-daemon[5200]: accepted connection from pid 6003, user alice (trusted) ok --add-root links and registers a gc root machine # [1333048.794204] machine nix-daemon[5200]: accepted connection from pid 6016, user alice (trusted) machine # [1333048.884253] machine nix-daemon[5200]: accepted connection from pid 6037, user alice (trusted) machine # [1333049.402097] machine nix-daemon[5200]: accepted connection from pid 6087, user alice (trusted) machine # [1333049.910030] machine nix-daemon[5200]: accepted connection from pid 6128, user alice (trusted) machine # [1333050.748054] machine nix-daemon[5200]: accepted connection from pid 6178, user alice (trusted) machine # [1333051.185809] machine nix-daemon[5200]: accepted connection from pid 6221, user alice (trusted) machine # [1333051.744290] machine nix-daemon[5200]: accepted connection from pid 6273, user alice (trusted) machine # [1333052.058378] machine nix-daemon[5200]: accepted connection from pid 6316, user alice (trusted) ok -o over an existing path acts as Nix does machine # [1333053.454854] machine nix-daemon[5200]: accepted connection from pid 6368, user alice (trusted) machine # [1333053.723480] machine nix-daemon[5200]: accepted connection from pid 6409, user alice (trusted) ok build a custom drv, default result machine # [1333054.827030] machine nix-daemon[5200]: accepted connection from pid 6453, user alice (trusted) machine # [1333055.053862] machine nix-daemon[5200]: accepted connection from pid 6488, user alice (trusted) ok build -o link machine # [1333055.860437] machine nix-daemon[5200]: accepted connection from pid 6532, user alice (trusted) machine # [1333056.031312] machine nix-daemon[5200]: accepted connection from pid 6567, user alice (trusted) ok build --no-out-link machine # [1333056.724403] machine nix-daemon[5200]: accepted connection from pid 6611, user alice (trusted) machine # [1333056.883999] machine nix-daemon[5200]: accepted connection from pid 6646, user alice (trusted) ok build two outputs of one drv machine # [1333057.298624] machine nix-daemon[5200]: accepted connection from pid 6698, user alice (trusted) machine # [1333057.386434] machine nix-daemon[5200]: accepted connection from pid 6716, user alice (trusted) ok build two drvs machine # [1333057.820351] machine nix-daemon[5200]: accepted connection from pid 6765, user alice (trusted) machine # [1333058.303146] machine nix-daemon[5200]: accepted connection from pid 6823, user alice (trusted) machine # [1333058.387635] machine nix-daemon[5200]: accepted connection from pid 6860, user alice (trusted) ok builder = unix://SCRATCH builds there and registers here ok --parse execs the real nix-instantiate ok --iets-option never reaches the fallback nix ok the fallback prints one line on stderr ok IETS_NO_FALLBACK=1 exits 1 ok nix-bin-dir full of iets: the fallback stops, it does not loop machine # [1333058.686276] machine nix-daemon[5200]: accepted connection from pid 6881, user alice (trusted) ok nix eval > /dev/full ok nix-instantiate --eval > /dev/full ok iets version > /dev/full reports, not aborts ok iets parse /tmp/iets-classic-e2e.HX3EUi/case/multi.nix > /dev/full reports, not aborts ok iets --help > /dev/full reports, not aborts ok iets lint list > /dev/full reports, not aborts ok a bad iets.toml and 'iets version' ok a bad iets.toml and 'iets --help' ok a bad iets.toml and 'iets eval -E 1' ok an early error is a record under internal-json ok fetchTarball falls back and prints the real result machine # [1333059.839577] machine nix-daemon[5200]: accepted connection from pid 7109, user alice (trusted) machine # [1333059.938581] machine nix-daemon[5200]: accepted connection from pid 7135, user alice (trusted) machine # [1333060.114605] machine nix-daemon[5200]: accepted connection from pid 7156, user alice (trusted) ok import from derivation falls back ok iets eval refuses import from derivation machine # [1333060.181028] machine nix-daemon[5200]: accepted connection from pid 7181, user alice (trusted) ok instantiate --eval a non-UTF-8 file name ok iets eval a non-UTF-8 file name ok a non-UTF-8 file name reaches the fallback intact ok the 'nix' name falls back ok nix eval --json .#x machine # [1333061.043945] machine nix-daemon[5200]: accepted connection from pid 7313, user alice (trusted) machine # [1333061.311576] machine nix-daemon[5200]: accepted connection from pid 7342, user alice (trusted) ok nix eval --raw .#x ok nix eval .#s (attrset, list, float) machine # [1333061.584190] machine nix-daemon[5200]: accepted connection from pid 7371, user alice (trusted) ok nix eval .#l ok nix flake prefetch-inputs, no inputs ok nix flake prefetch-inputs is iets's own machine # [1333061.843909] machine nix-daemon[5200]: accepted connection from pid 7400, user alice (trusted) machine # [1333061.919832] machine nix-daemon[5200]: accepted connection from pid 7426, user alice (trusted) machine # [1333062.158810] machine nix-daemon[5200]: accepted connection from pid 7455, user alice (trusted) ok nix eval, farm first on PATH, fresh tree ok fallback through the farm marker, real nix off PATH ok nix eval .#pkg (a derivation) ok nix eval . (packages..default) machine # [1333062.419217] machine nix-daemon[5200]: accepted connection from pid 7525, user alice (trusted) machine # [1333062.627597] machine nix-daemon[5200]: accepted connection from pid 7554, user alice (trusted) ok nix eval --expr ok nix eval --expr is pure ok nix eval --impure --expr ok nix --option pure-eval false eval --expr ok nix eval -f is impure ok nix eval .#x is pure ok nix-instantiate is impure machine # [1333063.747336] machine nix-daemon[5200]: accepted connection from pid 7716, user alice (trusted) ok nix-instantiate --pure-eval ok nix-instantiate --option pure-eval true ok nix-instantiate --pure-eval refuses a local file ok nix.conf system reaches builtins.currentSystem ok NIX_USER_CONF_FILES empty ok NIX_USER_CONF_FILES unset ok nix eval -f with pure-eval from the system nix.conf ok nix eval -f with pure-eval from a user nix.conf ok nix eval -f with pure-eval from NIX_CONFIG ok nix eval -f with pure-eval from --option ok nix eval -f with pure-eval from --impure ok instantiate -j 4294967296 ok instantiate --cores 4294967296 ok instantiate -j auto ok instantiate --cores 1K ok instantiate -j 2 ok instantiate -Ifoo=/etc ok nix-eval-jobs prints no summary ok iets eval-jobs keeps its summary ok nix.conf 'pure-eval = maybe' ok nix.conf 'show-trace = maybe' ok nix.conf 'sandbox = maybe' ok nix.conf 'eval-cache = 2' ok nix.conf 'connect-timeout = abc' ok nix.conf 'cores = -1' ok nix.conf 'cores = 4294967296' ok nix.conf 'max-jobs = abc' ok nix.conf 'cores = 1K' ok nix.conf 'min-free = 2G' ok nix.conf 'max-jobs = auto' ok nix.conf 'sandbox = relaxed' ok nix eval --expr, a nested error ok nix eval --expr, repeated and empty values ok nix eval --expr, functions machine # [1333067.474544] machine nix-daemon[5200]: accepted connection from pid 8557, user alice (trusted) ok symlink: readFile through a copy of the link itself machine # [1333068.022334] machine nix-daemon[5200]: accepted connection from pid 8586, user alice (trusted) ok symlink: readFile of a target the filter left out machine # [1333068.864487] machine nix-daemon[5200]: accepted connection from pid 8615, user alice (trusted) ok symlink: readDir through a copy of the link itself machine # [1333069.929596] machine nix-daemon[5200]: accepted connection from pid 8644, user alice (trusted) ok symlink: hashFile through a copy of the link itself machine # [1333070.701955] machine nix-daemon[5200]: accepted connection from pid 8673, user alice (trusted) ok symlink: readFile below a link in a copied tree machine # [1333071.154640] machine nix-daemon[5200]: accepted connection from pid 8702, user alice (trusted) ok symlink: readDir of a link in a copied tree machine # [1333071.411184] machine nix-daemon[5200]: accepted connection from pid 8731, user alice (trusted) ok symlink: pathExists below a link in a copied tree machine # [1333071.712333] machine nix-daemon[5200]: accepted connection from pid 8760, user alice (trusted) ok symlink: path of a link in a copied tree machine # [1333072.050213] machine nix-daemon[5200]: accepted connection from pid 8789, user alice (trusted) ok symlink: path of a link, local and copied agree ok symlink: path of a dangling link machine # [1333072.305929] machine nix-daemon[5200]: accepted connection from pid 8818, user alice (trusted) machine # [1333072.535376] machine nix-daemon[5200]: accepted connection from pid 8847, user alice (trusted) machine # [1333072.764822] machine nix-daemon[5200]: accepted connection from pid 8876, user alice (trusted) ok symlink: path of a dangling link in a copied tree ok symlink: storePath below a link in a copied tree machine # [1333072.806807] machine nix-daemon[8896]: unexpected Nix daemon error: error: interrupted by the user machine # [1333073.001554] machine nix-daemon[5200]: accepted connection from pid 8905, user alice (trusted) ok symlink: filterSource sees the store path of an unfiltered copy machine # [1333073.271596] machine nix-daemon[5200]: accepted connection from pid 8934, user alice (trusted) ok symlink: path keeps the references of a store path machine # [1333074.221903] machine nix-daemon[5200]: accepted connection from pid 8963, user alice (trusted) machine # [1333074.271625] machine nix-daemon[5200]: accepted connection from pid 8983, user alice (trusted) ok symlink: path flat refuses a store path with references ok nix eval -f FILE ATTR machine # [1333075.532657] machine nix-daemon[5200]: accepted connection from pid 9012, user alice (trusted) machine # [1333075.593574] machine nix-daemon[5200]: accepted connection from pid 9032, user alice (trusted) ok nix eval --json -f FILE ATTR ok auto-call a function file, defaults: nix-instantiate ok auto-call a function file, defaults: iets eval ok auto-call a '...' function file, defaults: nix-instantiate ok auto-call a '...' function file, defaults: iets eval ok auto-call a function file, --arg: nix-instantiate ok auto-call a function file, --arg: iets eval ok auto-call a '...' function file, --arg: nix-instantiate ok auto-call a '...' function file, --arg: iets eval ok auto-call a function file, --argstr: nix-instantiate ok auto-call a function file, --argstr: iets eval ok auto-call a '...' function file, --argstr: nix-instantiate ok auto-call a '...' function file, --argstr: iets eval ok a required --arg that is missing: the same first error line everywhere ok nix search, every package ok nix search --json ok nix search --json --pretty ok nix search, two regexes are ANDed ok nix search --exclude ok nix search is case insensitive ok nix search, a bracket expression ok nix search, an alternation ok nix search, no results ok nix search --json, no results machine # [1333106.872030] machine nix-daemon[5200]: accepted connection from pid 9848, user alice (trusted) ok nix search nixpkgs --json ^hello$ machine # [1333140.382403] machine nix-daemon[5200]: accepted connection from pid 9878, user alice (trusted) ok nix search nixpkgs --json ripgrep ok internal-json: undefined variable in a file ok internal-json: missing attribute ok internal-json: syntax error ok internal-json: nix eval, missing attribute machine # [1333191.270697] machine nix-daemon[5200]: accepted connection from pid 10005, user alice (trusted) machine # [1333191.692454] machine nix-daemon[5200]: accepted connection from pid 10039, user alice (trusted) ok internal-json: a failed build machine # [1333192.766994] machine nix-daemon[5200]: accepted connection from pid 10083, user alice (trusted) machine # [1333193.225779] machine nix-daemon[5200]: accepted connection from pid 10117, user alice (trusted) ok internal-json: a hash mismatch machine # [1333194.089873] machine nix-daemon[5200]: accepted connection from pid 10161, user alice (trusted) ok iets build: a failed build exits 100 machine # [1333195.111684] machine nix-daemon[5200]: accepted connection from pid 10196, user alice (trusted) ok iets build: the ✔ is the last line of a successful block machine # [1333195.482523] machine nix-daemon[5200]: accepted connection from pid 10196, user alice (trusted) machine # [1333195.703474] machine nix-daemon[5200]: accepted connection from pid 10233, user alice (trusted) ok iets build: a hash mismatch exits 102 and names the hash ok iets build: every record, activities too, has one sid machine # [1333196.747425] machine nix-daemon[5200]: accepted connection from pid 10267, user alice (trusted) ok iets build with fix-hashes: rewrites the hash and builds machine # [1333197.872699] machine nix-daemon[5200]: accepted connection from pid 10267, user alice (trusted) machine # [1333197.896983] machine nix-daemon[5200]: accepted connection from pid 10267, user alice (trusted) machine # [1333198.071043] machine nix-daemon[5200]: accepted connection from pid 10316, user alice (trusted) ok iets build without a terminal: fix-hashes asks nobody, the file stays machine # [1333199.188025] machine nix-daemon[5200]: accepted connection from pid 10352, user alice (trusted) ok iets build with fix-hashes: a resolved derivation's mismatch is fixed too machine # [1333202.286397] machine nix-daemon[5200]: accepted connection from pid 10352, user alice (trusted) machine # [1333202.315540] machine nix-daemon[5200]: accepted connection from pid 10352, user alice (trusted) machine # [1333203.471951] machine nix-daemon[5200]: accepted connection from pid 10408, user alice (trusted) machine # [1333203.887033] machine nix-daemon[5200]: accepted connection from pid 10408, user alice (trusted) machine # [1333204.023472] machine nix-daemon[5200]: accepted connection from pid 10450, user alice (trusted) ok internal-json: nix-build --no-out-link activity records match Nix's machine # [1333205.887226] machine nix-daemon[5200]: accepted connection from pid 10498, user alice (trusted) machine # [1333206.300411] machine nix-daemon[5200]: accepted connection from pid 10498, user alice (trusted) machine # [1333206.394166] machine nix-daemon[5200]: accepted connection from pid 10540, user alice (trusted) ok internal-json: nix build activity records match Nix's machine # [1333207.843833] machine nix-daemon[5200]: accepted connection from pid 10589, user alice (trusted) ok nom --json reads iets's activity records ok nom --json reads iets's activity records machine # [1333215.617851] machine nix-daemon[5200]: accepted connection from pid 10689, user alice (trusted) machine # [1333216.105615] machine nix-daemon[5200]: accepted connection from pid 10689, user alice (trusted) machine # [1333216.232047] machine nix-daemon[5200]: accepted connection from pid 10726, user alice (trusted) ok nix-build --no-out-link -E ok nix-build --no-out-link -E keeps a root instead of nothing machine # [1333216.501667] machine nix-daemon[5200]: accepted connection from pid 10750, user alice (trusted) machine # [1333217.002889] machine nix-daemon[5200]: accepted connection from pid 10771, user alice (trusted) machine # [1333217.134383] machine nix-daemon[5200]: accepted connection from pid 10771, user alice (trusted) machine # [1333217.273621] machine nix-daemon[5200]: accepted connection from pid 10785, user alice (trusted) ok nix build --no-link --print-out-paths ok nix build --no-link --print-out-paths keeps a root instead of nothing machine # [1333217.544719] machine nix-daemon[5200]: accepted connection from pid 10810, user alice (trusted) ok build-gc-root = false keeps no root, as in nix machine # [1333218.247537] machine nix-daemon[5200]: accepted connection from pid 10831, user alice (trusted) ok iets build roots the path it printed machine # [1333218.772992] machine nix-daemon[5200]: accepted connection from pid 10843, user alice (trusted) machine # [1333218.961964] machine nix-daemon[5200]: accepted connection from pid 10843, user alice (trusted) machine # [1333219.107117] machine nix-daemon[5200]: accepted connection from pid 10860, user alice (trusted) machine # [1333219.520634] machine nix-daemon[5200]: accepted connection from pid 10882, user alice (trusted) ok iets build --dry-run: nix build --dry-run's text, and the plan as JSON ok json-log-path: the file holds the error record ok json-log-path: stderr stays text machine # [1333220.469822] machine nix-daemon[5200]: accepted connection from pid 10921, user alice (trusted) ok json-log-path: the file gets a build's activity records, stderr stays text machine # [1333221.176115] machine nix-daemon[5200]: accepted connection from pid 10921, user alice (trusted) ok nix-instantiate -v --verbose ok -v is one warning with the reason machine # [1333223.393023] machine nix-daemon[5200]: accepted connection from pid 10997, user alice (trusted) ok nix eval --accept-flake-config --eval-store auto, a flake with a nixConfig ok --accept-flake-config and --eval-store auto are one warning each, with the reason ok an ignored flag is a level-1 ignored-flag record ok json-log-path gets the ignored-flag record ok a nix.conf with the settings of a fork changes nothing ok each of them is Nix's own unknown-setting warning, once ok an unknown setting is a level-1 unknown-setting record, once per name ok an unknown setting ok an unknown setting gets Nix's own warning ok accept-flake-config = true in NIX_CONFIG ok a client setting iets has nothing for is one warning; a default and one that holds are none ok restrict-eval is left to the real nix ok restrict-eval falls back ok iets eval --option sandbox: one ignored-setting record machine # [1333228.067405] machine nix-daemon[5200]: accepted connection from pid 11166, user alice (trusted) machine # [1333230.851763] machine nix-daemon[5200]: accepted connection from pid 11201, user alice (trusted) ok nix-build --option timeout 2 ok --option timeout reaches the daemon machine # [1333236.691040] machine nix-daemon[5200]: accepted connection from pid 11245, user alice (trusted) machine # [1333241.362388] machine nix-daemon[5200]: accepted connection from pid 11281, user alice (trusted) ok nix develop --option timeout 2 ok nix develop sends its build settings to the daemon ok the nix-path setting ok an empty NIX_PATH replaces the nix-path setting machine # [1333246.369293] machine nix-daemon[5200]: accepted connection from pid 11378, user alice (trusted) ok nix build .#pkg --print-out-paths -o result-x machine # [1333248.213478] machine nix-daemon[5200]: accepted connection from pid 11425, user alice (trusted) ok nix print-dev-env is iets print-dev-env ok derivation show a custom drv machine # [1333250.903088] machine nix-daemon[5200]: accepted connection from pid 11462, user alice (trusted) ok derivation show a multi-output drv machine # [1333251.628791] machine nix-daemon[5200]: accepted connection from pid 11491, user alice (trusted) ok derivation show a fixed-output drv machine # [1333252.662405] machine nix-daemon[5200]: accepted connection from pid 11520, user alice (trusted) machine # [1333253.456949] machine nix-daemon[5200]: accepted connection from pid 11549, user alice (trusted) ok derivation show structured attrs and an input drv ok derivation show two installables machine # [1333254.666207] machine nix-daemon[5200]: accepted connection from pid 11578, user alice (trusted) ok derivation show --pretty machine # [1333255.394052] machine nix-daemon[5200]: accepted connection from pid 11607, user alice (trusted) ok derivation show --no-pretty machine # [1333255.685244] machine nix-daemon[5200]: accepted connection from pid 11634, user alice (trusted) ok derivation show .#pkg machine # [1333256.613519] machine nix-daemon[5200]: accepted connection from pid 11663, user alice (trusted) ok derivation show -r over a real closure machine # [1333257.675162] machine nix-daemon[5200]: accepted connection from pid 11692, user alice (trusted) machine # [1333260.814647] machine nix-daemon[5200]: accepted connection from pid 11721, user alice (trusted) ok derivation show -r over nixpkgs hello.src ok derivation show structuredAttrs floats machine # [1333262.523843] machine nix-daemon[5200]: accepted connection from pid 11750, user alice (trusted) ok derivation show structuredAttrs floats --pretty machine # [1333263.061151] machine nix-daemon[5200]: accepted connection from pid 11779, user alice (trusted) ok derivation show an installable that does not exist ok derivation show an installable that does not exist: the same error line ok derivation show does not instantiate, where the real nix does ok derivation show --stdin falls back machine # [1333263.957547] machine nix-daemon[5200]: accepted connection from pid 11835, user alice (trusted) ok derivation show /nix/store/00000000000000000000000000000000-x.drv falls back machine # [1333268.451028] machine nix-daemon[5200]: accepted connection from pid 11868, user alice (trusted) machine # [1333269.614175] machine nix-daemon[5200]: accepted connection from pid 11925, user alice (trusted) ok nix-shell nixpkgs -A hello --run 'echo $name' machine # [1333273.433677] machine nix-daemon[5200]: accepted connection from pid 11996, user alice (trusted) machine # [1333274.609083] machine nix-daemon[5200]: accepted connection from pid 12054, user alice (trusted) ok nix-shell nixpkgs -A hello --run env (70 variables) machine # [1333278.309176] machine nix-daemon[5200]: accepted connection from pid 12126, user alice (trusted) machine # [1333279.460995] machine nix-daemon[5200]: accepted connection from pid 12185, user alice (trusted) ok nix-shell --pure --run env (41 variables) machine # [1333281.905661] machine nix-daemon[5200]: accepted connection from pid 12257, user alice (trusted) machine # [1333283.121174] machine nix-daemon[5200]: accepted connection from pid 12315, user alice (trusted) ok nix-shell --pure --keep FOO machine # [1333286.777426] machine nix-daemon[5200]: accepted connection from pid 12386, user alice (trusted) machine # [1333287.775674] machine nix-daemon[5200]: accepted connection from pid 12444, user alice (trusted) ok nix-shell --command, stdin not a tty machine # [1333289.658641] machine nix-daemon[5200]: accepted connection from pid 12516, user alice (trusted) ok nix-shell with no argument prefers shell.nix machine # [1333290.054175] machine nix-daemon[5200]: accepted connection from pid 12530, user alice (trusted) machine # [1333291.561538] machine nix-daemon[5200]: accepted connection from pid 12554, user alice (trusted) machine # [1333291.900447] machine nix-daemon[5200]: accepted connection from pid 12567, user alice (trusted) ok nix-shell --run 'exit 3' keeps the exit code ok nix-shell with no shell.nix or default.nix ok nix-shell roots the input it realised ok a collection leaves nix-shell's root, and the next entry builds nothing ok iets cache gc sweeps nix-shell's roots ok shell-gc-root = false keeps no root, and the collection takes the output machine # [1333311.409023] machine nix-daemon[5200]: accepted connection from pid 12815, user alice (trusted) machine # [1333316.911032] machine nix-daemon[5200]: accepted connection from pid 13085, user alice (trusted) ok nix develop -c env (107 variables) machine # [1333326.846227] machine nix-daemon[5200]: accepted connection from pid 13124, user alice (trusted) ok nix develop -c sh -c 'echo $name' machine # [1333331.754544] machine nix-daemon[5200]: accepted connection from pid 13163, user alice (trusted) ok nix develop --ignore-environment --keep HOME (72 variables) machine # [1333332.996607] machine nix-daemon[5200]: accepted connection from pid 13202, user alice (trusted) ok nix develop -u HOME machine # [1333337.888372] machine nix-daemon[5200]: accepted connection from pid 13226, user alice (trusted) machine # [1333338.483022] machine nix-daemon[5200]: accepted connection from pid 13262, user alice (trusted) ok nix develop keeps the shell's environment under a GC root machine # [1333343.212876] machine nix-daemon[5200]: accepted connection from pid 13283, user alice (trusted) ok shell-gc-root = false keeps no root for nix develop ok nix flake lock for the fmt fixture machine # [1333344.012611] machine nix-daemon[5200]: accepted connection from pid 13318, user alice (trusted) machine # [1333465.448218] machine nix-daemon[5200]: accepted connection from pid 13340, user alice (trusted) machine # [1333466.753464] machine nix-daemon[5200]: accepted connection from pid 13340, user alice (trusted) machine # [1333467.083681] machine nix-daemon[5200]: accepted connection from pid 13378, user alice (trusted) ok nix fmt with no arguments machine # [1333552.802564] machine nix-daemon[5200]: accepted connection from pid 13409, user alice (trusted) ok nix fmt with paths machine # [1333554.222935] machine nix-daemon[5200]: accepted connection from pid 13439, user alice (trusted) ok nix fmt -- --write x.nix machine # [1333564.694383] machine nix-daemon[5200]: accepted connection from pid 13461, user alice (trusted) ok nix fmt: an invalidation is silent on stderr and one record in json-log-path ok nix fmt keeps the formatter under a GC root ok iets cache gc sweeps the roots store machine # [1333565.163185] machine nix-daemon[5200]: accepted connection from pid 13480, user alice (trusted) ok nix fmt without a formatter output ok nix fmt names the missing attribute itself machine # [1333565.854139] machine nix-daemon[5200]: accepted connection from pid 13511, user alice (trusted) ok nix flake lock for the cache fixture machine # [1333566.292945] machine nix-daemon[5200]: accepted connection from pid 13539, user alice (trusted) ok nix eval: a cold run prints what nix prints ok nix eval: a cold run evaluates ok nix eval: a hit prints what nix prints ok nix eval: the second run is a hit with the same bytes ok nix eval: no lint under a classic name ok nix eval: a hit gives every warning once machine # [1333568.234116] machine nix-daemon[5200]: accepted connection from pid 13588, user alice (trusted) ok nix eval: an edit of a file the flake reads evaluates again, and then hits ok nix eval: the invalidation is silent on stderr and one record in json-log-path machine # [1333569.018416] machine nix-daemon[5200]: accepted connection from pid 13653, user alice (trusted) ok nix eval: another flake.lock evaluates again, and then hits ok nix eval --impure: its own entry, and a variable that changed evaluates again ok nix eval --override-input is nix's: no entry is read or written machine # [1333573.976686] machine nix-daemon[5200]: accepted connection from pid 13710, user alice (trusted) ok nix build: a cold run prints what nix prints ok nix build: a cold run evaluates machine # [1333574.396874] machine nix-daemon[5200]: accepted connection from pid 13710, user alice (trusted) machine # [1333574.483039] machine nix-daemon[5200]: accepted connection from pid 13747, user alice (trusted) machine # [1333574.674627] machine nix-daemon[5200]: accepted connection from pid 13769, user alice (trusted) machine # [1333575.024160] machine nix-daemon[5200]: accepted connection from pid 13769, user alice (trusted) ok nix build: a hit prints what nix prints ok nix build: the second run is a hit with the same bytes ok nix build: no lint under a classic name machine # [1333575.527850] machine nix-daemon[5200]: accepted connection from pid 13784, user alice (trusted) machine # [1333575.817318] machine nix-daemon[5200]: accepted connection from pid 13784, user alice (trusted) machine # [1333575.904654] machine nix-daemon[5200]: accepted connection from pid 13799, user alice (trusted) machine # [1333576.078116] machine nix-daemon[5200]: accepted connection from pid 13799, user alice (trusted) ok nix build: a hit gives every warning once machine # [1333576.636124] machine nix-daemon[5200]: accepted connection from pid 13814, user alice (trusted) machine # [1333577.139253] machine nix-daemon[5200]: accepted connection from pid 13814, user alice (trusted) machine # [1333577.297317] machine nix-daemon[5200]: accepted connection from pid 13855, user alice (trusted) machine # [1333577.446555] machine nix-daemon[5200]: accepted connection from pid 13855, user alice (trusted) ok nix build: an edit of a file the flake reads evaluates again, and then hits ok nix build: the invalidation is silent on stderr and one record in json-log-path machine # [1333577.645459] machine nix-daemon[5200]: accepted connection from pid 13870, user alice (trusted) machine # [1333578.072276] machine nix-daemon[5200]: accepted connection from pid 13870, user alice (trusted) machine # [1333578.246591] machine nix-daemon[5200]: accepted connection from pid 13911, user alice (trusted) ok nix build: another flake.lock evaluates again, and then hits machine # [1333578.383966] machine nix-daemon[5200]: accepted connection from pid 13911, user alice (trusted) machine # [1333578.929022] machine nix-daemon[5200]: accepted connection from pid 13926, user alice (trusted) machine # [1333579.404028] machine nix-daemon[5200]: accepted connection from pid 13926, user alice (trusted) machine # [1333579.497476] machine nix-daemon[5200]: accepted connection from pid 13963, user alice (trusted) machine # [1333579.704105] machine nix-daemon[5200]: accepted connection from pid 13963, user alice (trusted) machine # [1333580.485921] machine nix-daemon[5200]: accepted connection from pid 13978, user alice (trusted) ok nix build --impure: its own entry, and a variable that changed evaluates again ok nix build --override-input is nix's: no entry is read or written machine # [1333581.188447] machine nix-daemon[5200]: accepted connection from pid 13978, user alice (trusted) ok nix derivation show: a cold run prints what nix prints ok nix derivation show: a cold run evaluates machine # [1333582.165470] machine nix-daemon[5200]: accepted connection from pid 14033, user alice (trusted) ok nix derivation show: a hit prints what nix prints ok nix derivation show: the second run is a hit with the same bytes ok nix derivation show: no lint under a classic name ok nix derivation show: a hit gives every warning once ok nix derivation show: an edit of a file the flake reads evaluates again, and then hits ok nix derivation show: the invalidation is silent on stderr and one record in json-log-path ok nix derivation show: another flake.lock evaluates again, and then hits ok nix derivation show --impure: its own entry, and a variable that changed evaluates again ok nix derivation show --override-input is nix's: no entry is read or written machine # [1333589.528356] machine nix-daemon[5200]: accepted connection from pid 14150, user alice (trusted) machine # [1333591.002023] machine nix-daemon[5200]: accepted connection from pid 14308, user alice (trusted) ok nix develop: a cold run prints what nix prints ok nix develop: a cold run evaluates ok nix develop: a hit prints what nix prints ok nix develop: the second run is a hit with the same bytes ok nix develop: no lint under a classic name ok nix develop: a hit gives every warning once machine # [1333677.262242] machine nix-daemon[5200]: accepted connection from pid 14362, user alice (trusted) ok nix develop: an edit of a file the flake reads evaluates again, and then hits ok nix develop: the invalidation is silent on stderr and one record in json-log-path machine # [1333721.859041] machine nix-daemon[5200]: accepted connection from pid 14534, user alice (trusted) ok nix develop: another flake.lock evaluates again, and then hits machine # [1333751.752457] machine nix-daemon[5200]: accepted connection from pid 14706, user alice (trusted) machine # [1333826.586781] machine systemd[1]: Starting Cleanup of Temporary Directories... machine # [1333826.800291] machine nix-daemon[5200]: accepted connection from pid 14874, user alice (trusted) machine # [1333826.949153] machine systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully. machine # [1333826.949373] machine systemd[1]: Finished Cleanup of Temporary Directories. ok nix develop --impure: its own entry, and a variable that changed evaluates again ok nix develop --override-input is nix's: no entry is read or written machine # [1333831.832158] machine nix-daemon[5200]: accepted connection from pid 15045, user alice (trusted) machine # [1333832.292975] machine nix-daemon[5200]: accepted connection from pid 15045, user alice (trusted) machine # [1333908.827037] machine nix-daemon[5200]: accepted connection from pid 15063, user alice (trusted) machine # [1333909.626052] machine nix-daemon[5200]: accepted connection from pid 15079, user alice (trusted) ok nix build --no-link: a hit keeps the root machine # [1333910.071252] machine nix-daemon[5200]: accepted connection from pid 15079, user alice (trusted) machine # [1333910.209882] machine nix-daemon[5200]: accepted connection from pid 15096, user alice (trusted) ok nix build -o: a hit makes the out-link ok nix develop: a hit keeps the root machine # [1333910.721351] machine nix-daemon[5200]: accepted connection from pid 15111, user alice (trusted) ok nix fmt --json falls back ok nix-shell -p falls back ok nix develop --phase falls back ok nix develop --profile falls back ok nix develop --redirect falls back machine # [1333915.239243] machine nix-daemon[5200]: accepted connection from pid 15145, user alice (trusted) machine # [1333916.989824] machine nix-daemon[5200]: accepted connection from pid 15202, user alice (trusted) ok nix-shell fetches the sha256-pinned tarball of nixpkgs/shell.nix itself ok nix-shell falls back on a #! script machine # [1333925.118433] machine nix-daemon[5200]: accepted connection from pid 15276, user alice (trusted) ok nix flake metadata falls back ok nix eval nixpkgs#lib.version falls back ok iets eval nixpkgs#lib.version says why ok nix eval github:NixOS/nixpkgs#lib.version falls back ok iets eval github:NixOS/nixpkgs#lib.version says why ok nix eval --apply falls back 289 cases, 0 failed machine: (finished: must succeed: runuser -l alice -c 'cd iets && IETS=/nix/store/djlbargwnhm5z3wddlwvdv5j8ndb3zil-iets-0.1.0/bin/iets NIXPKGS=/nix/store/hhfnpma32czw4h3bqpag8dciax0bcmar-source E2E_OFFLINE=1 nu scripts/classic-e2e.nu' >&2, in 902.06 seconds) (finished: run the VM test script, in 1007.59 seconds) machine # [1333926.732243] machine runuser[4912]: pam_unix(runuser-l:session): session closed for user alice test script finished in 1008.01s cleanup kill NspawnMachine (pid 50) Container machine terminated by signal KILL. (finished: cleanup, in 0.46 seconds)