Run Test: slices-bi-singlenode-login 2026-04-18 00:02:59.317557 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-18 00:03:02.688688 CEST - Run: slices --version 2026-04-18 00:03:02.903023 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.0 Slices clientlib bi v5.1.2 2026-04-18 00:03:02.903299 CEST - Run: slices pubkey list --format text 2026-04-18 00:03:03.468210 CEST - Pubkey already registered 2026-04-18 00:03:03.468454 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-18 00:03:04.033505 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-18 00:03:04.033634 CEST - Check List Flavors 2026-04-18 00:03:04.033815 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-04-18 00:03:05.200157 CEST - Check List DiskImages 2026-04-18 00:03:05.200357 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-04-18 00:03:05.965850 CEST - Requesting resources 2026-04-18 00:03:05.966286 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-18 00:03:05.966379 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-316c70f1 --user-data /tmp/tmp04rn5kjq 2026-04-18 00:03:09.838346 CEST - Resource ID: r_gr-volos-bi-vm1_01kpeqg8xrerrvkeb147jtr61d 2026-04-18 00:03:09.838464 CEST - Waiting until resource ready 2026-04-18 00:03:11.838853 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-316c70f1 tst 2026-04-18 00:03:12.654485 CEST - Status: IMAGING 2026-04-18 00:03:15.520538 CEST - Status: IMAGING 2026-04-18 00:03:18.336501 CEST - Status: IMAGING 2026-04-18 00:03:21.152368 CEST - Status: BOOTING 2026-04-18 00:03:23.968241 CEST - Status: BOOTING 2026-04-18 00:03:26.784079 CEST - Status: BOOTING 2026-04-18 00:03:29.600021 CEST - Status: BOOTING 2026-04-18 00:03:32.466358 CEST - Status: BOOTING 2026-04-18 00:03:35.332493 CEST - Status: BOOTING 2026-04-18 00:03:38.148519 CEST - Status: BOOTING 2026-04-18 00:03:40.964629 CEST - Status: BOOTING 2026-04-18 00:03:43.881622 CEST - Status: BOOTING 2026-04-18 00:03:46.697615 CEST - Status: BOOTING 2026-04-18 00:03:49.513438 CEST - Status: BOOTING 2026-04-18 00:03:52.329516 CEST - Status: BOOTING 2026-04-18 00:03:55.145423 CEST - Status: BOOTING 2026-04-18 00:03:58.011411 CEST - Status: BOOTING 2026-04-18 00:04:00.927607 CEST - Status: BOOTING 2026-04-18 00:04:03.743494 CEST - Status: BOOTING 2026-04-18 00:04:06.609748 CEST - Status: BOOTING 2026-04-18 00:04:09.475635 CEST - Status: BOOTING 2026-04-18 00:04:12.291449 CEST - Status: BOOTING 2026-04-18 00:04:15.107367 CEST - Status: BOOTING 2026-04-18 00:04:17.923383 CEST - Status: BOOTING 2026-04-18 00:04:20.739266 CEST - Status: BOOTING 2026-04-18 00:04:23.555154 CEST - Status: BOOTING 2026-04-18 00:04:26.371035 CEST - Status: BOOTING 2026-04-18 00:04:29.237207 CEST - Status: BOOTING 2026-04-18 00:04:32.053000 CEST - Status: BOOTING 2026-04-18 00:04:34.869072 CEST - Status: BOOTING 2026-04-18 00:04:37.685059 CEST - Status: BOOTING 2026-04-18 00:04:40.501116 CEST - Status: BOOTING 2026-04-18 00:04:43.317035 CEST - Status: BOOTING 2026-04-18 00:04:46.132919 CEST - Status: BOOTING 2026-04-18 00:04:48.998999 CEST - Status: BOOTING 2026-04-18 00:04:51.815012 CEST - Status: BOOTING 2026-04-18 00:04:54.631170 CEST - Status: BOOTING 2026-04-18 00:04:57.448044 CEST - Status: BOOTING 2026-04-18 00:05:00.314162 CEST - Status: UP 2026-04-18 00:05:00.314241 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kpeqg68ne0vbe9debc7xy1pp 2026-04-18 00:05:00.314279 CEST - Validate resources 2026-04-18 00:05:01.180537 CEST - The fields of the created resource were validated. 2026-04-18 00:05:01.180642 CEST - Check if resources are registered in experiment 2026-04-18 00:05:01.180826 CEST - Run: slices experiment list-resources --format json tst-316c70f1 2026-04-18 00:05:01.846045 CEST - Status (on expauth): UP 2026-04-18 00:05:01.846189 CEST - Testing extend expires_at (all resources in experiment) 2026-04-18 00:05:01.846324 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-316c70f1 2026-04-18 00:05:04.215315 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-316c70f1 tst 2026-04-18 00:05:05.030907 CEST - Testing extend expires_at (single resource in experiment) 2026-04-18 00:05:05.031099 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-316c70f1 2026-04-18 00:05:07.349737 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-316c70f1 tst 2026-04-18 00:05:08.165455 CEST - Testing ssh login 2026-04-18 00:05:08.175248 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-316c70f1 tst 2026-04-18 00:05:09.141149 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-316c70f1 tst 2026-04-18 00:05:10.107127 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-316c70f1 tst 2026-04-18 00:05:11.073038 CEST - Logging in using 'slices bi ssh' 2026-04-18 00:05:11.073104 CEST - Forcing IPv4 only. 2026-04-18 00:05:11.073229 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-316c70f1 tst -- -4 uname -a 2026-04-18 00:05:15.346948 CEST - Forcing IPv4 only. 2026-04-18 00:05:15.347118 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-316c70f1 tst -- -4 uptime 2026-04-18 00:05:17.966785 CEST - CLI SSH Test passed. 2026-04-18 00:05:17.966844 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-04-18 00:05:17.966859 CEST - Uptime: 22:05:17 up 1 min, 1 user, load average: 0.75, 0.33, 0.12 2026-04-18 00:05:17.966889 CEST - Logging in using SSH over SSH proxy 2026-04-18 00:05:17.967049 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-316c70f1 tst 2026-04-18 00:05:18.933480 CEST - Added paramiko HostKeyEntry for 10.64.45.204 2026-04-18 00:05:18.933595 CEST - Added paramiko HostKeyEntry for 10.64.45.204 2026-04-18 00:05:18.933723 CEST - Added paramiko HostKeyEntry for 10.64.45.204 2026-04-18 00:05:18.933958 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-18 00:05:18.934030 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-18 00:05:18.934065 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-18 00:05:18.934076 CEST - Connecting to proxy 194.177.207.42:11122 2026-04-18 00:05:19.674808 CEST - Connecting to 10.64.45.204:22 over proxy 2026-04-18 00:05:21.225305 CEST - SSH Test output: 2026-04-18 00:05:21.225353 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-04-18 00:05:21.225365 CEST - Uptime: 22:05:20 up 1 min, 1 user, load average: 0.77, 0.34, 0.13 2026-04-18 00:05:21.533151 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-18 00:05:21.533212 CEST - lsb_release matches expected value 2026-04-18 00:05:21.533231 CEST - SSH Test passed. 2026-04-18 00:05:21.838690 CEST - Cloud-init user-data: Hello World. The time is now Fri, 17 Apr 2026 22:04:57 +0000! 2026-04-18 00:05:21.850610 CEST - Destroying tst-316c70f1 tst 2026-04-18 00:05:21.850842 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-316c70f1 tst