[stdout] Docker app's state test === RUN TestAppStatus apps: '[eclient]' state: 'RUNNING' secs: 1200 time: 2023-10-30T19:12:43.38620299Z out: appName eclient state changed to UNKNOWN time: 2023-10-30T19:12:47.037852241Z out: appName eclient state changed to INITIAL time: 2023-10-30T19:12:48.038865401Z out: appName eclient state changed to RESOLVING_TAG time: 2023-10-30T19:12:55.044536374Z out: appName eclient state changed to DOWNLOAD_STARTED time: 2023-10-30T19:13:03.052232157Z out: appName eclient state changed to DOWNLOAD_STARTED (0%) time: 2023-10-30T19:13:05.054106907Z out: appName eclient state changed to DOWNLOAD_STARTED (100%) time: 2023-10-30T19:13:10.059184505Z out: appName eclient state changed to DOWNLOAD_STARTED (0%) time: 2023-10-30T19:13:22.069664495Z out: appName eclient state changed to DOWNLOAD_STARTED (5%) time: 2023-10-30T19:13:24.071675905Z out: appName eclient state changed to DOWNLOAD_STARTED (10%) time: 2023-10-30T19:13:27.074824848Z out: appName eclient state changed to DOWNLOAD_STARTED (15%) time: 2023-10-30T19:13:30.078128654Z out: appName eclient state changed to DOWNLOAD_STARTED (17%) time: 2023-10-30T19:13:33.081546182Z out: appName eclient state changed to DOWNLOAD_STARTED (22%) time: 2023-10-30T19:13:35.083494636Z out: appName eclient state changed to DOWNLOAD_STARTED (50%) time: 2023-10-30T19:13:37.085454091Z out: appName eclient state changed to DOWNLOAD_STARTED (58%) time: 2023-10-30T19:13:37.085503209Z out: appName eclient state changed to DOWNLOAD_STARTED (65%) time: 2023-10-30T19:13:38.086390886Z out: appName eclient state changed to DOWNLOAD_STARTED (71%) time: 2023-10-30T19:13:39.087036376Z out: appName eclient state changed to DOWNLOAD_STARTED (75%) time: 2023-10-30T19:13:40.088207035Z out: appName eclient state changed to DOWNLOAD_STARTED (81%) time: 2023-10-30T19:13:41.088754041Z out: appName eclient state changed to DOWNLOAD_STARTED (85%) time: 2023-10-30T19:13:41.088787111Z out: appName eclient state changed to DOWNLOAD_STARTED (87%) time: 2023-10-30T19:13:42.08996038Z out: appName eclient state changed to DOWNLOAD_STARTED (89%) time: 2023-10-30T19:13:49.097472432Z out: appName eclient state changed to DOWNLOAD_STARTED (95%) time: 2023-10-30T19:13:51.098940176Z out: appName eclient state changed to LOADING time: 2023-10-30T19:14:06.112477353Z out: appName eclient state changed to DELIVERED time: 2023-10-30T19:14:08.113356942Z out: appName eclient state changed to CREATING_VOLUME time: 2023-10-30T19:15:22.164126243Z out: appName eclient state changed to INSTALLED time: 2023-10-30T19:20:46.426563068Z out: appName eclient state changed to UNKNOWN time: 2023-10-30T19:20:48.428484728Z out: appName eclient state changed to INITIAL time: 2023-10-30T19:21:25.455319273Z out: appName eclient state changed to INSTALLED time: 2023-10-30T19:21:41.465475027Z out: appName eclient state changed to INSTALLED: [description:"setting up OCI spec for domain eb7a34e4-ee67-458a-ac31-03891b904763.1.1 failed unexpected end of JSON input" timestamp:{seconds:1698693701 nanos:28610336} severity:SEVERITY_ERROR] app_test.go:171: ASSERTION FAILED (2023-10-30T19:32:43.386768165Z): expected apps [eclient] in RUNNING state app_test.go:173: actual eclient: INSTALLED: [description:"setting up OCI spec for domain eb7a34e4-ee67-458a-ac31-03891b904763.1.1 failed unexpected end of JSON input" timestamp:{seconds:1698693701 nanos:28610336} severity:SEVERITY_ERROR] app_test.go:175: history of states for eclient: app_test.go:177: state: no info from controller received in: 2023-10-30T19:12:43.381327018Z app_test.go:177: state: UNKNOWN received in: 2023-10-30T19:12:43.386200715Z app_test.go:177: state: INITIAL received in: 2023-10-30T19:12:47.037847943Z app_test.go:177: state: RESOLVING_TAG received in: 2023-10-30T19:12:48.038861794Z app_test.go:177: state: DOWNLOAD_STARTED received in: 2023-10-30T19:12:55.044533168Z app_test.go:177: state: DOWNLOAD_STARTED (0%) received in: 2023-10-30T19:13:03.052230995Z app_test.go:177: state:

