Process completed with exit code 1.

Process completed with exit code 1.

Process completed with exit code 1.

[stdout] Log/Info/Metric Test === RUN TestLog lim_test.go:162: time: 2025-05-22T16:31:20.746824641Z out: Wait for log of e720af7a-5668-465b-b19f-d6eaac2f4c3d number=1 timewait=10m0s testContext.go:291: WaitForProc terminated by timeout 10m0s testContext.go:274: WaitForProcWithErrorCallback terminated by timeout 10m0s --- FAIL: TestLog (600.00s) FAIL [exit status 1] FAIL: ../lim/testdata/log_test.txt:16: command failure

Process completed with exit code 1.

[stdout] Log/Info/Metric Test === RUN TestLog lim_test.go:162: time: 2025-05-22T16:32:06.96176564Z out: Wait for log of e07efdf2-67e3-4f80-9d31-f4596a51a406 number=1 timewait=10m0s testContext.go:291: WaitForProc terminated by timeout 10m0s testContext.go:274: WaitForProcWithErrorCallback terminated by timeout 10m0s --- FAIL: TestLog (600.00s) FAIL [exit status 1] FAIL: ../lim/testdata/log_test.txt:16: command failure

Process completed with exit code 1.

[stdout] Docker app's state test === RUN TestAppStatus apps: '[eclient-mount]' state: 'RUNNING' secs: 900 time: 2025-05-22T16:44:31.43692529Z out: appName eclient-mount state changed to DELIVERED: [description:"Remaining disk space 344123845 volume needs 1127219200\n\n\n" timestamp:{seconds:1747932252 nanos:157503705} severity:SEVERITY_ERROR entities:{entity:ENTITY_VOLUME entity_id:"989304fd-165f-4153-9d6f-1a09762ff7b8"} retry_condition:"Will retry when more space will be available"] time: 2025-05-22T16:44:40.50336895Z out: appName eclient-mount state changed to CREATING_VOLUME time: 2025-05-22T16:44:55.513870331Z out: appName eclient-mount state changed to INSTALLED [context canceled] FAIL: ../volume/testdata/volumes_test.txt:60: test interrupted while running command

[stdout] Reboot Test === RUN TestReboot reboot_test.go:162: time: 2025-05-22T16:30:32.540376761Z out: Wait for state of 271848b8-4221-4b2d-b946-b1d88015702b testContext.go:369: done waiting for State reboot_test.go:166: time: 2025-05-22T16:30:32.540410544Z out: timewait: 2562047h47m16.854775807s reboot_test.go:167: time: 2025-05-22T16:30:32.540419942Z out: reboot: false reboot_test.go:168: time: 2025-05-22T16:30:32.540427807Z out: count: 1 reboot_test.go:172: time: 2025-05-22T16:30:32.540438156Z out: LastRebootTime: 2025-05-22 16:28:28.224219289 +0000 UTC reboot_test.go:174: time: 2025-05-22T16:30:32.540446481Z out: LastRebootReason: NORMAL: First boot of device - at 2025-05-22T16:28:28.224219289Z rebooted with reason Reboot reason - system reset, reboot or kernel panic due to watchdog or kernel bug (no kdump) - at 2025-05-22T16:51:13.265873802Z at 2025-05-22 16:51:13.265873802 +0000 UTC/n testProc.go:84: time: 2025-05-22T16:52:45.622330147Z 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 2025-05-22T16:51:13.265873802Z testContext.go:260: done for device 271848b8-4221-4b2d-b946-b1d88015702b reboot_test.go:186: time: 2025-05-22T16:52:45.622403845Z out: Number of reboots: 0 --- PASS: TestReboot (1333.08s) PASS [stderr] time="2025-05-22T16:52:45Z" level=info msg="time: 2025-05-22T16:52:45.622330147Z 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 2025-05-22T16:51:13.265873802Z" FAIL: ../volume/testdata/volumes_test.txt:60: unexpected command success

Process completed with exit code 1.

[stdout] 1) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:49:57Z" level=fatal msg="command ssh failed: exit status 255" 2) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:50:27Z" level=fatal msg="command ssh failed: exit status 255" 3) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:50:57Z" level=fatal msg="command ssh failed: exit status 255" 4) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:51:27Z" level=fatal msg="command ssh failed: exit status 255" 5) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:51:57Z" level=fatal msg="command ssh failed: exit status 255" 6) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:52:27Z" level=fatal msg="command ssh failed: exit status 255" 7) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:52:57Z" level=fatal msg="command ssh failed: exit status 255" 8) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:53:27Z" level=fatal msg="command ssh failed: exit status 255" 9) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 2223 -- ssh -o ConnectTimeout=10 -o StrictHostKeyChecking=no -o PasswordAuthentication=no -i /home/runner/work/eve/eve/eden/dist/tests/eclient/image/cert/id_rsa root@FWD_IP -p FWD_PORT curl --header "Content-Type: application/json" --request POST -d '{"hello":"world"}' 169.254.169.254/eve/v1/kubeconfig time="2025-05-22T16:53:57Z" level=fatal msg="command ssh failed: exit status 255" 10) /home/runner/work/eve/eve/eden/dist/bin/eden sdn fwd eth0 22

