Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.25s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 323ms 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 862ms + 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-05 20:44:14.981725 UTC - Installing Slices CLI (latest stable version). 2026-08-05 20:44:14.981967 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-05 20:44:22.463592 UTC - Slices CLI installed. 2026-08-05 20:44:22.463896 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-05 20:44:22.466936 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-05 20:44:22.467048 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-05 20:44:22.467134 UTC - which slices: /app/.venv/bin/slices 2026-08-05 20:44:22.467155 UTC - Slices CLI exe: 'slices' 2026-08-05 20:44:22.467172 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-05 20:44:22.467315 UTC - Run: slices --version 2026-08-05 20:44:25.540968 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-05 20:44:25.541258 UTC - Run: slices pubkey list --format text 2026-08-05 20:44:26.306949 UTC - Pubkey already registered 2026-08-05 20:44:26.307222 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-05 20:44:26.922952 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-05 20:44:26.923049 UTC - Check List Flavors 2026-08-05 20:44:26.923204 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-08-05 20:44:27.689349 UTC - Check List DiskImages 2026-08-05 20:44:27.689585 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-08-05 20:44:28.359749 UTC - Requesting resources 2026-08-05 20:44:28.360291 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Debian 13.1' --flavor tiny --duration 2h --experiment tst-53493c6a 2026-08-05 20:44:29.579084 UTC - Resource ID: r_be-gent1-bi-vm1_01kz9tq9bjfhc8p30n466hj3xw 2026-08-05 20:44:29.579229 UTC - Waiting until resource ready 2026-08-05 20:44:31.579626 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-53493c6a tst 2026-08-05 20:44:32.295581 UTC - Status: IMAGING 2026-08-05 20:44:35.012060 UTC - Status: IMAGING 2026-08-05 20:44:37.778564 UTC - Status: IMAGING 2026-08-05 20:44:40.695701 UTC - Status: BOOTING 2026-08-05 20:44:43.463161 UTC - Status: BOOTING 2026-08-05 20:44:46.280837 UTC - Status: BOOTING 2026-08-05 20:44:49.098022 UTC - Status: BOOTING 2026-08-05 20:44:51.915018 UTC - Status: UP 2026-08-05 20:44:51.915117 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kz9tq93xeays1hktxftczhsj 2026-08-05 20:44:51.915173 UTC - Validate resources 2026-08-05 20:44:52.681686 UTC - The fields of the created resource were validated. 2026-08-05 20:44:52.681784 UTC - Check if resources are registered in experiment 2026-08-05 20:44:52.681950 UTC - Run: slices experiment list-resources --format json tst-53493c6a 2026-08-05 20:44:53.397751 UTC - Status (on expauth): UP 2026-08-05 20:44:53.397893 UTC - Testing extend expires_at (all resources in experiment) 2026-08-05 20:44:53.398036 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-53493c6a 2026-08-05 20:44:54.865785 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-53493c6a tst 2026-08-05 20:44:55.631905 UTC - Run: slices experiment list-resources --format json tst-53493c6a 2026-08-05 20:44:56.297886 UTC - expires_at (on expauth): 2026-08-05T23:44:00Z (correctly extended) 2026-08-05 20:44:56.298053 UTC - Testing extend expires_at (single resource in experiment) 2026-08-05 20:44:56.298354 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-53493c6a 2026-08-05 20:44:57.716584 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-53493c6a tst 2026-08-05 20:44:58.432844 UTC - Run: slices experiment list-resources --format json tst-53493c6a 2026-08-05 20:44:59.098712 UTC - expires_at (on expauth): 2026-08-06T00:44:00Z (correctly extended) 2026-08-05 20:44:59.098864 UTC - Testing ssh login 2026-08-05 20:44:59.114571 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-53493c6a tst 2026-08-05 20:44:59.880492 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-53493c6a tst 2026-08-05 20:45:00.646632 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-53493c6a tst 2026-08-05 20:45:01.412757 UTC - Logging in using 'slices bi ssh' 2026-08-05 20:45:01.412854 UTC - Forcing IPv4 only. 2026-08-05 20:45:01.413018 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-53493c6a tst -- -4 uname -a 2026-08-05 20:45:02.379418 UTC - Forcing IPv4 only. 2026-08-05 20:45:02.379600 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-53493c6a tst -- -4 uptime 2026-08-05 20:45:03.195572 UTC - CLI SSH Test passed. 2026-08-05 20:45:03.195659 UTC - Uname: Linux tst 6.12.48+deb13-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.48-1 (2025-09-20) x86_64 GNU/Linux 2026-08-05 20:45:03.195680 UTC - Uptime: 22:45:03 up 0 min, 1 user, load average: 0.12, 0.03, 0.01 2026-08-05 20:45:03.195716 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-08-05 20:45:03.196249 UTC - Added paramiko HostKeyEntry for 10.10.213.129 2026-08-05 20:45:03.196474 UTC - Added paramiko HostKeyEntry for 10.10.213.129 2026-08-05 20:45:03.196561 UTC - Added paramiko HostKeyEntry for 10.10.213.129 2026-08-05 20:45:03.196882 UTC - Connecting to 10.10.213.129:22 2026-08-05 20:45:03.434267 UTC - SSH Test output: 2026-08-05 20:45:03.434351 UTC - Uname: Linux tst 6.12.48+deb13-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.48-1 (2025-09-20) x86_64 GNU/Linux 2026-08-05 20:45:03.434392 UTC - Uptime: 22:45:03 up 0 min, 1 user, load average: 0.12, 0.03, 0.01 2026-08-05 20:45:03.486682 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-08-05 20:45:03.534238 UTC - /etc/debian_version: 13.1 2026-08-05 20:45:03.534323 UTC - lsb_release matches expected value 2026-08-05 20:45:03.534345 UTC - /etc/debian_version matches expected value 2026-08-05 20:45:03.534360 UTC - SSH Test passed. 2026-08-05 20:45:03.534464 UTC - Logging in using SSH over SSH proxy 2026-08-05 20:45:03.534640 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-53493c6a tst 2026-08-05 20:45:04.401362 UTC - Added paramiko HostKeyEntry for 10.10.213.129 2026-08-05 20:45:04.401522 UTC - Added paramiko HostKeyEntry for 10.10.213.129 2026-08-05 20:45:04.401573 UTC - Added paramiko HostKeyEntry for 10.10.213.129 2026-08-05 20:45:04.401840 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-05 20:45:04.401895 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-05 20:45:04.401997 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-05 20:45:04.402016 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-08-05 20:45:04.694328 UTC - Connecting to 10.10.213.129:22 over proxy 2026-08-05 20:45:04.931938 UTC - SSH Test output: 2026-08-05 20:45:04.932008 UTC - Uname: Linux tst 6.12.48+deb13-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.12.48-1 (2025-09-20) x86_64 GNU/Linux 2026-08-05 20:45:04.932029 UTC - Uptime: 22:45:04 up 0 min, 2 users, load average: 0.12, 0.03, 0.01 2026-08-05 20:45:04.984858 UTC - lsb_release: Debian GNU/Linux 13 (trixie) 2026-08-05 20:45:05.032122 UTC - /etc/debian_version: 13.1 2026-08-05 20:45:05.032199 UTC - lsb_release matches expected value 2026-08-05 20:45:05.032218 UTC - /etc/debian_version matches expected value 2026-08-05 20:45:05.032232 UTC - SSH Test passed. 2026-08-05 20:45:05.038990 UTC - Destroying tst-53493c6a tst 2026-08-05 20:45:05.039172 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-53493c6a tst