nixbot

builds

succeeded container-test-run-herdr-eternal-server checks.aarch64-linux.nixos · build #30 · raw

1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.65 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 # No journal files were found.18machine # No journal boot entry found for the specified boot (+0).19machine # No journal files were found.20machine # No journal boot entry found for the specified boot (+0).21machine # No journal files were found.22machine # No journal boot entry found for the specified boot (+0).23machine # No journal files were found.24machine # No journal boot entry found for the specified boot (+0).25machine # [2381739.624878] machine systemd-journald[58]: Journal started26machine # [2381739.624971] machine systemd-journald[58]: Runtime Journal (/run/log/journal/2c40f7df87ed40af9582924d0c540c8f) is 8M, max 4G, 3.9G free.27machine # [2381739.864765] machine systemd[1]: Finished Apply Kernel Variables.28machine # [2381739.878418] machine systemd[1]: Finished Create Static Device Nodes in /dev gracefully.29machine # [2381739.904861] machine systemd[1]: Starting Flush Journal to Persistent Storage...30machine # [2381739.905770] machine systemd[1]: Starting Create Static Device Nodes in /dev...31machine # [2381739.921798] machine systemd-journald[58]: Time spent on flushing to /var/log/journal/2c40f7df87ed40af9582924d0c540c8f is 10.529ms for 6 entries.32machine # [2381739.921798] machine systemd-journald[58]: System Journal (/var/log/journal/2c40f7df87ed40af9582924d0c540c8f) is 512B, max 4G, 3.9G free.33machine # [2381739.929853] machine systemd[1]: Finished Create Static Device Nodes in /dev.34machine # [2381739.930139] machine systemd[1]: Reached target Preparation for Local File Systems.35machine # [2381739.930251] machine systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys36machine # [2381739.965679] machine systemd[1]: Finished Flush Journal to Persistent Storage.37machine # [2381740.038330] machine systemd[1]: Finished Firewall.38machine # [2381740.617052] machine systemd[1]: Mounting /run/wrappers...39machine # [2381740.648421] machine systemd[1]: Mounted /run/wrappers.40machine # [2381740.649808] machine systemd[1]: Reached target Local File Systems.41machine # [2381740.650891] machine systemd[1]: Listening on Boot Loader Control Service Socket.42machine # [2381740.652699] machine systemd[1]: Starting Create SUID/SGID Wrappers...43machine # [2381740.652784] machine systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container44machine # [2381740.654331] machine systemd[1]: Starting Save Transient machine-id to Disk...45machine # [2381740.655574] machine systemd[1]: Starting Create System Files and Directories...46machine # [2381740.677579] machine systemd-tmpfiles[166]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted47machine # [2381740.678340] machine systemd-tmpfiles[166]: fchmod() of /var/log/journal failed: Operation not permitted48machine # [2381740.678550] machine systemd-tmpfiles[166]: fchmod() of /var/log/journal/2c40f7df87ed40af9582924d0c540c8f failed: Operation not permitted49machine # [2381740.678779] machine systemd-tmpfiles[166]: fchmod() of /run/log/journal failed: Operation not permitted50machine # [2381740.682262] machine systemd[1]: Finished Create System Files and Directories.51machine # [2381740.684551] machine suid-sgid-wrappers-start[173]: chmod: changing permissions of '/run/wrappers/wrappers.DCeUdL35FW/chsh': Operation not permitted52machine # [2381740.699400] machine systemd[1]: suid-sgid-wrappers.service: Main process exited, code=exited, status=1/FAILURE53machine # [2381740.699511] machine systemd[1]: suid-sgid-wrappers.service: Failed to read pids.max for control group /system.slice/suid-sgid-wrappers.service, ignoring: No data available54machine # [2381740.699551] machine systemd[1]: suid-sgid-wrappers.service: Failed to read pids.max for control group /system.slice/suid-sgid-wrappers.service, ignoring: No data available55machine # [2381740.699576] machine systemd[1]: suid-sgid-wrappers.service: Failed with result 'exit-code'.56machine # [2381740.700253] machine systemd[1]: Failed to start Create SUID/SGID Wrappers.57machine # [2381740.704165] machine systemd[1]: Starting Rebuild Journal Catalog...58machine # [2381740.705786] machine systemd[1]: Starting Record System Boot/Shutdown in UTMP...59machine # [2381740.722732] machine systemd[1]: Finished Record System Boot/Shutdown in UTMP.60machine # [2381740.731357] machine systemd[1]: Finished Rebuild Journal Catalog.61machine # [2381740.737148] machine systemd[1]: Starting Update is Completed...62machine # [2381740.754069] machine systemd[1]: Finished Update is Completed.63machine # [2381740.754234] machine systemd[1]: Reached target System Initialization.64machine # [2381740.754322] machine systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container65machine # [2381740.754402] machine systemd[1]: Started Daily Cleanup of Temporary Directories.66machine # [2381740.754420] machine systemd[1]: Reached target Timer Units.67machine # [2381740.754552] machine systemd[1]: Listening on D-Bus System Message Bus Socket.68machine # [2381740.754630] machine systemd[1]: Listening on herdr-eternal-server.socket.69machine # [2381740.754870] machine systemd[1]: Listening on Nix Daemon Socket.70machine # [2381740.755672] machine systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).71machine # [2381740.756284] machine systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).72machine # [2381740.756656] machine systemd[1]: Listening on SSH Socket.73machine # [2381740.756768] machine systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.74machine # [2381740.756785] machine systemd[1]: Reached target Socket Units.75machine # [2381740.756829] machine systemd[1]: Reached target Basic System.76machine # [2381740.758780] machine systemd[1]: Starting Import lastlog data into lastlog2 database...77machine # [2381740.760391] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...78machine # [2381740.761456] machine systemd[1]: Starting resolvconf update...79machine # [2381740.762887] machine systemd[1]: Starting SSH Host Keys Generation...80machine # [2381740.791230] machine systemd[1]: Finished Import lastlog data into lastlog2 database.81machine # [2381741.028392] machine systemd[1]: nscd.service: Failed to read pids.max for control group /system.slice/nscd.service, ignoring: No data available82machine # [2381741.028434] machine systemd[1]: nscd.service: Deactivated successfully.83machine # [2381741.028740] machine systemd[1]: Stopped Name Service Cache Daemon (nsncd).84machine # [2381741.036322] machine systemd[1]: Starting Name Service Cache Daemon (nsncd)...85machine # [2381741.240358] machine systemd[1]: Finished resolvconf update.86machine # [2381741.252572] machine sshd-keygen-start[195]: Generating public/private rsa key pair.87machine # [2381741.252572] machine sshd-keygen-start[195]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key88machine # [2381741.252572] machine sshd-keygen-start[195]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub89machine # [2381741.252572] machine sshd-keygen-start[195]: The key fingerprint is:90machine # [2381741.252572] machine sshd-keygen-start[195]: SHA256:arZqXLpqFptQCX4oDaLVl5Q3wJkVyXS/990Z7/jBoSM root@machine91machine # [2381741.252572] machine sshd-keygen-start[195]: The key's randomart image is:92machine # [2381741.252572] machine sshd-keygen-start[195]: +---[RSA 4096]----+93machine # [2381741.252572] machine sshd-keygen-start[195]: | . ooX+o. |94machine # [2381741.252572] machine sshd-keygen-start[195]: |+ . . B =. . |95machine # [2381741.252572] machine sshd-keygen-start[195]: |+=.. . . . . |96machine # [2381741.252572] machine sshd-keygen-start[195]: |oo+. . |97machine # [2381741.252572] machine sshd-keygen-start[195]: |... S . .o |98machine # [2381741.252572] machine sshd-keygen-start[195]: |. . .. .o.B|99machine # [2381741.252572] machine sshd-keygen-start[195]: | . = o+ E o +=|100machine # [2381741.252572] machine sshd-keygen-start[195]: | = +o . . .o.|101machine # [2381741.252572] machine sshd-keygen-start[195]: | o.ooo. ..o|102machine # [2381741.252572] machine sshd-keygen-start[195]: +----[SHA256]-----+103machine # [2381741.282568] machine systemd[1]: etc-machine\x2did.mount: Deactivated successfully.104machine # [2381741.282841] machine sshd-keygen-start[254]: Generating public/private ed25519 key pair.105machine # [2381741.282841] machine sshd-keygen-start[254]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key106machine # [2381741.282841] machine sshd-keygen-start[254]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub107machine # [2381741.282841] machine sshd-keygen-start[254]: The key fingerprint is:108machine # [2381741.282841] machine sshd-keygen-start[254]: SHA256:u64SBKJkuvQgQtdiL3G3SmucMSjk9liTM3m17etVEkc root@machine109machine # [2381741.282841] machine sshd-keygen-start[254]: The key's randomart image is:110machine # [2381741.282841] machine sshd-keygen-start[254]: +--[ED25519 256]--+111machine # [2381741.282841] machine sshd-keygen-start[254]: | . E |112machine # [2381741.282841] machine sshd-keygen-start[254]: |.=.= o o . |113machine # [2381741.282841] machine sshd-keygen-start[254]: |O.o.O o + . . |114machine # [2381741.282841] machine sshd-keygen-start[254]: |=* X.* o . o |115machine # [2381741.282841] machine sshd-keygen-start[254]: |=.B.O * S . . |116machine # [2381741.282841] machine sshd-keygen-start[254]: |.. o.* o o |117machine # [2381741.282841] machine sshd-keygen-start[254]: | .. . .. |118machine # [2381741.282841] machine sshd-keygen-start[254]: | . o. |119machine # [2381741.282841] machine sshd-keygen-start[254]: | ..o+. |120machine # [2381741.282841] machine sshd-keygen-start[254]: +----[SHA256]-----+121machine # [2381741.290003] machine systemd[1]: Finished Save Transient machine-id to Disk.122machine # [2381741.290182] machine systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available123machine # [2381741.290214] machine systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available124machine # [2381741.290232] machine systemd[1]: sshd-keygen.service: Deactivated successfully.125machine # [2381741.290423] machine systemd[1]: Finished SSH Host Keys Generation.126machine # [2381741.295083] machine systemd[1]: Reached target Preparation for Network.127machine # [2381741.298529] machine systemd[1]: Starting Address configuration of eth1...128machine # [2381741.300324] machine systemd[1]: Starting Extra networking commands....129machine # [2381741.406598] machine systemd[1]: Started Name Service Cache Daemon (nsncd).130machine # [2381741.406700] machine systemd[1]: Reached target Host and Network Name Lookups.131machine # [2381741.406779] machine systemd[1]: Reached target User and Group Name Lookups.132machine # [2381741.515331] machine nsncd[243]: Oct 24 13:58:14.676 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"133machine # [2381741.518378] machine systemd[1]: Starting User Login Management...134machine # [2381741.528949] machine network-addresses-eth1-start[257]: adding address 192.168.1.1/24... done135machine # [2381741.532162] machine network-addresses-eth1-start[257]: adding address 2001:db8:1::1/64... done136machine # [2381741.537383] machine systemd[1]: Finished Address configuration of eth1.137machine # [2381741.606256] machine systemd[1]: Finished Extra networking commands..138machine # [2381741.606440] machine systemd[1]: Reached target Network.139machine # [2381741.608192] machine systemd[1]: Starting Roaming-friendly transport for herdr --remote...140machine # [2381741.609757] machine systemd[1]: Starting Nginx Web Server...141machine # [2381741.611335] machine systemd[1]: Starting Permit User Sessions...142machine # [2381741.639252] machine systemd[1]: Finished Permit User Sessions.143machine # [2381741.642217] machine systemd[1]: Started Console Getty.144machine # [2381741.642264] machine systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0145machine # [2381741.642284] machine systemd[1]: Reached target Login Prompts.146machine # [2381742.704980] machine systemd-logind[270]: New seat seat0.147machine # [2381742.759224] machine systemd[1]: Starting D-Bus System Message Bus...148machine # [2381742.759577] machine systemd[1]: Started User Login Management.149machine # [2381742.761744] machine systemd[1]: Starting linger-users.service...150machine # [2381742.778606] machine systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available151machine # [2381742.778657] machine systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available152machine # [2381742.778692] machine systemd[1]: linger-users.service: Deactivated successfully.153machine # [2381742.779492] machine systemd[1]: Finished linger-users.service.154machine # [2381742.821968] machine nginx-pre-start[375]: nginx: the configuration file /nix/store/06qk2k7nb2avxys8qlc6lq6d7xn4whvy-nginx.conf syntax is ok155machine # [2381742.822625] machine nginx-pre-start[375]: nginx: configuration file /nix/store/06qk2k7nb2avxys8qlc6lq6d7xn4whvy-nginx.conf test is successful156machine # [2381742.832865] machine systemd[1]: Started Nginx Web Server.157machine # [2381743.157407] machine dbus-broker-launch[376]: Looking up NSS user entry for 'systemd-timesync'...158machine # [2381743.158717] machine dbus-broker-launch[376]: NSS returned no entry for 'systemd-timesync'159machine # [2381743.158717] machine dbus-broker-launch[376]: Invalid user-name in /nix/store/dr4dbcv7bdjx3rjamzgdfn2rg99bnkv9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"160machine # [2381743.160940] machine systemd[1]: Started D-Bus System Message Bus.161machine # [2381743.173250] machine dbus-broker-launch[376]: Ready162machine: still waiting for container 'machine' to reach ready state...163machine # [2381744.876827] machine herdr-eternal-server[332]: 2026-10-24T13:58:18.038063Z INFO herdr_eternal_server: listening addr=127.0.0.1:7433164machine # [2381744.881799] machine herdr-eternal-server[332]: 2026-10-24T13:58:18.042397Z INFO herdr_eternal_server: listening (quic) addr=[::]:7443165machine: (finished: waiting for unit herdr-eternal-server.service, in 10.81 seconds)166machine: waiting for unit nginx.service167machine: (finished: waiting for unit nginx.service, in 0.02 seconds)168machine: waiting for TCP port 80 on localhost169Connection to localhost (::1) 80 port [tcp/http] succeeded!170machine: (finished: waiting for TCP port 80 on localhost, in 0.06 seconds)171machine: must succeed: mkdir -p /root/.config/herdr-eternal172machine: (finished: must succeed: mkdir -p /root/.config/herdr-eternal, in 0.13 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/wwkb599ch76d5bak48pcc5w830g0130l-herdr-eternal-test-cert/cert.pem"181token = "test-token"182' > /root/.config/herdr-eternal/config.toml183machine # [2381744.881179] machine systemd[1]: Started Roaming-friendly transport for herdr --remote.184machine # [2381744.882003] machine systemd[1]: Reached target Multi-User System.185machine # [2381744.882273] machine systemd[1]: Startup finished in 6.030s.186machine: (finished: must succeed: printf '[targets.testbox]187url = "ws://localhost/herdr-eternal"188token = "test-token"189forward_agent = true190[targets.testbox-quic]191url = "ws://127.0.0.1:1"192quic_addr = "127.0.0.1:7443"193quic_ca = "/nix/store/wwkb599ch76d5bak48pcc5w830g0130l-herdr-eternal-test-cert/cert.pem"194token = "test-token"195' > /root/.config/herdr-eternal/config.toml, in 0.23 seconds)196machine: 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/null197machine: (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 3.02 seconds)198machine: must fail: herdr-eternal-ssh -T testbox 'exit 3' < /dev/null199machine: (finished: must fail: herdr-eternal-ssh -T testbox 'exit 3' < /dev/null, in 4.13 seconds)200machine: must succeed: herdr-eternal-ssh -T testbox-quic 'echo over-quic' < /dev/null201machine: (finished: must succeed: herdr-eternal-ssh -T testbox-quic 'echo over-quic' < /dev/null, in 2.27 seconds)202machine: must succeed: cat > /root/restart-client.sh <<'EOF'203/nix/store/dszk8f32d6ksdvxfqzki78544d0c288g-herdr-eternal-0.1.0/bin/herdr-eternal-ssh -T testbox 'echo before; sleep 5; echo after; exit 5' </dev/null > /root/restart-out204echo rc=$? >> /root/restart-out205EOF206machine: (finished: must succeed: cat > /root/restart-client.sh <<'EOF'207/nix/store/dszk8f32d6ksdvxfqzki78544d0c288g-herdr-eternal-0.1.0/bin/herdr-eternal-ssh -T testbox 'echo before; sleep 5; echo after; exit 5' </dev/null > /root/restart-out208echo rc=$? >> /root/restart-out209EOF, in 0.02 seconds)210machine: must succeed: systemd-run --unit=restart-client --setenv=HOME=/root sh /root/restart-client.sh211Running as unit: restart-client.service; invocation ID: 13512fa88a684a24a52245a4e37b2b8b212machine: (finished: must succeed: systemd-run --unit=restart-client --setenv=HOME=/root sh /root/restart-client.sh, in 0.31 seconds)213??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.214 File "/nix/store/dvn429min4lc9fa0vqsj6vniisy18z5d-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39215machine: waiting for success: grep -q before /root/restart-out216??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.217 File "/nix/store/dvn429min4lc9fa0vqsj6vniisy18z5d-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39218machine # [2381755.219049] machine systemd[1]: Started [systemd-run] /run/current-system/sw/bin/sh /root/restart-client.sh.219machine: (finished: waiting for success: grep -q before /root/restart-out, in 3.53 seconds)220machine: must succeed: systemctl show -p MainPID --value herdr-eternal-server221machine: (finished: must succeed: systemctl show -p MainPID --value herdr-eternal-server, in 0.02 seconds)222machine: must succeed: systemctl restart herdr-eternal-server223machine # [2381758.791046] machine systemd[1]: Stopping Roaming-friendly transport for herdr --remote...224machine # [2381758.791929] machine herdr-eternal-server[332]: 2026-10-24T13:58:31.953123Z INFO herdr_eternal_server: handed sessions over to the fd store fds=3225machine # [2381758.804620] machine systemd[1]: herdr-eternal-server.service: Deactivated successfully.226machine # [2381758.804757] machine systemd[1]: herdr-eternal-server.service: Unit process 1535 (sh) remains running after unit stopped.227machine # [2381758.804812] machine systemd[1]: herdr-eternal-server.service: Unit process 1536 (zsh) remains running after unit stopped.228machine # [2381758.804866] machine systemd[1]: herdr-eternal-server.service: Unit process 1537 (sleep) remains running after unit stopped.229machine # [2381758.805674] machine systemd[1]: Stopped Roaming-friendly transport for herdr --remote.230machine # [2381758.805750] machine systemd[1]: herdr-eternal-server.service: Consumed 14.137s CPU time over 17.196s wall clock time.231machine # [2381758.826819] machine systemd[1]: herdr-eternal-server.service: Found left-over process 1535 (sh) in control group while starting unit. Ignoring.232machine # [2381758.826826] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.233machine # [2381758.826877] machine systemd[1]: herdr-eternal-server.service: Found left-over process 1536 (zsh) in control group while starting unit. Ignoring.234machine # [2381758.826880] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.235machine # [2381758.826923] machine systemd[1]: herdr-eternal-server.service: Found left-over process 1537 (sleep) in control group while starting unit. Ignoring.236machine # [2381758.826927] machine systemd[1]: herdr-eternal-server.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies.237machine # [2381758.828551] machine systemd[1]: Starting Roaming-friendly transport for herdr --remote...238machine: (finished: must succeed: systemctl restart herdr-eternal-server, in 4.85 seconds)239machine: must succeed: systemctl show -p MainPID --value herdr-eternal-server240machine: (finished: must succeed: systemctl show -p MainPID --value herdr-eternal-server, in 0.02 seconds)241machine: waiting for success: grep -q rc= /root/restart-out242machine: (finished: waiting for success: grep -q rc= /root/restart-out, in 0.31 seconds)243machine: must succeed: cat /root/restart-out244machine: (finished: must succeed: cat /root/restart-out, in 0.01 seconds)245machine: must succeed: journalctl -u herdr-eternal-server | grep -q 'restored handed-over session'246machine # [2381763.618780] machine herdr-eternal-server[1542]: 2026-10-24T13:58:36.780298Z INFO herdr_eternal_server: listening addr=127.0.0.1:7433247machine # [2381763.621862] machine herdr-eternal-server[1542]: 2026-10-24T13:58:36.783412Z INFO herdr_eternal_server: listening (quic) addr=[::]:7443248machine # [2381763.622033] machine herdr-eternal-server[1542]: 2026-10-24T13:58:36.783604Z INFO herdr_eternal_server: restored handed-over session token=332-1792850311052015553-3249machine # [2381763.622328] machine systemd[1]: Started Roaming-friendly transport for herdr --remote.250machine # [2381763.640095] machine systemd[1]: restart-client.service: Failed to read pids.max for control group /system.slice/restart-client.service, ignoring: No data available251machine # [2381763.640135] machine systemd[1]: restart-client.service: Failed to read pids.max for control group /system.slice/restart-client.service, ignoring: No data available252machine # [2381763.640161] machine systemd[1]: restart-client.service: Deactivated successfully.253machine # [2381763.640536] machine systemd[1]: restart-client.service: Consumed 22.040s CPU time over 8.421s wall clock time.254machine: (finished: must succeed: journalctl -u herdr-eternal-server | grep -q 'restored handed-over session', in 0.56 seconds)255machine: must succeed: ssh-keygen -t ed25519 -N "" -f /root/agent-key256machine: (finished: must succeed: ssh-keygen -t ed25519 -N "" -f /root/agent-key, in 0.32 seconds)257machine: must succeed: install -d -m 700 -o alice -g users /home/alice/.ssh258machine: (finished: must succeed: install -d -m 700 -o alice -g users /home/alice/.ssh, in 0.35 seconds)259machine: must succeed: install -m 600 -o alice -g users /root/agent-key.pub /home/alice/.ssh/authorized_keys260machine: (finished: must succeed: install -m 600 -o alice -g users /root/agent-key.pub /home/alice/.ssh/authorized_keys, in 0.05 seconds)261machine: must succeed: rm /root/agent-key.pub262machine: (finished: must succeed: rm /root/agent-key.pub, in 0.29 seconds)263machine: 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/null264Identity added: /root/agent-key (root@machine)265Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.266machine # [2381768.918332] machine systemd[1]: Created slice Slice /system/sshd.267machine # [2381768.918422] machine systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.268machine # [2381768.921352] machine systemd[1]: Started SSH per-connection Daemon ([::1]:58826).269machine: (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 3.87 seconds)270(finished: run the VM test script, in 35.19 seconds)271test script finished in 35.43s272cleanup273kill NspawnMachine (pid 49)274machine # [2381769.380843] machine sshd-session[1950]: Accepted publickey for alice from ::1 port 58826 ssh2: ED25519 SHA256:qcnIqgF5c/62q+pBAEwXzBoTBuNyYRkYhdDZI+vnc6g275machine # [2381769.400780] machine sshd-session[1954]: Received disconnect from ::1 port 58826:11: disconnected by user276machine # [2381769.400906] machine sshd-session[1954]: Disconnected from user alice ::1 port 58826277machine # [2381769.402835] machine systemd[1]: sshd@0-188457-::1:22-::1:58826.service: Deactivated successfully.278machine # [2381769.405168] machine herdr-eternal-server[1542]: 2026-10-24T13:58:42.566377Z WARN herdr_eternal_server: connection failed: websocket error: WebSocket protocol error: Connection reset without closing handshake peer=127.0.0.1:40022279(finished: cleanup, in 0.52 seconds)280additionally exposed symbols:281 machine,282 vlan1,283 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