[stdout] Reboot Test === RUN TestReboot reboot_test.go:162: time: 2023-10-11T17:11:34.353312704Z out: Wait for state of d06693f1-bf31-4891-88cd-8e1d9a1f2c30 testContext.go:380: done waiting for State reboot_test.go:166: time: 2023-10-11T17:11:34.353333784Z out: timewait: 2562047h47m16.854775807s reboot_test.go:167: time: 2023-10-11T17:11:34.353337802Z out: reboot: false reboot_test.go:168: time: 2023-10-11T17:11:34.353340978Z out: count: 1 reboot_test.go:172: time: 2023-10-11T17:11:34.353346178Z out: LastRebootTime: 2023-10-11 17:09:07.609750535 +0000 UTC reboot_test.go:174: time: 2023-10-11T17:11:34.353349614Z out: LastRebootReason: NORMAL: First boot of device - at 2023-10-11T17:09:07.609750535Z rebooted with reason Reboot reason - kernel crash (no kdump) - at 2023-10-11T17:20:06.563555387Z at 2023-10-11 17:20:06.563555387 +0000 UTC/n testProc.go:84: time: 2023-10-11T17:20:48.743316875Z out: projects.ProcInfoFunc done with return: abnormal reboot: Reboot reason - kernel crash (no kdump) - at 2023-10-11T17:20:06.563555387Z testContext.go:271: done for device d06693f1-bf31-4891-88cd-8e1d9a1f2c30 reboot_test.go:186: time: 2023-10-11T17:20:48.743378362Z out: Number of reboots: 0 --- PASS: TestReboot (554.39s) PASS [stderr] time="2023-10-11T17:20:48Z" level=info msg="time: 2023-10-11T17:20:48.743316875Z out: projects.ProcInfoFunc done with return: abnormal reboot: Reboot reason - kernel crash (no kdump) - at 2023-10-11T17:20:06.563555387Z" FAIL: ../eclient/testdata/acl.txt:43: unexpected command success

[stdout] Docker app's state test === RUN TestAppStatus apps: '[curl-acl1 curl-acl2]' state: 'RUNNING' secs: 900 time: 2023-10-11T17:12:16.186664072Z out: appName curl-acl2 state changed to UNKNOWN time: 2023-10-11T17:12:16.186676396Z out: appName curl-acl1 state changed to UNKNOWN time: 2023-10-11T17:12:21.531549384Z out: appName curl-acl1 state changed to INITIAL time: 2023-10-11T17:12:22.532033828Z out: appName curl-acl1 state changed to RESOLVING_TAG time: 2023-10-11T17:12:22.532055078Z out: appName curl-acl2 state changed to RESOLVING_TAG time: 2023-10-11T17:12:28.537196199Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED time: 2023-10-11T17:12:28.537218803Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED time: 2023-10-11T17:12:29.53841326Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-11T17:12:29.538442236Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-11T17:12:34.542939542Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (100%) time: 2023-10-11T17:12:39.546625177Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (100%) time: 2023-10-11T17:12:45.551411185Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-11T17:12:49.55474392Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (0%) time: 2023-10-11T17:12:52.55760034Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (1%) time: 2023-10-11T17:12:53.55834547Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (1%) time: 2023-10-11T17:12:56.56109725Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (3%) time: 2023-10-11T17:13:03.565594158Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (3%) time: 2023-10-11T17:13:06.567994975Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (7%) time: 2023-10-11T17:13:09.571309024Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (6%) time: 2023-10-11T17:13:10.572286419Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (14%) time: 2023-10-11T17:13:12.574404435Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (16%) time: 2023-10-11T17:13:13.575292429Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (53%) time: 2023-10-11T17:13:16.578919437Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (53%) time: 2023-10-11T17:13:18.579550459Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (71%) time: 2023-10-11T17:13:20.580526151Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (71%) time: 2023-10-11T17:13:22.58271415Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (93%) time: 2023-10-11T17:13:23.583297709Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (90%) time: 2023-10-11T17:13:23.583313989Z out: appName curl-acl1 state changed to DOWNLOAD_STARTED (98%) time: 2023-10-11T17:13:23.583321182Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (98%) time: 2023-10-11T17:13:27.586851828Z out: appName curl-acl2 state changed to DOWNLOAD_STARTED (100%) time: 2023-10-11T17:13:30.588999519Z out: appName curl-acl1 state changed to LOADING time: 2023-10-11T17:13:30.589026049Z out: appName curl-acl2 state changed to VERIFIED time: 2023-10-11T17:13:39.595664057Z out: appName curl-acl1 state changed to DELIVERED time: 2023-10-11T17:13:39.595683724Z out: appName curl-acl2 state changed to LOADING time: 2023-10-11T17:13:44.600524782Z out: appName curl-acl2 state changed to CREATING_VOLUME time: 2023-10-11T17:13:44.600544369Z out: appName curl-acl1 state changed to CREATING_VOLUME time: 2023-10-11T17:15:30.675774939Z out: appName curl-acl1 state changed to INSTALLED time: 2023-10-11T17:15:33.67881526Z out: appName curl-acl2 state changed to INSTALLED [context canceled] FAIL: ../eclient/testdata/acl.txt:43: test interrupted while running command

