Run Test: slices-bi-singlenode-login 2026-03-16 23:28:02.321322 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-16 23:28:05.492036 CET - Run: slices --version 2026-03-16 23:28:05.688741 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-16 23:28:05.688995 CET - Run: slices pubkey list --format text 2026-03-16 23:28:06.279705 CET - Pubkey already registered 2026-03-16 23:28:06.279928 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-16 23:28:06.808938 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-16 23:28:06.809069 CET - Check List Flavors 2026-03-16 23:28:06.809241 CET - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-03-16 23:28:07.550621 CET - Check List DiskImages 2026-03-16 23:28:07.550832 CET - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-03-16 23:28:08.217962 CET - Requesting resources 2026-03-16 23:28:08.218415 CET - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-03-16 23:28:08.218510 CET - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-d37f8947 --user-data /tmp/tmpuru7z_n4 2026-03-16 23:28:10.105403 CET - Resource ID: r_fr-sophia2-bi-vm1_01kkwc722be4g8j6br6v6gzkmr 2026-03-16 23:28:10.105573 CET - Waiting until resource ready 2026-03-16 23:28:12.105951 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-d37f8947 tst 2026-03-16 23:28:12.852561 CET - Status: IMAGING 2026-03-16 23:28:15.584704 CET - Status: IMAGING 2026-03-16 23:28:18.326993 CET - Status: IMAGING 2026-03-16 23:28:21.074632 CET - Status: IMAGING 2026-03-16 23:28:23.823038 CET - Status: IMAGING 2026-03-16 23:28:26.567380 CET - Status: IMAGING 2026-03-16 23:28:29.299390 CET - Status: BOOTING 2026-03-16 23:28:32.033076 CET - Status: BOOTING 2026-03-16 23:28:34.770621 CET - Status: BOOTING 2026-03-16 23:28:37.550824 CET - Status: BOOTING 2026-03-16 23:28:40.290102 CET - Status: BOOTING 2026-03-16 23:28:43.047245 CET - Status: BOOTING 2026-03-16 23:28:45.794207 CET - Status: BOOTING 2026-03-16 23:28:48.548808 CET - Status: BOOTING 2026-03-16 23:28:51.302674 CET - Status: BOOTING 2026-03-16 23:28:54.051172 CET - Status: BOOTING 2026-03-16 23:28:56.798293 CET - Status: BOOTING 2026-03-16 23:28:59.541505 CET - Status: BOOTING 2026-03-16 23:29:02.273025 CET - Status: BOOTING 2026-03-16 23:29:05.005446 CET - Status: BOOTING 2026-03-16 23:29:07.756714 CET - Status: BOOTING 2026-03-16 23:29:10.499929 CET - Status: BOOTING 2026-03-16 23:29:13.196780 CET - Status: UP 2026-03-16 23:29:13.196830 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kkwc7192f88v9agdkht0b1a6 2026-03-16 23:29:13.196876 CET - Validate resources 2026-03-16 23:29:13.891278 CET - The fields of the created resource were validated. 2026-03-16 23:29:13.891336 CET - Check if resources are registered in experiment 2026-03-16 23:29:13.891492 CET - Run: slices experiment list-resources --format json tst-d37f8947 2026-03-16 23:29:14.516095 CET - Status (on expauth): UP 2026-03-16 23:29:14.516220 CET - Testing extend expires_at (all resources in experiment) 2026-03-16 23:29:14.516348 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-d37f8947 2026-03-16 23:29:16.213356 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-d37f8947 tst 2026-03-16 23:29:16.910553 CET - Testing extend expires_at (single resource in experiment) 2026-03-16 23:29:16.910718 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-d37f8947 2026-03-16 23:29:18.585709 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-d37f8947 tst 2026-03-16 23:29:19.290630 CET - Testing ssh login 2026-03-16 23:29:19.300999 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d37f8947 tst 2026-03-16 23:29:20.127614 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d37f8947 tst 2026-03-16 23:29:20.954992 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d37f8947 tst 2026-03-16 23:29:21.805331 CET - Logging in using 'slices bi ssh' 2026-03-16 23:29:21.805382 CET - Forcing IPv4 only. 2026-03-16 23:29:21.805517 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-d37f8947 tst -- -4 uname -a 2026-03-16 23:29:24.487001 CET - Forcing IPv4 only. 2026-03-16 23:29:24.487145 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-d37f8947 tst -- -4 uptime 2026-03-16 23:29:26.032389 CET - CLI SSH Test passed. 2026-03-16 23:29:26.032430 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-16 23:29:26.032440 CET - Uptime: 22:29:26 up 0 min, 1 user, load average: 0.66, 0.21, 0.07 2026-03-16 23:29:26.032464 CET - Logging in using SSH over SSH proxy 2026-03-16 23:29:26.032599 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d37f8947 tst 2026-03-16 23:29:26.852264 CET - Added paramiko HostKeyEntry for 10.123.7.42 2026-03-16 23:29:26.852359 CET - Added paramiko HostKeyEntry for 10.123.7.42 2026-03-16 23:29:26.852511 CET - Added paramiko HostKeyEntry for 10.123.7.42 2026-03-16 23:29:26.852792 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-16 23:29:26.852887 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-16 23:29:26.852922 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-16 23:29:26.852931 CET - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-03-16 23:29:27.239933 CET - Connecting to 10.123.7.42:22 over proxy 2026-03-16 23:29:27.930682 CET - SSH Test output: 2026-03-16 23:29:27.930732 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-16 23:29:27.930746 CET - Uptime: 22:29:27 up 0 min, 1 user, load average: 0.66, 0.21, 0.07 2026-03-16 23:29:28.065537 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-03-16 23:29:28.065592 CET - lsb_release matches expected value 2026-03-16 23:29:28.065606 CET - SSH Test passed. 2026-03-16 23:29:28.200152 CET - Cloud-init user-data: Hello World. The time is now Mon, 16 Mar 2026 22:29:09 +0000! 2026-03-16 23:29:28.206249 CET - Destroying tst-d37f8947 tst 2026-03-16 23:29:28.206396 CET - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-d37f8947 tst