[stdout] /home/runner/actions-runner/_work/eden/eden/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -i /home/runner/actions-runner/_work/eden/eden/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT grep -q "after_restart" /etc/injected_file.txt Try 1 time="2024-11-13T12:08:09Z" level=fatal msg="command ssh failed: exit status 255" Try 2 time="2024-11-13T12:08:21Z" level=fatal msg="command ssh failed: exit status 255" Try 3 time="2024-11-13T12:08:33Z" level=fatal msg="command ssh failed: exit status 255" Try 4 time="2024-11-13T12:08:45Z" level=fatal msg="command ssh failed: exit status 255" Try 5 [stderr] kex_exchange_identification: read: Connection reset by peer Connection reset by 127.0.0.1 port 2223 Connection timed out during banner exchange Connection to 127.0.0.1 port 2223 timed out Connection timed out during banner exchange Connection to 127.0.0.1 port 2223 timed out Connection timed out during banner exchange Connection to 127.0.0.1 port 2223 timed out [context deadline exceeded] FAIL: ../eclient/testdata/userdata.txt:48: command failure

Process completed with exit code 1.

[stdout] Reboot Test === RUN TestReboot reboot_test.go:162: time: 2024-11-13T12:03:33.040291482Z out: Wait for state of 0a55d89f-fd0f-4c9b-adba-4ab87053143a testContext.go:369: done waiting for State reboot_test.go:166: time: 2024-11-13T12:03:33.040741774Z out: timewait: 2562047h47m16.854775807s reboot_test.go:167: time: 2024-11-13T12:03:33.040747403Z out: reboot: false reboot_test.go:168: time: 2024-11-13T12:03:33.04075081Z out: count: 1 reboot_test.go:172: time: 2024-11-13T12:03:33.040758014Z out: LastRebootTime: 2024-11-13 11:56:25.275593075 +0000 UTC reboot_test.go:174: time: 2024-11-13T12:03:33.040762141Z out: LastRebootReason: Reboot reason - system reset, reboot or kernel panic due to watchdog or kernel bug (no kdump) - at 2024-11-13T11:56:25.275593075Z rebooted with reason Reboot reason - system reset, reboot or kernel panic due to watchdog or kernel bug (no kdump) - at 2024-11-13T12:11:31.64871107Z at 2024-11-13 12:11:31.64871107 +0000 UTC/n testProc.go:84: time: 2024-11-13T12:12:23.420490179Z out: testcontext.ProcInfoFunc done with return: abnormal reboot: Reboot reason - system reset, reboot or kernel panic due to watchdog or kernel bug (no kdump) - at 2024-11-13T12:11:31.64871107Z testContext.go:260: done for device 0a55d89f-fd0f-4c9b-adba-4ab87053143a reboot_test.go:186: time: 2024-11-13T12:12:23.420553418Z out: Number of reboots: 0 --- PASS: TestReboot (530.38s) PASS [stderr] time="2024-11-13T12:12:23Z" level=info msg="time: 2024-11-13T12:12:23.420490179Z out: testcontext.ProcInfoFunc done with return: abnormal reboot: Reboot reason - system reset, reboot or kernel panic due to watchdog or kernel bug (no kdump) - at 2024-11-13T12:11:31.64871107Z" FAIL: ../eclient/testdata/userdata.txt:33: unexpected command success

[stdout] Docker app's state test === RUN TestAppStatus apps: '[eclient]' state: '-' secs: 600 time: 2024-11-13T12:07:04.669836597Z out: appName eclient state changed to RUNNING testProc.go:84: time: 2024-11-13T12:12:23.087294299Z out: testcontext.ProcInfoFunc done with return: time: 2024-11-13T12:12:23.087287987Z out: no app with eclient found testContext.go:260: done for device 0a55d89f-fd0f-4c9b-adba-4ab87053143a [stderr] time="2024-11-13T12:12:23Z" level=info msg="time: 2024-11-13T12:12:23.087294299Z out: testcontext.ProcInfoFunc done with return: \ntime: 2024-11-13T12:12:23.087287987Z out: no app with eclient found\n" [context canceled] FAIL: ../eclient/testdata/userdata.txt:33: test interrupted while running command

Process completed with exit code 1.

