Run Test: slices-bi-singlenode-login 2026-04-06 00:01:56.196189 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-06 00:01:59.454606 CEST - Run: slices --version 2026-04-06 00:01:59.651368 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-06 00:01:59.651618 CEST - Run: slices pubkey list --format text 2026-04-06 00:02:00.234466 CEST - Pubkey already registered 2026-04-06 00:02:00.234689 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-06 00:02:00.768208 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-06 00:02:00.768312 CEST - Check List Flavors 2026-04-06 00:02:00.768481 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-04-06 00:02:01.936770 CEST - Check List DiskImages 2026-04-06 00:02:01.936959 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-04-06 00:02:02.695032 CEST - Requesting resources 2026-04-06 00:02:02.695448 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-06 00:02:02.695555 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-0e71d169 --user-data /tmp/tmp0rrdg714 2026-04-06 00:02:09.081456 CEST - Resource ID: r_gr-volos-bi-vm1_01knftnskhf999bpa4n06caj8v 2026-04-06 00:02:09.081586 CEST - Waiting until resource ready 2026-04-06 00:02:11.081930 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0e71d169 tst 2026-04-06 00:02:11.900548 CEST - Status: IMAGING 2026-04-06 00:02:14.724237 CEST - Status: IMAGING 2026-04-06 00:02:17.531638 CEST - Status: IMAGING 2026-04-06 00:02:20.341000 CEST - Status: BOOTING 2026-04-06 00:02:23.222744 CEST - Status: BOOTING 2026-04-06 00:02:26.044516 CEST - Status: BOOTING 2026-04-06 00:02:28.888974 CEST - Status: BOOTING 2026-04-06 00:02:31.779528 CEST - Status: BOOTING 2026-04-06 00:02:34.598463 CEST - Status: BOOTING 2026-04-06 00:02:37.423457 CEST - Status: BOOTING 2026-04-06 00:02:40.243649 CEST - Status: BOOTING 2026-04-06 00:02:43.070484 CEST - Status: BOOTING 2026-04-06 00:02:45.882356 CEST - Status: BOOTING 2026-04-06 00:02:48.702407 CEST - Status: BOOTING 2026-04-06 00:02:51.532369 CEST - Status: BOOTING 2026-04-06 00:02:54.416795 CEST - Status: BOOTING 2026-04-06 00:02:57.250742 CEST - Status: BOOTING 2026-04-06 00:03:00.068589 CEST - Status: BOOTING 2026-04-06 00:03:02.882897 CEST - Status: BOOTING 2026-04-06 00:03:05.721365 CEST - Status: BOOTING 2026-04-06 00:03:08.547883 CEST - Status: BOOTING 2026-04-06 00:03:11.369647 CEST - Status: BOOTING 2026-04-06 00:03:14.207723 CEST - Status: BOOTING 2026-04-06 00:03:17.034545 CEST - Status: BOOTING 2026-04-06 00:03:19.869410 CEST - Status: BOOTING 2026-04-06 00:03:22.693494 CEST - Status: BOOTING 2026-04-06 00:03:25.521535 CEST - Status: BOOTING 2026-04-06 00:03:28.340563 CEST - Status: BOOTING 2026-04-06 00:03:31.157638 CEST - Status: BOOTING 2026-04-06 00:03:33.977534 CEST - Status: BOOTING 2026-04-06 00:03:36.791003 CEST - Status: BOOTING 2026-04-06 00:03:39.641434 CEST - Status: BOOTING 2026-04-06 00:03:42.467278 CEST - Status: BOOTING 2026-04-06 00:03:45.306528 CEST - Status: BOOTING 2026-04-06 00:03:48.109819 CEST - Status: BOOTING 2026-04-06 00:03:50.917900 CEST - Status: BOOTING 2026-04-06 00:03:53.746403 CEST - Status: BOOTING 2026-04-06 00:03:56.570770 CEST - Status: BOOTING 2026-04-06 00:03:59.392292 CEST - Status: BOOTING 2026-04-06 00:04:02.209148 CEST - Status: BOOTING 2026-04-06 00:04:05.026601 CEST - Status: UP 2026-04-06 00:04:05.026646 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01knftnmjje0sspbgyr7ykjz36 2026-04-06 00:04:05.026678 CEST - Validate resources 2026-04-06 00:04:05.840894 CEST - The fields of the created resource were validated. 2026-04-06 00:04:05.840950 CEST - Check if resources are registered in experiment 2026-04-06 00:04:05.841104 CEST - Run: slices experiment list-resources --format json tst-0e71d169 2026-04-06 00:04:06.466435 CEST - Status (on expauth): UP 2026-04-06 00:04:06.466572 CEST - Testing extend expires_at (all resources in experiment) 2026-04-06 00:04:06.466699 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-0e71d169 2026-04-06 00:04:08.817241 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0e71d169 tst 2026-04-06 00:04:09.642997 CEST - Testing extend expires_at (single resource in experiment) 2026-04-06 00:04:09.643163 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-0e71d169 2026-04-06 00:04:11.977455 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0e71d169 tst 2026-04-06 00:04:12.797774 CEST - Testing ssh login 2026-04-06 00:04:12.807430 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-0e71d169 tst 2026-04-06 00:04:13.747515 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-0e71d169 tst 2026-04-06 00:04:14.686812 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-0e71d169 tst 2026-04-06 00:04:15.645307 CEST - Logging in using 'slices bi ssh' 2026-04-06 00:04:15.645357 CEST - Forcing IPv4 only. 2026-04-06 00:04:15.645522 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-0e71d169 tst -- -4 uname -a 2026-04-06 00:04:20.353543 CEST - Forcing IPv4 only. 2026-04-06 00:04:20.353696 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-0e71d169 tst -- -4 uptime 2026-04-06 00:04:23.013015 CEST - CLI SSH Test passed. 2026-04-06 00:04:23.013057 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-06 00:04:23.013067 CEST - Uptime: 22:04:22 up 1 min, 1 user, load average: 0.70, 0.28, 0.10 2026-04-06 00:04:23.013092 CEST - Logging in using SSH over SSH proxy 2026-04-06 00:04:23.013227 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-0e71d169 tst 2026-04-06 00:04:24.017895 CEST - Added paramiko HostKeyEntry for 10.64.45.186 2026-04-06 00:04:24.017978 CEST - Added paramiko HostKeyEntry for 10.64.45.186 2026-04-06 00:04:24.018105 CEST - Added paramiko HostKeyEntry for 10.64.45.186 2026-04-06 00:04:24.018347 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-06 00:04:24.018424 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-06 00:04:24.018460 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-06 00:04:24.018470 CEST - Connecting to proxy 194.177.207.42:11122 2026-04-06 00:04:24.781896 CEST - Connecting to 10.64.45.186:22 over proxy 2026-04-06 00:04:26.310976 CEST - SSH Test output: 2026-04-06 00:04:26.311016 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-06 00:04:26.311025 CEST - Uptime: 22:04:25 up 1 min, 1 user, load average: 0.65, 0.27, 0.10 2026-04-06 00:04:26.617799 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-06 00:04:26.617845 CEST - lsb_release matches expected value 2026-04-06 00:04:26.617855 CEST - SSH Test passed. 2026-04-06 00:04:26.924551 CEST - Cloud-init user-data: Hello World. The time is now Sun, 05 Apr 2026 22:04:02 +0000! 2026-04-06 00:04:26.930894 CEST - Destroying tst-0e71d169 tst 2026-04-06 00:04:26.931070 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0e71d169 tst