Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.23s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 785ms 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.28s + 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 13:16:02.881176 UTC - Installing Slices CLI (latest stable version). 2026-08-05 13:16:02.881395 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-05 13:16:08.267255 UTC - Slices CLI installed. 2026-08-05 13:16:08.267545 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 13:16:08.269474 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 13:16:08.269553 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 13:16:08.269620 UTC - which slices: /app/.venv/bin/slices 2026-08-05 13:16:08.269639 UTC - Slices CLI exe: 'slices' 2026-08-05 13:16:08.269656 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-05 13:16:08.269796 UTC - Run: slices --version 2026-08-05 13:16:11.444048 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 13:16:11.444346 UTC - Run: slices pubkey list --format text 2026-08-05 13:16:12.561775 UTC - Pubkey already registered 2026-08-05 13:16:12.562005 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-05 13:16:13.582489 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-05 13:16:13.582738 UTC - Check List Flavors 2026-08-05 13:16:13.582895 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-08-05 13:16:15.217672 UTC - Check List DiskImages 2026-08-05 13:16:15.217855 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-08-05 13:16:16.141031 UTC - Requesting resources 2026-08-05 13:16:16.141521 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-02f613b6 2026-08-05 13:16:17.981621 UTC - Resource ID: r_hu-budapest-bi-vm1_01kz912kyqeqr99cthw0aev2j3 2026-08-05 13:16:17.981824 UTC - Waiting until resource ready 2026-08-05 13:16:19.982145 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-02f613b6 tst 2026-08-05 13:16:21.211299 UTC - Status: IMAGING 2026-08-05 13:16:24.282301 UTC - Status: IMAGING 2026-08-05 13:16:27.413315 UTC - Status: IMAGING 2026-08-05 13:16:30.342846 UTC - Status: IMAGING 2026-08-05 13:16:33.485140 UTC - Status: IMAGING 2026-08-05 13:16:36.404553 UTC - Status: IMAGING 2026-08-05 13:16:39.472639 UTC - Status: IMAGING 2026-08-05 13:16:42.439446 UTC - Status: IMAGING 2026-08-05 13:16:45.355585 UTC - Status: IMAGING 2026-08-05 13:16:48.272263 UTC - Status: IMAGING 2026-08-05 13:16:51.091621 UTC - Status: IMAGING 2026-08-05 13:16:54.684514 UTC - Status: IMAGING 2026-08-05 13:16:57.706443 UTC - Status: IMAGING 2026-08-05 13:17:01.435247 UTC - Status: IMAGING 2026-08-05 13:17:05.439164 UTC - Status: IMAGING 2026-08-05 13:17:08.462153 UTC - Status: IMAGING 2026-08-05 13:17:11.328660 UTC - Status: IMAGING 2026-08-05 13:17:14.865137 UTC - Status: IMAGING 2026-08-05 13:17:18.472830 UTC - Status: IMAGING 2026-08-05 13:17:21.495261 UTC - Status: IMAGING 2026-08-05 13:17:24.739380 UTC - Status: IMAGING 2026-08-05 13:17:27.927734 UTC - Status: IMAGING 2026-08-05 13:17:31.060314 UTC - Status: UP 2026-08-05 13:17:31.061896 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kz912k9vfwva22fm8j29rf7y 2026-08-05 13:17:31.061976 UTC - Validate resources 2026-08-05 13:17:32.462467 UTC - The fields of the created resource were validated. 2026-08-05 13:17:32.462722 UTC - Check if resources are registered in experiment 2026-08-05 13:17:32.462886 UTC - Run: slices experiment list-resources --format json tst-02f613b6 2026-08-05 13:17:33.634756 UTC - Status (on expauth): UP 2026-08-05 13:17:33.634889 UTC - Testing extend expires_at (all resources in experiment) 2026-08-05 13:17:33.635002 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-02f613b6 2026-08-05 13:17:35.420451 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-02f613b6 tst 2026-08-05 13:17:36.587984 UTC - Run: slices experiment list-resources --format json tst-02f613b6 2026-08-05 13:17:37.253273 UTC - expires_at (on expauth): 2026-08-05T16:17:00Z (correctly extended) 2026-08-05 13:17:37.253366 UTC - Testing extend expires_at (single resource in experiment) 2026-08-05 13:17:37.253516 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-02f613b6 2026-08-05 13:17:38.720702 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-02f613b6 tst 2026-08-05 13:17:39.536934 UTC - Run: slices experiment list-resources --format json tst-02f613b6 2026-08-05 13:17:40.202170 UTC - expires_at (on expauth): 2026-08-05T17:17:00Z (correctly extended) 2026-08-05 13:17:40.202277 UTC - Testing ssh login 2026-08-05 13:17:40.218009 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-02f613b6 tst 2026-08-05 13:17:41.451496 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-02f613b6 tst 2026-08-05 13:17:42.469345 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-02f613b6 tst 2026-08-05 13:17:43.485864 UTC - Logging in using 'slices bi ssh' 2026-08-05 13:17:43.486204 UTC - Forcing IPv4 only. 2026-08-05 13:17:43.486342 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-02f613b6 tst -- -4 uname -a 2026-08-05 13:17:48.517760 UTC - Forcing IPv4 only. 2026-08-05 13:17:48.517954 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-02f613b6 tst -- -4 uptime 2026-08-05 13:17:51.138918 UTC - CLI SSH Test passed. 2026-08-05 13:17:51.139016 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-b6fa97cc-9ea7-4f9b-9541-f0 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-05 13:17:51.139058 UTC - Uptime: 13:17:51 up 1 min, 1 user, load average: 0.23, 0.08, 0.03 2026-08-05 13:17:51.139108 UTC - Logging in using SSH over SSH proxy 2026-08-05 13:17:51.139313 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-02f613b6 tst 2026-08-05 13:17:52.156629 UTC - Added paramiko HostKeyEntry for 192.168.0.86 2026-08-05 13:17:52.156797 UTC - Added paramiko HostKeyEntry for 192.168.0.86 2026-08-05 13:17:52.156957 UTC - Added paramiko HostKeyEntry for 192.168.0.86 2026-08-05 13:17:52.157210 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-08-05 13:17:52.157262 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-08-05 13:17:52.157367 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-08-05 13:17:52.157387 UTC - Connecting to proxy 193.225.251.128:22 2026-08-05 13:17:52.689250 UTC - Connecting to 192.168.0.86:22 over proxy 2026-08-05 13:17:53.451157 UTC - SSH Test output: 2026-08-05 13:17:53.451228 UTC - Uname: Linux 9524f874-af0c-4a76-a2a6-5351b52bb50f-b6fa97cc-9ea7-4f9b-9541-f0 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-05 13:17:53.451250 UTC - Uptime: 13:17:53 up 1 min, 1 user, load average: 0.23, 0.08, 0.03 2026-08-05 13:17:53.597152 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-05 13:17:53.597241 UTC - lsb_release matches expected value 2026-08-05 13:17:53.597267 UTC - SSH Test passed. 2026-08-05 13:17:53.610862 UTC - Destroying tst-02f613b6 tst 2026-08-05 13:17:53.611071 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-02f613b6 tst