container-test-run-herdr-eternal-server
checks.aarch64-linux.nixos
· build #25
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Initializing machine ID from random generator.6Test will time out and terminate in 3600.0 seconds7run the VM test script8machine: waiting for unit herdr-eternal-server.service9machine: systemd-nspawn running (pid 49)10machine: Waiting for journal at /build/vm-state-machine/var/log/journal...11nixos-nspawn(machine): TAP vde-tap1 not found; container will be isolated from VDE12nixos-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.13Note: 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.14░ Spawning container machine on /build/vm-state-machine.15machine # No journal files were found.16machine # No journal boot entry found for the specified boot (+0).17machine # [2380430.770451] machine systemd-journald[58]: Journal started18machine # [2380430.770503] machine systemd-journald[58]: Runtime Journal (/run/log/journal/1fdbd52f771045b49a3e04bd4e7bf9af) is 8M, max 4G, 3.9G free.19machine # [2380430.784837] machine systemd[1]: Finished Create Static Device Nodes in /dev gracefully.20machine # [2380430.802912] machine systemd[1]: Starting Flush Journal to Persistent Storage...21machine # [2380430.804204] machine systemd[1]: Starting Create Static Device Nodes in /dev...22machine # [2380430.818081] machine systemd-journald[58]: Time spent on flushing to /var/log/journal/1fdbd52f771045b49a3e04bd4e7bf9af is 7.791ms for 5 entries.23machine # [2380430.818081] machine systemd-journald[58]: System Journal (/var/log/journal/1fdbd52f771045b49a3e04bd4e7bf9af) is 512B, max 4G, 3.9G free.24machine # [2380430.824797] machine systemd[1]: Finished Create Static Device Nodes in /dev.25machine # [2380430.826196] machine systemd[1]: Reached target Preparation for Local File Systems.26machine # [2380430.826380] machine systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys27machine # [2380430.856131] machine systemd[1]: Finished Flush Journal to Persistent Storage.28machine # [2380431.025216] machine systemd[1]: Finished Firewall.29machine # [2380431.761412] machine systemd[1]: Mounting /run/wrappers...30machine # [2380431.830108] machine systemd[1]: Mounted /run/wrappers.31machine # [2380431.831743] machine systemd[1]: Reached target Local File Systems.32machine # [2380431.832836] machine systemd[1]: Listening on Boot Loader Control Service Socket.33machine # [2380431.834670] machine systemd[1]: Starting Create SUID/SGID Wrappers...34machine # [2380431.834718] machine systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container35machine # [2380431.835825] machine systemd[1]: Starting Save Transient machine-id to Disk...36machine # [2380431.837322] machine systemd[1]: Starting Create System Files and Directories...37machine # [2380431.859222] machine systemd-tmpfiles[166]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted38machine # [2380431.859728] machine systemd-tmpfiles[166]: fchmod() of /var/log/journal failed: Operation not permitted39machine # [2380431.860001] machine systemd-tmpfiles[166]: fchmod() of /var/log/journal/1fdbd52f771045b49a3e04bd4e7bf9af failed: Operation not permitted40machine # [2380431.860322] machine systemd-tmpfiles[166]: fchmod() of /run/log/journal failed: Operation not permitted41machine # [2380431.863387] machine systemd[1]: Finished Create System Files and Directories.42machine # [2380431.864131] machine suid-sgid-wrappers-start[173]: chmod: changing permissions of '/run/wrappers/wrappers.hOx9M2laBk/chsh': Operation not permitted43machine # [2380431.883765] machine systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE44machine # [2380431.884114] machine systemd[1]: suid-sgid-wrappers.service: Failed to read pids.max for control group /system.slice/suid-sgid-wrappers.service, ignoring: No data available45machine # [2380431.884166] machine systemd[1]: suid-sgid-wrappers.service: Failed to read pids.max for control group /system.slice/suid-sgid-wrappers.service, ignoring: No data available46machine # [2380431.884198] machine systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'.47machine # [2380431.885517] machine systemd[1]: Failed to start Create SUID/SGID Wrappers.48machine # [2380431.896313] machine systemd[1]: Starting Rebuild Journal Catalog...49machine # [2380431.898486] machine systemd[1]: Starting Record System Boot/Shutdown in UTMP...50machine # [2380431.914814] machine systemd[1]: Finished Record System Boot/Shutdown in UTMP.51machine # [2380431.926669] machine systemd[1]: Finished Rebuild Journal Catalog.52machine # [2380431.928537] machine systemd[1]: Starting Update is Completed...53machine # [2380431.942934] machine systemd[1]: Finished Update is Completed.54machine # [2380431.943064] machine systemd[1]: Reached target System Initialization.55machine # [2380431.943170] machine systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container56machine # [2380431.943215] machine systemd[1]: Started Daily Cleanup of Temporary Directories.57machine # [2380431.943237] machine systemd[1]: Reached target Timer Units.58machine # [2380431.943377] machine systemd[1]: Listening on D-Bus System Message Bus Socket.59machine # [2380431.943466] machine systemd[1]: Listening on herdr-eternal-server.socket.60machine # [2380431.943777] machine systemd[1]: Listening on Nix Daemon Socket.61machine # [2380431.944860] machine systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).62machine # [2380431.945688] machine systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).63machine # [2380431.946205] machine systemd[1]: Listening on SSH Socket.64machine # [2380431.946343] machine systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.65machine # [2380431.946365] machine systemd[1]: Reached target Socket Units.66machine # [2380431.946409] machine systemd[1]: Reached target Basic System.67machine # [2380431.948266] machine systemd[1]: Starting Import lastlog data into lastlog2 database...68machine # [2380431.950104] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...69machine # [2380431.951361] machine systemd[1]: Starting resolvconf update...70machine # [2380431.953184] machine systemd[1]: Starting SSH Host Keys Generation...71machine # [2380431.976322] machine systemd[1]: Finished Import lastlog data into lastlog2 database.72machine # [2380432.042988] machine systemd[1]: etc-machine\x2did.mount: Deactivated successfully.73machine # [2380432.044473] machine systemd[1]: Finished Save Transient machine-id to Disk.74machine # [2380432.070597] machine systemd[1]: nscd.service: Failed to read pids.max for control group /system.slice/nscd.service, ignoring: No data available75machine # [2380432.070635] machine systemd[1]: nscd.service: Deactivated successfully.76machine # [2380432.070960] machine systemd[1]: Stopped Name Service Cache Daemon (nsncd).77machine # [2380432.075450] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...78machine # [2380432.124380] machine systemd[1]: Finished resolvconf update.79machine # [2380432.124762] machine systemd[1]: Reached target Preparation for Network.80machine # [2380432.126376] machine systemd[1]: Starting Address configuration of eth1...81machine # [2380432.127878] machine systemd[1]: Starting Extra networking commands....82machine # [2380432.151105] machine network-addresses-eth1-start[250]: adding address 192.168.1.1/24... done83machine # [2380432.154876] machine network-addresses-eth1-start[250]: adding address 2001:db8:1::1/64... done84machine # [2380432.160871] machine systemd[1]: Finished Address configuration of eth1.85machine # [2380432.225598] machine systemd[1]: Finished Extra networking commands..86machine # [2380432.225766] machine systemd[1]: Reached target Network.87machine # [2380432.227172] machine systemd[1]: Starting Roaming-friendly transport for herdr --remote...88machine # [2380432.229011] machine systemd[1]: Starting Nginx Web Server...89machine # [2380432.358811] machine systemd[1]: Started Name Service Cache Daemon (nsncd).90machine # [2380432.358905] machine systemd[1]: Reached target Host and Network Name Lookups.91machine # [2380432.358970] machine systemd[1]: Reached target User and Group Name Lookups.92machine # [2380432.361361] machine systemd[1]: Starting User Login Management...93machine # [2380432.362829] machine systemd[1]: Starting Permit User Sessions...94machine # [2380432.401930] machine nsncd[245]: Oct 24 13:36:25.563 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"95machine # [2380432.437946] machine systemd[1]: Finished Permit User Sessions.96machine # [2380432.440206] machine systemd[1]: Started Console Getty.97machine # [2380432.440258] machine systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty098machine # [2380432.440277] machine systemd[1]: Reached target Login Prompts.99machine # [2380432.472684] machine sshd-keygen-start[196]: Generating public/private rsa key pair.100machine # [2380432.472684] machine sshd-keygen-start[196]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key101machine # [2380432.472684] machine sshd-keygen-start[196]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub102machine # [2380432.472684] machine sshd-keygen-start[196]: The key fingerprint is:103machine # [2380432.472684] machine sshd-keygen-start[196]: SHA256:+GLBs8AccSDdqgXZhO7GR9cpvfR4gLKizFA/Svk4sO8 root@machine104machine # [2380432.472684] machine sshd-keygen-start[196]: The key's randomart image is:105machine # [2380432.472684] machine sshd-keygen-start[196]: +---[RSA 4096]----+106machine # [2380432.472684] machine sshd-keygen-start[196]: | .*+o. |107machine # [2380432.472684] machine sshd-keygen-start[196]: | +.oo. |108machine # [2380432.472684] machine sshd-keygen-start[196]: | . ... + . |109machine # [2380432.472684] machine sshd-keygen-start[196]: | oo=o+.* |110machine # [2380432.472684] machine sshd-keygen-start[196]: | + *++=oS= |111machine # [2380432.472684] machine sshd-keygen-start[196]: |o O =. =o o |112machine # [2380432.472684] machine sshd-keygen-start[196]: |+* * .+ .. |113machine # [2380432.472684] machine sshd-keygen-start[196]: |oo+ .. . |114machine # [2380432.472684] machine sshd-keygen-start[196]: | oE. |115machine # [2380432.472684] machine sshd-keygen-start[196]: +----[SHA256]-----+116machine # [2380432.593934] machine sshd-keygen-start[353]: Generating public/private ed25519 key pair.117machine # [2380432.593934] machine sshd-keygen-start[353]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key118machine # [2380432.593934] machine sshd-keygen-start[353]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub119machine # [2380432.593934] machine sshd-keygen-start[353]: The key fingerprint is:120machine # [2380432.593934] machine sshd-keygen-start[353]: SHA256:/L3COet+TiPggxRZQPQ3rWvEjcDgXRl3davDM0jB+0Y root@machine121machine # [2380432.593934] machine sshd-keygen-start[353]: The key's randomart image is:122machine # [2380432.593934] machine sshd-keygen-start[353]: +--[ED25519 256]--+123machine # [2380432.593934] machine sshd-keygen-start[353]: | o=.. ++. ..o|124machine # [2380432.593934] machine sshd-keygen-start[353]: | . B ..+.. o|125machine # [2380432.593934] machine sshd-keygen-start[353]: | + = o.o . |126machine # [2380432.593934] machine sshd-keygen-start[353]: | o +.*oE. |127machine # [2380432.593934] machine sshd-keygen-start[353]: | . S =.+* |128machine # [2380432.593934] machine sshd-keygen-start[353]: | . o + o o+ |129machine # [2380432.593934] machine sshd-keygen-start[353]: | . o.=.= |130machine # [2380432.593934] machine sshd-keygen-start[353]: | o=o.o |131machine # [2380432.593934] machine sshd-keygen-start[353]: | o+*o |132machine # [2380432.593934] machine sshd-keygen-start[353]: +----[SHA256]-----+133machine # [2380432.595714] machine systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available134machine # [2380432.595764] machine systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available135machine # [2380432.595797] machine systemd[1]: sshd-keygen.service: Deactivated successfully.136machine # [2380432.596175] machine systemd[1]: Finished SSH Host Keys Generation.137machine # [2380433.440532] machine systemd-logind[331]: New seat seat0.138machine # [2380433.486232] machine systemd[1]: Starting D-Bus System Message Bus...139machine # [2380433.486588] machine systemd[1]: Started User Login Management.140machine # [2380433.487978] machine systemd[1]: Starting linger-users.service...141machine # [2380433.517354] machine systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available142machine # [2380433.517422] machine systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available143machine # [2380433.517473] machine systemd[1]: linger-users.service: Deactivated successfully.144machine # [2380433.517842] machine systemd[1]: Finished linger-users.service.145machine # [2380433.530153] machine nginx-pre-start[466]: nginx: the configuration file /nix/store/06qk2k7nb2avxys8qlc6lq6d7xn4whvy-nginx.conf syntax is ok146machine # [2380433.531128] machine nginx-pre-start[466]: nginx: configuration file /nix/store/06qk2k7nb2avxys8qlc6lq6d7xn4whvy-nginx.conf test is successful147machine # [2380433.544078] machine systemd[1]: Started Nginx Web Server.148machine # [2380434.060857] machine dbus-broker-launch[468]: Looking up NSS user entry for 'systemd-timesync'...149machine # [2380434.061991] machine dbus-broker-launch[468]: NSS returned no entry for 'systemd-timesync'150machine # [2380434.061991] machine dbus-broker-launch[468]: Invalid user-name in /nix/store/dkdl3ysxcyjyz95nrvri4fqfkq1a1bf7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"151machine # [2380434.064242] machine systemd[1]: Started D-Bus System Message Bus.152machine # [2380434.076813] machine dbus-broker-launch[468]: Ready153machine # [2380434.163484] machine herdr-eternal-server[308]: 2026-10-24T13:36:27.325000Z INFO herdr_eternal_server: listening addr=127.0.0.1:7433154machine # [2380434.177283] machine herdr-eternal-server[308]: 2026-10-24T13:36:27.338801Z INFO herdr_eternal_server: listening (quic) addr=[::]:7443155machine # [2380434.177591] machine systemd[1]: Started Roaming-friendly transport for herdr --remote.156machine # [2380434.178482] machine systemd[1]: Reached target Multi-User System.157machine # [2380434.178734] machine systemd[1]: Startup finished in 3.903s.158machine: (finished: waiting for unit herdr-eternal-server.service, in 5.89 seconds)159machine: waiting for unit nginx.service160machine: (finished: waiting for unit nginx.service, in 0.02 seconds)161machine: waiting for TCP port 80 on localhost162Connection to localhost (::1) 80 port [tcp/http] succeeded!163machine: (finished: waiting for TCP port 80 on localhost, in 1.04 seconds)164machine: must succeed: mkdir -p /root/.config/herdr-eternal165machine: (finished: must succeed: mkdir -p /root/.config/herdr-eternal, in 0.03 seconds)166machine: must succeed: printf '[targets.testbox]167url = "ws://localhost/herdr-eternal"168token = "test-token"169forward_agent = true170[targets.testbox-quic]171url = "ws://127.0.0.1:1"172quic_addr = "127.0.0.1:7443"173quic_ca = "/nix/store/wwkb599ch76d5bak48pcc5w830g0130l-herdr-eternal-test-cert/cert.pem"174token = "test-token"175' > /root/.config/herdr-eternal/config.toml176machine: (finished: must succeed: printf '[targets.testbox]177url = "ws://localhost/herdr-eternal"178token = "test-token"179forward_agent = true180[targets.testbox-quic]181url = "ws://127.0.0.1:1"182quic_addr = "127.0.0.1:7443"183quic_ca = "/nix/store/wwkb599ch76d5bak48pcc5w830g0130l-herdr-eternal-test-cert/cert.pem"184token = "test-token"185' > /root/.config/herdr-eternal/config.toml, in 0.01 seconds)186machine: 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/null187machine: (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 2.75 seconds)188machine: must fail: herdr-eternal-ssh -T testbox 'exit 3' < /dev/null189machine: (finished: must fail: herdr-eternal-ssh -T testbox 'exit 3' < /dev/null, in 1.30 seconds)190machine: must succeed: herdr-eternal-ssh -T testbox-quic 'echo over-quic' < /dev/null191machine: (finished: must succeed: herdr-eternal-ssh -T testbox-quic 'echo over-quic' < /dev/null, in 1.17 seconds)192machine: must succeed: cat > /root/restart-client.sh <<'EOF'193/nix/store/839jdly8sf9gd4140vg2sz2a4kipxmc3-herdr-eternal-0.1.0/bin/herdr-eternal-ssh -T testbox 'echo before; sleep 5; echo after; exit 5' </dev/null > /root/restart-out194echo rc=$? >> /root/restart-out195EOF196machine: (finished: must succeed: cat > /root/restart-client.sh <<'EOF'197/nix/store/839jdly8sf9gd4140vg2sz2a4kipxmc3-herdr-eternal-0.1.0/bin/herdr-eternal-ssh -T testbox 'echo before; sleep 5; echo after; exit 5' </dev/null > /root/restart-out198echo rc=$? >> /root/restart-out199EOF, in 0.16 seconds)200machine: must succeed: systemd-run --unit=restart-client --setenv=HOME=/root sh /root/restart-client.sh201Running as unit: restart-client.service; invocation ID: 0feefce9a20142d9bee4febcca58ca4d202machine: (finished: must succeed: systemd-run --unit=restart-client --setenv=HOME=/root sh /root/restart-client.sh, in 0.15 seconds)203??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.204 File "/nix/store/dvn429min4lc9fa0vqsj6vniisy18z5d-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39205machine: waiting for success: grep -q before /root/restart-out206??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.207 File "/nix/store/dvn429min4lc9fa0vqsj6vniisy18z5d-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39208grep: /root/restart-out: No such file or directory209machine # [2380441.298602] machine systemd[1]: Started [systemd-run] /run/current-system/sw/bin/sh /root/restart-client.sh.210machine: (finished: waiting for success: grep -q before /root/restart-out, in 3.07 seconds)211machine: must succeed: systemctl show -p MainPID --value herdr-eternal-server212machine: (finished: must succeed: systemctl show -p MainPID --value herdr-eternal-server, in 0.02 seconds)213machine: must succeed: systemctl restart herdr-eternal-server214machine # [2380444.469902] machine systemd[1]: Stopping Roaming-friendly transport for herdr --remote...215machine # [2380444.473128] machine herdr-eternal-server[308]: 2026-10-24T13:36:37.634629Z INFO herdr_eternal_server: handed sessions over to the fd store fds=3216machine # [2380444.486495] machine systemd[1]: herdr-eternal-server.service: Deactivated successfully.217machine # [2380444.486660] machine systemd[1]: herdr-eternal-server.service: Unit process 1537 (sh) remains running after unit stopped.218machine # [2380444.486719] machine systemd[1]: herdr-eternal-server.service: Unit process 1538 (zsh) remains running after unit stopped.219machine # [2380444.486768] machine systemd[1]: herdr-eternal-server.service: Unit process 1539 (sleep) remains running after unit stopped.220machine # [2380444.487414] machine systemd[1]: Stopped Roaming-friendly transport for herdr --remote.221machine # [2380444.487488] machine systemd[1]: herdr-eternal-server.service: Consumed 4.832s CPU time over 12.259s wall clock time.222machine # [2380444.508358] machine systemd[1]: herdr-eternal-server.service: Found left-over process 1537 (sh) in control group while starting unit. Ignoring.223machine # [2380444.508366] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.224machine # [2380444.508419] machine systemd[1]: herdr-eternal-server.service: Found left-over process 1538 (zsh) in control group while starting unit. Ignoring.225machine # [2380444.508422] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.226machine # [2380444.508466] machine systemd[1]: herdr-eternal-server.service: Found left-over process 1539 (sleep) in control group while starting unit. Ignoring.227machine # [2380444.508471] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.228machine # [2380444.510690] machine systemd[1]: Starting Roaming-friendly transport for herdr --remote...229machine: (finished: must succeed: systemctl restart herdr-eternal-server, in 1.70 seconds)230machine: must succeed: systemctl show -p MainPID --value herdr-eternal-server231machine: (finished: must succeed: systemctl show -p MainPID --value herdr-eternal-server, in 0.16 seconds)232machine: waiting for success: grep -q rc= /root/restart-out233machine # [2380446.096975] machine herdr-eternal-server[1544]: 2026-10-24T13:36:39.258037Z INFO herdr_eternal_server: listening addr=127.0.0.1:7433234machine # [2380446.099555] machine herdr-eternal-server[1544]: 2026-10-24T13:36:39.260584Z INFO herdr_eternal_server: listening (quic) addr=[::]:7443235machine # [2380446.100705] machine herdr-eternal-server[1544]: 2026-10-24T13:36:39.262271Z INFO herdr_eternal_server: restored handed-over session token=308-1792848996948512382-3236machine # [2380446.101246] machine systemd[1]: Started Roaming-friendly transport for herdr --remote.237machine # [2380448.828404] machine systemd[1]: restart-client.service: Failed to read pids.max for control group /system.slice/restart-client.service, ignoring: No data available238machine # [2380448.828464] machine systemd[1]: restart-client.service: Failed to read pids.max for control group /system.slice/restart-client.service, ignoring: No data available239machine # [2380448.828498] machine systemd[1]: restart-client.service: Deactivated successfully.240machine # [2380448.829093] machine systemd[1]: restart-client.service: Consumed 4.706s CPU time over 7.529s wall clock time.241machine: (finished: waiting for success: grep -q rc= /root/restart-out, in 3.33 seconds)242machine: must succeed: cat /root/restart-out243machine: (finished: must succeed: cat /root/restart-out, in 0.02 seconds)244machine: must succeed: journalctl -u herdr-eternal-server | grep -q 'restored handed-over session'245machine: (finished: must succeed: journalctl -u herdr-eternal-server | grep -q 'restored handed-over session', in 0.03 seconds)246machine: must succeed: ssh-keygen -t ed25519 -N "" -f /root/agent-key247machine: (finished: must succeed: ssh-keygen -t ed25519 -N "" -f /root/agent-key, in 0.13 seconds)248machine: must succeed: install -d -m 700 -o alice -g users /home/alice/.ssh249machine: (finished: must succeed: install -d -m 700 -o alice -g users /home/alice/.ssh, in 0.02 seconds)250machine: must succeed: install -m 600 -o alice -g users /root/agent-key.pub /home/alice/.ssh/authorized_keys251machine: (finished: must succeed: install -m 600 -o alice -g users /root/agent-key.pub /home/alice/.ssh/authorized_keys, in 0.11 seconds)252machine: must succeed: rm /root/agent-key.pub253machine: (finished: must succeed: rm /root/agent-key.pub, in 0.06 seconds)254machine: 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/null255Identity added: /root/agent-key (root@machine)256machine # [2380451.340917] machine systemd[1]: Created slice Slice /system/sshd.257machine # [2380451.341001] machine systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.258machine # [2380451.343494] machine systemd[1]: Started SSH per-connection Daemon ([::1]:44952).259Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.260machine: (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 1.76 seconds)261(finished: run the VM test script, in 22.94 seconds)262test script finished in 23.01s263cleanup264kill NspawnMachine (pid 49)265(finished: cleanup, in 0.22 seconds)266additionally exposed symbols:267 machine,268 vlan1,269 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_ssh270Container machine terminated by signal KILL.