Process completed with exit code 1.

[stdout] Docker app's state test === RUN TestAppStatus apps: '[app1]' state: 'RUNNING' secs: 600 time: 2025-05-22T17:02:40.109627445Z out: appName app1 state changed to UNKNOWN time: 2025-05-22T17:02:52.955274352Z out: appName app1 state changed to INITIAL time: 2025-05-22T17:02:58.958886383Z out: appName app1 state changed to DOWNLOAD_STARTED time: 2025-05-22T17:03:07.965751909Z out: appName app1 state changed to DOWNLOAD_STARTED (0%) time: 2025-05-22T17:03:39.995631493Z out: appName app1 state changed to DOWNLOAD_STARTED (100%) time: 2025-05-22T17:04:05.018504014Z out: appName app1 state changed to DOWNLOAD_STARTED (0%) time: 2025-05-22T17:04:17.028776648Z out: appName app1 state changed to DOWNLOAD_STARTED (5%) time: 2025-05-22T17:04:33.041372475Z out: appName app1 state changed to DOWNLOAD_STARTED (10%) time: 2025-05-22T17:04:36.044404445Z out: appName app1 state changed to DOWNLOAD_STARTED (11%) time: 2025-05-22T17:04:41.049110592Z out: appName app1 state changed to DOWNLOAD_STARTED (12%) time: 2025-05-22T17:04:46.052737673Z out: appName app1 state changed to DOWNLOAD_STARTED (13%) time: 2025-05-22T17:04:52.057151287Z out: appName app1 state changed to DOWNLOAD_STARTED (14%) time: 2025-05-22T17:04:58.061986582Z out: appName app1 state changed to DOWNLOAD_STARTED (16%) time: 2025-05-22T17:05:00.063190256Z out: appName app1 state changed to DOWNLOAD_STARTED (46%) time: 2025-05-22T17:05:04.066954543Z out: appName app1 state changed to DOWNLOAD_STARTED (48%) time: 2025-05-22T17:05:12.073289239Z out: appName app1 state changed to DOWNLOAD_STARTED (49%) time: 2025-05-22T17:05:18.07837643Z out: appName app1 state changed to DOWNLOAD_STARTED (58%) time: 2025-05-22T17:05:21.081319417Z out: appName app1 state changed to DOWNLOAD_STARTED (67%) time: 2025-05-22T17:05:23.083211089Z out: appName app1 state changed to DOWNLOAD_STARTED (68%) time: 2025-05-22T17:05:26.085635063Z out: appName app1 state changed to DOWNLOAD_STARTED (69%) time: 2025-05-22T17:05:31.089598534Z out: appName app1 state changed to DOWNLOAD_STARTED (70%) time: 2025-05-22T17:05:34.092233336Z out: appName app1 state changed to DOWNLOAD_STARTED (72%) time: 2025-05-22T17:05:36.094225238Z out: appName app1 state changed to DOWNLOAD_STARTED (83%) time: 2025-05-22T17:05:38.09610963Z out: appName app1 state changed to DOWNLOAD_STARTED (84%) time: 2025-05-22T17:05:41.099602865Z out: appName app1 state changed to DOWNLOAD_STARTED (85%) time: 2025-05-22T17:05:43.101207089Z out: appName app1 state changed to DOWNLOAD_STARTED (86%) time: 2025-05-22T17:05:46.104392352Z out: appName app1 state changed to DOWNLOAD_STARTED (87%) time: 2025-05-22T17:05:49.107610045Z out: appName app1 state changed to DOWNLOAD_STARTED (88%) time: 2025-05-22T17:05:52.110127962Z out: appName app1 state changed to DOWNLOAD_STARTED (89%) time: 2025-05-22T17:05:54.112228288Z out: appName app1 state changed to DOWNLOAD_STARTED (95%) time: 2025-05-22T17:05:55.113470906Z out: appName app1 state changed to DOWNLOAD_STARTED (97%) time: 2025-05-22T17:05:56.114621818Z out: appName app1 state changed to DOWNLOAD_STARTED (98%) time: 2025-05-22T17:06:01.118413048Z out: appName app1 state changed to DOWNLOAD_STARTED (99%) time: 2025-05-22T17:06:07.122430521Z out: appName app1 state changed to DOWNLOAD_STARTED time: 2025-05-22T17:06:07.122461108Z out: appName app1 state changed to DOWNLOAD_STARTED (100%) time: 2025-05-22T17:06:10.124883382Z out: appName app1 state changed to LOADING time: 2025-05-22T17:07:34.191701158Z out: appName app1 state changed to DELIVERED time: 2025-05-22T17:07:39.19503712Z out: appName app1 state changed to CREATING_VOLUME time: 2025-05-22T17:12:39.401362363Z out: appName app1 state changed to INSTALLED app_test.go:178: ASSERTION FAILED (2025-05-22T17:12:40.110414066Z): expected apps [app1] in RUNNING state app_test.go:180: actual app1: INSTALLED app_test.go:182: history of states for app1: app_test.go:184: state: no info from controller received in: 2025-05-22T17:02:40.089838074Z app_test.go:184: state: UNKNOWN receiv