[stdout] time: 2024-11-13T12:14:06.950905216Z out: VCOM Test started configName: default configFile: /home/runner/.eden/contexts/default.yml time="2024-11-13T12:14:06Z" level=debug msg="Will use config from /home/runner/.eden/contexts/default.yml" time="2024-11-13T12:14:06Z" level=debug msg="Try to add config from /tmp/go-test-script750963738/script-eden_vcom/eden-config.yml" --- FAIL: TestVcomLinkTpmRequestEK (0.62s) vcom_test.go:41: time: 2024-11-13T12:14:06.980394507Z out: TestvComLinkTpmRequestEK started vcom_test.go:41: time: 2024-11-13T12:14:06.980411498Z out: Checking if vComLink is running on EVE... vcom_test.go:41: time: 2024-11-13T12:14:07.596872373Z out: vComLink agent is running vcom_test.go:41: time: 2024-11-13T12:14:07.596897409Z out: Checking if vComLink is reachable from a VM, deploying ubuntu-22.04-server-cloudimg-amd64... vcom_test.go:41: time: 2024-11-13T12:14:07.596923196Z out: TestvComLinkTpmRequestEK finished [stderr] Warning: Permanently added '[127.0.0.1]:2222' (ED25519) to the list of known hosts. panic: runtime error: invalid memory address or nil pointer dereference [recovered] panic: runtime error: invalid memory address or nil pointer dereference [signal SIGSEGV: segmentation violation code=0x1 addr=0x28 pc=0xdc0a17] goroutine 70 [running]: testing.tRunner.func1.2({0xecde40, 0x19b54b0}) /opt/hostedtoolcache/go/1.22.3/x64/src/testing/testing.go:1631 +0x24a testing.tRunner.func1() /opt/hostedtoolcache/go/1.22.3/x64/src/testing/testing.go:1634 +0x377 panic({0xecde40?, 0x19b54b0?}) /opt/hostedtoolcache/go/1.22.3/x64/src/runtime/panic.go:770 +0x132 command-line-arguments.TestVcomLinkTpmRequestEK.WithSSH.func2(0xc000771aa8?, {0xc000046060?, 0xc800000?}) /home/runner/actions-runner/_work/eden/eden/eden/pkg/evetestkit/utils.go:451 +0x57 github.com/lf-edge/eden/pkg/evetestkit.(*EveNode).EveDeployApp(_, {_, _}, _, {{0xc000046060, 0x17}, {0x10a8ea7, 0x4e}, {0x106b5df, 0x6}, ...}, ...) /home/runner/actions-runner/_work/eden/eden/eden/pkg/evetestkit/utils.go:501 +0xc4 command-line-arguments.TestVcomLinkTpmRequestEK(0xc0002cf1e0) /home/runner/actions-runner/_work/eden/eden/eden/tests/vcom/vcom_test.go:125 +0x51a testing.tRunner(0xc0002cf1e0, 0x10d26b8) /opt/hostedtoolcache/go/1.22.3/x64/src/testing/testing.go:1689 +0xfb created by testing.(*T).Run in goroutine 1 /opt/hostedtoolcache/go/1.22.3/x64/src/testing/testing.go:1742 +0x390 [exit status 2] FAIL: testdata/eden_vcom.txt:1: command failure

Process completed with exit code 1.

