Run Test: slices-bi-singlenode-login 2026-04-30 17:03:20.367383 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-30 17:03:23.738532 CEST - Run: slices --version 2026-04-30 17:03:23.952985 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-04-30 17:03:23.953254 CEST - Run: slices pubkey list --format text 2026-04-30 17:03:24.518244 CEST - Pubkey already registered 2026-04-30 17:03:24.518470 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-30 17:03:25.083602 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-30 17:03:25.083725 CEST - Check List Flavors 2026-04-30 17:03:25.083900 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-04-30 17:03:26.049693 CEST - Check List DiskImages 2026-04-30 17:03:26.049875 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-04-30 17:03:26.765187 CEST - Requesting resources 2026-04-30 17:03:26.765613 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-30 17:03:26.765727 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-57c2d389 --user-data /tmp/tmp03v5haid 2026-04-30 17:03:30.637118 CEST - Resource ID: r_gr-volos-bi-vm1_01kqfen6v6fg88tdw73dnbwv34 2026-04-30 17:03:30.637238 CEST - Waiting until resource ready 2026-04-30 17:03:32.637615 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-57c2d389 tst 2026-04-30 17:03:33.453356 CEST - Status: IMAGING 2026-04-30 17:03:36.269347 CEST - Status: IMAGING 2026-04-30 17:03:39.085326 CEST - Status: IMAGING 2026-04-30 17:03:41.901184 CEST - Status: IMAGING 2026-04-30 17:03:44.717064 CEST - Status: BOOTING 2026-04-30 17:03:47.533450 CEST - Status: BOOTING 2026-04-30 17:03:50.399461 CEST - Status: BOOTING 2026-04-30 17:03:53.215360 CEST - Status: BOOTING 2026-04-30 17:03:56.031149 CEST - Status: BOOTING 2026-04-30 17:03:58.847105 CEST - Status: BOOTING 2026-04-30 17:04:01.662940 CEST - Status: BOOTING 2026-04-30 17:04:04.478866 CEST - Status: BOOTING 2026-04-30 17:04:07.295048 CEST - Status: BOOTING 2026-04-30 17:04:10.111051 CEST - Status: BOOTING 2026-04-30 17:04:12.927083 CEST - Status: BOOTING 2026-04-30 17:04:15.743059 CEST - Status: BOOTING 2026-04-30 17:04:18.559062 CEST - Status: BOOTING 2026-04-30 17:04:21.374832 CEST - Status: BOOTING 2026-04-30 17:04:24.190831 CEST - Status: BOOTING 2026-04-30 17:04:27.006749 CEST - Status: BOOTING 2026-04-30 17:04:29.822697 CEST - Status: BOOTING 2026-04-30 17:04:32.638616 CEST - Status: BOOTING 2026-04-30 17:04:35.454549 CEST - Status: BOOTING 2026-04-30 17:04:38.270597 CEST - Status: BOOTING 2026-04-30 17:04:41.086526 CEST - Status: BOOTING 2026-04-30 17:04:43.902301 CEST - Status: BOOTING 2026-04-30 17:04:46.718336 CEST - Status: BOOTING 2026-04-30 17:04:49.534590 CEST - Status: BOOTING 2026-04-30 17:04:52.350406 CEST - Status: BOOTING 2026-04-30 17:04:55.216546 CEST - Status: BOOTING 2026-04-30 17:04:58.082567 CEST - Status: BOOTING 2026-04-30 17:05:00.898388 CEST - Status: BOOTING 2026-04-30 17:05:03.714341 CEST - Status: BOOTING 2026-04-30 17:05:06.530153 CEST - Status: BOOTING 2026-04-30 17:05:09.346238 CEST - Status: BOOTING 2026-04-30 17:05:12.162262 CEST - Status: BOOTING 2026-04-30 17:05:14.978068 CEST - Status: BOOTING 2026-04-30 17:05:17.793947 CEST - Status: BOOTING 2026-04-30 17:05:20.609959 CEST - Status: BOOTING 2026-04-30 17:05:23.425882 CEST - Status: BOOTING 2026-04-30 17:05:26.241914 CEST - Status: UP 2026-04-30 17:05:26.241972 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kqfen472fv9rkmx1q61hfbf7 2026-04-30 17:05:26.242015 CEST - Validate resources 2026-04-30 17:05:27.058064 CEST - The fields of the created resource were validated. 2026-04-30 17:05:27.058139 CEST - Check if resources are registered in experiment 2026-04-30 17:05:27.058296 CEST - Run: slices experiment list-resources --format json tst-57c2d389 2026-04-30 17:05:27.673409 CEST - Status (on expauth): UP 2026-04-30 17:05:27.673544 CEST - Testing extend expires_at (all resources in experiment) 2026-04-30 17:05:27.673661 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-57c2d389 2026-04-30 17:05:30.042465 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-57c2d389 tst 2026-04-30 17:05:30.858032 CEST - Testing extend expires_at (single resource in experiment) 2026-04-30 17:05:30.858200 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-57c2d389 2026-04-30 17:05:33.276827 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-57c2d389 tst 2026-04-30 17:05:34.092377 CEST - Testing ssh login 2026-04-30 17:05:34.102206 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-57c2d389 tst 2026-04-30 17:05:35.068105 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-57c2d389 tst 2026-04-30 17:05:35.983819 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-57c2d389 tst 2026-04-30 17:05:36.949807 CEST - Logging in using 'slices bi ssh' 2026-04-30 17:05:36.949869 CEST - Forcing IPv4 only. 2026-04-30 17:05:36.949994 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-57c2d389 tst -- -4 uname -a 2026-04-30 17:05:41.423438 CEST - Forcing IPv4 only. 2026-04-30 17:05:41.423624 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-57c2d389 tst -- -4 uptime 2026-04-30 17:05:43.992427 CEST - CLI SSH Test passed. 2026-04-30 17:05:43.992482 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-30 17:05:43.992495 CEST - Uptime: 15:05:43 up 1 min, 1 user, load average: 0.88, 0.44, 0.17 2026-04-30 17:05:43.992523 CEST - Logging in using SSH over SSH proxy 2026-04-30 17:05:43.992662 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-57c2d389 tst 2026-04-30 17:05:44.908695 CEST - Added paramiko HostKeyEntry for 10.64.45.57 2026-04-30 17:05:44.908842 CEST - Added paramiko HostKeyEntry for 10.64.45.57 2026-04-30 17:05:44.908982 CEST - Added paramiko HostKeyEntry for 10.64.45.57 2026-04-30 17:05:44.909231 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-30 17:05:44.909310 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-30 17:05:44.909348 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-30 17:05:44.909360 CEST - Connecting to proxy 194.177.207.42:11122 2026-04-30 17:05:45.645321 CEST - Connecting to 10.64.45.57:22 over proxy 2026-04-30 17:05:47.118871 CEST - SSH Test output: 2026-04-30 17:05:47.118924 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-30 17:05:47.118939 CEST - Uptime: 15:05:46 up 1 min, 1 user, load average: 0.81, 0.44, 0.17 2026-04-30 17:05:47.425941 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-30 17:05:47.425997 CEST - lsb_release matches expected value 2026-04-30 17:05:47.426010 CEST - SSH Test passed. 2026-04-30 17:05:47.731810 CEST - Cloud-init user-data: Hello World. The time is now Thu, 30 Apr 2026 15:05:22 +0000! 2026-04-30 17:05:47.738227 CEST - Destroying tst-57c2d389 tst 2026-04-30 17:05:47.738390 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-57c2d389 tst