Run Test: slices-bi-singlenode-login 2026-03-27 07:29:37.096691 CET - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-03-27 07:29:41.137218 CET - Run: slices --version 2026-03-27 07:29:41.341694 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-27 07:29:41.341928 CET - Run: slices pubkey list --format text 2026-03-27 07:29:41.936607 CET - Pubkey already registered 2026-03-27 07:29:41.936838 CET - Run: slices bi infrastructure list --format csv --all --refresh 2026-03-27 07:29:42.486520 CET - Refreshed infrastructure list. Total: 22 entries. 2026-03-27 07:29:42.486668 CET - Check List Flavors 2026-03-27 07:29:42.486855 CET - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-03-27 07:29:43.171944 CET - Check List DiskImages 2026-03-27 07:29:43.172118 CET - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-03-27 07:29:43.822592 CET - Requesting resources 2026-03-27 07:29:43.823011 CET - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-03-27 07:29:43.823098 CET - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-2f28bf14 --user-data /tmp/tmpocp9cm6r 2026-03-27 07:29:45.677786 CET - Resource ID: r_fr-sophia2-bi-vm1_01kmpzr2d6ez9tx484y1dhfb0w 2026-03-27 07:29:45.677892 CET - Waiting until resource ready 2026-03-27 07:29:47.678336 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-2f28bf14 tst 2026-03-27 07:29:48.396304 CET - Status: IMAGING 2026-03-27 07:29:51.108967 CET - Status: IMAGING 2026-03-27 07:29:53.833120 CET - Status: IMAGING 2026-03-27 07:29:56.550978 CET - Status: BOOTING 2026-03-27 07:29:59.273201 CET - Status: BOOTING 2026-03-27 07:30:02.009445 CET - Status: BOOTING 2026-03-27 07:30:04.743604 CET - Status: BOOTING 2026-03-27 07:30:07.462535 CET - Status: BOOTING 2026-03-27 07:30:10.194370 CET - Status: BOOTING 2026-03-27 07:30:12.911492 CET - Status: BOOTING 2026-03-27 07:30:15.636065 CET - Status: BOOTING 2026-03-27 07:30:18.366408 CET - Status: BOOTING 2026-03-27 07:30:21.093610 CET - Status: BOOTING 2026-03-27 07:30:23.812160 CET - Status: BOOTING 2026-03-27 07:30:26.539781 CET - Status: BOOTING 2026-03-27 07:30:29.281641 CET - Status: BOOTING 2026-03-27 07:30:32.021735 CET - Status: BOOTING 2026-03-27 07:30:34.764944 CET - Status: BOOTING 2026-03-27 07:30:37.509356 CET - Status: BOOTING 2026-03-27 07:30:40.282268 CET - Status: BOOTING 2026-03-27 07:30:43.041552 CET - Status: BOOTING 2026-03-27 07:30:45.759858 CET - Status: BOOTING 2026-03-27 07:30:48.484298 CET - Status: BOOTING 2026-03-27 07:30:51.214411 CET - Status: BOOTING 2026-03-27 07:30:53.972056 CET - Status: BOOTING 2026-03-27 07:30:56.704676 CET - Status: BOOTING 2026-03-27 07:30:59.445703 CET - Status: BOOTING 2026-03-27 07:31:02.178372 CET - Status: BOOTING 2026-03-27 07:31:05.020281 CET - Status: BOOTING 2026-03-27 07:31:07.869531 CET - Status: BOOTING 2026-03-27 07:31:10.729439 CET - Status: BOOTING 2026-03-27 07:31:13.525569 CET - Status: BOOTING 2026-03-27 07:31:16.263361 CET - Status: BOOTING 2026-03-27 07:31:18.987682 CET - Status: BOOTING 2026-03-27 07:31:21.712222 CET - Status: BOOTING 2026-03-27 07:31:24.435679 CET - Status: BOOTING 2026-03-27 07:31:27.199178 CET - Status: BOOTING 2026-03-27 07:31:29.932970 CET - Status: BOOTING 2026-03-27 07:31:32.648246 CET - Status: UP 2026-03-27 07:31:32.648309 CET - Experiment ID: exp_expauth.ilabt.imec.be_01kmpzr1mme6vrc20w0xdg5zgn 2026-03-27 07:31:32.648351 CET - Validate resources 2026-03-27 07:31:33.341776 CET - The fields of the created resource were validated. 2026-03-27 07:31:33.341848 CET - Check if resources are registered in experiment 2026-03-27 07:31:33.342061 CET - Run: slices experiment list-resources --format json tst-2f28bf14 2026-03-27 07:31:33.958079 CET - Status (on expauth): UP 2026-03-27 07:31:33.958204 CET - Testing extend expires_at (all resources in experiment) 2026-03-27 07:31:33.958329 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-2f28bf14 2026-03-27 07:31:35.811862 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-2f28bf14 tst 2026-03-27 07:31:36.542224 CET - Testing extend expires_at (single resource in experiment) 2026-03-27 07:31:36.542392 CET - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-2f28bf14 2026-03-27 07:31:38.382626 CET - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-2f28bf14 tst 2026-03-27 07:31:39.070676 CET - Testing ssh login 2026-03-27 07:31:39.080260 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-2f28bf14 tst 2026-03-27 07:31:39.924348 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-2f28bf14 tst 2026-03-27 07:31:40.723769 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-2f28bf14 tst 2026-03-27 07:31:41.518576 CET - Logging in using 'slices bi ssh' 2026-03-27 07:31:41.518630 CET - Forcing IPv4 only. 2026-03-27 07:31:41.518772 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-2f28bf14 tst -- -4 uname -a 2026-03-27 07:31:43.863800 CET - Forcing IPv4 only. 2026-03-27 07:31:43.863960 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-2f28bf14 tst -- -4 uptime 2026-03-27 07:31:45.356690 CET - CLI SSH Test passed. 2026-03-27 07:31:45.356748 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-27 07:31:45.356759 CET - Uptime: 06:31:45 up 1 min, 1 user, load average: 0.26, 0.07, 0.02 2026-03-27 07:31:45.356786 CET - Logging in using SSH over SSH proxy 2026-03-27 07:31:45.356928 CET - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-2f28bf14 tst 2026-03-27 07:31:46.160244 CET - Added paramiko HostKeyEntry for 10.123.180.218 2026-03-27 07:31:46.160335 CET - Added paramiko HostKeyEntry for 10.123.180.218 2026-03-27 07:31:46.160494 CET - Added paramiko HostKeyEntry for 10.123.180.218 2026-03-27 07:31:46.160766 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-27 07:31:46.160844 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-27 07:31:46.160878 CET - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-03-27 07:31:46.160889 CET - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-03-27 07:31:46.548211 CET - Connecting to 10.123.180.218:22 over proxy 2026-03-27 07:31:47.207410 CET - SSH Test output: 2026-03-27 07:31:47.207455 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-27 07:31:47.207464 CET - Uptime: 06:31:47 up 1 min, 1 user, load average: 0.24, 0.07, 0.02 2026-03-27 07:31:47.341253 CET - lsb_release: Ubuntu 24.04.3 LTS 2026-03-27 07:31:47.341307 CET - lsb_release matches expected value 2026-03-27 07:31:47.341322 CET - SSH Test passed. 2026-03-27 07:31:47.475098 CET - Cloud-init user-data: Hello World. The time is now Fri, 27 Mar 2026 06:31:30 +0000! 2026-03-27 07:31:47.481465 CET - Destroying tst-2f28bf14 tst 2026-03-27 07:31:47.481626 CET - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-2f28bf14 tst