[stdout] === RUN TestEdenScripts === RUN TestEdenScripts/revert_eve_image_update === PAUSE TestEdenScripts/revert_eve_image_update === CONT TestEdenScripts/revert_eve_image_update > eden controller edge-node update --config timer.test.baseimage.update=30 edenProg: /home/runner/actions-runner/_work/eden/eden/eden/dist/bin/eden timewait: 0s > message 'EVE image download' > eden -t 10m utils download eve-rootfs --eve-tag=13.3.0 --eve-hv=kvm --downloader-dist=/home/runner/actions-runner/_work/eden/eden/eden/dist/default-eve -v debug edenProg: /home/runner/actions-runner/_work/eden/eden/eden/dist/bin/eden timewait: 10m0s > stdout '/home/runner/actions-runner/_work/eden/eden/eden/dist/default-eve/rootfs-13.3.0-kvm-amd64.squashfs' > message 'EVE update request' > eden -t 10m controller edge-node eveimage-update file:///home/runner/actions-runner/_work/eden/eden/eden/dist/default-eve/rootfs-13.3.0-kvm-amd64.squashfs edenProg: /home/runner/actions-runner/_work/eden/eden/eden/dist/bin/eden timewait: 10m0s > ! stderr . > message 'Waiting for EVE starting testing...' > test eden.lim.test -test.v -timewait 30m -test.run TestInfo -out InfoContent.dinfo.SwList[0].ShortVersion 'InfoContent.dinfo.SwList[0].PartitionState:inprogress' testProg: /home/runner/actions-runner/_work/eden/eden/eden/dist/bin/eden.lim.test timewait: 0s ::error file=tests/update_eve_image/testdata/revert_eve_image_update.txt,line=35::[stdout] Log/Info/Metric Test === RUN TestInfo lim_test.go:273: time: 2024-11-13T12:02:43.422775357Z out: Wait for info of 240b745e-d454-4fe4-888e-f8bcd4d4b01e number=1 timewait=30m0s testContext.go:291: WaitForProc terminated by timeout 30m0s testContext.go:274: WaitForProcWithErrorCallback terminated by timeout 30m0s --- FAIL: TestInfo (1800.00s) FAIL [exit status 1] FAIL: /home/runner/actions-runner/_work/eden/eden/eden/dist/tests/update_eve_image/testdata/revert_eve_image_update.txt:35: command failure testscript.go:418: WORK=$WORK PATH=/home/runner/go/bin:/opt/hostedtoolcache/go/1.22.3/x64/bin:/snap/bin:/home/runner/.local/bin:/opt/pipx_bin:/home/runner/.cargo/bin:/home/runner/.config/composer/vendor/bin:/usr/local/.ghcup/bin:/home/runner/.dotnet/tools:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin DOCKER_HOST= TMPDIR=$WORK/tmp devnull=/dev/null /=/ :=: EDEN_CONFIG=default HOME=/no-home exe= # Obtain eve.tag from config # Obtain eve.hv from config # Obtain eve.arch from config # Combine variables into $short_version # Use eden.lim.test for access Infos with timewait 30m # Decrease update testing time (0.023s) > eden controller edge-node update --config timer.test.baseimage.update=30 # Download EVE rootfs into eve-dist (1.204s) > message 'EVE image download' message: EVE image download > eden -t 10m utils download eve-rootfs --eve-tag=13.3.0 --eve-hv=kvm --downloader-dist=/home/runner/actions-runner/_work/eden/eden/eden/dist/default-eve -v debug [stdout] configName: default configFile: /home/runner/.eden/contexts/default.yml time="2024-11-13T12:02:40Z" level=debug msg="Try ImagePull with (lfedge/eve:13.3.0-kvm-amd64)" time="2024-11-13T12:02:40Z" level=debug msg="Try to get version of rootfs" time="2024-11-13T12:02:40Z" level=debug msg="Try to call 'docker run lfedge/eve:13.3.0-kvm-amd64 -f raw version' with volumes map[]" time="2024-11-13T12:02:40Z" level=debug msg="image version: 13.3.0-kvm-amd64" time="2024-11-13T12:02:40Z" level=debug msg="provided version: 13.3.0-kvm-amd64" time="2024-11-13T12:02:40Z" level=debug msg="Try to call 'docker run lfedge/eve:13.3.0-kvm-amd64 -f raw rootfs' with volumes map[/out:/home/runner/actions-runner/_work/eden/eden/eden/dist/default-eve]" time="2024-11-13T12:02:41Z" level=debug msg="245+1 records in\r\n245+1 records out\r\n257822720 bytes (258 MB, 246 MiB)

[stdout] Log/Info/Metric Test === RUN TestInfo lim_test.go:273: time: 2024-11-13T12:02:43.422775357Z out: Wait for info of 240b745e-d454-4fe4-888e-f8bcd4d4b01e number=1 timewait=30m0s testContext.go:291: WaitForProc terminated by timeout 30m0s testContext.go:274: WaitForProcWithErrorCallback terminated by timeout 30m0s --- FAIL: TestInfo (1800.00s) FAIL [exit status 1] FAIL: /home/runner/actions-runner/_work/eden/eden/eden/dist/tests/update_eve_image/testdata/revert_eve_image_update.txt:35: command failure

Process completed with exit code 1.

Process completed with exit code 1.

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/

The following actions use a deprecated Node.js version and will be forced to run on node20: actions/setup-go@v3, actions/upload-artifact@v3. For more info: https://github.blog/changelog/2024-03-07-github-actions-all-actions-will-run-on-node20-instead-of-node16-by-default/