Run Test: slices-bi-singlenode-login 2026-04-28 08:08:30.878949 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-28 08:08:34.049425 CEST - Run: slices --version 2026-04-28 08:08:34.263759 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-28 08:08:34.264005 CEST - Run: slices pubkey list --format text 2026-04-28 08:08:34.778760 CEST - Pubkey already registered 2026-04-28 08:08:34.779021 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-28 08:08:35.293782 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-28 08:08:35.293885 CEST - Check List Flavors 2026-04-28 08:08:35.294039 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-04-28 08:08:36.360047 CEST - Check List DiskImages 2026-04-28 08:08:36.360231 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-04-28 08:08:37.075637 CEST - Requesting resources 2026-04-28 08:08:37.076100 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-28 08:08:37.076198 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-b6b5a38e --user-data /tmp/tmp420epzl3 2026-04-28 08:08:40.897891 CEST - Resource ID: r_gr-volos-bi-vm1_01kq9b8f6ce7sbvj0mmwh87ecj 2026-04-28 08:08:40.898008 CEST - Waiting until resource ready 2026-04-28 08:08:42.898385 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-b6b5a38e tst 2026-04-28 08:08:43.713964 CEST - Status: IMAGING 2026-04-28 08:08:46.529899 CEST - Status: IMAGING 2026-04-28 08:08:49.345936 CEST - Status: IMAGING 2026-04-28 08:08:52.161943 CEST - Status: BOOTING 2026-04-28 08:08:54.977841 CEST - Status: BOOTING 2026-04-28 08:08:57.793795 CEST - Status: BOOTING 2026-04-28 08:09:00.609698 CEST - Status: BOOTING 2026-04-28 08:09:03.425284 CEST - Status: BOOTING 2026-04-28 08:09:06.241284 CEST - Status: BOOTING 2026-04-28 08:09:09.057102 CEST - Status: BOOTING 2026-04-28 08:09:11.872897 CEST - Status: BOOTING 2026-04-28 08:09:14.688671 CEST - Status: BOOTING 2026-04-28 08:09:17.504592 CEST - Status: BOOTING 2026-04-28 08:09:20.320574 CEST - Status: BOOTING 2026-04-28 08:09:23.136426 CEST - Status: BOOTING 2026-04-28 08:09:25.952333 CEST - Status: BOOTING 2026-04-28 08:09:28.768100 CEST - Status: BOOTING 2026-04-28 08:09:31.584012 CEST - Status: BOOTING 2026-04-28 08:09:34.399674 CEST - Status: BOOTING 2026-04-28 08:09:37.215611 CEST - Status: BOOTING 2026-04-28 08:09:40.031431 CEST - Status: BOOTING 2026-04-28 08:09:42.847203 CEST - Status: BOOTING 2026-04-28 08:09:45.663065 CEST - Status: BOOTING 2026-04-28 08:09:48.478957 CEST - Status: BOOTING 2026-04-28 08:09:51.295010 CEST - Status: BOOTING 2026-04-28 08:09:54.110794 CEST - Status: BOOTING 2026-04-28 08:09:56.926729 CEST - Status: BOOTING 2026-04-28 08:09:59.742736 CEST - Status: BOOTING 2026-04-28 08:10:02.558662 CEST - Status: BOOTING 2026-04-28 08:10:05.374625 CEST - Status: BOOTING 2026-04-28 08:10:08.190570 CEST - Status: BOOTING 2026-04-28 08:10:11.006527 CEST - Status: BOOTING 2026-04-28 08:10:13.822699 CEST - Status: BOOTING 2026-04-28 08:10:16.638969 CEST - Status: BOOTING 2026-04-28 08:10:19.454793 CEST - Status: BOOTING 2026-04-28 08:10:22.270561 CEST - Status: BOOTING 2026-04-28 08:10:25.136510 CEST - Status: UP 2026-04-28 08:10:25.136581 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kq9b8cjvf9ks86pthm35b4vz 2026-04-28 08:10:25.136626 CEST - Validate resources 2026-04-28 08:10:25.952555 CEST - The fields of the created resource were validated. 2026-04-28 08:10:25.952621 CEST - Check if resources are registered in experiment 2026-04-28 08:10:25.952806 CEST - Run: slices experiment list-resources --format json tst-b6b5a38e 2026-04-28 08:10:26.517757 CEST - Status (on expauth): UP 2026-04-28 08:10:26.517894 CEST - Testing extend expires_at (all resources in experiment) 2026-04-28 08:10:26.518018 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-b6b5a38e 2026-04-28 08:10:29.137023 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-b6b5a38e tst 2026-04-28 08:10:29.952444 CEST - Testing extend expires_at (single resource in experiment) 2026-04-28 08:10:29.952607 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-b6b5a38e 2026-04-28 08:10:32.271407 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-b6b5a38e tst 2026-04-28 08:10:33.087203 CEST - Testing ssh login 2026-04-28 08:10:33.097828 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-b6b5a38e tst 2026-04-28 08:10:34.063873 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-b6b5a38e tst 2026-04-28 08:10:35.080129 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-b6b5a38e tst 2026-04-28 08:10:36.095983 CEST - Logging in using 'slices bi ssh' 2026-04-28 08:10:36.096048 CEST - Forcing IPv4 only. 2026-04-28 08:10:36.096170 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-b6b5a38e tst -- -4 uname -a 2026-04-28 08:10:39.066108 CEST - Forcing IPv4 only. 2026-04-28 08:10:39.066270 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-b6b5a38e tst -- -4 uptime 2026-04-28 08:10:41.585081 CEST - CLI SSH Test passed. 2026-04-28 08:10:41.585131 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-28 08:10:41.585145 CEST - Uptime: 06:10:41 up 1 min, 2 users, load average: 1.37, 0.51, 0.18 2026-04-28 08:10:41.585174 CEST - Logging in using SSH over SSH proxy 2026-04-28 08:10:41.585311 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-b6b5a38e tst 2026-04-28 08:10:42.551402 CEST - Added paramiko HostKeyEntry for 10.64.45.222 2026-04-28 08:10:42.551505 CEST - Added paramiko HostKeyEntry for 10.64.45.222 2026-04-28 08:10:42.551640 CEST - Added paramiko HostKeyEntry for 10.64.45.222 2026-04-28 08:10:42.551922 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-28 08:10:42.552008 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-28 08:10:42.552044 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-28 08:10:42.552055 CEST - Connecting to proxy 194.177.207.42:11122 2026-04-28 08:10:43.289866 CEST - Connecting to 10.64.45.222:22 over proxy 2026-04-28 08:10:44.769763 CEST - SSH Test output: 2026-04-28 08:10:44.769878 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-28 08:10:44.769891 CEST - Uptime: 06:10:44 up 1 min, 1 user, load average: 1.37, 0.51, 0.18 2026-04-28 08:10:45.073588 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-28 08:10:45.073640 CEST - lsb_release matches expected value 2026-04-28 08:10:45.073652 CEST - SSH Test passed. 2026-04-28 08:10:45.379313 CEST - Cloud-init user-data: Hello World. The time is now Tue, 28 Apr 2026 06:10:20 +0000! 2026-04-28 08:10:45.385574 CEST - Destroying tst-b6b5a38e tst 2026-04-28 08:10:45.385740 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-b6b5a38e tst