Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.49s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 174ms 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 223ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + 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.4 + 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.3.post1 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev192+gcac2d3fe6 (from file:///app) + tomli-w==1.2.0 + tomlkit==0.15.1 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-29 20:01:02.420836 UTC - Installing Slices CLI (latest stable version). 2026-07-29 20:01:02.421051 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-29 20:01:09.137780 UTC - Slices CLI installed. 2026-07-29 20:01:09.139396 UTC - OS release: PRETTY_NAME="Debian GNU/Linux 13 (trixie)" NAME="Debian GNU/Linux" VERSION_ID="13" VERSION="13 (trixie)" VERSION_CODENAME=trixie DEBIAN_VERSION_FULL=13.5 ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" 2026-07-29 20:01:09.145646 UTC - ls -a /root/ /scripts/ (error 2): None ls: cannot access '/scripts/': No such file or directory /root/: . .. .cache .local .slices run_test_runner.sh slices-cli-venv 2026-07-29 20:01:09.145739 UTC - env: {'PATH': '/app/.venv/bin:/usr/local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/root/.local/bin/:/root/slices-cli-venv/bin', 'COLUMNS': '200'} 2026-07-29 20:01:09.145810 UTC - which slices: /app/.venv/bin/slices 2026-07-29 20:01:09.145829 UTC - Slices CLI exe: 'slices' 2026-07-29 20:01:09.145852 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-29 20:01:09.146026 UTC - Run: slices --version 2026-07-29 20:01:12.484140 UTC - version: Slices CLI v2026.1.3 Slices CLI core v1.2.6 Slices CLI ai v1.1.0 Slices CLI bi v2.2.1 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-07-29 20:01:12.484569 UTC - Run: slices pubkey list --format text 2026-07-29 20:01:13.500790 UTC - Pubkey already registered 2026-07-29 20:01:13.501049 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-29 20:01:14.116298 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-29 20:01:14.116404 UTC - Check List Flavors 2026-07-29 20:01:14.116553 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 flavor list -f json 2026-07-29 20:01:14.832110 UTC - Check List DiskImages 2026-07-29 20:01:14.832329 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 diskimage list -f json 2026-07-29 20:01:15.497610 UTC - Requesting resources 2026-07-29 20:01:15.498108 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-b9cad836 2026-07-29 20:01:16.864882 UTC - Resource ID: r_fr-sophia2-bi-vm2_01kyqqf4cge8htvdth12mxt4zs 2026-07-29 20:01:16.865031 UTC - Waiting until resource ready 2026-07-29 20:01:18.865466 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-b9cad836 tst 2026-07-29 20:01:19.681962 UTC - Status: IMAGING 2026-07-29 20:01:22.498200 UTC - Status: BOOTING 2026-07-29 20:01:25.264380 UTC - Status: BOOTING 2026-07-29 20:01:28.030239 UTC - Status: BOOTING 2026-07-29 20:01:30.846435 UTC - Status: BOOTING 2026-07-29 20:01:33.713881 UTC - Status: BOOTING 2026-07-29 20:01:36.530016 UTC - Status: BOOTING 2026-07-29 20:01:39.296034 UTC - Status: BOOTING 2026-07-29 20:01:42.062222 UTC - Status: UP 2026-07-29 20:01:42.062291 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kyqqf3x5ephbnrcq9sq3xvkg 2026-07-29 20:01:42.062368 UTC - Validate resources 2026-07-29 20:01:42.828223 UTC - The fields of the created resource were validated. 2026-07-29 20:01:42.828311 UTC - Check if resources are registered in experiment 2026-07-29 20:01:42.828473 UTC - Run: slices experiment list-resources --format json tst-b9cad836 2026-07-29 20:01:43.443654 UTC - Status (on expauth): UP 2026-07-29 20:01:43.443796 UTC - Testing extend expires_at (all resources in experiment) 2026-07-29 20:01:43.443923 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend --duration 3h --experiment tst-b9cad836 2026-07-29 20:01:44.610237 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-b9cad836 tst 2026-07-29 20:01:45.426283 UTC - Run: slices experiment list-resources --format json tst-b9cad836 2026-07-29 20:01:46.041598 UTC - expires_at (on expauth): 2026-07-29T23:01:00Z (correctly extended) 2026-07-29 20:01:46.041693 UTC - Testing extend expires_at (single resource in experiment) 2026-07-29 20:01:46.041872 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend tst --duration 4h --experiment tst-b9cad836 2026-07-29 20:01:47.158380 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-b9cad836 tst 2026-07-29 20:01:47.974480 UTC - Run: slices experiment list-resources --format json tst-b9cad836 2026-07-29 20:01:48.589986 UTC - expires_at (on expauth): 2026-07-30T00:01:00Z (correctly extended) 2026-07-29 20:01:48.590161 UTC - Testing ssh login 2026-07-29 20:01:48.604652 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show ssh_config --experiment tst-b9cad836 tst 2026-07-29 20:01:49.521393 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-b9cad836 tst 2026-07-29 20:01:50.437697 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-b9cad836 tst 2026-07-29 20:01:51.303836 UTC - Logging in using 'slices bi ssh' 2026-07-29 20:01:51.303926 UTC - Forcing IPv4 only. 2026-07-29 20:01:51.304063 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-b9cad836 tst -- -4 uname -a 2026-07-29 20:01:53.622840 UTC - Forcing IPv4 only. 2026-07-29 20:01:53.623087 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-b9cad836 tst -- -4 uptime 2026-07-29 20:01:55.296821 UTC - CLI SSH Test passed. 2026-07-29 20:01:55.296900 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-29 20:01:55.296919 UTC - Uptime: 20:01:54 up 0 min, 1 user, load average: 0.41, 0.11, 0.04 2026-07-29 20:01:55.296954 UTC - Logging in using SSH over SSH proxy 2026-07-29 20:01:55.297097 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-b9cad836 tst 2026-07-29 20:01:56.213603 UTC - Added paramiko HostKeyEntry for 172.28.9.245 2026-07-29 20:01:56.213833 UTC - Added paramiko HostKeyEntry for 172.28.9.245 2026-07-29 20:01:56.213905 UTC - Added paramiko HostKeyEntry for 172.28.9.245 2026-07-29 20:01:56.214303 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-29 20:01:56.214458 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-29 20:01:56.214530 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-29 20:01:56.214570 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-29 20:01:56.607966 UTC - Connecting to 172.28.9.245:22 over proxy 2026-07-29 20:01:57.279458 UTC - SSH Test output: 2026-07-29 20:01:57.279554 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-29 20:01:57.279576 UTC - Uptime: 20:01:55 up 0 min, 1 user, load average: 0.38, 0.11, 0.04 2026-07-29 20:01:57.414515 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-29 20:01:57.414614 UTC - lsb_release matches expected value 2026-07-29 20:01:57.414635 UTC - SSH Test passed. 2026-07-29 20:01:57.422348 UTC - Destroying tst-b9cad836 tst 2026-07-29 20:01:57.422566 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 destroy --experiment tst-b9cad836 tst