Process completed with exit code 1.

[stdout] Docker volume's state test === RUN TestVolStatus vol_test.go:136: time: 2023-10-11T17:16:08.331053629Z out: volumes: '[local-datastore-volume]' state: 'DELIVERED' secs: 1200 time: 2023-10-11T17:16:08.337184001Z out: volName local-datastore-volume state changed to UNKNOWN time: 2023-10-11T17:16:14.18994818Z out: volName local-datastore-volume state changed to INITIAL time: 2023-10-11T17:16:15.190744897Z out: volName local-datastore-volume state changed to DOWNLOAD_STARTED (0%) time: 2023-10-11T17:16:16.191408492Z out: volName local-datastore-volume state changed to DOWNLOAD_STARTED vol_test.go:164: ASSERTION FAILED (2023-10-11T17:36:08.337278753Z): expected volumes [local-datastore-volume] in DELIVERED state vol_test.go:166: actual local-datastore-volume: DOWNLOAD_STARTED vol_test.go:168: history of states for local-datastore-volume: vol_test.go:170: state: no info from controller received in: 2023-10-11T17:16:08.331067133Z vol_test.go:170: state: UNKNOWN received in: 2023-10-11T17:16:08.337182329Z vol_test.go:170: state: INITIAL received in: 2023-10-11T17:16:14.18994281Z vol_test.go:170: state: DOWNLOAD_STARTED (0%) received in: 2023-10-11T17:16:15.190739988Z vol_test.go:170: state: DOWNLOAD_STARTED received in: 2023-10-11T17:16:16.191405466Z testContext.go:285: WaitForProcWithErrorCallback terminated by timeout 20m0s --- FAIL: TestVolStatus (1201.01s) FAIL [exit status 1] FAIL: ../volume/testdata/local_datastore.txt:37: command failure

Process completed with exit code 1.

[stdout] Reboot Test === RUN TestReboot reboot_test.go:162: time: 2023-10-11T17:29:49.749102897Z out: Wait for state of 8ec4f828-f225-49cd-980f-f861ae7a5f36 testContext.go:380: done waiting for State reboot_test.go:166: time: 2023-10-11T17:29:49.749121883Z out: timewait: 20m0s reboot_test.go:167: time: 2023-10-11T17:29:49.749125419Z out: reboot: false reboot_test.go:168: time: 2023-10-11T17:29:49.749128766Z out: count: 2 reboot_test.go:172: time: 2023-10-11T17:29:49.749133064Z out: LastRebootTime: 2023-10-11 17:27:54.869389674 +0000 UTC reboot_test.go:174: time: 2023-10-11T17:29:49.74913647Z out: LastRebootReason: NORMAL: First boot of device - at 2023-10-11T17:27:54.869389674Z rebooted with reason Reboot reason - kernel crash (no kdump) - at 2023-10-11T17:40:14.382715687Z at 2023-10-11 17:40:14.382715687 +0000 UTC/n testProc.go:84: time: 2023-10-11T17:40:51.215430854Z out: projects.ProcInfoFunc done with return: abnormal reboot: Reboot reason - kernel crash (no kdump) - at 2023-10-11T17:40:14.382715687Z testContext.go:271: done for device 8ec4f828-f225-49cd-980f-f861ae7a5f36 reboot_test.go:186: time: 2023-10-11T17:40:51.215492871Z out: Number of reboots: 0 --- PASS: TestReboot (661.47s) PASS [stderr] time="2023-10-11T17:40:51Z" level=info msg="time: 2023-10-11T17:40:51.215430854Z out: projects.ProcInfoFunc done with return: abnormal reboot: Reboot reason - kernel crash (no kdump) - at 2023-10-11T17:40:14.382715687Z" FAIL: ../docker/testdata/2dockers_test.txt:13: unexpected command success

