Run Test: slices-bi-singlenode-login 2026-03-09 07:32:02.300495 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-09 07:32:05.307916 CET - Run: slices --version 2026-03-09 07:32:05.490232 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-09 07:32:05.490502 CET - Run: slices pubkey list --format text 2026-03-09 07:32:06.119769 CET - Pubkey already registered 2026-03-09 07:32:06.119998 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-09 07:32:06.614573 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-09 07:32:06.614725 CET - Check List Flavors 2026-03-09 07:32:06.614899 CET - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-03-09 07:32:07.963963 CET - Check List DiskImages 2026-03-09 07:32:07.964148 CET - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-03-09 07:32:08.685289 CET - Requesting resources 2026-03-09 07:32:08.685766 CET - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-266489e7 --user-data /tmp/tmpy5uweroi 2026-03-09 07:32:12.506944 CET - Resource ID: r_gr-volos-bi-vm1_01kk8mqkr8fagsdzhwf8x1pvhx 2026-03-09 07:32:12.507137 CET - Waiting until resource ready 2026-03-09 07:32:14.507523 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-266489e7 tst 2026-03-09 07:32:15.303746 CET - Status: IMAGING 2026-03-09 07:32:18.099395 CET - Status: IMAGING 2026-03-09 07:32:20.904774 CET - Status: IMAGING 2026-03-09 07:32:23.722356 CET - Status: BOOTING 2026-03-09 07:32:26.531020 CET - Status: BOOTING 2026-03-09 07:32:29.329159 CET - Status: BOOTING 2026-03-09 07:32:32.144290 CET - Status: BOOTING 2026-03-09 07:32:34.934740 CET - Status: BOOTING 2026-03-09 07:32:37.736965 CET - Status: BOOTING 2026-03-09 07:32:40.532975 CET - Status: BOOTING 2026-03-09 07:32:43.353549 CET - Status: BOOTING 2026-03-09 07:32:46.145540 CET - Status: BOOTING 2026-03-09 07:32:48.934716 CET - Status: BOOTING 2026-03-09 07:32:51.724027 CET - Status: BOOTING 2026-03-09 07:32:54.517312 CET - Status: BOOTING 2026-03-09 07:32:57.320238 CET - Status: BOOTING 2026-03-09 07:33:00.129792 CET - Status: BOOTING 2026-03-09 07:33:02.934729 CET - Status: BOOTING 2026-03-09 07:33:05.742009 CET - Status: BOOTING 2026-03-09 07:33:08.535342 CET - Status: BOOTING 2026-03-09 07:33:11.335857 CET - Status: BOOTING 2026-03-09 07:33:14.125826 CET - Status: BOOTING 2026-03-09 07:33:16.920067 CET - Status: BOOTING 2026-03-09 07:33:19.771116 CET - Status: BOOTING 2026-03-09 07:33:22.569951 CET - Status: BOOTING 2026-03-09 07:33:25.374866 CET - Status: BOOTING 2026-03-09 07:33:28.180157 CET - Status: BOOTING 2026-03-09 07:33:30.982421 CET - Status: BOOTING 2026-03-09 07:33:33.778102 CET - Status: BOOTING 2026-03-09 07:33:36.591990 CET - Status: BOOTING 2026-03-09 07:33:39.429832 CET - Status: BOOTING 2026-03-09 07:33:42.230231 CET - Status: BOOTING 2026-03-09 07:33:45.033236 CET - Status: BOOTING 2026-03-09 07:33:47.831981 CET - Status: BOOTING 2026-03-09 07:33:50.628264 CET - Status: BOOTING 2026-03-09 07:33:53.504086 CET - Status: BOOTING 2026-03-09 07:33:56.334951 CET - Status: BOOTING 2026-03-09 07:33:59.188836 CET - Status: UP 2026-03-09 07:33:59.188904 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kk8mqh6xfpwsaqdy223cty7f 2026-03-09 07:33:59.188957 CET - Check if resources are registered in experiment 2026-03-09 07:33:59.189180 CET - Run: slices experiment list-resources --format json tst-266489e7 2026-03-09 07:33:59.808804 CET - Status (on expauth): UP 2026-03-09 07:33:59.808973 CET - Testing extend expires_at (all resources in experiment) 2026-03-09 07:33:59.809151 CET - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-266489e7 2026-03-09 07:34:02.017053 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-266489e7 tst 2026-03-09 07:34:02.828997 CET - Testing extend expires_at (single resource in experiment) 2026-03-09 07:34:02.829157 CET - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-266489e7 2026-03-09 07:34:05.041081 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-266489e7 tst 2026-03-09 07:34:05.845171 CET - Testing ssh login 2026-03-09 07:34:05.855066 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-266489e7 tst 2026-03-09 07:34:06.774495 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-266489e7 tst 2026-03-09 07:34:07.696151 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-266489e7 tst 2026-03-09 07:34:08.612405 CET - Logging in using 'slices bi ssh' 2026-03-09 07:34:08.612456 CET - Forcing IPv4 only. 2026-03-09 07:34:08.612611 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-266489e7 tst -- -4 uname -a 2026-03-09 07:34:12.900770 CET - Forcing IPv4 only. 2026-03-09 07:34:12.900925 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-266489e7 tst -- -4 uptime 2026-03-09 07:34:15.402503 CET - CLI SSH Test passed. 2026-03-09 07:34:15.402544 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-09 07:34:15.402554 CET - Uptime: 06:34:15 up 1 min, 1 user, load average: 1.07, 0.42, 0.15 2026-03-09 07:34:15.402578 CET - Logging in using SSH over SSH proxy 2026-03-09 07:34:15.402715 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-266489e7 tst 2026-03-09 07:34:16.327017 CET - Added paramiko HostKeyEntry for 10.64.45.254 2026-03-09 07:34:16.327104 CET - Added paramiko HostKeyEntry for 10.64.45.254 2026-03-09 07:34:16.327229 CET - Added paramiko HostKeyEntry for 10.64.45.254 2026-03-09 07:34:16.327496 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-09 07:34:16.327571 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-09 07:34:16.327603 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-09 07:34:16.327612 CET - Connecting to proxy 194.177.207.42:11122 2026-03-09 07:34:17.061431 CET - Connecting to 10.64.45.254:22 over proxy 2026-03-09 07:34:18.529018 CET - SSH Test output: 2026-03-09 07:34:18.529062 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-09 07:34:18.529072 CET - Uptime: 06:34:18 up 1 min, 1 user, load average: 0.98, 0.41, 0.15 2026-03-09 07:34:18.830787 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-03-09 07:34:18.830850 CET - lsb_release matches expected value 2026-03-09 07:34:18.830862 CET - SSH Test passed. 2026-03-09 07:34:19.133510 CET - Cloud-init user-data: Hello World. The time is now Mon, 09 Mar 2026 06:33:54 +0000! 2026-03-09 07:34:19.139796 CET - Destroying tst-266489e7 tst 2026-03-09 07:34:19.139970 CET - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-266489e7 tst