Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.98s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 383ms 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 1.11s + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + cffi==2.1.1 + cryptography==50.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.3 + 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-08-07 20:02:30.204786 UTC - Installing Slices CLI (latest stable version). 2026-08-07 20:02:30.205044 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-07 20:02:36.916539 UTC - Slices CLI installed. 2026-08-07 20:02:36.916896 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-08-07 20:02:36.919032 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-08-07 20:02:36.919130 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-08-07 20:02:36.919229 UTC - which slices: /app/.venv/bin/slices 2026-08-07 20:02:36.919262 UTC - Slices CLI exe: 'slices' 2026-08-07 20:02:36.919288 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-07 20:02:36.919460 UTC - Run: slices --version 2026-08-07 20:02:41.720891 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-08-07 20:02:41.721396 UTC - Run: slices pubkey list --format text 2026-08-07 20:02:42.637372 UTC - Pubkey already registered 2026-08-07 20:02:42.637771 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-07 20:02:43.681420 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-07 20:02:43.681531 UTC - Check List Flavors 2026-08-07 20:02:43.681700 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 flavor list -f json 2026-08-07 20:02:45.019407 UTC - Check List DiskImages 2026-08-07 20:02:45.019619 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 diskimage list -f json 2026-08-07 20:02:45.793947 UTC - Requesting resources 2026-08-07 20:02:45.795429 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-49186307 2026-08-07 20:02:47.605383 UTC - Resource ID: r_fr-sophia2-bi-vm1_01kzex4bvaezs845stknd4f5rk 2026-08-07 20:02:47.605561 UTC - Waiting until resource ready 2026-08-07 20:02:49.605908 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-49186307 tst 2026-08-07 20:02:50.895129 UTC - Status: IMAGING 2026-08-07 20:02:53.826770 UTC - Status: BOOTING 2026-08-07 20:02:57.211438 UTC - Status: BOOTING 2026-08-07 20:03:00.978178 UTC - Status: BOOTING 2026-08-07 20:03:04.053055 UTC - Status: BOOTING 2026-08-07 20:03:07.624357 UTC - Status: BOOTING 2026-08-07 20:03:11.009275 UTC - Status: UP 2026-08-07 20:03:11.009356 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kzex4bb6f2qt3gktwe5v2d72 2026-08-07 20:03:11.009398 UTC - Validate resources 2026-08-07 20:03:13.320771 UTC - The fields of the created resource were validated. 2026-08-07 20:03:13.320871 UTC - Check if resources are registered in experiment 2026-08-07 20:03:13.321018 UTC - Run: slices experiment list-resources --format json tst-49186307 2026-08-07 20:03:15.115140 UTC - Status (on expauth): UP 2026-08-07 20:03:15.115274 UTC - Testing extend expires_at (all resources in experiment) 2026-08-07 20:03:15.115383 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 extend --duration 3h --experiment tst-49186307 2026-08-07 20:03:17.403810 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-49186307 tst 2026-08-07 20:03:19.007923 UTC - Run: slices experiment list-resources --format json tst-49186307 2026-08-07 20:03:20.682173 UTC - expires_at (on expauth): 2026-08-07T23:03:00Z (correctly extended) 2026-08-07 20:03:20.682419 UTC - Testing extend expires_at (single resource in experiment) 2026-08-07 20:03:20.682620 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 extend tst --duration 4h --experiment tst-49186307 2026-08-07 20:03:23.374528 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 list-resources --format json --experiment tst-49186307 tst 2026-08-07 20:03:25.034021 UTC - Run: slices experiment list-resources --format json tst-49186307 2026-08-07 20:03:26.265514 UTC - expires_at (on expauth): 2026-08-08T00:03:00Z (correctly extended) 2026-08-07 20:03:26.265627 UTC - Testing ssh login 2026-08-07 20:03:26.282888 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-49186307 tst 2026-08-07 20:03:28.217058 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-49186307 tst 2026-08-07 20:03:29.742626 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-49186307 tst 2026-08-07 20:03:31.370799 UTC - Logging in using 'slices bi ssh' 2026-08-07 20:03:31.370869 UTC - Forcing IPv4 only. 2026-08-07 20:03:31.370985 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-49186307 tst -- -4 uname -a 2026-08-07 20:03:34.221959 UTC - Forcing IPv4 only. 2026-08-07 20:03:34.222136 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --show nothing --experiment tst-49186307 tst -- -4 uptime 2026-08-07 20:03:36.353575 UTC - CLI SSH Test passed. 2026-08-07 20:03:36.353676 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-08-07 20:03:36.353697 UTC - Uptime: 20:03:35 up 0 min, 1 user, load average: 0.09, 0.03, 0.01 2026-08-07 20:03:36.353739 UTC - Logging in using SSH over SSH proxy 2026-08-07 20:03:36.353967 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-49186307 tst 2026-08-07 20:03:38.298100 UTC - Added paramiko HostKeyEntry for 10.123.22.228 2026-08-07 20:03:38.298339 UTC - Added paramiko HostKeyEntry for 10.123.22.228 2026-08-07 20:03:38.298403 UTC - Added paramiko HostKeyEntry for 10.123.22.228 2026-08-07 20:03:38.298754 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-08-07 20:03:38.298851 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-08-07 20:03:38.298895 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-08-07 20:03:38.298913 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-08-07 20:03:38.695823 UTC - Connecting to 10.123.22.228:22 over proxy 2026-08-07 20:03:39.358192 UTC - SSH Test output: 2026-08-07 20:03:39.358266 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-08-07 20:03:39.358286 UTC - Uptime: 20:03:38 up 0 min, 1 user, load average: 0.09, 0.03, 0.01 2026-08-07 20:03:39.493537 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-07 20:03:39.493630 UTC - lsb_release matches expected value 2026-08-07 20:03:39.493653 UTC - SSH Test passed. 2026-08-07 20:03:39.508841 UTC - Destroying tst-49186307 tst 2026-08-07 20:03:39.509059 UTC - Run: slices bi --infra fr-sophia2-bi-vm1 destroy --experiment tst-49186307 tst