[stdout] Docker app deployment Test === RUN TestDockerStart docker_test.go:189: time: 2023-10-11T17:29:51.432098146Z out: Add app to list config changed, to see config run 'eden controller edge-node get-config' docker_test.go:195: time: 2023-10-11T17:29:52.437425832Z out: Add processing of app messages docker_test.go:199: time: 2023-10-11T17:29:52.4374462Z out: Add processing of app running messages docker_test.go:203: time: 2023-10-11T17:29:52.437452352Z out: Add function to obtain EVE IP docker_test.go:207: time: 2023-10-11T17:29:52.437457251Z out: Add trying to access app via http testProc.go:84: time: 2023-10-11T17:29:59.759801005Z out: projects.ProcTimerFunc done with return: external ip is: 127.0.0.1 testProc.go:84: time: 2023-10-11T17:30:01.803654627Z out: projects.ProcInfoFunc done with return: app found with name t1 [stderr] time="2023-10-11T17:29:59Z" level=info msg="time: 2023-10-11T17:29:59.759801005Z out: projects.ProcTimerFunc done with return: external ip is: 127.0.0.1" time="2023-10-11T17:30:01Z" level=info msg="time: 2023-10-11T17:30:01.803654627Z out: projects.ProcInfoFunc done with return: app found with name t1" [context canceled] FAIL: ../docker/testdata/2dockers_test.txt:13: test interrupted while running command

Process completed with exit code 1.

[stdout] Docker volume's state test === RUN TestVolStatus vol_test.go:136: time: 2023-10-11T17:35:58.490888479Z out: volumes: '[local-datastore-volume]' state: 'DELIVERED' secs: 1200 time: 2023-10-11T17:35:58.498572743Z out: volName local-datastore-volume state changed to UNKNOWN time: 2023-10-11T17:36:04.00898997Z out: volName local-datastore-volume state changed to INITIAL time: 2023-10-11T17:36:06.010259943Z out: volName local-datastore-volume state changed to DOWNLOAD_STARTED (0%) time: 2023-10-11T17:36:11.015617143Z out: volName local-datastore-volume state changed to DOWNLOAD_STARTED vol_test.go:164: ASSERTION FAILED (2023-10-11T17:55:58.49941786Z): expected volumes [local-datastore-volume] in DELIVERED state vol_test.go:166: actual local-datastore-volume: DOWNLOAD_STARTED vol_test.go:168: history of states for local-datastore-volume: vol_test.go:170: state: no info from controller received in: 2023-10-11T17:35:58.490900622Z vol_test.go:170: state: UNKNOWN received in: 2023-10-11T17:35:58.498571781Z vol_test.go:170: state: INITIAL received in: 2023-10-11T17:36:04.008986273Z vol_test.go:170: state: DOWNLOAD_STARTED (0%) received in: 2023-10-11T17:36:06.010259001Z vol_test.go:170: state: DOWNLOAD_STARTED received in: 2023-10-11T17:36:11.015614097Z testContext.go:285: WaitForProcWithErrorCallback terminated by timeout 20m0s --- FAIL: TestVolStatus (1201.01s) FAIL [exit status 1] FAIL: ../volume/testdata/local_datastore.txt:37: command failure