Run Test: slices-bi-singlenode-login 2026-03-15 09:03:56.943502 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-15 09:04:00.074006 CET - Run: slices --version 2026-03-15 09:04:00.254905 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.8 Slices clientlib bi v5.1.2 2026-03-15 09:04:00.255179 CET - Run: slices pubkey list --format text 2026-03-15 09:04:00.938114 CET - Pubkey already registered 2026-03-15 09:04:00.938408 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-15 09:04:01.443300 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-15 09:04:01.443464 CET - Check List Flavors 2026-03-15 09:04:01.443661 CET - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-03-15 09:04:05.145462 CET - Check List DiskImages 2026-03-15 09:04:05.145646 CET - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-03-15 09:04:05.853798 CET - Requesting resources 2026-03-15 09:04:05.854254 CET - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-03-15 09:04:05.854344 CET - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-1d641c1f --user-data /tmp/tmpkwz9q1b0 2026-03-15 09:04:10.863438 CET - Resource ID: r_gr-volos-bi-vm1_01kkr8cas9e2hsbmt3gvmk6ds3 2026-03-15 09:04:10.863612 CET - Waiting until resource ready 2026-03-15 09:04:12.864025 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-1d641c1f tst 2026-03-15 09:04:13.667920 CET - Status: IMAGING 2026-03-15 09:04:16.462484 CET - Status: IMAGING 2026-03-15 09:04:19.257887 CET - Status: IMAGING 2026-03-15 09:04:22.077219 CET - Status: BOOTING 2026-03-15 09:04:24.886309 CET - Status: BOOTING 2026-03-15 09:04:27.716830 CET - Status: BOOTING 2026-03-15 09:04:30.513503 CET - Status: BOOTING 2026-03-15 09:04:33.316202 CET - Status: BOOTING 2026-03-15 09:04:36.110096 CET - Status: BOOTING 2026-03-15 09:04:38.937949 CET - Status: BOOTING 2026-03-15 09:04:41.736194 CET - Status: BOOTING 2026-03-15 09:04:44.534593 CET - Status: BOOTING 2026-03-15 09:04:47.331745 CET - Status: BOOTING 2026-03-15 09:04:50.159052 CET - Status: BOOTING 2026-03-15 09:04:52.955790 CET - Status: BOOTING 2026-03-15 09:04:55.753709 CET - Status: BOOTING 2026-03-15 09:04:58.543264 CET - Status: BOOTING 2026-03-15 09:05:01.341346 CET - Status: BOOTING 2026-03-15 09:05:04.151229 CET - Status: BOOTING 2026-03-15 09:05:06.964795 CET - Status: BOOTING 2026-03-15 09:05:09.763410 CET - Status: BOOTING 2026-03-15 09:05:12.566543 CET - Status: BOOTING 2026-03-15 09:05:15.368612 CET - Status: BOOTING 2026-03-15 09:05:18.178694 CET - Status: BOOTING 2026-03-15 09:05:20.983418 CET - Status: BOOTING 2026-03-15 09:05:23.792730 CET - Status: BOOTING 2026-03-15 09:05:26.587217 CET - Status: BOOTING 2026-03-15 09:05:29.376639 CET - Status: BOOTING 2026-03-15 09:05:32.171532 CET - Status: BOOTING 2026-03-15 09:05:34.961120 CET - Status: BOOTING 2026-03-15 09:05:37.774908 CET - Status: BOOTING 2026-03-15 09:05:40.578980 CET - Status: BOOTING 2026-03-15 09:05:43.377554 CET - Status: BOOTING 2026-03-15 09:05:46.179127 CET - Status: BOOTING 2026-03-15 09:05:48.967813 CET - Status: BOOTING 2026-03-15 09:05:51.770255 CET - Status: BOOTING 2026-03-15 09:05:54.571009 CET - Status: BOOTING 2026-03-15 09:05:57.372264 CET - Status: BOOTING 2026-03-15 09:06:00.162376 CET - Status: BOOTING 2026-03-15 09:06:02.963783 CET - Status: BOOTING 2026-03-15 09:06:05.747157 CET - Status: BOOTING 2026-03-15 09:06:08.540669 CET - Status: UP 2026-03-15 09:06:08.540713 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kkr8c719exwaqdftms6502nd 2026-03-15 09:06:08.540763 CET - Validate resources 2026-03-15 09:06:09.337604 CET - The fields of the created resource were validated. 2026-03-15 09:06:09.337681 CET - Check if resources are registered in experiment 2026-03-15 09:06:09.337839 CET - Run: slices experiment list-resources --format json tst-1d641c1f 2026-03-15 09:06:09.946520 CET - Status (on expauth): UP 2026-03-15 09:06:09.946664 CET - Testing extend expires_at (all resources in experiment) 2026-03-15 09:06:09.946789 CET - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-1d641c1f 2026-03-15 09:06:12.213768 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-1d641c1f tst 2026-03-15 09:06:13.017209 CET - Testing extend expires_at (single resource in experiment) 2026-03-15 09:06:13.017369 CET - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-1d641c1f 2026-03-15 09:06:15.241829 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-1d641c1f tst 2026-03-15 09:06:16.031189 CET - Testing ssh login 2026-03-15 09:06:16.040726 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-1d641c1f tst 2026-03-15 09:06:16.955625 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-1d641c1f tst 2026-03-15 09:06:17.867948 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-1d641c1f tst 2026-03-15 09:06:18.793137 CET - Logging in using 'slices bi ssh' 2026-03-15 09:06:18.793187 CET - Forcing IPv4 only. 2026-03-15 09:06:18.793326 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-1d641c1f tst -- -4 uname -a 2026-03-15 09:06:21.822625 CET - Forcing IPv4 only. 2026-03-15 09:06:21.822767 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-1d641c1f tst -- -4 uptime 2026-03-15 09:06:24.351523 CET - CLI SSH Test passed. 2026-03-15 09:06:24.351563 CET - 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-03-15 09:06:24.351572 CET - Uptime: 08:06:24 up 1 min, 2 users, load average: 1.11, 0.57, 0.22 2026-03-15 09:06:24.351597 CET - Logging in using SSH over SSH proxy 2026-03-15 09:06:24.351733 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-1d641c1f tst 2026-03-15 09:06:25.277263 CET - Added paramiko HostKeyEntry for 10.64.45.222 2026-03-15 09:06:25.277355 CET - Added paramiko HostKeyEntry for 10.64.45.222 2026-03-15 09:06:25.277485 CET - Added paramiko HostKeyEntry for 10.64.45.222 2026-03-15 09:06:25.277734 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-15 09:06:25.277807 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-15 09:06:25.277839 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-15 09:06:25.277847 CET - Connecting to proxy 194.177.207.42:11122 2026-03-15 09:06:26.013717 CET - Connecting to 10.64.45.222:22 over proxy 2026-03-15 09:06:27.411021 CET - SSH Test output: 2026-03-15 09:06:27.411065 CET - 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-03-15 09:06:27.411075 CET - Uptime: 08:06:27 up 1 min, 2 users, load average: 1.02, 0.56, 0.22 2026-03-15 09:06:27.714253 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-03-15 09:06:27.714302 CET - lsb_release matches expected value 2026-03-15 09:06:27.714313 CET - SSH Test passed. 2026-03-15 09:06:28.015283 CET - Cloud-init user-data: Hello World. The time is now Sun, 15 Mar 2026 08:06:04 +0000! 2026-03-15 09:06:28.021545 CET - Destroying tst-1d641c1f tst 2026-03-15 09:06:28.021712 CET - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-1d641c1f tst