bld1: building 289yv49clpb5w8x9w1kpvs9sqxmnjfww-container-test-run-iets-daemon-e2e.drv Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Initializing machine ID from random generator. 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 # [576404.813664] machine systemd-journald[57]: Journal started machine # [576404.813729] machine systemd-journald[57]: Runtime Journal (/run/log/journal/553771882dc74e00a6f5380ed69b3e3b) is 8M, max 2.5G, 2.5G free. machine # [576404.836421] machine systemd[1]: Finished Apply Kernel Variables. machine # [576404.853455] machine systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [576404.873158] machine systemd[1]: Starting Flush Journal to Persistent Storage... machine # [576404.873687] machine systemd[1]: Starting Create Static Device Nodes in /dev... machine # [576404.898557] machine systemd-journald[57]: Time spent on flushing to /var/log/journal/553771882dc74e00a6f5380ed69b3e3b is 1.407ms for 6 entries. machine # [576404.898557] machine systemd-journald[57]: System Journal (/var/log/journal/553771882dc74e00a6f5380ed69b3e3b) is 512B, max 4G, 3.9G free. machine # [576404.908809] machine systemd[1]: Finished Create Static Device Nodes in /dev. machine # [576404.909563] machine systemd[1]: Reached target Preparation for Local File Systems. machine # [576404.909674] machine systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine # [576404.919861] machine systemd[1]: Finished Firewall. machine # [576404.925925] machine systemd[1]: Finished Flush Journal to Persistent Storage. machine # [576405.815922] machine systemd[1]: Mounting /run/wrappers... machine # [576405.871212] machine systemd[1]: Mounted /run/wrappers. machine # [576405.872328] machine systemd[1]: Reached target Local File Systems. machine # [576405.873302] machine systemd[1]: Listening on Boot Loader Control Service Socket. machine # [576405.874246] machine systemd[1]: Starting Create SUID/SGID Wrappers... machine # [576405.874279] machine systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine # [576405.874965] machine systemd[1]: Starting Save Transient machine-id to Disk... machine # [576405.875483] machine systemd[1]: Starting Create System Files and Directories... machine # [576405.909571] machine systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine # [576405.909850] machine systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted machine # [576405.909927] machine systemd-tmpfiles[161]: fchmod() of /var/log/journal/553771882dc74e00a6f5380ed69b3e3b failed: Operation not permitted machine # [576405.910058] machine systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted machine # [576405.912283] machine suid-sgid-wrappers-start[168]: chmod: changing permissions of '/run/wrappers/wrappers.FFaCTNkw45/chsh': Operation not permitted machine # [576405.916487] machine systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE machine # [576405.916573] machine systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'. machine # [576405.916809] machine systemd[1]: Failed to start Create SUID/SGID Wrappers. machine # [576405.917100] machine systemd[1]: Finished Create System Files and Directories. machine # [576405.950778] machine systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [576405.951840] machine systemd[1]: Finished Save Transient machine-id to Disk. machine # [576405.954042] machine systemd[1]: Starting Rebuild Journal Catalog... machine # [576405.954540] machine systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [576405.985608] machine systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [576405.992515] machine systemd[1]: Finished Rebuild Journal Catalog. machine # [576405.993672] machine systemd[1]: Starting Update is Completed... machine # [576406.001340] machine systemd[1]: Finished Update is Completed. machine # [576406.001463] machine systemd[1]: Reached target System Initialization. machine # [576406.001524] machine systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine # [576406.001552] machine systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [576406.001748] machine systemd[1]: Reached target Timer Units. machine # [576406.001846] machine systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [576406.001922] machine systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [576406.001937] machine systemd[1]: Reached target Socket Units. machine # [576406.001963] machine systemd[1]: Reached target Basic System. machine # [576406.002932] machine systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [576406.003680] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [576406.004297] machine systemd[1]: Starting resolvconf update... machine # [576406.016085] machine systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [576406.043680] machine systemd[1]: nscd.service: Deactivated successfully. machine # [576406.043828] machine systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [576406.045666] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [576406.051228] machine resolvconf-start[235]: setfacl: /run/resolvconf: Operation not supported machine # [576406.052073] machine systemd[1]: resolvconf.service: Main process exited, code=exited, status=1/FAILURE machine # [576406.052162] machine systemd[1]: resolvconf.service: Failed with result 'exit-code'. machine # [576406.062212] machine systemd[1]: Failed to start resolvconf update. machine # [576406.062474] machine systemd[1]: Reached target Preparation for Network. machine # [576406.063162] machine systemd[1]: Starting Address configuration of eth1... machine # [576406.063667] machine systemd[1]: Starting Extra networking commands.... machine # [576406.075645] machine network-addresses-eth1-start[238]: adding address 192.168.1.1/24... done machine # [576406.077949] machine network-addresses-eth1-start[238]: adding address 2001:db8:1::1/64... done machine # [576406.080852] machine systemd[1]: Finished Address configuration of eth1. machine # [576406.106062] machine systemd[1]: Finished Extra networking commands.. machine # [576406.106197] machine systemd[1]: Reached target Network. machine # [576406.193890] machine systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [576406.193964] machine systemd[1]: Reached target Host and Network Name Lookups. machine # [576406.194113] machine nsncd[230]: Oct 22 12:59:27.216 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [576406.194014] machine systemd[1]: Reached target User and Group Name Lookups. machine # [576406.195123] machine systemd[1]: Starting User Login Management... machine # [576406.195924] machine systemd[1]: Starting Permit User Sessions... machine # [576406.218901] machine systemd[1]: Finished Permit User Sessions. machine # [576406.219885] machine systemd[1]: Started Console Getty. machine # [576406.219916] machine systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine # [576406.219933] machine systemd[1]: Reached target Login Prompts. machine # [576407.158971] machine systemd-logind[306]: New seat seat0. machine # [576407.159949] machine systemd[1]: Starting D-Bus System Message Bus... machine # [576407.160058] machine systemd[1]: Started User Login Management. machine # [576407.160741] machine systemd[1]: Starting linger-users.service... machine # [576407.186403] machine systemd[1]: linger-users.service: Deactivated successfully. machine # [576407.186593] machine systemd[1]: Finished linger-users.service. machine # [576407.186753] machine systemd[1]: Reached target Multi-User System. machine # [576407.627591] machine dbus-broker-launch[316]: Looking up NSS user entry for 'systemd-timesync'... machine # [576407.628419] machine dbus-broker-launch[316]: NSS returned no entry for 'systemd-timesync' machine # [576407.628419] machine dbus-broker-launch[316]: Invalid user-name in /nix/store/qd8cn2q590nmz0k4q57w1x9vg0xwvl2v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [576407.628826] machine systemd[1]: Started D-Bus System Message Bus. machine # [576407.629108] machine systemd[1]: Startup finished in 3.241s. machine # [576407.636930] machine dbus-broker-launch[316]: Ready machine: (finished: waiting for unit multi-user.target, in 4.14 seconds) machine: must succeed: /nix/store/phhjngxgfhr1lrzk0w7ms3775mh0pxd5-writable-store /nix/store/w3mynb6skwlzy174999fkgljgqbih8lh-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/phhjngxgfhr1lrzk0w7ms3775mh0pxd5-writable-store /nix/store/w3mynb6skwlzy174999fkgljgqbih8lh-closure-info, in 9.44 seconds) machine: must succeed: systemctl start nix-daemon.socket machine: (finished: must succeed: systemctl start nix-daemon.socket, in 0.01 seconds) machine: must succeed: cp -r /nix/store/xn0ib2blv3cac5a73099iaifgz4dfzdc-source /home/alice/iets && chmod -R u+w /home/alice/iets && chown -R alice /home/alice/iets machine: (finished: must succeed: cp -r /nix/store/xn0ib2blv3cac5a73099iaifgz4dfzdc-source /home/alice/iets && chmod -R u+w /home/alice/iets && chown -R alice /home/alice/iets, in 0.09 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 # [576417.516125] machine systemd[1]: Listening on Nix Daemon Socket. machine # [576417.619474] machine runuser[4964]: 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.20 seconds) machine: must succeed: runuser -l alice -c 'cd iets && IETS=/nix/store/wvszpmj4gviw6jm1b420k4g880ppz0d4-iets-0.1.0/bin/iets NIXPKGS=/nix/store/r5l65vg4gi4dnx54zkwagfb8jmlqniy5-source E2E_OFFLINE=1 nu scripts/daemon-e2e.nu' >&2 == 1. custom derivation with a source tree, --builder daemon machine # [576417.808027] machine runuser[4964]: pam_unix(runuser-l:session): session closed for user alice machine # [576417.825189] machine runuser[4977]: pam_unix(runuser-l:session): session opened for user alice(uid=1000) by (uid=0) machine # [576418.293342] machine systemd[1]: Started Nix Daemon. machine # [576418.404173] machine nix-daemon[5092]: accepted connection from pid 5074, user alice (trusted) machine # [576418.544313] machine nix-daemon[5092]: accepted connection from pid 5113, user alice (trusted) drv: /nix/store/c57xcccbjrwfmsk4l72r3iqsh6p2zzwp-iets-daemon-e2e.drv src: /nix/store/k0jxns9w9xxd3gd7a1m1w46zzns4qkg8-src machine # [576418.620018] machine nix-daemon[5092]: accepted connection from pid 5134, user alice (trusted) machine # [576418.793517] machine nix-daemon[5092]: accepted connection from pid 5155, user alice (trusted) machine # [576418.860875] machine nix-daemon[5092]: accepted connection from pid 5176, user alice (trusted) machine # [576418.937021] machine nix-daemon[5092]: accepted connection from pid 5197, user alice (trusted) machine # [576419.070014] machine nix-daemon[5092]: accepted connection from pid 5223, user alice (trusted) machine # [576419.248169] machine nix-daemon[5092]: accepted connection from pid 5249, user alice (trusted) machine # [576419.348689] machine nix-daemon[5092]: accepted connection from pid 5271, user alice (trusted) eval: 1 derivations, 1 sources, 0.948s plan: 1 sources, 1 drvs, 0.000s connect: protocol 1.38, trusted, 0.008s query: 2 paths, 2 missing, 0.000s resolve: 1 sources, 0.007s add: 2 paths, 2376 bytes, 0.002s build: 0.154s outputs: 0.000s fetch: 1 outputs, 0.004s worker: 6 ops, 9 round trips, 2888 bytes sent machine # [576420.461094] machine nix-daemon[5092]: accepted connection from pid 5292, user alice (trusted) machine # [576420.738077] machine nix-daemon[5092]: accepted connection from pid 5327, user alice (trusted) machine # [576420.801036] machine nix-daemon[5092]: accepted connection from pid 5348, user alice (trusted) machine # [576420.910099] machine nix-daemon[5092]: accepted connection from pid 5369, user alice (trusted) machine # [576420.971405] machine nix-daemon[5092]: accepted connection from pid 5390, user alice (trusted) machine # [576421.042322] machine nix-daemon[5092]: accepted connection from pid 5415, user alice (trusted) ok: /nix/store/v393d2r3jdnc8qyjij7mjlrp6hnvj0df-iets-daemon-e2e == 2. hello through the local daemon (closure already valid) machine # [576421.942770] machine nix-daemon[5092]: accepted connection from pid 5445, user alice (trusted) machine # [576424.173036] machine nix-daemon[5092]: accepted connection from pid 5465, user alice (trusted) eval: 742 derivations, 158 sources, 3.640s plan: 158 sources, 607 drvs, 0.001s connect: protocol 1.38, trusted, 0.051s query: 2 paths, 0 missing, 0.000s resolve: 0 sources, 0.000s add: 0 paths, 0 bytes, 0.000s build: 0.000s outputs: 0.000s worker: 3 ops, 6 round trips, 336 bytes sent ok: /nix/store/5z2yp3ysx8476c8g5w25b0smlgkjvaq3-hello-2.12.3 == 3. hello cold against a scratch chroot daemon, --no-build machine # [576428.200518] machine nix-daemon[5092]: accepted connection from pid 5486, user alice (trusted) machine # [576428.252198] machine nix-daemon[5092]: accepted connection from pid 5486, user alice (trusted) eval: 742 derivations, 158 sources, 1.873s plan: 158 sources, 607 drvs, 0.058s connect: protocol 1.38, trusted, 0.006s query: 765 paths, 765 missing, 0.003s resolve: 158 sources, 0.005s add: 765 paths, 2510512 bytes, 0.644s build: 0.000s outputs: 0.000s worker: 5 ops, 8 round trips, 2571560 bytes sent machine # [576431.100182] machine nix-daemon[5092]: accepted connection from pid 5645, user alice (trusted) machine # [576431.205721] machine nix-daemon[5092]: accepted connection from pid 5685, user alice (trusted) machine # [576431.298231] machine nix-daemon[5092]: accepted connection from pid 5727, user alice (trusted) machine # [576431.373236] machine nix-daemon[5092]: accepted connection from pid 5771, user alice (trusted) ok: 765 paths registered, hashes and ca match the local store == 4. hello warm against the scratch daemon eval: 742 derivations, 158 sources, 0.710s plan: 158 sources, 607 drvs, 0.002s connect: protocol 1.38, trusted, 0.003s query: 1 paths, 0 missing, 0.000s resolve: 0 sources, 0.001s add: 0 paths, 0 bytes, 0.000s build: 0.000s outputs: 0.000s worker: 2 ops, 5 round trips, 248 bytes sent ok == 5. custom derivation, --builder unix:///nix/var/nix/daemon-socket/socket drv: /nix/store/3a0lh3b7csibn9p9qzyb5v2mg71grg97-iets-daemon-e2e-unix.drv src: /nix/store/ckfqwc7j2jzz7szz1c2bbachdsr2lrci-src machine # [576432.215117] machine nix-daemon[5092]: accepted connection from pid 5810, user alice (trusted) machine # [576432.274123] machine nix-daemon[5092]: accepted connection from pid 5830, user alice (trusted) machine # [576432.328933] machine nix-daemon[5092]: accepted connection from pid 5851, user alice (trusted) machine # [576432.504326] machine nix-daemon[5092]: accepted connection from pid 5872, user alice (trusted) machine # [576432.562322] machine nix-daemon[5092]: accepted connection from pid 5893, user alice (trusted) machine # [576432.612176] machine nix-daemon[5092]: accepted connection from pid 5914, user alice (trusted) machine # [576432.659638] machine nix-daemon[5092]: accepted connection from pid 5940, user alice (trusted) machine # [576432.708755] machine nix-daemon[5092]: accepted connection from pid 5966, user alice (trusted) machine # [576432.766294] machine nix-daemon[5092]: accepted connection from pid 5988, user alice (trusted) eval: 1 derivations, 1 sources, 0.797s plan: 1 sources, 1 drvs, 0.000s connect: protocol 1.38, trusted, 0.032s query: 2 paths, 2 missing, 0.000s resolve: 1 sources, 0.001s add: 2 paths, 2392 bytes, 0.002s build: 0.095s outputs: 0.000s fetch: 1 outputs, 0.000s worker: 6 ops, 9 round trips, 2912 bytes sent machine # [576433.633807] machine nix-daemon[5092]: accepted connection from pid 6009, user alice (trusted) machine # [576433.799017] machine nix-daemon[5092]: accepted connection from pid 6044, user alice (trusted) machine # [576433.851350] machine nix-daemon[5092]: accepted connection from pid 6065, user alice (trusted) machine # [576433.900399] machine nix-daemon[5092]: accepted connection from pid 6086, user alice (trusted) ok: /nix/store/0k23gwghsrg9ma118saw5inal2i7avmc-iets-daemon-e2e-unix == 6. custom derivation, --builder ssh-ng://shim (ssh shim runs nix-daemon --stdio) machine # [576433.951180] machine nix-daemon[5092]: accepted connection from pid 6107, user alice (trusted) machine # [576434.005620] machine nix-daemon[5092]: accepted connection from pid 6132, user alice (trusted) machine # [576434.071093] machine nix-daemon[5092]: accepted connection from pid 6168, user alice (trusted) machine # [576434.119998] machine nix-daemon[5092]: accepted connection from pid 6188, user alice (trusted) drv: /nix/store/pjnvx1jl1ajkjk6zssv33sns2cl4q43y-iets-daemon-e2e-ssh.drv src: /nix/store/kg6cggpn0ki7rk62wbn3qav4jmqqml70-src machine # [576434.169338] machine nix-daemon[5092]: accepted connection from pid 6209, user alice (trusted) machine # [576434.353138] machine nix-daemon[5092]: accepted connection from pid 6230, user alice (trusted) machine # [576434.418239] machine nix-daemon[5092]: accepted connection from pid 6251, user alice (trusted) machine # [576434.470147] machine nix-daemon[5092]: accepted connection from pid 6272, user alice (trusted) machine # [576434.526440] machine nix-daemon[5092]: accepted connection from pid 6298, user alice (trusted) machine # [576434.580381] machine nix-daemon[5092]: accepted connection from pid 6324, user alice (trusted) machine # [576434.642012] machine nix-daemon[5092]: accepted connection from pid 6346, user alice (trusted) eval: 1 derivations, 1 sources, 1.257s plan: 1 sources, 1 drvs, 0.000s connect: protocol 1.38, trusted, 0.077s query: 2 paths, 2 missing, 0.000s resolve: 1 sources, 0.000s add: 2 paths, 2392 bytes, 0.002s build: 0.086s outputs: 0.000s fetch: 1 outputs, 0.160s worker: 5 ops, 8 round trips, 2800 bytes sent machine # [576436.068415] machine nix-daemon[5092]: accepted connection from pid 6375, user alice (trusted) ok: /nix/store/sqpkv2azhyv13i7fyk8nj1z8mnjh1wyg-iets-daemon-e2e-ssh == 7. builtins.storePath of the hello output as an input source, local daemon has it machine # [576436.385128] machine nix-daemon[5092]: accepted connection from pid 6420, user alice (trusted) machine # [576436.446195] machine nix-daemon[5092]: accepted connection from pid 6441, user alice (trusted) machine # [576436.496525] machine nix-daemon[5092]: accepted connection from pid 6462, user alice (trusted) machine # [576436.549077] machine nix-daemon[5092]: accepted connection from pid 6483, user alice (trusted) machine # [576436.604354] machine nix-daemon[5092]: accepted connection from pid 6508, user alice (trusted) machine # [576436.662945] machine nix-daemon[5092]: accepted connection from pid 6538, user alice (trusted) machine # [576436.717765] machine nix-daemon[5092]: accepted connection from pid 6558, user alice (trusted) machine # [576436.772554] machine nix-daemon[5092]: accepted connection from pid 6579, user alice (trusted) machine # [576436.913815] machine nix-daemon[5092]: accepted connection from pid 6600, user alice (trusted) eval: 1 derivations, 0 sources, 2.247s plan: 1 sources, 1 drvs, 0.000s connect: protocol 1.38, trusted, 0.040s query: 2 paths, 1 missing, 0.000s resolve: 0 sources, 0.000s add: 1 paths, 944 bytes, 0.017s build: 0.111s outputs: 0.000s worker: 5 ops, 8 round trips, 1408 bytes sent ok: /nix/store/7wz4193fxbjlxvrpwj37vcwjqc5w5y4m-iets-daemon-e2e-storepath == 8. the same through a scratch daemon that lacks the output and substitutes it from file:// machine # [576439.427546] machine nix-daemon[5092]: accepted connection from pid 6622, user alice (trusted) machine # [576439.596589] machine nix-daemon[5092]: accepted connection from pid 6622, user alice (trusted) machine # [576439.638498] machine nix-daemon[5092]: accepted connection from pid 6659, user alice (trusted) eval: 1 derivations, 0 sources, 0.920s plan: 1 sources, 1 drvs, 0.000s connect: protocol 1.38, trusted, 0.004s query: 2 paths, 2 missing, 0.000s resolve: 0 sources, 0.053s substitute: 1 paths left to the daemon, 0.061s add: 1 paths, 944 bytes, 0.058s build: 0.000s outputs: 0.000s worker: 5 ops, 8 round trips, 1384 bytes sent ok: substituted, drv registered machine # [576441.160722] machine nix-daemon[5092]: accepted connection from pid 6738, user alice (trusted) eval: 1 derivations, 0 sources, 0.546s plan: 1 sources, 1 drvs, 0.000s connect: protocol 1.38, trusted, 0.012s query: 2 paths, 0 missing, 0.000s resolve: 0 sources, 0.000s add: 0 paths, 0 bytes, 0.000s build: 0.075s outputs: 0.000s worker: 4 ops, 7 round trips, 480 bytes sent ok: /nix/store/7wz4193fxbjlxvrpwj37vcwjqc5w5y4m-iets-daemon-e2e-storepath == 9. the stdout contract: a path on stdout, or a non-zero exit machine # [576443.227678] machine nix-daemon[5092]: accepted connection from pid 6824, user alice (trusted) ok: /nix/store/qw6wc6dh32ykb6ikz3kv5v0bb2hwi3xk-iets-contract-ok machine # [576443.537387] machine nix-daemon[5092]: accepted connection from pid 6824, user alice (trusted) ok: a failed build exits 100 with no path machine # [576444.727911] machine nix-daemon[5092]: accepted connection from pid 6861, user alice (trusted) ok: no silent success PASS machine: (finished: must succeed: runuser -l alice -c 'cd iets && IETS=/nix/store/wvszpmj4gviw6jm1b420k4g880ppz0d4-iets-0.1.0/bin/iets NIXPKGS=/nix/store/r5l65vg4gi4dnx54zkwagfb8jmlqniy5-source E2E_OFFLINE=1 nu scripts/daemon-e2e.nu' >&2, in 29.36 seconds) (finished: run the VM test script, in 43.25 seconds) machine # [576447.071334] machine nix-daemon[5092]: accepted connection from pid 6912, user alice (trusted) machine # [576447.167066] machine runuser[4977]: pam_unix(runuser-l:session): session closed for user alice test script finished in 44.10s cleanup kill NspawnMachine (pid 50) Container machine terminated by signal KILL. (finished: cleanup, in 0.12 seconds)