Process completed with exit code 1.

[stdout] Log/Info/Metric Test === RUN TestInfo lim_test.go:273: time: 2023-10-30T20:26:25.068267475Z out: Wait for info of 50292a06-d03a-49d1-9b30-ba8a38337548 number=1 timewait=30m0s testContext.go:302: WaitForProc terminated by timeout 30m0s testContext.go:285: WaitForProcWithErrorCallback terminated by timeout 30m0s --- FAIL: TestInfo (1800.00s) FAIL [exit status 1] FAIL: ../update_eve_image/testdata/update_eve_image_oci.txt:43: command failure

Process completed with exit code 1.

[stdout] VNC access to app Test === RUN TestVNCVMStart vnc_test.go:245: Add app to list config changed, to see config run 'eden controller edge-node get-config' vnc_test.go:251: Add processing of app running messages vnc_test.go:101: state: INITIAL received in: 2023-10-30T20:53:07.889301902Z vnc_test.go:101: state: DOWNLOAD_STARTED received in: 2023-10-30T20:53:07.889363718Z vnc_test.go:101: state: LOADING received in: 2023-10-30T20:57:30.084549705Z vnc_test.go:101: state: DELIVERED received in: 2023-10-30T21:00:29.194960644Z vnc_test.go:101: state: CREATING_VOLUME received in: 2023-10-30T21:00:29.195015886Z vnc_test.go:101: state: INSTALLED received in: 2023-10-30T21:02:54.279847215Z --- app vnc-app logs --- ------ testContext.go:285: WaitForProcWithErrorCallback terminated by timeout 15m0s --- FAIL: TestVNCVMStart (901.04s) FAIL [stderr] time="2023-10-30T20:53:02Z" level=info msg="Starting download of image from https://cloud-images.ubuntu.com/releases/groovy/release-20210108/ubuntu-20.10-server-cloudimg-amd64.img" [exit status 1] FAIL: ../vnc/testdata/vnc_test.txt:7: command failure

Process completed with exit code 1.

[stdout] /home/runner/actions-runner/_work/eve/eve/eden/dist/bin/eden sdn fwd eth0 8028 -- ssh -q -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/actions-runner/_work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT grep -q Ubuntu /etc/issue # Inject fake location information (1.619s) > exec -t 1m bash inject-fake-location.sh 57.928721 -5.197889 120.542 1650531954000 [stderr] Warning: Permanently added '[127.0.0.1]:2222' (ED25519) to the list of known hosts. # Local profile server should obtain the location information > exec -t 1m bash wait-for-location-lps.sh '"2022-04-21T09:05:54Z"' [stderr] cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.json': No such file or directory parse error: Invalid literal at line 1, column 6 cat: can't open '/mnt/location.j

Process completed with exit code 1.

