Run Test: slices-bi-singlenode-login 2026-06-05 17:25:53.524492 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpb_fblnvl.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-05 17:25:57.800009 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/e953c93d-4074-4e7d-871b-17a9cf36ece6/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-05 17:26:05.746062 CEST - Run: slices --version 2026-06-05 17:26:05.960673 CEST - version: Slices CLI v2026.1.2 Slices CLI core v1.2.4 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib ai v1.0.0 Slices clientlib core v5.5.1 2026-06-05 17:26:05.960987 CEST - Run: slices pubkey list --format text 2026-06-05 17:26:06.526355 CEST - Pubkey already registered 2026-06-05 17:26:06.526643 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-05 17:26:07.142214 CEST - Refreshed infrastructure list. Total: 23 entries. 2026-06-05 17:26:07.142339 CEST - Check List Flavors 2026-06-05 17:26:07.142529 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-06-05 17:26:08.409996 CEST - Check List DiskImages 2026-06-05 17:26:08.410295 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-06-05 17:26:09.226450 CEST - Requesting resources 2026-06-05 17:26:09.226815 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-05 17:26:09.226942 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-5173749d --user-data /tmp/tmpot85634m 2026-06-05 17:26:15.459553 CEST - Resource ID: r_gr-volos-bi-vm1_01ktc68qmmfq180twcs07nhfch 2026-06-05 17:26:15.459716 CEST - Waiting until resource ready 2026-06-05 17:26:17.460193 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-5173749d tst 2026-06-05 17:26:18.379043 CEST - Status: IMAGING 2026-06-05 17:26:21.295968 CEST - Status: IMAGING 2026-06-05 17:26:24.213159 CEST - Status: IMAGING 2026-06-05 17:26:27.130424 CEST - Status: BOOTING 2026-06-05 17:26:30.097952 CEST - Status: BOOTING 2026-06-05 17:26:33.065101 CEST - Status: BOOTING 2026-06-05 17:26:36.032735 CEST - Status: BOOTING 2026-06-05 17:26:38.950709 CEST - Status: BOOTING 2026-06-05 17:26:41.867682 CEST - Status: BOOTING 2026-06-05 17:26:44.785259 CEST - Status: BOOTING 2026-06-05 17:26:47.702113 CEST - Status: BOOTING 2026-06-05 17:26:50.619407 CEST - Status: BOOTING 2026-06-05 17:26:53.536453 CEST - Status: BOOTING 2026-06-05 17:26:56.453195 CEST - Status: BOOTING 2026-06-05 17:26:59.370132 CEST - Status: BOOTING 2026-06-05 17:27:02.287188 CEST - Status: BOOTING 2026-06-05 17:27:05.204158 CEST - Status: BOOTING 2026-06-05 17:27:08.121119 CEST - Status: BOOTING 2026-06-05 17:27:11.038152 CEST - Status: BOOTING 2026-06-05 17:27:13.955227 CEST - Status: BOOTING 2026-06-05 17:27:16.872274 CEST - Status: BOOTING 2026-06-05 17:27:19.789373 CEST - Status: BOOTING 2026-06-05 17:27:22.656013 CEST - Status: BOOTING 2026-06-05 17:27:25.572881 CEST - Status: BOOTING 2026-06-05 17:27:28.490215 CEST - Status: BOOTING 2026-06-05 17:27:31.457426 CEST - Status: BOOTING 2026-06-05 17:27:34.374280 CEST - Status: BOOTING 2026-06-05 17:27:37.291122 CEST - Status: BOOTING 2026-06-05 17:27:40.258312 CEST - Status: BOOTING 2026-06-05 17:27:43.175362 CEST - Status: BOOTING 2026-06-05 17:27:46.092323 CEST - Status: BOOTING 2026-06-05 17:27:48.959257 CEST - Status: BOOTING 2026-06-05 17:27:51.826019 CEST - Status: BOOTING 2026-06-05 17:27:54.692884 CEST - Status: BOOTING 2026-06-05 17:27:57.609756 CEST - Status: BOOTING 2026-06-05 17:28:00.577140 CEST - Status: BOOTING 2026-06-05 17:28:03.494244 CEST - Status: BOOTING 2026-06-05 17:28:06.411379 CEST - Status: BOOTING 2026-06-05 17:28:09.278155 CEST - Status: BOOTING 2026-06-05 17:28:12.144735 CEST - Status: BOOTING 2026-06-05 17:28:15.061641 CEST - Status: UP 2026-06-05 17:28:15.061729 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01ktc68jt8er3vw6b9bts89d2f 2026-06-05 17:28:15.061774 CEST - Validate resources 2026-06-05 17:28:15.928608 CEST - The fields of the created resource were validated. 2026-06-05 17:28:15.928692 CEST - Check if resources are registered in experiment 2026-06-05 17:28:15.928943 CEST - Run: slices experiment list-resources --format json tst-5173749d 2026-06-05 17:28:16.594755 CEST - Status (on expauth): UP 2026-06-05 17:28:16.594921 CEST - Testing extend expires_at (all resources in experiment) 2026-06-05 17:28:16.595064 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-5173749d 2026-06-05 17:28:19.015269 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-5173749d tst 2026-06-05 17:28:19.931810 CEST - Run: slices experiment list-resources --format json tst-5173749d 2026-06-05 17:28:20.547313 CEST - expires_at (on expauth): 2026-06-05T18:28:00Z (correctly extended) 2026-06-05 17:28:20.547392 CEST - Testing extend expires_at (single resource in experiment) 2026-06-05 17:28:20.547567 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-5173749d 2026-06-05 17:28:22.917241 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-5173749d tst 2026-06-05 17:28:23.834047 CEST - Run: slices experiment list-resources --format json tst-5173749d 2026-06-05 17:28:24.499799 CEST - expires_at (on expauth): 2026-06-05T19:28:00Z (correctly extended) 2026-06-05 17:28:24.499916 CEST - Testing ssh login 2026-06-05 17:28:24.511154 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-5173749d tst 2026-06-05 17:28:25.527994 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-5173749d tst 2026-06-05 17:28:26.544920 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-5173749d tst 2026-06-05 17:28:27.561716 CEST - Logging in using 'slices bi ssh' 2026-06-05 17:28:27.561806 CEST - Forcing IPv4 only. 2026-06-05 17:28:27.561978 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-5173749d tst -- -4 uname -a 2026-06-05 17:28:31.887482 CEST - Forcing IPv4 only. 2026-06-05 17:28:31.887674 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-5173749d tst -- -4 uptime 2026-06-05 17:28:34.408418 CEST - CLI SSH Test passed. 2026-06-05 17:28:34.408480 CEST - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-05 17:28:34.408493 CEST - Uptime: 15:28:34 up 1 min, 2 users, load average: 0.98, 0.58, 0.23 2026-06-05 17:28:34.408542 CEST - Logging in using SSH over SSH proxy 2026-06-05 17:28:34.408748 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-5173749d tst 2026-06-05 17:28:35.425997 CEST - Added paramiko HostKeyEntry for 10.64.45.108 2026-06-05 17:28:35.426125 CEST - Added paramiko HostKeyEntry for 10.64.45.108 2026-06-05 17:28:35.426277 CEST - Added paramiko HostKeyEntry for 10.64.45.108 2026-06-05 17:28:35.426555 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-05 17:28:35.426640 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-05 17:28:35.426678 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-06-05 17:28:35.426690 CEST - Connecting to proxy 194.177.207.42:11122 2026-06-05 17:28:36.173515 CEST - Connecting to 10.64.45.108:22 over proxy 2026-06-05 17:28:37.574597 CEST - SSH Test output: 2026-06-05 17:28:37.574656 CEST - Uname: Linux tst 6.8.0-85-generic #85-Ubuntu SMP PREEMPT_DYNAMIC Thu Sep 18 15:26:59 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-06-05 17:28:37.574670 CEST - Uptime: 15:28:37 up 2 min, 1 user, load average: 0.90, 0.57, 0.23 2026-06-05 17:28:37.879457 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-05 17:28:37.879535 CEST - lsb_release matches expected value 2026-06-05 17:28:37.879550 CEST - SSH Test passed. 2026-06-05 17:28:38.182901 CEST - Cloud-init user-data: Hello World. The time is now Fri, 05 Jun 2026 15:28:11 +0000! 2026-06-05 17:28:38.189987 CEST - Destroying tst-5173749d tst 2026-06-05 17:28:38.190215 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-5173749d tst