Run Test: slices-bi-singlenode-login 2026-04-01 17:03:13.585508 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-01 17:03:17.108970 CEST - Run: slices --version 2026-04-01 17:03:17.324530 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-01 17:03:17.324849 CEST - Run: slices pubkey list --format text 2026-04-01 17:03:17.945396 CEST - Pubkey already registered 2026-04-01 17:03:17.945669 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-01 17:03:18.495500 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-01 17:03:18.495682 CEST - Check List Flavors 2026-04-01 17:03:18.495883 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-04-01 17:03:19.501023 CEST - Check List DiskImages 2026-04-01 17:03:19.501231 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-04-01 17:03:20.283291 CEST - Requesting resources 2026-04-01 17:03:20.283816 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-01 17:03:20.283917 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-c357df6b --user-data /tmp/tmpxx8rdb3q 2026-04-01 17:03:23.861465 CEST - Resource ID: r_gr-volos-bi-vm1_01kn4s4587eh1tys3ays4bvcbm 2026-04-01 17:03:23.861616 CEST - Waiting until resource ready 2026-04-01 17:03:25.862050 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-c357df6b tst 2026-04-01 17:03:26.695817 CEST - Status: IMAGING 2026-04-01 17:03:29.560115 CEST - Status: IMAGING 2026-04-01 17:03:32.386526 CEST - Status: IMAGING 2026-04-01 17:03:35.276144 CEST - Status: BOOTING 2026-04-01 17:03:38.123475 CEST - Status: BOOTING 2026-04-01 17:03:40.970039 CEST - Status: BOOTING 2026-04-01 17:03:43.803012 CEST - Status: BOOTING 2026-04-01 17:03:46.667974 CEST - Status: BOOTING 2026-04-01 17:03:49.512795 CEST - Status: BOOTING 2026-04-01 17:03:52.388206 CEST - Status: BOOTING 2026-04-01 17:03:55.215791 CEST - Status: BOOTING 2026-04-01 17:03:58.052785 CEST - Status: BOOTING 2026-04-01 17:04:00.882940 CEST - Status: BOOTING 2026-04-01 17:04:03.737107 CEST - Status: BOOTING 2026-04-01 17:04:06.592646 CEST - Status: BOOTING 2026-04-01 17:04:09.427795 CEST - Status: BOOTING 2026-04-01 17:04:12.256006 CEST - Status: BOOTING 2026-04-01 17:04:15.086385 CEST - Status: BOOTING 2026-04-01 17:04:17.922670 CEST - Status: BOOTING 2026-04-01 17:04:20.768977 CEST - Status: BOOTING 2026-04-01 17:04:23.600230 CEST - Status: BOOTING 2026-04-01 17:04:26.434604 CEST - Status: BOOTING 2026-04-01 17:04:29.263936 CEST - Status: BOOTING 2026-04-01 17:04:32.145633 CEST - Status: BOOTING 2026-04-01 17:04:35.038359 CEST - Status: BOOTING 2026-04-01 17:04:37.919422 CEST - Status: BOOTING 2026-04-01 17:04:40.766367 CEST - Status: BOOTING 2026-04-01 17:04:43.594570 CEST - Status: BOOTING 2026-04-01 17:04:46.424506 CEST - Status: BOOTING 2026-04-01 17:04:49.332748 CEST - Status: BOOTING 2026-04-01 17:04:52.161878 CEST - Status: BOOTING 2026-04-01 17:04:54.990514 CEST - Status: BOOTING 2026-04-01 17:04:57.827109 CEST - Status: BOOTING 2026-04-01 17:05:00.654735 CEST - Status: BOOTING 2026-04-01 17:05:03.521664 CEST - Status: BOOTING 2026-04-01 17:05:06.357235 CEST - Status: BOOTING 2026-04-01 17:05:09.191760 CEST - Status: BOOTING 2026-04-01 17:05:12.023256 CEST - Status: BOOTING 2026-04-01 17:05:14.863498 CEST - Status: UP 2026-04-01 17:05:14.863561 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kn4s42wne3ttf0ty0jcjmapk 2026-04-01 17:05:14.863616 CEST - Validate resources 2026-04-01 17:05:15.707834 CEST - The fields of the created resource were validated. 2026-04-01 17:05:15.707903 CEST - Check if resources are registered in experiment 2026-04-01 17:05:15.708077 CEST - Run: slices experiment list-resources --format json tst-c357df6b 2026-04-01 17:05:16.361020 CEST - Status (on expauth): UP 2026-04-01 17:05:16.361208 CEST - Testing extend expires_at (all resources in experiment) 2026-04-01 17:05:16.361389 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-c357df6b 2026-04-01 17:05:18.709716 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-c357df6b tst 2026-04-01 17:05:19.606938 CEST - Testing extend expires_at (single resource in experiment) 2026-04-01 17:05:19.607120 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-c357df6b 2026-04-01 17:05:21.968690 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-c357df6b tst 2026-04-01 17:05:22.878493 CEST - Testing ssh login 2026-04-01 17:05:22.889759 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-c357df6b tst 2026-04-01 17:05:23.860075 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-c357df6b tst 2026-04-01 17:05:24.828351 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-c357df6b tst 2026-04-01 17:05:25.787682 CEST - Logging in using 'slices bi ssh' 2026-04-01 17:05:25.787745 CEST - Forcing IPv4 only. 2026-04-01 17:05:25.787909 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-c357df6b tst -- -4 uname -a 2026-04-01 17:05:29.537861 CEST - Forcing IPv4 only. 2026-04-01 17:05:29.538032 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-c357df6b tst -- -4 uptime 2026-04-01 17:05:32.112030 CEST - CLI SSH Test passed. 2026-04-01 17:05:32.112081 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-01 17:05:32.112091 CEST - Uptime: 15:05:32 up 1 min, 1 user, load average: 0.83, 0.40, 0.15 2026-04-01 17:05:32.112120 CEST - Logging in using SSH over SSH proxy 2026-04-01 17:05:32.112271 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-c357df6b tst 2026-04-01 17:05:33.097154 CEST - Added paramiko HostKeyEntry for 10.64.45.95 2026-04-01 17:05:33.097283 CEST - Added paramiko HostKeyEntry for 10.64.45.95 2026-04-01 17:05:33.097437 CEST - Added paramiko HostKeyEntry for 10.64.45.95 2026-04-01 17:05:33.097759 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-01 17:05:33.097845 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-01 17:05:33.097891 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-01 17:05:33.097903 CEST - Connecting to proxy 194.177.207.42:11122 2026-04-01 17:05:33.837449 CEST - Connecting to 10.64.45.95:22 over proxy 2026-04-01 17:05:35.318822 CEST - SSH Test output: 2026-04-01 17:05:35.318875 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-01 17:05:35.318886 CEST - Uptime: 15:05:34 up 1 min, 1 user, load average: 0.76, 0.39, 0.15 2026-04-01 17:05:35.622522 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-01 17:05:35.622590 CEST - lsb_release matches expected value 2026-04-01 17:05:35.622606 CEST - SSH Test passed. 2026-04-01 17:05:35.929602 CEST - Cloud-init user-data: Hello World. The time is now Wed, 01 Apr 2026 15:05:10 +0000! 2026-04-01 17:05:35.936198 CEST - Destroying tst-c357df6b tst 2026-04-01 17:05:35.936369 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-c357df6b tst