Run Test: slices-bi-singlenode-login 2026-03-07 07:32:08.856698 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-07 07:32:12.184129 CET - Run: slices --version 2026-03-07 07:32:12.371746 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-07 07:32:12.372008 CET - Run: slices pubkey list --format text 2026-03-07 07:32:13.025461 CET - Pubkey already registered 2026-03-07 07:32:13.025769 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-07 07:32:13.531354 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-07 07:32:13.531491 CET - Check List Flavors 2026-03-07 07:32:13.531673 CET - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-03-07 07:32:14.922672 CET - Check List DiskImages 2026-03-07 07:32:14.922874 CET - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-03-07 07:32:15.641766 CET - Requesting resources 2026-03-07 07:32:15.642266 CET - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-0c1a8120 --user-data /tmp/tmphi9lacqa 2026-03-07 07:32:18.086712 CET - Resource ID: r_gr-volos-bi-vm1_01kk3fyb6hek8rkyw9byd0ttma 2026-03-07 07:32:18.086880 CET - Waiting until resource ready 2026-03-07 07:32:20.087298 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0c1a8120 tst 2026-03-07 07:32:20.902042 CET - Status: IMAGING 2026-03-07 07:32:23.726944 CET - Status: IMAGING 2026-03-07 07:32:26.540379 CET - Status: IMAGING 2026-03-07 07:32:29.363019 CET - Status: BOOTING 2026-03-07 07:32:32.173398 CET - Status: BOOTING 2026-03-07 07:32:34.980680 CET - Status: BOOTING 2026-03-07 07:32:37.801908 CET - Status: BOOTING 2026-03-07 07:32:40.618197 CET - Status: BOOTING 2026-03-07 07:32:43.426955 CET - Status: BOOTING 2026-03-07 07:32:46.254499 CET - Status: BOOTING 2026-03-07 07:32:49.065274 CET - Status: BOOTING 2026-03-07 07:32:51.875324 CET - Status: BOOTING 2026-03-07 07:32:54.704186 CET - Status: BOOTING 2026-03-07 07:32:57.523531 CET - Status: BOOTING 2026-03-07 07:33:00.334921 CET - Status: BOOTING 2026-03-07 07:33:03.139057 CET - Status: BOOTING 2026-03-07 07:33:05.946807 CET - Status: BOOTING 2026-03-07 07:33:08.762640 CET - Status: BOOTING 2026-03-07 07:33:11.585087 CET - Status: BOOTING 2026-03-07 07:33:14.407573 CET - Status: BOOTING 2026-03-07 07:33:17.239694 CET - Status: BOOTING 2026-03-07 07:33:20.145070 CET - Status: BOOTING 2026-03-07 07:33:22.955149 CET - Status: BOOTING 2026-03-07 07:33:25.766751 CET - Status: BOOTING 2026-03-07 07:33:28.594491 CET - Status: BOOTING 2026-03-07 07:33:31.407466 CET - Status: BOOTING 2026-03-07 07:33:34.229711 CET - Status: BOOTING 2026-03-07 07:33:37.051531 CET - Status: BOOTING 2026-03-07 07:33:39.870195 CET - Status: BOOTING 2026-03-07 07:33:42.675237 CET - Status: BOOTING 2026-03-07 07:33:45.488423 CET - Status: BOOTING 2026-03-07 07:33:48.296104 CET - Status: BOOTING 2026-03-07 07:33:51.109625 CET - Status: BOOTING 2026-03-07 07:33:53.914519 CET - Status: BOOTING 2026-03-07 07:33:56.723169 CET - Status: BOOTING 2026-03-07 07:33:59.537451 CET - Status: BOOTING 2026-03-07 07:34:02.339600 CET - Status: BOOTING 2026-03-07 07:34:05.149950 CET - Status: UP 2026-03-07 07:34:05.149998 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kk3fy9yhe3bvanj3vbygv822 2026-03-07 07:34:05.150036 CET - Check if resources are registered in experiment 2026-03-07 07:34:05.150232 CET - Run: slices experiment list-resources --format json tst-0c1a8120 2026-03-07 07:34:05.775839 CET - Status (on expauth): UP 2026-03-07 07:34:05.775974 CET - Testing extend expires_at (all resources in experiment) 2026-03-07 07:34:05.776108 CET - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-0c1a8120 2026-03-07 07:34:08.022678 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0c1a8120 tst 2026-03-07 07:34:08.836934 CET - Testing extend expires_at (single resource in experiment) 2026-03-07 07:34:08.837130 CET - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-0c1a8120 2026-03-07 07:34:11.071253 CET - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0c1a8120 tst 2026-03-07 07:34:11.877296 CET - Testing ssh login 2026-03-07 07:34:11.887328 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-0c1a8120 tst 2026-03-07 07:34:12.819452 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-0c1a8120 tst 2026-03-07 07:34:13.745305 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-0c1a8120 tst 2026-03-07 07:34:14.670420 CET - Logging in using 'slices bi ssh' 2026-03-07 07:34:14.670473 CET - Forcing IPv4 only. 2026-03-07 07:34:14.670609 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-0c1a8120 tst -- -4 uname -a 2026-03-07 07:34:17.994338 CET - Forcing IPv4 only. 2026-03-07 07:34:17.994493 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-0c1a8120 tst -- -4 uptime 2026-03-07 07:34:20.552205 CET - CLI SSH Test passed. 2026-03-07 07:34:20.552248 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-07 07:34:20.552259 CET - Uptime: 06:34:20 up 1 min, 1 user, load average: 0.83, 0.37, 0.14 2026-03-07 07:34:20.552285 CET - Logging in using SSH over SSH proxy 2026-03-07 07:34:20.552427 CET - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-0c1a8120 tst 2026-03-07 07:34:21.489039 CET - Added paramiko HostKeyEntry for 10.64.45.224 2026-03-07 07:34:21.489127 CET - Added paramiko HostKeyEntry for 10.64.45.224 2026-03-07 07:34:21.489262 CET - Added paramiko HostKeyEntry for 10.64.45.224 2026-03-07 07:34:21.489506 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-07 07:34:21.489577 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-07 07:34:21.489609 CET - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-07 07:34:21.489618 CET - Connecting to proxy 194.177.207.42:11122 2026-03-07 07:34:22.261732 CET - Connecting to 10.64.45.224:22 over proxy 2026-03-07 07:34:23.758585 CET - SSH Test output: 2026-03-07 07:34:23.758631 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-07 07:34:23.758642 CET - Uptime: 06:34:23 up 1 min, 1 user, load average: 0.76, 0.36, 0.14 2026-03-07 07:34:24.065979 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-03-07 07:34:24.066028 CET - lsb_release matches expected value 2026-03-07 07:34:24.066038 CET - SSH Test passed. 2026-03-07 07:34:24.369757 CET - Cloud-init user-data: Hello World. The time is now Sat, 07 Mar 2026 06:33:59 +0000! 2026-03-07 07:34:24.376414 CET - Destroying tst-0c1a8120 tst 2026-03-07 07:34:24.376578 CET - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0c1a8120 tst