Run Test: slices-bi-singlenode-login 2026-04-03 00:28:32.321318 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-03 00:28:35.450808 CEST - Run: slices --version 2026-04-03 00:28:35.648936 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-03 00:28:35.649171 CEST - Run: slices pubkey list --format text 2026-04-03 00:28:36.235288 CEST - Pubkey already registered 2026-04-03 00:28:36.235499 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-03 00:28:36.826673 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-03 00:28:36.826815 CEST - Check List Flavors 2026-04-03 00:28:36.826981 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-04-03 00:28:37.619305 CEST - Check List DiskImages 2026-04-03 00:28:37.619493 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-04-03 00:28:38.363872 CEST - Requesting resources 2026-04-03 00:28:38.364324 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-04-03 00:28:38.364412 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-d454ccfc --user-data /tmp/tmprtcef05n 2026-04-03 00:28:40.231660 CEST - Resource ID: r_fr-sophia2-bi-vm1_01kn8506ese4s8sqfy5nnfmwwx 2026-04-03 00:28:40.231849 CEST - Waiting until resource ready 2026-04-03 00:28:42.232331 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-d454ccfc tst 2026-04-03 00:28:43.039062 CEST - Status: IMAGING 2026-04-03 00:28:45.830222 CEST - Status: IMAGING 2026-04-03 00:28:48.616734 CEST - Status: IMAGING 2026-04-03 00:28:51.366765 CEST - Status: BOOTING 2026-04-03 00:28:54.105692 CEST - Status: BOOTING 2026-04-03 00:28:56.855181 CEST - Status: BOOTING 2026-04-03 00:28:59.588442 CEST - Status: BOOTING 2026-04-03 00:29:02.324792 CEST - Status: BOOTING 2026-04-03 00:29:05.063072 CEST - Status: BOOTING 2026-04-03 00:29:07.811177 CEST - Status: BOOTING 2026-04-03 00:29:10.553607 CEST - Status: BOOTING 2026-04-03 00:29:13.294015 CEST - Status: BOOTING 2026-04-03 00:29:16.041855 CEST - Status: BOOTING 2026-04-03 00:29:18.778563 CEST - Status: BOOTING 2026-04-03 00:29:21.518391 CEST - Status: BOOTING 2026-04-03 00:29:24.254799 CEST - Status: BOOTING 2026-04-03 00:29:26.990971 CEST - Status: BOOTING 2026-04-03 00:29:29.726222 CEST - Status: BOOTING 2026-04-03 00:29:32.456396 CEST - Status: BOOTING 2026-04-03 00:29:35.220545 CEST - Status: BOOTING 2026-04-03 00:29:37.945508 CEST - Status: BOOTING 2026-04-03 00:29:40.679019 CEST - Status: BOOTING 2026-04-03 00:29:43.409218 CEST - Status: BOOTING 2026-04-03 00:29:46.148545 CEST - Status: BOOTING 2026-04-03 00:29:48.974394 CEST - Status: BOOTING 2026-04-03 00:29:51.707627 CEST - Status: BOOTING 2026-04-03 00:29:54.437559 CEST - Status: BOOTING 2026-04-03 00:29:57.241878 CEST - Status: BOOTING 2026-04-03 00:29:59.994321 CEST - Status: BOOTING 2026-04-03 00:30:02.739618 CEST - Status: BOOTING 2026-04-03 00:30:05.483315 CEST - Status: BOOTING 2026-04-03 00:30:08.225190 CEST - Status: BOOTING 2026-04-03 00:30:10.991498 CEST - Status: BOOTING 2026-04-03 00:30:13.743210 CEST - Status: BOOTING 2026-04-03 00:30:16.531365 CEST - Status: BOOTING 2026-04-03 00:30:19.267483 CEST - Status: BOOTING 2026-04-03 00:30:22.030181 CEST - Status: BOOTING 2026-04-03 00:30:24.781068 CEST - Status: BOOTING 2026-04-03 00:30:27.471497 CEST - Status: UP 2026-04-03 00:30:27.471539 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kn8505qhewwr2ngggc9dm2ey 2026-04-03 00:30:27.471568 CEST - Validate resources 2026-04-03 00:30:28.166634 CEST - The fields of the created resource were validated. 2026-04-03 00:30:28.166690 CEST - Check if resources are registered in experiment 2026-04-03 00:30:28.166857 CEST - Run: slices experiment list-resources --format json tst-d454ccfc 2026-04-03 00:30:28.791320 CEST - Status (on expauth): UP 2026-04-03 00:30:28.791449 CEST - Testing extend expires_at (all resources in experiment) 2026-04-03 00:30:28.791583 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-d454ccfc 2026-04-03 00:30:30.542761 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-d454ccfc tst 2026-04-03 00:30:31.251855 CEST - Testing extend expires_at (single resource in experiment) 2026-04-03 00:30:31.252020 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-d454ccfc 2026-04-03 00:30:33.002980 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-d454ccfc tst 2026-04-03 00:30:33.690303 CEST - Testing ssh login 2026-04-03 00:30:33.700199 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d454ccfc tst 2026-04-03 00:30:34.518074 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d454ccfc tst 2026-04-03 00:30:35.358154 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d454ccfc tst 2026-04-03 00:30:36.191947 CEST - Logging in using 'slices bi ssh' 2026-04-03 00:30:36.192000 CEST - Forcing IPv4 only. 2026-04-03 00:30:36.192134 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-d454ccfc tst -- -4 uname -a 2026-04-03 00:30:38.199898 CEST - Forcing IPv4 only. 2026-04-03 00:30:38.200052 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-d454ccfc tst -- -4 uptime 2026-04-03 00:30:39.708337 CEST - CLI SSH Test passed. 2026-04-03 00:30:39.708378 CEST - 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-04-03 00:30:39.708388 CEST - Uptime: 22:30:39 up 1 min, 1 user, load average: 0.24, 0.09, 0.03 2026-04-03 00:30:39.708414 CEST - Logging in using SSH over SSH proxy 2026-04-03 00:30:39.708554 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d454ccfc tst 2026-04-03 00:30:40.536992 CEST - Added paramiko HostKeyEntry for 10.123.65.35 2026-04-03 00:30:40.537094 CEST - Added paramiko HostKeyEntry for 10.123.65.35 2026-04-03 00:30:40.537243 CEST - Added paramiko HostKeyEntry for 10.123.65.35 2026-04-03 00:30:40.537501 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-04-03 00:30:40.537576 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-04-03 00:30:40.537611 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-04-03 00:30:40.537621 CEST - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-04-03 00:30:40.928640 CEST - Connecting to 10.123.65.35:22 over proxy 2026-04-03 00:30:41.601727 CEST - SSH Test output: 2026-04-03 00:30:41.601776 CEST - 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-04-03 00:30:41.601787 CEST - Uptime: 22:30:41 up 1 min, 1 user, load average: 0.22, 0.09, 0.03 2026-04-03 00:30:41.740298 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-03 00:30:41.740347 CEST - lsb_release matches expected value 2026-04-03 00:30:41.740357 CEST - SSH Test passed. 2026-04-03 00:30:41.878904 CEST - Cloud-init user-data: Hello World. The time is now Thu, 02 Apr 2026 22:30:24 +0000! 2026-04-03 00:30:41.885362 CEST - Destroying tst-d454ccfc tst 2026-04-03 00:30:41.885524 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-d454ccfc tst