Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.27s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 188ms warning: Failed to hardlink files; falling back to full copy. This may lead to degraded performance. If the cache and target directories are on different filesystems, hardlinking may not be supported. If this is intentional, set `export UV_LINK_MODE=copy` or use `--link-mode=copy` to suppress this warning. Installed 32 packages in 220ms + annotated-types==0.7.0 + anyio==4.14.1 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.6.17 + cffi==2.1.0 + cryptography==49.0.0 + dnspython==2.8.0 + h11==0.16.0 + httpcore==1.0.9 + httpx==0.28.1 + httpx-oauth==0.17.0 + idna==3.18 + invoke==3.0.3 + joserfc==1.7.3 + msgspec==0.21.1 + packaging==26.2 + paramiko==4.0.0 + pycparser==3.0 + pydantic==2.13.4 + pydantic-core==2.46.4 + pyjwt==2.13.0 + pynacl==1.6.2 + pytz==2026.2 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev179+g419876b58 (from file:///app) + tomli-w==1.2.0 + tomlkit==0.15.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-08 15:00:41.839993 UTC - Installing Slices CLI (latest stable version). 2026-07-08 15:00:41.840290 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-08 15:00:48.771937 UTC - Slices CLI installed. 2026-07-08 15:00:48.772173 UTC - Slices CLI exe: 'slices' 2026-07-08 15:00:48.772209 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-08 15:00:48.772391 UTC - Run: slices --version 2026-07-08 15:00:51.504824 UTC - 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-07-08 15:00:51.505168 UTC - Run: slices pubkey list --format text 2026-07-08 15:00:52.571146 UTC - Pubkey already registered 2026-07-08 15:00:52.571440 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-08 15:00:53.186697 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-08 15:00:53.186799 UTC - Check List Flavors 2026-07-08 15:00:53.186959 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 flavor list -f json 2026-07-08 15:00:54.754391 UTC - Check List DiskImages 2026-07-08 15:00:54.754593 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 diskimage list -f json 2026-07-08 15:00:55.470205 UTC - Requesting resources 2026-07-08 15:00:55.471080 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-407e9088 2026-07-08 15:00:58.040657 UTC - Resource ID: r_fr-sophia2-bi-vm2_01kx13y4vpesgrgnctxbwq31gv 2026-07-08 15:00:58.040827 UTC - Waiting until resource ready 2026-07-08 15:01:00.041266 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-407e9088 tst 2026-07-08 15:01:00.912378 UTC - Status: IMAGING 2026-07-08 15:01:03.678409 UTC - Status: BOOTING 2026-07-08 15:01:06.494516 UTC - Status: BOOTING 2026-07-08 15:01:09.361421 UTC - Status: BOOTING 2026-07-08 15:01:12.127610 UTC - Status: BOOTING 2026-07-08 15:01:14.893842 UTC - Status: BOOTING 2026-07-08 15:01:17.710180 UTC - Status: BOOTING 2026-07-08 15:01:20.577224 UTC - Status: BOOTING 2026-07-08 15:01:23.393861 UTC - Status: UP 2026-07-08 15:01:23.393963 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx13y3wve7asgjqggaeg01bh 2026-07-08 15:01:23.394013 UTC - Validate resources 2026-07-08 15:01:24.160658 UTC - The fields of the created resource were validated. 2026-07-08 15:01:24.160795 UTC - Check if resources are registered in experiment 2026-07-08 15:01:24.160987 UTC - Run: slices experiment list-resources --format json tst-407e9088 2026-07-08 15:01:24.826444 UTC - Status (on expauth): UP 2026-07-08 15:01:24.826607 UTC - Testing extend expires_at (all resources in experiment) 2026-07-08 15:01:24.826731 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend --duration 3h --experiment tst-407e9088 2026-07-08 15:01:26.945893 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-407e9088 tst 2026-07-08 15:01:27.761777 UTC - Run: slices experiment list-resources --format json tst-407e9088 2026-07-08 15:01:28.427377 UTC - expires_at (on expauth): 2026-07-08T18:01:00Z (correctly extended) 2026-07-08 15:01:28.427505 UTC - Testing extend expires_at (single resource in experiment) 2026-07-08 15:01:28.427673 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend tst --duration 4h --experiment tst-407e9088 2026-07-08 15:01:30.647074 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-407e9088 tst 2026-07-08 15:01:31.413316 UTC - Run: slices experiment list-resources --format json tst-407e9088 2026-07-08 15:01:32.029018 UTC - expires_at (on expauth): 2026-07-08T19:01:00Z (correctly extended) 2026-07-08 15:01:32.029143 UTC - Testing ssh login 2026-07-08 15:01:32.042154 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show ssh_config --experiment tst-407e9088 tst 2026-07-08 15:01:32.958339 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-407e9088 tst 2026-07-08 15:01:33.924614 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-407e9088 tst 2026-07-08 15:01:34.790720 UTC - Logging in using 'slices bi ssh' 2026-07-08 15:01:34.790794 UTC - Forcing IPv4 only. 2026-07-08 15:01:34.790928 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-407e9088 tst -- -4 uname -a 2026-07-08 15:01:37.210291 UTC - Forcing IPv4 only. 2026-07-08 15:01:37.210489 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-407e9088 tst -- -4 uptime 2026-07-08 15:01:38.978307 UTC - CLI SSH Test passed. 2026-07-08 15:01:38.978383 UTC - 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-07-08 15:01:38.978402 UTC - Uptime: 15:01:37 up 0 min, 1 user, load average: 0.30, 0.08, 0.03 2026-07-08 15:01:38.978446 UTC - Logging in using SSH over SSH proxy 2026-07-08 15:01:38.978613 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-407e9088 tst 2026-07-08 15:01:39.995127 UTC - Added paramiko HostKeyEntry for 172.28.9.150 2026-07-08 15:01:39.995348 UTC - Added paramiko HostKeyEntry for 172.28.9.150 2026-07-08 15:01:39.995414 UTC - Added paramiko HostKeyEntry for 172.28.9.150 2026-07-08 15:01:39.995713 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-08 15:01:39.995821 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-08 15:01:39.995873 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-08 15:01:39.995891 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-08 15:01:40.685768 UTC - Connecting to 172.28.9.150:22 over proxy 2026-07-08 15:01:41.978622 UTC - SSH Test output: 2026-07-08 15:01:41.978698 UTC - 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-07-08 15:01:41.978719 UTC - Uptime: 15:01:40 up 0 min, 1 user, load average: 0.30, 0.08, 0.03 2026-07-08 15:01:42.260261 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-08 15:01:42.260341 UTC - lsb_release matches expected value 2026-07-08 15:01:42.260363 UTC - SSH Test passed. 2026-07-08 15:01:42.267176 UTC - Destroying tst-407e9088 tst 2026-07-08 15:01:42.267731 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 destroy --experiment tst-407e9088 tst