[stdout] Docker app's state test === RUN TestAppStatus apps: '[t1 t2]' state: 'RUNNING' secs: 600 time: 2023-10-30T21:27:59.83956301Z out: appName t1 state changed to UNKNOWN time: 2023-10-30T21:27:59.839570774Z out: appName t2 state changed to UNKNOWN time: 2023-10-30T21:28:13.368859466Z out: appName t1 state changed to RESOLVING_TAG time: 2023-10-30T21:28:15.370636898Z out: appName t2 state changed to INITIAL time: 2023-10-30T21:28:18.372299719Z out: appName t1 state changed to DOWNLOAD_STARTED time: 2023-10-30T21:28:19.373119339Z out: appName t2 state changed to DOWNLOAD_STARTED time: 2023-10-30T21:28:20.373455796Z out: appName t1 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-30T21:28:20.373465445Z out: appName t2 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-30T21:28:28.377625137Z out: appName t2 state changed to DOWNLOAD_STARTED (100%) time: 2023-10-30T21:28:56.394078177Z out: appName t1 state changed to DOWNLOAD_STARTED (100%) time: 2023-10-30T21:29:07.399515134Z out: appName t1 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-30T21:29:14.403534272Z out: appName t2 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-30T21:29:18.405832466Z out: appName t2 state changed to DOWNLOAD_STARTED (1%) time: 2023-10-30T21:29:20.406620032Z out: appName t1 state changed to DOWNLOAD_STARTED (1%) time: 2023-10-30T21:29:22.407327028Z out: appName t2 state changed to DOWNLOAD_STARTED (2%) time: 2023-10-30T21:29:22.407358105Z out: appName t1 state changed to DOWNLOAD_STARTED (2%) time: 2023-10-30T21:29:27.41154091Z out: appName t2 state changed to DOWNLOAD_STARTED (3%) time: 2023-10-30T21:29:29.412496248Z out: appName t1 state changed to DOWNLOAD_STARTED (3%) time: 2023-10-30T21:29:32.413927883Z out: appName t2 state changed to DOWNLOAD_STARTED (4%) time: 2023-10-30T21:29:34.415662026Z out: appName t1 state changed to DOWNLOAD_STARTED (4%) time: 2023-10-30T21:29:37.418220813Z out: appName t2 state changed to DOWNLOAD_STARTED (5%) time: 2023-10-30T21:29:41.421728195Z out: appName t1 state changed to DOWNLOAD_STARTED (6%) time: 2023-10-30T21:29:43.423155098Z out: appName t2 state changed to DOWNLOAD_STARTED (6%) time: 2023-10-30T21:29:44.423755755Z out: appName t2 state changed to DOWNLOAD_STARTED (7%) time: 2023-10-30T21:29:46.425750103Z out: appName t1 state changed to DOWNLOAD_STARTED (7%) time: 2023-10-30T21:29:47.425961645Z out: appName t2 state changed to DOWNLOAD_STARTED (8%) time: 2023-10-30T21:29:49.427206556Z out: appName t1 state changed to DOWNLOAD_STARTED (8%) time: 2023-10-30T21:29:50.427757943Z out: appName t2 state changed to DOWNLOAD_STARTED (45%) time: 2023-10-30T21:29:52.429051178Z out: appName t1 state changed to DOWNLOAD_STARTED (45%) time: 2023-10-30T21:29:53.429534287Z out: appName t2 state changed to DOWNLOAD_STARTED (80%) time: 2023-10-30T21:29:56.431707162Z out: appName t1 state changed to DOWNLOAD_STARTED (80%) time: 2023-10-30T21:29:58.43329558Z out: appName t2 state changed to DOWNLOAD_STARTED (81%) time: 2023-10-30T21:30:00.434803576Z out: appName t1 state changed to DOWNLOAD_STARTED (81%) time: 2023-10-30T21:30:01.435667557Z out: appName t1 state changed to DOWNLOAD_STARTED (82%) time: 2023-10-30T21:30:03.437210191Z out: appName t2 state changed to DOWNLOAD_STARTED (82%) time: 2023-10-30T21:30:07.440209764Z out: appName t2 state changed to DOWNLOAD_STARTED (83%) time: 2023-10-30T21:30:07.4402453Z out: appName t1 state changed to DOWNLOAD_STARTED (83%) time: 2023-10-30T21:30:07.440254286Z out: appName t2 state changed to DOWNLOAD_STARTED (84%) time: 2023-10-30T21:30:09.441992598Z out: appName t1 state changed to DOWNLOAD_STARTED (84%) time: 2023-10-30T21:30:11.44379691Z out: appName t2 state changed to DOWNLOAD_STARTED (86%) time: 2023-10-30T21:30:12.444768133Z out: appName t1 state changed to DOWNLOAD_STARTED (86%) time: 2023-10-30T21:30:13.445463996Z out: appName t2 state changed to DOWNLOAD_STARTED (100%) time: 2023-10-30T21:31:31.492809674Z out: appName t2 state changed to LOADING time: 2023-10-30T21:31:32.493741025Z out: appName t1 sta

Process completed with exit code 1.

[stdout] time="2023-10-30T21:32:36Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:32:50Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:33:03Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:33:17Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:33:31Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:33:45Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:33:59Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:34:12Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:34:26Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:34:40Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:34:54Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:35:08Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:35:21Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:35:35Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:35:49Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:36:03Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:36:16Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:36:30Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:36:44Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:36:58Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:37:12Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:37:25Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:37:39Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:37:53Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:38:07Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:38:20Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:38:34Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:38:48Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:39:02Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:39:15Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:39:29Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:39:43Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:39:57Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:40:10Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:40:24Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:40:38Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:40:52Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:41:05Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:41:19Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:41:33Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:41:47Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:42:01Z" level=fatal msg="command ssh failed: exit status 1" time="2023-10-30T21:42:14Z" level=fatal msg="command ssh failed: exit status 1" [stderr] ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server on '10.11.12.3' (115) ERROR 2002 (HY000): Can't connect to server