Run Test: slices-bi-singlenode-login 2026-03-12 17:03:47.539503 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-12 17:03:50.683811 CET - Run: slices --version 2026-03-12 17:03:50.869414 CET - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.3.8 Slices clientlib bi v5.1.2 2026-03-12 17:03:50.869661 CET - Run: slices pubkey list --format text 2026-03-12 17:03:51.460800 CET - Pubkey already registered 2026-03-12 17:03:51.461018 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-12 17:03:51.967334 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-12 17:03:51.967432 CET - Check List Flavors 2026-03-12 17:03:51.967646 CET - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-03-12 17:03:52.718138 CET - Check List DiskImages 2026-03-12 17:03:52.718339 CET - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-03-12 17:03:53.359203 CET - Requesting resources 2026-03-12 17:03:53.359705 CET - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-03-12 17:03:53.359800 CET - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-decd1ca7 --user-data /tmp/tmp_h5tkuhh 2026-03-12 17:03:55.221247 CET - Resource ID: r_fr-sophia2-bi-vm1_01kkhcmkh4ehrtmbfyy84q3a10 2026-03-12 17:03:55.221372 CET - Waiting until resource ready 2026-03-12 17:03:57.221780 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-decd1ca7 tst 2026-03-12 17:03:57.962667 CET - Status: IMAGING 2026-03-12 17:04:00.706423 CET - Status: IMAGING 2026-03-12 17:04:03.426565 CET - Status: IMAGING 2026-03-12 17:04:06.145541 CET - Status: IMAGING 2026-03-12 17:04:08.866449 CET - Status: IMAGING 2026-03-12 17:04:11.593635 CET - Status: BOOTING 2026-03-12 17:04:14.341462 CET - Status: BOOTING 2026-03-12 17:04:17.065716 CET - Status: BOOTING 2026-03-12 17:04:19.834948 CET - Status: BOOTING 2026-03-12 17:04:22.563093 CET - Status: BOOTING 2026-03-12 17:04:25.297927 CET - Status: BOOTING 2026-03-12 17:04:28.029053 CET - Status: BOOTING 2026-03-12 17:04:30.749587 CET - Status: BOOTING 2026-03-12 17:04:33.477590 CET - Status: BOOTING 2026-03-12 17:04:36.239489 CET - Status: BOOTING 2026-03-12 17:04:38.974492 CET - Status: BOOTING 2026-03-12 17:04:41.695567 CET - Status: BOOTING 2026-03-12 17:04:44.424870 CET - Status: BOOTING 2026-03-12 17:04:47.167869 CET - Status: BOOTING 2026-03-12 17:04:49.880330 CET - Status: BOOTING 2026-03-12 17:04:52.614751 CET - Status: BOOTING 2026-03-12 17:04:55.303343 CET - Status: UP 2026-03-12 17:04:55.303386 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kkhcmjqefmst9c1s6txbgyay 2026-03-12 17:04:55.303420 CET - Validate resources 2026-03-12 17:04:55.979192 CET - The fields of the created resource were validated. 2026-03-12 17:04:55.979250 CET - Check if resources are registered in experiment 2026-03-12 17:04:55.979432 CET - Run: slices experiment list-resources --format json tst-decd1ca7 2026-03-12 17:04:56.602037 CET - Status (on expauth): UP 2026-03-12 17:04:56.602173 CET - Testing extend expires_at (all resources in experiment) 2026-03-12 17:04:56.602337 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-decd1ca7 2026-03-12 17:04:58.378526 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-decd1ca7 tst 2026-03-12 17:04:59.054758 CET - Testing extend expires_at (single resource in experiment) 2026-03-12 17:04:59.054924 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-decd1ca7 2026-03-12 17:05:00.775541 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-decd1ca7 tst 2026-03-12 17:05:01.452589 CET - Testing ssh login 2026-03-12 17:05:01.462056 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-decd1ca7 tst 2026-03-12 17:05:02.259431 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-decd1ca7 tst 2026-03-12 17:05:03.049963 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-decd1ca7 tst 2026-03-12 17:05:03.852149 CET - Logging in using 'slices bi ssh' 2026-03-12 17:05:03.852201 CET - Forcing IPv4 only. 2026-03-12 17:05:03.852356 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-decd1ca7 tst -- -4 uname -a 2026-03-12 17:05:06.766878 CET - Forcing IPv4 only. 2026-03-12 17:05:06.767041 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-decd1ca7 tst -- -4 uptime 2026-03-12 17:05:08.319151 CET - CLI SSH Test passed. 2026-03-12 17:05:08.319201 CET - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-03-12 17:05:08.319211 CET - Uptime: 16:05:08 up 0 min, 1 user, load average: 0.60, 0.19, 0.07 2026-03-12 17:05:08.319237 CET - Logging in using SSH over SSH proxy 2026-03-12 17:05:08.319386 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-decd1ca7 tst 2026-03-12 17:05:09.174437 CET - Added paramiko HostKeyEntry for 10.123.68.63 2026-03-12 17:05:09.174547 CET - Added paramiko HostKeyEntry for 10.123.68.63 2026-03-12 17:05:09.174686 CET - Added paramiko HostKeyEntry for 10.123.68.63 2026-03-12 17:05:09.174938 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-12 17:05:09.175012 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-12 17:05:09.175046 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-12 17:05:09.175055 CET - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-03-12 17:05:09.596571 CET - Connecting to 10.123.68.63:22 over proxy 2026-03-12 17:05:10.288097 CET - SSH Test output: 2026-03-12 17:05:10.288145 CET - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-03-12 17:05:10.288155 CET - Uptime: 16:05:10 up 0 min, 1 user, load average: 0.60, 0.19, 0.07 2026-03-12 17:05:10.426289 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-03-12 17:05:10.426341 CET - lsb_release matches expected value 2026-03-12 17:05:10.426359 CET - SSH Test passed. 2026-03-12 17:05:10.565321 CET - Cloud-init user-data: Hello World. The time is now Thu, 12 Mar 2026 16:04:50 +0000! 2026-03-12 17:05:10.571700 CET - Destroying tst-decd1ca7 tst 2026-03-12 17:05:10.571855 CET - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-decd1ca7 tst