Run Test: slices-bi-singlenode-login 2026-05-09 08:04:27.215762 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-05-09 08:04:31.239130 CEST - Run: slices --version 2026-05-09 08:04:31.453801 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-05-09 08:04:31.454060 CEST - Run: slices pubkey list --format text 2026-05-09 08:04:32.019376 CEST - Pubkey already registered 2026-05-09 08:04:32.019628 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-05-09 08:04:32.584753 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-05-09 08:04:32.584894 CEST - Check List Flavors 2026-05-09 08:04:32.585070 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-05-09 08:04:33.951889 CEST - Check List DiskImages 2026-05-09 08:04:33.952096 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-05-09 08:04:34.717715 CEST - Requesting resources 2026-05-09 08:04:34.718199 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-05-09 08:04:34.718295 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-a5779638 --user-data /tmp/tmplyx47u9g 2026-05-09 08:04:39.644848 CEST - Resource ID: r_gr-volos-bi-vm1_01kr5nd0kjfg1938mvsgmec1n1 2026-05-09 08:04:39.645013 CEST - Waiting until resource ready 2026-05-09 08:04:41.645471 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-a5779638 tst 2026-05-09 08:04:42.511685 CEST - Status: IMAGING 2026-05-09 08:04:45.378364 CEST - Status: IMAGING 2026-05-09 08:04:48.245162 CEST - Status: IMAGING 2026-05-09 08:04:51.112022 CEST - Status: BOOTING 2026-05-09 08:04:53.978649 CEST - Status: BOOTING 2026-05-09 08:04:56.845154 CEST - Status: BOOTING 2026-05-09 08:04:59.711777 CEST - Status: BOOTING 2026-05-09 08:05:02.578413 CEST - Status: BOOTING 2026-05-09 08:05:05.445150 CEST - Status: BOOTING 2026-05-09 08:05:08.311641 CEST - Status: BOOTING 2026-05-09 08:05:11.177939 CEST - Status: BOOTING 2026-05-09 08:05:14.044200 CEST - Status: BOOTING 2026-05-09 08:05:16.910726 CEST - Status: BOOTING 2026-05-09 08:05:19.777435 CEST - Status: BOOTING 2026-05-09 08:05:22.644145 CEST - Status: BOOTING 2026-05-09 08:05:25.560993 CEST - Status: BOOTING 2026-05-09 08:05:28.427477 CEST - Status: BOOTING 2026-05-09 08:05:31.294408 CEST - Status: BOOTING 2026-05-09 08:05:34.160951 CEST - Status: BOOTING 2026-05-09 08:05:37.027249 CEST - Status: BOOTING 2026-05-09 08:05:39.893505 CEST - Status: BOOTING 2026-05-09 08:05:42.760001 CEST - Status: BOOTING 2026-05-09 08:05:45.626597 CEST - Status: BOOTING 2026-05-09 08:05:48.493341 CEST - Status: BOOTING 2026-05-09 08:05:51.360048 CEST - Status: BOOTING 2026-05-09 08:05:54.226698 CEST - Status: BOOTING 2026-05-09 08:05:57.093454 CEST - Status: BOOTING 2026-05-09 08:05:59.960084 CEST - Status: BOOTING 2026-05-09 08:06:02.826827 CEST - Status: BOOTING 2026-05-09 08:06:05.693492 CEST - Status: BOOTING 2026-05-09 08:06:08.560232 CEST - Status: BOOTING 2026-05-09 08:06:11.426857 CEST - Status: BOOTING 2026-05-09 08:06:14.293620 CEST - Status: BOOTING 2026-05-09 08:06:17.160203 CEST - Status: BOOTING 2026-05-09 08:06:20.026577 CEST - Status: BOOTING 2026-05-09 08:06:22.893207 CEST - Status: UP 2026-05-09 08:06:22.893295 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kr5ncxknetv9pygr00zsfkym 2026-05-09 08:06:22.893336 CEST - Validate resources 2026-05-09 08:06:23.759663 CEST - The fields of the created resource were validated. 2026-05-09 08:06:23.759742 CEST - Check if resources are registered in experiment 2026-05-09 08:06:23.759912 CEST - Run: slices experiment list-resources --format json tst-a5779638 2026-05-09 08:06:24.375217 CEST - Status (on expauth): UP 2026-05-09 08:06:24.375402 CEST - Testing extend expires_at (all resources in experiment) 2026-05-09 08:06:24.375539 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-a5779638 2026-05-09 08:06:27.347110 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-a5779638 tst 2026-05-09 08:06:28.213309 CEST - Testing extend expires_at (single resource in experiment) 2026-05-09 08:06:28.213545 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-a5779638 2026-05-09 08:06:31.285831 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-a5779638 tst 2026-05-09 08:06:32.152080 CEST - Testing ssh login 2026-05-09 08:06:32.162713 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-a5779638 tst 2026-05-09 08:06:33.129150 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-a5779638 tst 2026-05-09 08:06:34.145673 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-a5779638 tst 2026-05-09 08:06:35.112157 CEST - Logging in using 'slices bi ssh' 2026-05-09 08:06:35.112246 CEST - Forcing IPv4 only. 2026-05-09 08:06:35.112386 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-a5779638 tst -- -4 uname -a 2026-05-09 08:06:38.885712 CEST - Forcing IPv4 only. 2026-05-09 08:06:38.885888 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-a5779638 tst -- -4 uptime 2026-05-09 08:06:41.405545 CEST - CLI SSH Test passed. 2026-05-09 08:06:41.405611 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-05-09 08:06:41.405626 CEST - Uptime: 06:06:41 up 1 min, 1 user, load average: 0.70, 0.26, 0.09 2026-05-09 08:06:41.405660 CEST - Logging in using SSH over SSH proxy 2026-05-09 08:06:41.405819 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-a5779638 tst 2026-05-09 08:06:42.372551 CEST - Added paramiko HostKeyEntry for 10.64.45.68 2026-05-09 08:06:42.372668 CEST - Added paramiko HostKeyEntry for 10.64.45.68 2026-05-09 08:06:42.372868 CEST - Added paramiko HostKeyEntry for 10.64.45.68 2026-05-09 08:06:42.373179 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-09 08:06:42.373290 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-09 08:06:42.373334 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-09 08:06:42.373347 CEST - Connecting to proxy 194.177.207.42:11122 2026-05-09 08:06:43.115267 CEST - Connecting to 10.64.45.68:22 over proxy 2026-05-09 08:06:44.599841 CEST - SSH Test output: 2026-05-09 08:06:44.599900 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-05-09 08:06:44.599915 CEST - Uptime: 06:06:44 up 1 min, 1 user, load average: 0.64, 0.25, 0.09 2026-05-09 08:06:44.909723 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-05-09 08:06:44.909790 CEST - lsb_release matches expected value 2026-05-09 08:06:44.909803 CEST - SSH Test passed. 2026-05-09 08:06:45.218656 CEST - Cloud-init user-data: Hello World. The time is now Sat, 09 May 2026 06:06:17 +0000! 2026-05-09 08:06:45.225588 CEST - Destroying tst-a5779638 tst 2026-05-09 08:06:45.225813 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-a5779638 tst