Run Test: slices-bi-singlenode-login 2026-05-03 17:03:17.561147 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-05-03 17:03:20.681592 CEST - Run: slices --version 2026-05-03 17:03:20.896034 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.1 Slices clientlib bi v5.1.2 2026-05-03 17:03:20.896311 CEST - Run: slices pubkey list --format text 2026-05-03 17:03:21.461544 CEST - Pubkey already registered 2026-05-03 17:03:21.461846 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-05-03 17:03:21.976986 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-05-03 17:03:21.977106 CEST - Check List Flavors 2026-05-03 17:03:21.977263 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-05-03 17:03:23.043463 CEST - Check List DiskImages 2026-05-03 17:03:23.043633 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-05-03 17:03:23.809369 CEST - Requesting resources 2026-05-03 17:03:23.809776 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-05-03 17:03:23.809862 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-347a794d --user-data /tmp/tmp10gfdicj 2026-05-03 17:03:26.629874 CEST - Resource ID: r_gr-volos-bi-vm1_01kqq5v7vpfdh9be6qq56t7vqw 2026-05-03 17:03:26.629991 CEST - Waiting until resource ready 2026-05-03 17:03:28.630400 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-347a794d tst 2026-05-03 17:03:29.496178 CEST - Status: IMAGING 2026-05-03 17:03:32.312516 CEST - Status: IMAGING 2026-05-03 17:03:35.128546 CEST - Status: IMAGING 2026-05-03 17:03:37.944539 CEST - Status: IMAGING 2026-05-03 17:03:40.810592 CEST - Status: BOOTING 2026-05-03 17:03:43.626705 CEST - Status: BOOTING 2026-05-03 17:03:46.493065 CEST - Status: BOOTING 2026-05-03 17:03:49.359171 CEST - Status: BOOTING 2026-05-03 17:03:52.175207 CEST - Status: BOOTING 2026-05-03 17:03:55.041504 CEST - Status: BOOTING 2026-05-03 17:03:57.857395 CEST - Status: BOOTING 2026-05-03 17:04:00.673550 CEST - Status: BOOTING 2026-05-03 17:04:03.489640 CEST - Status: BOOTING 2026-05-03 17:04:06.305555 CEST - Status: BOOTING 2026-05-03 17:04:09.121565 CEST - Status: BOOTING 2026-05-03 17:04:11.937554 CEST - Status: BOOTING 2026-05-03 17:04:14.753491 CEST - Status: BOOTING 2026-05-03 17:04:17.569457 CEST - Status: BOOTING 2026-05-03 17:04:20.385503 CEST - Status: BOOTING 2026-05-03 17:04:23.201511 CEST - Status: BOOTING 2026-05-03 17:04:26.017494 CEST - Status: BOOTING 2026-05-03 17:04:28.833698 CEST - Status: BOOTING 2026-05-03 17:04:31.699763 CEST - Status: BOOTING 2026-05-03 17:04:34.516188 CEST - Status: BOOTING 2026-05-03 17:04:37.382727 CEST - Status: BOOTING 2026-05-03 17:04:40.248823 CEST - Status: BOOTING 2026-05-03 17:04:43.115039 CEST - Status: BOOTING 2026-05-03 17:04:45.981285 CEST - Status: BOOTING 2026-05-03 17:04:48.797247 CEST - Status: BOOTING 2026-05-03 17:04:51.663372 CEST - Status: BOOTING 2026-05-03 17:04:54.479290 CEST - Status: BOOTING 2026-05-03 17:04:57.345622 CEST - Status: BOOTING 2026-05-03 17:05:00.211993 CEST - Status: BOOTING 2026-05-03 17:05:03.028033 CEST - Status: BOOTING 2026-05-03 17:05:05.844232 CEST - Status: BOOTING 2026-05-03 17:05:08.710834 CEST - Status: BOOTING 2026-05-03 17:05:11.527000 CEST - Status: BOOTING 2026-05-03 17:05:14.343038 CEST - Status: BOOTING 2026-05-03 17:05:17.159065 CEST - Status: BOOTING 2026-05-03 17:05:19.975030 CEST - Status: BOOTING 2026-05-03 17:05:22.791227 CEST - Status: UP 2026-05-03 17:05:22.791313 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kqq5v6b6fhyb78v809zdn1t4 2026-05-03 17:05:22.791374 CEST - Validate resources 2026-05-03 17:05:23.657489 CEST - The fields of the created resource were validated. 2026-05-03 17:05:23.657562 CEST - Check if resources are registered in experiment 2026-05-03 17:05:23.657723 CEST - Run: slices experiment list-resources --format json tst-347a794d 2026-05-03 17:05:24.272940 CEST - Status (on expauth): UP 2026-05-03 17:05:24.273077 CEST - Testing extend expires_at (all resources in experiment) 2026-05-03 17:05:24.273219 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-347a794d 2026-05-03 17:05:26.742537 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-347a794d tst 2026-05-03 17:05:27.558128 CEST - Testing extend expires_at (single resource in experiment) 2026-05-03 17:05:27.558300 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-347a794d 2026-05-03 17:05:32.732945 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-347a794d tst 2026-05-03 17:05:33.548564 CEST - Testing ssh login 2026-05-03 17:05:33.558158 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-347a794d tst 2026-05-03 17:05:34.524228 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-347a794d tst 2026-05-03 17:05:35.490363 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-347a794d tst 2026-05-03 17:05:36.456330 CEST - Logging in using 'slices bi ssh' 2026-05-03 17:05:36.456395 CEST - Forcing IPv4 only. 2026-05-03 17:05:36.456521 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-347a794d tst -- -4 uname -a 2026-05-03 17:05:40.379366 CEST - Forcing IPv4 only. 2026-05-03 17:05:40.379524 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-347a794d tst -- -4 uptime 2026-05-03 17:05:42.999006 CEST - CLI SSH Test passed. 2026-05-03 17:05:42.999060 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-05-03 17:05:42.999073 CEST - Uptime: 15:05:42 up 1 min, 2 users, load average: 0.75, 0.34, 0.13 2026-05-03 17:05:42.999100 CEST - Logging in using SSH over SSH proxy 2026-05-03 17:05:42.999253 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-347a794d tst 2026-05-03 17:05:43.965851 CEST - Added paramiko HostKeyEntry for 10.64.45.127 2026-05-03 17:05:43.965958 CEST - Added paramiko HostKeyEntry for 10.64.45.127 2026-05-03 17:05:43.966098 CEST - Added paramiko HostKeyEntry for 10.64.45.127 2026-05-03 17:05:43.966350 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-03 17:05:43.966427 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-03 17:05:43.966464 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-03 17:05:43.966476 CEST - Connecting to proxy 194.177.207.42:11122 2026-05-03 17:05:44.702173 CEST - Connecting to 10.64.45.127:22 over proxy 2026-05-03 17:05:46.252845 CEST - SSH Test output: 2026-05-03 17:05:46.252890 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-05-03 17:05:46.252903 CEST - Uptime: 15:05:45 up 1 min, 1 user, load average: 0.75, 0.34, 0.13 2026-05-03 17:05:46.555955 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-05-03 17:05:46.556024 CEST - lsb_release matches expected value 2026-05-03 17:05:46.556044 CEST - SSH Test passed. 2026-05-03 17:05:46.862211 CEST - Cloud-init user-data: Hello World. The time is now Sun, 03 May 2026 15:05:20 +0000! 2026-05-03 17:05:46.868526 CEST - Destroying tst-347a794d tst 2026-05-03 17:05:46.868693 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-347a794d tst