Process completed with exit code 1.

[stdout] Docker app's state test === RUN TestAppStatus apps: '[eclient1 eclient2]' state: 'RUNNING' secs: 1200 time: 2025-05-22T17:20:48.450042129Z out: appName eclient1 state changed to UNKNOWN time: 2025-05-22T17:20:48.450046006Z out: appName eclient2 state changed to UNKNOWN time: 2025-05-22T17:20:49.211084594Z out: appName eclient2 state changed to RUNNING time: 2025-05-22T17:21:12.226714488Z out: appName eclient1 state changed to HALTING time: 2025-05-22T17:21:20.232475014Z out: appName eclient1 state changed to HALTED time: 2025-05-22T17:22:26.282620151Z out: appName eclient2 state changed to HALTING time: 2025-05-22T17:22:36.290951307Z out: appName eclient2 state changed to HALTED time: 2025-05-22T17:27:45.537547448Z out: appName eclient2 state changed to UNKNOWN time: 2025-05-22T17:27:45.537556805Z out: appName eclient1 state changed to UNKNOWN time: 2025-05-22T17:28:04.609077151Z out: appName eclient1 state changed to INITIAL time: 2025-05-22T17:28:05.610307671Z out: appName eclient2 state changed to INITIAL time: 2025-05-22T17:30:43.749591575Z out: appName eclient2 state changed to INSTALLED time: 2025-05-22T17:37:48.134391163Z out: appName eclient1 state changed to UNKNOWN time: 2025-05-22T17:37:48.134409407Z out: appName eclient2 state changed to UNKNOWN time: 2025-05-22T17:38:04.147532535Z out: appName eclient1 state changed to INITIAL time: 2025-05-22T17:38:07.150890331Z out: appName eclient2 state changed to INITIAL time: 2025-05-22T17:39:49.245266998Z out: appName eclient2 state changed to INSTALLED time: 2025-05-22T17:40:20.272893058Z out: appName eclient2 state changed to BOOTING time: 2025-05-22T17:40:23.276185237Z out: appName eclient2 state changed to RUNNING time: 2025-05-22T17:40:26.279409987Z out: appName eclient1 state changed to INSTALLED app_test.go:178: ASSERTION FAILED (2025-05-22T17:40:48.450984435Z): expected apps [eclient1 eclient2] in RUNNING state app_test.go:180: actual eclient1: INSTALLED app_test.go:182: history of states for eclient1: app_test.go:184: state: no info from controller received in: 2025-05-22T17:20:48.450038813Z app_test.go:184: state: UNKNOWN received in: 2025-05-22T17:20:48.450041037Z app_test.go:184: state: HALTING received in: 2025-05-22T17:21:12.226706904Z app_test.go:184: state: HALTED received in: 2025-05-22T17:21:20.232470676Z app_test.go:184: state: UNKNOWN received in: 2025-05-22T17:27:45.537555463Z app_test.go:184: state: INITIAL received in: 2025-05-22T17:28:04.609073284Z app_test.go:184: state: UNKNOWN received in: 2025-05-22T17:37:48.134387326Z app_test.go:184: state: INITIAL received in: 2025-05-22T17:38:04.147526073Z app_test.go:184: state: INSTALLED received in: 2025-05-22T17:40:26.279404256Z --- app eclient1 logs --- {"severity":"info","source":"9a0a2809-d0a8-4483-b39e-fbc70d3ac5fb.1.1","content":"Found user 'avahi' (UID 86) and group 'avahi' (GID 86).","msgid":"1","timestamp":"2025-05-22T17:18:21.050371967Z"} {"severity":"info","source":"9a0a2809-d0a8-4483-b39e-fbc70d3ac5fb.1.1","content":"Successfully dropped root privileges.","msgid":"2","timestamp":"2025-05-22T17:18:21.050438041Z"} {"severity":"info","source":"9a0a2809-d0a8-4483-b39e-fbc70d3ac5fb.1.1","content":"avahi-daemon 0.8 starting up.","msgid":"3","timestamp":"2025-05-22T17:18:21.050760153Z"} {"severity":"info","source":"9a0a2809-d0a8-4483-b39e-fbc70d3ac5fb.1.1","content":"WARNING: No NSS support for mDNS detected, consider installing nss-mdns!","msgid":"4","timestamp":"2025-05-22T17:18:21.050797764Z"} {"severity":"info","source":"9a0a2809-d0a8-4483-b39e-fbc70d3ac5fb.1.1","content":"Successfully called chroot().","msgid":"5","timestamp":"2025-05-22T17:18:21.050984553Z"} {"severity":"info","source":"9a0a2809-d0a8-4483-b39e-fbc70d3ac5fb.1.1","content":"Successfully dropped remaining capabilities.","msgid":"6","timestamp":"2025-05-22T17:18:21.050990504Z"} {"severity":"info","source":"9a0a2809-d0a8-4483-b39e-fbc70d3ac5fb.1.1","content":"Loading service file /services/http.service.","msgid":"7","timestamp":"2

Process completed with exit code 1.