Run Test: slices-bi-singlenode-login 2026-04-02 00:03:30.906155 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-02 00:03:34.174637 CEST - Run: slices --version 2026-04-02 00:03:34.377524 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-02 00:03:34.377768 CEST - Run: slices pubkey list --format text 2026-04-02 00:03:34.947771 CEST - Pubkey already registered 2026-04-02 00:03:34.948036 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-02 00:03:35.469261 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-02 00:03:35.469365 CEST - Check List Flavors 2026-04-02 00:03:35.469590 CEST - Run: slices bi --infra gr-volos-bi-vm1 flavor list -f json 2026-04-02 00:03:36.415859 CEST - Check List DiskImages 2026-04-02 00:03:36.416043 CEST - Run: slices bi --infra gr-volos-bi-vm1 diskimage list -f json 2026-04-02 00:03:37.148593 CEST - Requesting resources 2026-04-02 00:03:37.149044 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-02 00:03:37.149148 CEST - Run: slices bi --infra gr-volos-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-e77f70e5 --user-data /tmp/tmp8la2x491 2026-04-02 00:03:41.533050 CEST - Resource ID: r_gr-volos-bi-vm1_01kn5h5qw3eqhbspjk9xkb90yy 2026-04-02 00:03:41.533226 CEST - Waiting until resource ready 2026-04-02 00:03:43.533619 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-e77f70e5 tst 2026-04-02 00:03:44.360629 CEST - Status: IMAGING 2026-04-02 00:03:47.171780 CEST - Status: IMAGING 2026-04-02 00:03:50.028412 CEST - Status: IMAGING 2026-04-02 00:03:52.832315 CEST - Status: BOOTING 2026-04-02 00:03:55.663176 CEST - Status: BOOTING 2026-04-02 00:03:58.479140 CEST - Status: BOOTING 2026-04-02 00:04:01.294275 CEST - Status: BOOTING 2026-04-02 00:04:04.132051 CEST - Status: BOOTING 2026-04-02 00:04:07.008017 CEST - Status: BOOTING 2026-04-02 00:04:09.861028 CEST - Status: BOOTING 2026-04-02 00:04:12.709140 CEST - Status: BOOTING 2026-04-02 00:04:15.548048 CEST - Status: BOOTING 2026-04-02 00:04:18.384145 CEST - Status: BOOTING 2026-04-02 00:04:21.203050 CEST - Status: BOOTING 2026-04-02 00:04:24.026044 CEST - Status: BOOTING 2026-04-02 00:04:26.849556 CEST - Status: BOOTING 2026-04-02 00:04:29.679930 CEST - Status: BOOTING 2026-04-02 00:04:32.499683 CEST - Status: BOOTING 2026-04-02 00:04:35.317503 CEST - Status: BOOTING 2026-04-02 00:04:38.122859 CEST - Status: BOOTING 2026-04-02 00:04:40.953690 CEST - Status: BOOTING 2026-04-02 00:04:43.757093 CEST - Status: BOOTING 2026-04-02 00:04:46.577224 CEST - Status: BOOTING 2026-04-02 00:04:49.385144 CEST - Status: BOOTING 2026-04-02 00:04:52.202291 CEST - Status: BOOTING 2026-04-02 00:04:55.063784 CEST - Status: BOOTING 2026-04-02 00:04:57.898245 CEST - Status: BOOTING 2026-04-02 00:05:00.744745 CEST - Status: BOOTING 2026-04-02 00:05:03.570004 CEST - Status: BOOTING 2026-04-02 00:05:06.390232 CEST - Status: BOOTING 2026-04-02 00:05:09.234841 CEST - Status: BOOTING 2026-04-02 00:05:12.042535 CEST - Status: BOOTING 2026-04-02 00:05:14.865971 CEST - Status: BOOTING 2026-04-02 00:05:17.679243 CEST - Status: BOOTING 2026-04-02 00:05:20.485463 CEST - Status: BOOTING 2026-04-02 00:05:23.287463 CEST - Status: BOOTING 2026-04-02 00:05:26.090938 CEST - Status: BOOTING 2026-04-02 00:05:28.923529 CEST - Status: BOOTING 2026-04-02 00:05:31.748779 CEST - Status: BOOTING 2026-04-02 00:05:34.566896 CEST - Status: UP 2026-04-02 00:05:34.566939 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kn5h5mnef0pbp2n0cktmhye0 2026-04-02 00:05:34.566971 CEST - Validate resources 2026-04-02 00:05:35.393876 CEST - The fields of the created resource were validated. 2026-04-02 00:05:35.393936 CEST - Check if resources are registered in experiment 2026-04-02 00:05:35.394102 CEST - Run: slices experiment list-resources --format json tst-e77f70e5 2026-04-02 00:05:36.013215 CEST - Status (on expauth): UP 2026-04-02 00:05:36.013342 CEST - Testing extend expires_at (all resources in experiment) 2026-04-02 00:05:36.013489 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend --duration 3h --experiment tst-e77f70e5 2026-04-02 00:05:38.293119 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-e77f70e5 tst 2026-04-02 00:05:39.117820 CEST - Testing extend expires_at (single resource in experiment) 2026-04-02 00:05:39.117995 CEST - Run: slices bi --infra gr-volos-bi-vm1 extend tst --duration 4h --experiment tst-e77f70e5 2026-04-02 00:05:41.397294 CEST - Run: slices bi --infra gr-volos-bi-vm1 list-resources --format json --experiment tst-e77f70e5 tst 2026-04-02 00:05:42.212528 CEST - Testing ssh login 2026-04-02 00:05:42.222100 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-e77f70e5 tst 2026-04-02 00:05:43.156923 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-e77f70e5 tst 2026-04-02 00:05:44.089230 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-e77f70e5 tst 2026-04-02 00:05:45.028345 CEST - Logging in using 'slices bi ssh' 2026-04-02 00:05:45.028398 CEST - Forcing IPv4 only. 2026-04-02 00:05:45.028562 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-e77f70e5 tst -- -4 uname -a 2026-04-02 00:05:48.095796 CEST - Forcing IPv4 only. 2026-04-02 00:05:48.095943 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --show nothing --experiment tst-e77f70e5 tst -- -4 uptime 2026-04-02 00:05:50.722320 CEST - CLI SSH Test passed. 2026-04-02 00:05:50.722361 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-02 00:05:50.722372 CEST - Uptime: 22:05:50 up 1 min, 1 user, load average: 1.30, 0.80, 0.31 2026-04-02 00:05:50.722400 CEST - Logging in using SSH over SSH proxy 2026-04-02 00:05:50.722555 CEST - Run: slices bi --infra gr-volos-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-e77f70e5 tst 2026-04-02 00:05:51.670629 CEST - Added paramiko HostKeyEntry for 10.64.45.99 2026-04-02 00:05:51.670717 CEST - Added paramiko HostKeyEntry for 10.64.45.99 2026-04-02 00:05:51.670846 CEST - Added paramiko HostKeyEntry for 10.64.45.99 2026-04-02 00:05:51.671086 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-02 00:05:51.671160 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-02 00:05:51.671192 CEST - Added paramiko HostKeyEntry for [194.177.207.42]:11122 2026-04-02 00:05:51.671202 CEST - Connecting to proxy 194.177.207.42:11122 2026-04-02 00:05:52.411671 CEST - Connecting to 10.64.45.99:22 over proxy 2026-04-02 00:05:53.896365 CEST - SSH Test output: 2026-04-02 00:05:53.896403 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-02 00:05:53.896413 CEST - Uptime: 22:05:53 up 1 min, 1 user, load average: 1.30, 0.80, 0.31 2026-04-02 00:05:54.202096 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-02 00:05:54.202143 CEST - lsb_release matches expected value 2026-04-02 00:05:54.202153 CEST - SSH Test passed. 2026-04-02 00:05:54.507286 CEST - Cloud-init user-data: Hello World. The time is now Wed, 01 Apr 2026 22:05:31 +0000! 2026-04-02 00:05:54.513893 CEST - Destroying tst-e77f70e5 tst 2026-04-02 00:05:54.514070 CEST - Run: slices bi --infra gr-volos-bi-vm1 destroy --experiment tst-e77f70e5 tst