Run Test: slices-bi-singlenode-login 2026-05-29 08:18:19.692369 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-05-29 08:18:22.863473 CEST - Run: slices --version 2026-05-29 08:18:23.077907 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-29 08:18:23.078187 CEST - Run: slices pubkey list --format text 2026-05-29 08:18:23.643309 CEST - Pubkey already registered 2026-05-29 08:18:23.643532 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-05-29 08:18:24.208571 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-05-29 08:18:24.208680 CEST - Check List Flavors 2026-05-29 08:18:24.208870 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-05-29 08:18:25.225092 CEST - Check List DiskImages 2026-05-29 08:18:25.225280 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-05-29 08:18:25.990879 CEST - Requesting resources 2026-05-29 08:18:25.991361 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-05-29 08:18:25.991489 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-25d3b8ed --user-data /tmp/tmpksek0rpq 2026-05-29 08:18:29.914699 CEST - Resource ID: r_gr-volos-bi-vm1_01kss64qdjfs88hfz500bsr0bd 2026-05-29 08:18:29.914826 CEST - Waiting until resource ready 2026-05-29 08:18:31.915279 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-25d3b8ed tst 2026-05-29 08:18:32.781185 CEST - Status: IMAGING 2026-05-29 08:18:35.597383 CEST - Status: IMAGING 2026-05-29 08:18:38.413697 CEST - Status: IMAGING 2026-05-29 08:18:41.280005 CEST - Status: BOOTING 2026-05-29 08:18:44.096151 CEST - Status: BOOTING 2026-05-29 08:18:46.962546 CEST - Status: BOOTING 2026-05-29 08:18:49.828847 CEST - Status: BOOTING 2026-05-29 08:18:52.695121 CEST - Status: BOOTING 2026-05-29 08:18:55.561326 CEST - Status: BOOTING 2026-05-29 08:18:58.427732 CEST - Status: BOOTING 2026-05-29 08:19:01.293958 CEST - Status: BOOTING 2026-05-29 08:19:04.110064 CEST - Status: BOOTING 2026-05-29 08:19:06.976537 CEST - Status: BOOTING 2026-05-29 08:19:09.842835 CEST - Status: BOOTING 2026-05-29 08:19:12.709157 CEST - Status: BOOTING 2026-05-29 08:19:15.525190 CEST - Status: BOOTING 2026-05-29 08:19:18.391397 CEST - Status: BOOTING 2026-05-29 08:19:21.257688 CEST - Status: BOOTING 2026-05-29 08:19:24.174286 CEST - Status: BOOTING 2026-05-29 08:19:27.040586 CEST - Status: BOOTING 2026-05-29 08:19:29.907205 CEST - Status: BOOTING 2026-05-29 08:19:32.824143 CEST - Status: BOOTING 2026-05-29 08:19:35.741087 CEST - Status: BOOTING 2026-05-29 08:19:38.607428 CEST - Status: BOOTING 2026-05-29 08:19:41.473624 CEST - Status: BOOTING 2026-05-29 08:19:44.339844 CEST - Status: BOOTING 2026-05-29 08:19:47.205912 CEST - Status: BOOTING 2026-05-29 08:19:50.072615 CEST - Status: BOOTING 2026-05-29 08:19:52.888781 CEST - Status: BOOTING 2026-05-29 08:19:55.755331 CEST - Status: BOOTING 2026-05-29 08:19:58.621637 CEST - Status: BOOTING 2026-05-29 08:20:01.538438 CEST - Status: BOOTING 2026-05-29 08:20:04.404642 CEST - Status: BOOTING 2026-05-29 08:20:07.321479 CEST - Status: BOOTING 2026-05-29 08:20:10.188111 CEST - Status: BOOTING 2026-05-29 08:20:13.054664 CEST - Status: UP 2026-05-29 08:20:13.054726 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kss64mrpew5v2ddzpdxax1q6 2026-05-29 08:20:13.054763 CEST - Validate resources 2026-05-29 08:20:13.920934 CEST - The fields of the created resource were validated. 2026-05-29 08:20:13.921010 CEST - Check if resources are registered in experiment 2026-05-29 08:20:13.921170 CEST - Run: slices experiment list-resources --format json tst-25d3b8ed 2026-05-29 08:20:14.536499 CEST - Status (on expauth): UP 2026-05-29 08:20:14.536650 CEST - Testing extend expires_at (all resources in experiment) 2026-05-29 08:20:14.536785 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-25d3b8ed 2026-05-29 08:20:17.106525 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-25d3b8ed tst 2026-05-29 08:20:17.922405 CEST - Run: slices experiment list-resources --format json tst-25d3b8ed 2026-05-29 08:20:18.537627 CEST - expires_at (on expauth): 2026-05-29T09:20:00Z (correctly extended) 2026-05-29 08:20:18.537690 CEST - Testing extend expires_at (single resource in experiment) 2026-05-29 08:20:18.537821 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-25d3b8ed 2026-05-29 08:20:21.007265 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-25d3b8ed tst 2026-05-29 08:20:21.823226 CEST - Run: slices experiment list-resources --format json tst-25d3b8ed 2026-05-29 08:20:22.438532 CEST - expires_at (on expauth): 2026-05-29T10:20:00Z (correctly extended) 2026-05-29 08:20:22.438644 CEST - Testing ssh login 2026-05-29 08:20:22.448513 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-25d3b8ed tst 2026-05-29 08:20:23.415030 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-25d3b8ed tst 2026-05-29 08:20:24.382021 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-25d3b8ed tst 2026-05-29 08:20:25.348231 CEST - Logging in using 'slices bi ssh' 2026-05-29 08:20:25.348295 CEST - Forcing IPv4 only. 2026-05-29 08:20:25.348419 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-25d3b8ed tst -- -4 uname -a 2026-05-29 08:20:28.369903 CEST - Forcing IPv4 only. 2026-05-29 08:20:28.370127 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-25d3b8ed tst -- -4 uptime 2026-05-29 08:20:30.940494 CEST - CLI SSH Test passed. 2026-05-29 08:20:30.940551 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-29 08:20:30.940565 CEST - Uptime: 06:20:30 up 1 min, 1 user, load average: 1.74, 0.60, 0.22 2026-05-29 08:20:30.940594 CEST - Logging in using SSH over SSH proxy 2026-05-29 08:20:30.940776 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-25d3b8ed tst 2026-05-29 08:20:31.907185 CEST - Added paramiko HostKeyEntry for 10.64.45.137 2026-05-29 08:20:31.907296 CEST - Added paramiko HostKeyEntry for 10.64.45.137 2026-05-29 08:20:31.907433 CEST - Added paramiko HostKeyEntry for 10.64.45.137 2026-05-29 08:20:31.907708 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-29 08:20:31.907801 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-29 08:20:31.907847 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-05-29 08:20:31.907859 CEST - Connecting to proxy 194.177.207.42:11122 2026-05-29 08:20:32.665016 CEST - Connecting to 10.64.45.137:22 over proxy 2026-05-29 08:20:34.147371 CEST - SSH Test output: 2026-05-29 08:20:34.147421 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-29 08:20:34.147435 CEST - Uptime: 06:20:33 up 1 min, 1 user, load average: 1.60, 0.59, 0.22 2026-05-29 08:20:34.454746 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-05-29 08:20:34.454803 CEST - lsb_release matches expected value 2026-05-29 08:20:34.454816 CEST - SSH Test passed. 2026-05-29 08:20:34.760254 CEST - Cloud-init user-data: Hello World. The time is now Fri, 29 May 2026 06:20:07 +0000! 2026-05-29 08:20:34.767019 CEST - Destroying tst-25d3b8ed tst 2026-05-29 08:20:34.767234 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-25d3b8ed tst