Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 3.63s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 371ms 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 232ms + 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-09 06:00:44.184503 UTC - Installing Slices CLI (latest stable version). 2026-07-09 06:00:44.185030 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-09 06:00:50.412916 UTC - Slices CLI installed. 2026-07-09 06:00:50.413121 UTC - Slices CLI exe: 'slices' 2026-07-09 06:00:50.413152 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-09 06:00:50.413333 UTC - Run: slices --version 2026-07-09 06:00:53.134825 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-09 06:00:53.135081 UTC - Run: slices pubkey list --format text 2026-07-09 06:00:54.052262 UTC - Pubkey already registered 2026-07-09 06:00:54.052483 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-09 06:00:54.667651 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-09 06:00:54.667745 UTC - Check List Flavors 2026-07-09 06:00:54.667897 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 flavor list -f json 2026-07-09 06:00:56.285457 UTC - Check List DiskImages 2026-07-09 06:00:56.285639 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 diskimage list -f json 2026-07-09 06:00:56.951002 UTC - Requesting resources 2026-07-09 06:00:56.951524 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-ee91bb53 2026-07-09 06:01:01.174840 UTC - Resource ID: r_fr-sophia2-bi-vm2_01kx2qe6arf5ht97m2x35hkzp7 2026-07-09 06:01:01.174997 UTC - Waiting until resource ready 2026-07-09 06:01:03.175344 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-ee91bb53 tst 2026-07-09 06:01:03.940977 UTC - Status: IMAGING 2026-07-09 06:01:06.757158 UTC - Status: BOOTING 2026-07-09 06:01:09.573378 UTC - Status: BOOTING 2026-07-09 06:01:12.389514 UTC - Status: BOOTING 2026-07-09 06:01:15.155613 UTC - Status: BOOTING 2026-07-09 06:01:17.971834 UTC - Status: BOOTING 2026-07-09 06:01:20.737748 UTC - Status: BOOTING 2026-07-09 06:01:23.553799 UTC - Status: BOOTING 2026-07-09 06:01:26.369931 UTC - Status: BOOTING 2026-07-09 06:01:29.239278 UTC - Status: UP 2026-07-09 06:01:29.239384 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx2qe4q6fp48hht1qcwjdj10 2026-07-09 06:01:29.239439 UTC - Validate resources 2026-07-09 06:01:30.005769 UTC - The fields of the created resource were validated. 2026-07-09 06:01:30.005870 UTC - Check if resources are registered in experiment 2026-07-09 06:01:30.006040 UTC - Run: slices experiment list-resources --format json tst-ee91bb53 2026-07-09 06:01:30.671498 UTC - Status (on expauth): UP 2026-07-09 06:01:30.671661 UTC - Testing extend expires_at (all resources in experiment) 2026-07-09 06:01:30.671818 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend --duration 3h --experiment tst-ee91bb53 2026-07-09 06:01:33.241565 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-ee91bb53 tst 2026-07-09 06:01:34.057479 UTC - Run: slices experiment list-resources --format json tst-ee91bb53 2026-07-09 06:01:34.772967 UTC - expires_at (on expauth): 2026-07-09T09:01:00Z (correctly extended) 2026-07-09 06:01:34.773064 UTC - Testing extend expires_at (single resource in experiment) 2026-07-09 06:01:34.773224 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend tst --duration 4h --experiment tst-ee91bb53 2026-07-09 06:01:37.393738 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-ee91bb53 tst 2026-07-09 06:01:38.263198 UTC - Run: slices experiment list-resources --format json tst-ee91bb53 2026-07-09 06:01:38.929413 UTC - expires_at (on expauth): 2026-07-09T10:01:00Z (correctly extended) 2026-07-09 06:01:38.929621 UTC - Testing ssh login 2026-07-09 06:01:38.944169 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show ssh_config --experiment tst-ee91bb53 tst 2026-07-09 06:01:39.961735 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-ee91bb53 tst 2026-07-09 06:01:40.928145 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-ee91bb53 tst 2026-07-09 06:01:41.844772 UTC - Logging in using 'slices bi ssh' 2026-07-09 06:01:41.844861 UTC - Forcing IPv4 only. 2026-07-09 06:01:41.845018 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-ee91bb53 tst -- -4 uname -a 2026-07-09 06:01:44.265546 UTC - Forcing IPv4 only. 2026-07-09 06:01:44.265728 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-ee91bb53 tst -- -4 uptime 2026-07-09 06:01:46.033321 UTC - CLI SSH Test passed. 2026-07-09 06:01:46.033393 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-09 06:01:46.033412 UTC - Uptime: 06:01:45 up 0 min, 1 user, load average: 0.26, 0.08, 0.02 2026-07-09 06:01:46.033447 UTC - Logging in using SSH over SSH proxy 2026-07-09 06:01:46.033597 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-ee91bb53 tst 2026-07-09 06:01:46.949910 UTC - Added paramiko HostKeyEntry for 172.28.9.220 2026-07-09 06:01:46.950112 UTC - Added paramiko HostKeyEntry for 172.28.9.220 2026-07-09 06:01:46.950172 UTC - Added paramiko HostKeyEntry for 172.28.9.220 2026-07-09 06:01:46.950486 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-09 06:01:46.950571 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-09 06:01:46.950613 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-09 06:01:46.950631 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-09 06:01:47.364675 UTC - Connecting to 172.28.9.220:22 over proxy 2026-07-09 06:01:48.055814 UTC - SSH Test output: 2026-07-09 06:01:48.055883 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-09 06:01:48.055904 UTC - Uptime: 06:01:47 up 0 min, 1 user, load average: 0.24, 0.07, 0.02 2026-07-09 06:01:48.195486 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-09 06:01:48.195566 UTC - lsb_release matches expected value 2026-07-09 06:01:48.195587 UTC - SSH Test passed. 2026-07-09 06:01:48.203026 UTC - Destroying tst-ee91bb53 tst 2026-07-09 06:01:48.203197 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 destroy --experiment tst-ee91bb53 tst