container-test-run-herdr-eternal-server
checks.x86_64-linux.nixos
· build #38
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Initializing machine ID from random generator.5Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 machine,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_ssh11machine: waiting for unit herdr-eternal-server.service12machine: systemd-nspawn running (pid 50)13machine: Waiting for journal at /build/vm-state-machine/var/log/journal...14nixos-nspawn(machine): TAP vde-tap1 not found; container will be isolated from VDE15nixos-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.16Note: 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.17░ Spawning container machine on /build/vm-state-machine.18machine # [110529.900487] machine systemd-journald[58]: Journal started19machine # [110529.900597] machine systemd-journald[58]: Runtime Journal (/run/log/journal/2d0a8e98a76145a79a511c90f5a40560) is 8M, max 2.5G, 2.5G free.20machine # [110529.911763] machine systemd[1]: Finished Apply Kernel Variables.21machine # [110529.924961] machine systemd[1]: Finished Create Static Device Nodes in /dev gracefully.22machine # [110529.940233] machine systemd[1]: Starting Flush Journal to Persistent Storage...23machine # [110529.941884] machine systemd[1]: Starting Create Static Device Nodes in /dev...24machine # [110529.965791] machine systemd-journald[58]: Time spent on flushing to /var/log/journal/2d0a8e98a76145a79a511c90f5a40560 is 1.838ms for 6 entries.25machine # [110529.965791] machine systemd-journald[58]: System Journal (/var/log/journal/2d0a8e98a76145a79a511c90f5a40560) is 512B, max 4G, 3.9G free.26machine # [110529.975382] machine systemd[1]: Finished Create Static Device Nodes in /dev.27machine # [110529.976045] machine systemd[1]: Reached target Preparation for Local File Systems.28machine # [110529.976140] machine systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys29machine # [110529.993566] machine systemd[1]: Finished Flush Journal to Persistent Storage.30machine # [110530.030343] machine systemd[1]: Finished Firewall.31machine # [110530.896767] machine systemd[1]: Mounting /run/wrappers...32machine # [110530.922660] machine systemd[1]: Mounted /run/wrappers.33machine # [110530.923358] machine systemd[1]: Reached target Local File Systems.34machine # [110530.924049] machine systemd[1]: Listening on Boot Loader Control Service Socket.35machine # [110530.924680] machine systemd[1]: Starting Create SUID/SGID Wrappers...36machine # [110530.924707] machine systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container37machine # [110530.925227] machine systemd[1]: Starting Save Transient machine-id to Disk...38machine # [110530.925677] machine systemd[1]: Starting Create System Files and Directories...39machine # [110530.940929] machine systemd-tmpfiles[166]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted40machine # [110530.941194] machine systemd-tmpfiles[166]: fchmod() of /var/log/journal failed: Operation not permitted41machine # [110530.941363] machine systemd-tmpfiles[166]: fchmod() of /var/log/journal/2d0a8e98a76145a79a511c90f5a40560 failed: Operation not permitted42machine # [110530.941586] machine systemd-tmpfiles[166]: fchmod() of /run/log/journal failed: Operation not permitted43machine # [110530.943226] machine suid-sgid-wrappers-start[173]: chmod: changing permissions of '/run/wrappers/wrappers.rsBEwKQnRK/chsh': Operation not permitted44machine # [110530.943905] machine systemd[1]: Finished Create System Files and Directories.45machine # [110530.956926] machine systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE46machine # [110530.956982] machine systemd[1]: suid-sgid-wrappers.service: Failed to read pids.max for control group /system.slice/suid-sgid-wrappers.service, ignoring: No data available47machine # [110530.957034] machine systemd[1]: suid-sgid-wrappers.service: Failed to read pids.max for control group /system.slice/suid-sgid-wrappers.service, ignoring: No data available48machine # [110530.957059] machine systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'.49machine # [110530.957200] machine systemd[1]: Failed to start Create SUID/SGID Wrappers.50machine # [110530.959489] machine systemd[1]: Starting Rebuild Journal Catalog...51machine # [110530.960113] machine systemd[1]: Starting Record System Boot/Shutdown in UTMP...52machine # [110530.991833] machine systemd[1]: etc-machine\x2did.mount: Deactivated successfully.53machine # [110530.992660] machine systemd[1]: Finished Save Transient machine-id to Disk.54machine # [110530.992880] machine systemd[1]: Finished Rebuild Journal Catalog.55machine # [110530.996588] machine systemd[1]: Starting Update is Completed...56machine # [110530.997601] machine systemd[1]: Finished Record System Boot/Shutdown in UTMP.57machine # [110531.005241] machine systemd[1]: Finished Update is Completed.58machine # [110531.005316] machine systemd[1]: Reached target System Initialization.59machine # [110531.005370] machine systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container60machine # [110531.005407] machine systemd[1]: Started Daily Cleanup of Temporary Directories.61machine # [110531.005422] machine systemd[1]: Reached target Timer Units.62machine # [110531.005540] machine systemd[1]: Listening on D-Bus System Message Bus Socket.63machine # [110531.005669] machine systemd[1]: Listening on herdr-eternal-server.socket.64machine # [110531.005802] machine systemd[1]: Listening on Nix Daemon Socket.65machine # [110531.006815] machine systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).66machine # [110531.007404] machine systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).67machine # [110531.007758] machine systemd[1]: Listening on SSH Socket.68machine # [110531.007860] machine systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.69machine # [110531.007875] machine systemd[1]: Reached target Socket Units.70machine # [110531.007905] machine systemd[1]: Reached target Basic System.71machine # [110531.008805] machine systemd[1]: Starting Import lastlog data into lastlog2 database...72machine # [110531.009611] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...73machine # [110531.010052] machine systemd[1]: Starting resolvconf update...74machine # [110531.010548] machine systemd[1]: Starting SSH Host Keys Generation...75machine # [110531.024857] machine systemd[1]: Finished Import lastlog data into lastlog2 database.76machine # [110531.056880] machine systemd[1]: nscd.service: Failed to read pids.max for control group /system.slice/nscd.service, ignoring: No data available77machine # [110531.056910] machine systemd[1]: nscd.service: Deactivated successfully.78machine # [110531.057086] machine systemd[1]: Stopped Name Service Cache Daemon (nsncd).79machine # [110531.059189] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...80machine # [110531.066647] machine resolvconf-start[247]: setfacl: /run/resolvconf: Operation not supported81machine # [110531.067685] machine systemd[1]: resolvconf.service: Main process exited, code=exited, status=1/FAILURE82machine # [110531.067746] machine systemd[1]: resolvconf.service: Failed to read pids.max for control group /system.slice/resolvconf.service, ignoring: No data available83machine # [110531.067804] machine systemd[1]: resolvconf.service: Failed to read pids.max for control group /system.slice/resolvconf.service, ignoring: No data available84machine # [110531.067838] machine systemd[1]: resolvconf.service: Failed with result 'exit-code'.85machine # [110531.071228] machine systemd[1]: Failed to start resolvconf update.86machine # [110531.071481] machine systemd[1]: Reached target Preparation for Network.87machine # [110531.072271] machine systemd[1]: Starting Address configuration of eth1...88machine # [110531.072841] machine systemd[1]: Starting Extra networking commands....89machine # [110531.086864] machine network-addresses-eth1-start[250]: adding address 192.168.1.1/24... done90machine # [110531.089040] machine network-addresses-eth1-start[250]: adding address 2001:db8:1::1/64... done91machine # [110531.092046] machine systemd[1]: Finished Address configuration of eth1.92machine # [110531.112154] machine sshd-keygen-start[198]: Generating public/private rsa key pair.93machine # [110531.112154] machine sshd-keygen-start[198]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key94machine # [110531.112154] machine sshd-keygen-start[198]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub95machine # [110531.112154] machine sshd-keygen-start[198]: The key fingerprint is:96machine # [110531.112154] machine sshd-keygen-start[198]: SHA256:HicdPsLwbDc467l/HKKOACUT1jwd7lpsHPYQezutQTE root@machine97machine # [110531.112154] machine sshd-keygen-start[198]: The key's randomart image is:98machine # [110531.112154] machine sshd-keygen-start[198]: +---[RSA 4096]----+99machine # [110531.112154] machine sshd-keygen-start[198]: | oo .o.E |100machine # [110531.112154] machine sshd-keygen-start[198]: | . .+..o o |101machine # [110531.112154] machine sshd-keygen-start[198]: | o ..B o . |102machine # [110531.112154] machine sshd-keygen-start[198]: | + = @ * . |103machine # [110531.112154] machine sshd-keygen-start[198]: | . * S O |104machine # [110531.112154] machine sshd-keygen-start[198]: | . + o %.o. |105machine # [110531.112154] machine sshd-keygen-start[198]: | o +. o . |106machine # [110531.112154] machine sshd-keygen-start[198]: | . o.. o |107machine # [110531.112154] machine sshd-keygen-start[198]: | ..=o.. |108machine # [110531.112154] machine sshd-keygen-start[198]: +----[SHA256]-----+109machine # [110531.118612] machine systemd[1]: Finished Extra networking commands..110machine # [110531.118696] machine systemd[1]: Reached target Network.111machine # [110531.119482] machine systemd[1]: Starting Roaming-friendly transport for herdr --remote...112machine # [110531.120315] machine systemd[1]: Starting Nginx Web Server...113machine # [110531.122602] machine sshd-keygen-start[313]: Generating public/private ed25519 key pair.114machine # [110531.122602] machine sshd-keygen-start[313]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key115machine # [110531.122602] machine sshd-keygen-start[313]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub116machine # [110531.122602] machine sshd-keygen-start[313]: The key fingerprint is:117machine # [110531.122602] machine sshd-keygen-start[313]: SHA256:IzEfwIh2AhZqpFp9aZt5zN5vXO7ljgPAhL/e8AsAjtU root@machine118machine # [110531.122602] machine sshd-keygen-start[313]: The key's randomart image is:119machine # [110531.122602] machine sshd-keygen-start[313]: +--[ED25519 256]--+120machine # [110531.122602] machine sshd-keygen-start[313]: |.=.. o. . |121machine # [110531.122602] machine sshd-keygen-start[313]: |= +.o .+. . |122machine # [110531.122602] machine sshd-keygen-start[313]: |oo.o. O E+ |123machine # [110531.122602] machine sshd-keygen-start[313]: |o. * @ .+ |124machine # [110531.122602] machine sshd-keygen-start[313]: |. . * S o |125machine # [110531.122602] machine sshd-keygen-start[313]: | + +o . . |126machine # [110531.122602] machine sshd-keygen-start[313]: | ..o= + .|127machine # [110531.122602] machine sshd-keygen-start[313]: | .o= o+ |128machine # [110531.122602] machine sshd-keygen-start[313]: | .ooooo|129machine # [110531.122602] machine sshd-keygen-start[313]: +----[SHA256]-----+130machine # [110531.124116] machine systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available131machine # [110531.124163] machine systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available132machine # [110531.124187] machine systemd[1]: sshd-keygen.service: Deactivated successfully.133machine # [110531.133219] machine systemd[1]: Finished SSH Host Keys Generation.134machine # [110531.141832] machine herdr-eternal-server[314]: 2026-10-31T02:50:27.315520Z INFO herdr_eternal_server: listening addr=127.0.0.1:7433135machine # [110531.148193] machine herdr-eternal-server[314]: 2026-10-31T02:50:27.317161Z INFO herdr_eternal_server: listening (quic) addr=[::]:7443136machine # [110531.143476] machine systemd[1]: Started Roaming-friendly transport for herdr --remote.137machine # [110531.253527] machine nsncd[240]: Oct 31 02:50:27.427 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"138machine # [110531.253554] machine systemd[1]: Started Name Service Cache Daemon (nsncd).139machine # [110531.253627] machine systemd[1]: Reached target Host and Network Name Lookups.140machine # [110531.253672] machine systemd[1]: Reached target User and Group Name Lookups.141machine # [110531.254953] machine systemd[1]: Starting User Login Management...142machine # [110531.255574] machine systemd[1]: Starting Permit User Sessions...143machine # [110531.276299] machine systemd[1]: Finished Permit User Sessions.144machine # [110531.277114] machine systemd[1]: Started Console Getty.145machine # [110531.277137] machine systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0146machine # [110531.277149] machine systemd[1]: Reached target Login Prompts.147machine # [110532.302101] machine systemd[1]: Starting D-Bus System Message Bus...148machine # [110532.302662] machine systemd-logind[355]: New seat seat0.149machine # [110532.302944] machine systemd[1]: Started User Login Management.150machine # [110532.303509] machine systemd[1]: Starting linger-users.service...151machine # [110532.321663] machine nginx-pre-start[367]: nginx: the configuration file /nix/store/rw6l7zhsy6xfk06js1dsjbxvagn7a97f-nginx.conf syntax is ok152machine # [110532.322922] machine nginx-pre-start[367]: nginx: configuration file /nix/store/rw6l7zhsy6xfk06js1dsjbxvagn7a97f-nginx.conf test is successful153machine # [110532.326209] machine systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available154machine # [110532.326261] machine systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available155machine # [110532.326296] machine systemd[1]: linger-users.service: Deactivated successfully.156machine # [110532.326507] machine systemd[1]: Finished linger-users.service.157machine # [110532.330658] machine systemd[1]: Started Nginx Web Server.158machine # [110532.330847] machine systemd[1]: Reached target Multi-User System.159machine: (finished: waiting for unit herdr-eternal-server.service, in 3.65 seconds)160machine: waiting for unit nginx.service161machine: (finished: waiting for unit nginx.service, in 0.01 seconds)162machine: waiting for TCP port 80 on localhost163machine # [110532.714658] machine dbus-broker-launch[365]: Looking up NSS user entry for 'systemd-timesync'...164machine # [110532.715544] machine dbus-broker-launch[365]: NSS returned no entry for 'systemd-timesync'165machine # [110532.715544] machine dbus-broker-launch[365]: Invalid user-name in /nix/store/g1daqs2prqmrw8isjxl47y27kdd5x8b5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"166machine # [110532.716769] machine systemd[1]: Started D-Bus System Message Bus.167machine # [110532.717015] machine systemd[1]: Startup finished in 3.165s.168machine # [110532.723842] machine dbus-broker-launch[365]: Ready169Connection to localhost (::1) 80 port [tcp/http] succeeded!170machine: (finished: waiting for TCP port 80 on localhost, in 1.02 seconds)171machine: must succeed: mkdir -p /root/.config/herdr-eternal172machine: (finished: must succeed: mkdir -p /root/.config/herdr-eternal, in 0.01 seconds)173machine: must succeed: printf '[targets.testbox]174url = "ws://localhost/herdr-eternal"175token = "test-token"176forward_agent = true177[targets.testbox-quic]178url = "ws://127.0.0.1:1"179quic_addr = "127.0.0.1:7443"180quic_ca = "/nix/store/4y0ggsy56jkcdmk7yr3iwf9bkab3g7bb-herdr-eternal-test-cert/cert.pem"181token = "test-token"182' > /root/.config/herdr-eternal/config.toml183machine: (finished: must succeed: printf '[targets.testbox]184url = "ws://localhost/herdr-eternal"185token = "test-token"186forward_agent = true187[targets.testbox-quic]188url = "ws://127.0.0.1:1"189quic_addr = "127.0.0.1:7443"190quic_ca = "/nix/store/4y0ggsy56jkcdmk7yr3iwf9bkab3g7bb-herdr-eternal-test-cert/cert.pem"191token = "test-token"192' > /root/.config/herdr-eternal/config.toml, in 0.00 seconds)193machine: must succeed: herdr-eternal-ssh -T testbox 'id -un; echo $SHELL; echo $USER; echo $LOGNAME; echo $HOME; curl --version > /dev/null && echo curl-ok; echo systemd=$RUNTIME_DIRECTORY$LISTEN_FDS$INVOCATION_ID' < /dev/null194machine: (finished: must succeed: herdr-eternal-ssh -T testbox 'id -un; echo $SHELL; echo $USER; echo $LOGNAME; echo $HOME; curl --version > /dev/null && echo curl-ok; echo systemd=$RUNTIME_DIRECTORY$LISTEN_FDS$INVOCATION_ID' < /dev/null, in 0.03 seconds)195machine: must fail: herdr-eternal-ssh -T testbox 'exit 3' < /dev/null196machine: (finished: must fail: herdr-eternal-ssh -T testbox 'exit 3' < /dev/null, in 0.02 seconds)197machine: must succeed: herdr-eternal-ssh -T testbox-quic 'echo over-quic' < /dev/null198machine: (finished: must succeed: herdr-eternal-ssh -T testbox-quic 'echo over-quic' < /dev/null, in 0.02 seconds)199machine: must succeed: cat > /root/restart-client.sh <<'EOF'200/nix/store/gq6c1sc8y1slz6dp7h0ydx8mpx4rl6vr-herdr-eternal-0.1.0/bin/herdr-eternal-ssh -T testbox 'echo before; sleep 5; echo after; exit 5' </dev/null > /root/restart-out201echo rc=$? >> /root/restart-out202EOF203machine: (finished: must succeed: cat > /root/restart-client.sh <<'EOF'204/nix/store/gq6c1sc8y1slz6dp7h0ydx8mpx4rl6vr-herdr-eternal-0.1.0/bin/herdr-eternal-ssh -T testbox 'echo before; sleep 5; echo after; exit 5' </dev/null > /root/restart-out205echo rc=$? >> /root/restart-out206EOF, in 0.01 seconds)207machine: must succeed: systemd-run --unit=restart-client --setenv=HOME=/root sh /root/restart-client.sh208Running as unit: restart-client.service; invocation ID: b13fe3a5ebaa48a7a8d9ff248a1af2a7209machine: (finished: must succeed: systemd-run --unit=restart-client --setenv=HOME=/root sh /root/restart-client.sh, in 0.01 seconds)210??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.211 File "/nix/store/nnab7wdwimd0gr2jj9xc8bi3rbkzkzjh-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39212machine: waiting for success: grep -q before /root/restart-out213??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.214 File "/nix/store/nnab7wdwimd0gr2jj9xc8bi3rbkzkzjh-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39215grep: /root/restart-out: No such file or directory216machine # [110533.925644] machine systemd[1]: Started [systemd-run] /run/current-system/sw/bin/sh /root/restart-client.sh.217machine: (finished: waiting for success: grep -q before /root/restart-out, in 1.01 seconds)218machine: must succeed: systemctl show -p MainPID --value herdr-eternal-server219machine: (finished: must succeed: systemctl show -p MainPID --value herdr-eternal-server, in 0.01 seconds)220machine: must succeed: systemctl restart herdr-eternal-server221machine: (finished: must succeed: systemctl restart herdr-eternal-server, in 0.06 seconds)222machine: must succeed: systemctl show -p MainPID --value herdr-eternal-server223machine: (finished: must succeed: systemctl show -p MainPID --value herdr-eternal-server, in 0.01 seconds)224machine: waiting for success: grep -q rc= /root/restart-out225machine # [110534.956096] machine systemd[1]: Stopping Roaming-friendly transport for herdr --remote...226machine # [110534.956487] machine herdr-eternal-server[314]: 2026-10-31T02:50:31.130154Z INFO herdr_eternal_server: handed sessions over to the fd store fds=3227machine # [110534.958300] machine systemd[1]: herdr-eternal-server.service: Deactivated successfully.228machine # [110534.958403] machine systemd[1]: herdr-eternal-server.service: Unit process 526 (sh) remains running after unit stopped.229machine # [110534.958476] machine systemd[1]: herdr-eternal-server.service: Unit process 527 (zsh) remains running after unit stopped.230machine # [110534.958532] machine systemd[1]: herdr-eternal-server.service: Unit process 528 (sleep) remains running after unit stopped.231machine # [110534.958681] machine systemd[1]: Stopped Roaming-friendly transport for herdr --remote.232machine # [110534.972954] machine systemd[1]: herdr-eternal-server.service: Found left-over process 526 (sh) in control group while starting unit. Ignoring.233machine # [110534.972960] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.234machine # [110534.973013] machine systemd[1]: herdr-eternal-server.service: Found left-over process 527 (zsh) in control group while starting unit. Ignoring.235machine # [110534.973017] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.236machine # [110534.973135] machine systemd[1]: herdr-eternal-server.service: Found left-over process 528 (sleep) in control group while starting unit. Ignoring.237machine # [110534.973141] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.238machine # [110534.973915] machine systemd[1]: Starting Roaming-friendly transport for herdr --remote...239machine # [110534.996480] machine herdr-eternal-server[533]: 2026-10-31T02:50:31.170324Z INFO herdr_eternal_server: listening addr=127.0.0.1:7433240machine # [110534.996773] machine herdr-eternal-server[533]: 2026-10-31T02:50:31.170564Z INFO herdr_eternal_server: listening (quic) addr=[::]:7443241machine # [110534.996818] machine herdr-eternal-server[533]: 2026-10-31T02:50:31.170679Z INFO herdr_eternal_server: restored handed-over session token=314-1793415030130931545-3242machine # [110535.005632] machine systemd[1]: Started Roaming-friendly transport for herdr --remote.243machine: (finished: waiting for success: grep -q rc= /root/restart-out, in 4.03 seconds)244machine: must succeed: cat /root/restart-out245machine: (finished: must succeed: cat /root/restart-out, in 0.01 seconds)246machine: must succeed: journalctl -u herdr-eternal-server | grep -q 'restored handed-over session'247machine: (finished: must succeed: journalctl -u herdr-eternal-server | grep -q 'restored handed-over session', in 0.01 seconds)248machine: must succeed: ssh-keygen -t ed25519 -N "" -f /root/agent-key249machine: (finished: must succeed: ssh-keygen -t ed25519 -N "" -f /root/agent-key, in 0.01 seconds)250machine: must succeed: install -d -m 700 -o alice -g users /home/alice/.ssh251machine: (finished: must succeed: install -d -m 700 -o alice -g users /home/alice/.ssh, in 0.01 seconds)252machine: must succeed: install -m 600 -o alice -g users /root/agent-key.pub /home/alice/.ssh/authorized_keys253machine: (finished: must succeed: install -m 600 -o alice -g users /root/agent-key.pub /home/alice/.ssh/authorized_keys, in 0.01 seconds)254machine: must succeed: rm /root/agent-key.pub255machine: (finished: must succeed: rm /root/agent-key.pub, in 0.01 seconds)256machine: must succeed: ssh-agent sh -c 'ssh-add /root/agent-key && rm /root/agent-key && herdr-eternal-ssh -T testbox "ssh -o StrictHostKeyChecking=accept-new -o BatchMode=yes alice@localhost id -un"' < /dev/null257Identity added: /root/agent-key (root@machine)258Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.259machine # [110538.969488] machine systemd[1]: restart-client.service: Failed to read pids.max for control group /system.slice/restart-client.service, ignoring: No data available260machine # [110538.969535] machine systemd[1]: restart-client.service: Failed to read pids.max for control group /system.slice/restart-client.service, ignoring: No data available261machine # [110538.969561] machine systemd[1]: restart-client.service: Deactivated successfully.262machine # [110539.140865] machine systemd[1]: Created slice Slice /system/sshd.263machine # [110539.140917] machine systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.264machine # [110539.141565] machine systemd[1]: Started SSH per-connection Daemon ([::1]:52446).265machine: (finished: must succeed: ssh-agent sh -c 'ssh-add /root/agent-key && rm /root/agent-key && herdr-eternal-ssh -T testbox "ssh -o StrictHostKeyChecking=accept-new -o BatchMode=yes alice@localhost id -un"' < /dev/null, in 0.18 seconds)266(finished: run the VM test script, in 10.12 seconds)267test script finished in 10.13s268cleanup269kill NspawnMachine (pid 50)270(finished: cleanup, in 0.06 seconds)271Container machine terminated by signal KILL.