Run Test: slices-bi-singlenode-login 2026-03-29 17:03:15.812935 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-29 17:03:18.971983 CEST - Run: slices --version 2026-03-29 17:03:19.173207 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.4.1 Slices clientlib bi v5.1.2 2026-03-29 17:03:19.173475 CEST - Run: slices pubkey list --format text 2026-03-29 17:03:19.762280 CEST - Pubkey already registered 2026-03-29 17:03:19.762522 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-29 17:03:20.319412 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-03-29 17:03:20.319506 CEST - Check List Flavors 2026-03-29 17:03:20.319711 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-03-29 17:03:22.249937 CEST - Check List DiskImages 2026-03-29 17:03:22.250125 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-03-29 17:03:22.992095 CEST - Requesting resources 2026-03-29 17:03:22.992609 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-03-29 17:03:22.992755 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-0e76940c --user-data /tmp/tmpu1_d2bgk 2026-03-29 17:03:25.204948 CEST - Resource ID: r_gr-volos-bi-vm1_01kmx1y1jafc9vex1rzmf5x1fa 2026-03-29 17:03:25.205126 CEST - Waiting until resource ready 2026-03-29 17:03:27.205518 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0e76940c tst 2026-03-29 17:03:28.049881 CEST - Status: IMAGING 2026-03-29 17:03:30.882491 CEST - Status: IMAGING 2026-03-29 17:03:33.707490 CEST - Status: IMAGING 2026-03-29 17:03:36.528700 CEST - Status: BOOTING 2026-03-29 17:03:39.346816 CEST - Status: BOOTING 2026-03-29 17:03:42.168285 CEST - Status: BOOTING 2026-03-29 17:03:45.036768 CEST - Status: BOOTING 2026-03-29 17:03:47.862850 CEST - Status: BOOTING 2026-03-29 17:03:50.680766 CEST - Status: BOOTING 2026-03-29 17:03:53.494586 CEST - Status: BOOTING 2026-03-29 17:03:56.318285 CEST - Status: BOOTING 2026-03-29 17:03:59.150942 CEST - Status: BOOTING 2026-03-29 17:04:01.978976 CEST - Status: BOOTING 2026-03-29 17:04:04.801602 CEST - Status: BOOTING 2026-03-29 17:04:07.616956 CEST - Status: BOOTING 2026-03-29 17:04:10.430068 CEST - Status: BOOTING 2026-03-29 17:04:13.246430 CEST - Status: BOOTING 2026-03-29 17:04:16.057732 CEST - Status: BOOTING 2026-03-29 17:04:18.868486 CEST - Status: BOOTING 2026-03-29 17:04:21.680271 CEST - Status: BOOTING 2026-03-29 17:04:24.494041 CEST - Status: BOOTING 2026-03-29 17:04:27.337988 CEST - Status: BOOTING 2026-03-29 17:04:30.147605 CEST - Status: BOOTING 2026-03-29 17:04:32.957124 CEST - Status: BOOTING 2026-03-29 17:04:35.777789 CEST - Status: BOOTING 2026-03-29 17:04:38.590911 CEST - Status: BOOTING 2026-03-29 17:04:41.420097 CEST - Status: BOOTING 2026-03-29 17:04:44.241261 CEST - Status: BOOTING 2026-03-29 17:04:47.068381 CEST - Status: BOOTING 2026-03-29 17:04:49.889094 CEST - Status: BOOTING 2026-03-29 17:04:52.703722 CEST - Status: BOOTING 2026-03-29 17:04:55.539147 CEST - Status: BOOTING 2026-03-29 17:04:58.384149 CEST - Status: BOOTING 2026-03-29 17:05:01.194292 CEST - Status: BOOTING 2026-03-29 17:05:04.029686 CEST - Status: BOOTING 2026-03-29 17:05:06.874263 CEST - Status: BOOTING 2026-03-29 17:05:09.693308 CEST - Status: BOOTING 2026-03-29 17:05:12.515447 CEST - Status: BOOTING 2026-03-29 17:05:15.347969 CEST - Status: UP 2026-03-29 17:05:15.348026 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kmx1y0fzfcbvx3yj8bvhcmpv 2026-03-29 17:05:15.348058 CEST - Validate resources 2026-03-29 17:05:16.191299 CEST - The fields of the created resource were validated. 2026-03-29 17:05:16.191358 CEST - Check if resources are registered in experiment 2026-03-29 17:05:16.191588 CEST - Run: slices experiment list-resources --format json tst-0e76940c 2026-03-29 17:05:16.823763 CEST - Status (on expauth): UP 2026-03-29 17:05:16.823890 CEST - Testing extend expires_at (all resources in experiment) 2026-03-29 17:05:16.824021 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-0e76940c 2026-03-29 17:05:19.136274 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0e76940c tst 2026-03-29 17:05:19.965460 CEST - Testing extend expires_at (single resource in experiment) 2026-03-29 17:05:19.965627 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-0e76940c 2026-03-29 17:05:22.307584 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-0e76940c tst 2026-03-29 17:05:23.130253 CEST - Testing ssh login 2026-03-29 17:05:23.139818 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-0e76940c tst 2026-03-29 17:05:24.100517 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-0e76940c tst 2026-03-29 17:05:25.047248 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-0e76940c tst 2026-03-29 17:05:25.970163 CEST - Logging in using 'slices bi ssh' 2026-03-29 17:05:25.970212 CEST - Forcing IPv4 only. 2026-03-29 17:05:25.970345 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-0e76940c tst -- -4 uname -a 2026-03-29 17:05:30.045286 CEST - Forcing IPv4 only. 2026-03-29 17:05:30.045459 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-0e76940c tst -- -4 uptime 2026-03-29 17:05:32.609232 CEST - CLI SSH Test passed. 2026-03-29 17:05:32.609273 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-03-29 17:05:32.609284 CEST - Uptime: 15:05:32 up 1 min, 1 user, load average: 0.65, 0.25, 0.09 2026-03-29 17:05:32.609310 CEST - Logging in using SSH over SSH proxy 2026-03-29 17:05:32.609463 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-0e76940c tst 2026-03-29 17:05:33.567211 CEST - Added paramiko HostKeyEntry for 10.64.45.145 2026-03-29 17:05:33.567302 CEST - Added paramiko HostKeyEntry for 10.64.45.145 2026-03-29 17:05:33.567445 CEST - Added paramiko HostKeyEntry for 10.64.45.145 2026-03-29 17:05:33.567725 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-29 17:05:33.567801 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-29 17:05:33.567837 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-03-29 17:05:33.567848 CEST - Connecting to proxy 194.177.207.42:11122 2026-03-29 17:05:34.315007 CEST - Connecting to 10.64.45.145:22 over proxy 2026-03-29 17:05:35.834559 CEST - SSH Test output: 2026-03-29 17:05:35.834601 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-03-29 17:05:35.834612 CEST - Uptime: 15:05:35 up 1 min, 1 user, load average: 0.60, 0.25, 0.09 2026-03-29 17:05:36.142390 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-03-29 17:05:36.142446 CEST - lsb_release matches expected value 2026-03-29 17:05:36.142456 CEST - SSH Test passed. 2026-03-29 17:05:36.448395 CEST - Cloud-init user-data: Hello World. The time is now Sun, 29 Mar 2026 15:05:10 +0000! 2026-03-29 17:05:36.454934 CEST - Destroying tst-0e76940c tst 2026-03-29 17:05:36.455088 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-0e76940c tst