Run Test: slices-bi-singlenode-login 2026-06-25 08:27:12.936474 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmpyne7glr7.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-25 08:27:16.759830 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/f4ab3d94-42d2-4abc-908a-1182b5828ce6/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-25 08:27:24.693094 CEST - Run: slices --version 2026-06-25 08:27:24.907506 CEST - version: Slices CLI v2026.1.2 Slices CLI core v1.2.4 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib ai v1.0.0 Slices clientlib core v5.5.1 2026-06-25 08:27:24.907809 CEST - Run: slices pubkey list --format text 2026-06-25 08:27:25.472966 CEST - Pubkey already registered 2026-06-25 08:27:25.473216 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-25 08:27:25.988231 CEST - Refreshed infrastructure list. Total: 24 entries. 2026-06-25 08:27:25.988368 CEST - Check List Flavors 2026-06-25 08:27:25.988545 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-06-25 08:27:26.654083 CEST - Check List DiskImages 2026-06-25 08:27:26.654347 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-06-25 08:27:27.320181 CEST - Requesting resources 2026-06-25 08:27:27.320681 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-25 08:27:27.320881 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-486e6801 --user-data /tmp/tmpcv74a354 2026-06-25 08:27:29.490887 CEST - Resource ID: r_fr-sophia2-bi-vm1_01kvyqck7gf28an2bqjc2ce2xv 2026-06-25 08:27:29.491147 CEST - Waiting until resource ready 2026-06-25 08:27:31.491603 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-486e6801 tst 2026-06-25 08:27:32.257775 CEST - Status: IMAGING 2026-06-25 08:27:34.973619 CEST - Status: BOOTING 2026-06-25 08:27:37.739882 CEST - Status: BOOTING 2026-06-25 08:27:40.455852 CEST - Status: BOOTING 2026-06-25 08:27:43.171738 CEST - Status: BOOTING 2026-06-25 08:27:45.887918 CEST - Status: BOOTING 2026-06-25 08:27:48.704568 CEST - Status: BOOTING 2026-06-25 08:27:51.521220 CEST - Status: BOOTING 2026-06-25 08:27:54.237099 CEST - Status: UP 2026-06-25 08:27:54.237184 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kvyqcjebf4m8rb6192hh01mn 2026-06-25 08:27:54.237224 CEST - Validate resources 2026-06-25 08:27:54.952977 CEST - The fields of the created resource were validated. 2026-06-25 08:27:54.953075 CEST - Check if resources are registered in experiment 2026-06-25 08:27:54.953242 CEST - Run: slices experiment list-resources --format json tst-486e6801 2026-06-25 08:27:55.568493 CEST - Status (on expauth): UP 2026-06-25 08:27:55.568646 CEST - Testing extend expires_at (all resources in experiment) 2026-06-25 08:27:55.568807 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-486e6801 2026-06-25 08:27:57.236467 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-486e6801 tst 2026-06-25 08:27:57.952063 CEST - Run: slices experiment list-resources --format json tst-486e6801 2026-06-25 08:27:58.517341 CEST - expires_at (on expauth): 2026-06-25T09:27:00Z (correctly extended) 2026-06-25 08:27:58.517431 CEST - Testing extend expires_at (single resource in experiment) 2026-06-25 08:27:58.517572 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-486e6801 2026-06-25 08:28:00.335546 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-486e6801 tst 2026-06-25 08:28:01.101668 CEST - Run: slices experiment list-resources --format json tst-486e6801 2026-06-25 08:28:01.767628 CEST - expires_at (on expauth): 2026-06-25T10:27:00Z (correctly extended) 2026-06-25 08:28:01.767773 CEST - Testing ssh login 2026-06-25 08:28:01.778243 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-486e6801 tst 2026-06-25 08:28:02.644296 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-486e6801 tst 2026-06-25 08:28:03.510663 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-486e6801 tst 2026-06-25 08:28:04.376567 CEST - Logging in using 'slices bi ssh' 2026-06-25 08:28:04.376644 CEST - Forcing IPv4 only. 2026-06-25 08:28:04.376827 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-486e6801 tst -- -4 uname -a 2026-06-25 08:28:06.495729 CEST - Forcing IPv4 only. 2026-06-25 08:28:06.495927 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-486e6801 tst -- -4 uptime 2026-06-25 08:28:08.063666 CEST - CLI SSH Test passed. 2026-06-25 08:28:08.063750 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-06-25 08:28:08.063785 CEST - Uptime: 06:28:06 up 0 min, 1 user, load average: 0.26, 0.06, 0.02 2026-06-25 08:28:08.063819 CEST - Logging in using SSH over SSH proxy 2026-06-25 08:28:08.063986 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-486e6801 tst 2026-06-25 08:28:08.930389 CEST - Added paramiko HostKeyEntry for 10.123.163.0 2026-06-25 08:28:08.930610 CEST - Added paramiko HostKeyEntry for 10.123.163.0 2026-06-25 08:28:08.930675 CEST - Added paramiko HostKeyEntry for 10.123.163.0 2026-06-25 08:28:08.930948 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-06-25 08:28:08.931042 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-06-25 08:28:08.931099 CEST - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-06-25 08:28:08.931118 CEST - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-06-25 08:28:09.328018 CEST - Connecting to 10.123.163.0:22 over proxy 2026-06-25 08:28:09.988327 CEST - SSH Test output: 2026-06-25 08:28:09.988397 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-06-25 08:28:09.988414 CEST - Uptime: 06:28:08 up 0 min, 1 user, load average: 0.24, 0.06, 0.02 2026-06-25 08:28:10.123304 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-25 08:28:10.123388 CEST - lsb_release matches expected value 2026-06-25 08:28:10.123407 CEST - SSH Test passed. 2026-06-25 08:28:10.257685 CEST - Cloud-init user-data: Hello World. The time is now Thu, 25 Jun 2026 06:27:52 +0000! 2026-06-25 08:28:10.264145 CEST - Destroying tst-486e6801 tst 2026-06-25 08:28:10.264314 CEST - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-486e6801 tst