Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 9.59s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 607ms 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 760ms + annotated-types==0.7.0 + anyio==4.14.2 + 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.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.2 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev187+g005dd054e (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-20 20:08:16.417382 UTC - Installing Slices CLI (latest stable version). 2026-07-20 20:08:16.417808 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-20 20:08:30.958885 UTC - Slices CLI installed. 2026-07-20 20:08:30.964636 UTC - PATH: {'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-20 20:08:30.966915 UTC - ls -a /root/ /scripts/ (error 2): None b"ls: cannot access '/scripts/': No such file or directory\n/root/:\n.\n..\n.cache\n.local\n.slices\nrun_test_runner.sh\nslices-cli-venv\n" 2026-07-20 20:08:30.967840 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-20 20:08:30.967971 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-20 20:08:30.968001 UTC - Slices CLI exe: 'slices' 2026-07-20 20:08:30.968019 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-20 20:08:30.968153 UTC - Run: slices --version 2026-07-20 20:08:38.542410 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-20 20:08:38.542726 UTC - Run: slices pubkey list --format text 2026-07-20 20:08:40.622530 UTC - Pubkey already registered 2026-07-20 20:08:40.622796 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-20 20:08:42.152007 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-20 20:08:42.152106 UTC - Check List Flavors 2026-07-20 20:08:42.152252 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-07-20 20:08:44.385802 UTC - Check List DiskImages 2026-07-20 20:08:44.385982 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-07-20 20:08:45.303677 UTC - Requesting resources 2026-07-20 20:08:45.304457 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-9788b8a3 2026-07-20 20:08:50.180950 UTC - Resource ID: r_hu-budapest-bi-vm1_01ky0jag0wef9avaxtea6vcysq 2026-07-20 20:08:50.181164 UTC - Waiting until resource ready 2026-07-20 20:08:52.181579 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-9788b8a3 tst 2026-07-20 20:08:52.997218 UTC - Status: IMAGING 2026-07-20 20:08:55.863321 UTC - Status: IMAGING 2026-07-20 20:08:58.681059 UTC - Status: IMAGING 2026-07-20 20:09:01.497187 UTC - Status: IMAGING 2026-07-20 20:09:04.546512 UTC - Status: IMAGING 2026-07-20 20:09:07.816268 UTC - Status: IMAGING 2026-07-20 20:09:10.963828 UTC - Status: IMAGING 2026-07-20 20:09:13.997971 UTC - Status: IMAGING 2026-07-20 20:09:16.832824 UTC - Status: IMAGING 2026-07-20 20:09:19.753965 UTC - Status: IMAGING 2026-07-20 20:09:23.488420 UTC - Status: IMAGING 2026-07-20 20:09:27.321974 UTC - Status: IMAGING 2026-07-20 20:09:30.702341 UTC - Status: IMAGING 2026-07-20 20:09:33.686382 UTC - Status: IMAGING 2026-07-20 20:09:36.771138 UTC - Status: IMAGING 2026-07-20 20:09:40.044688 UTC - Status: IMAGING 2026-07-20 20:09:43.348650 UTC - Status: IMAGING 2026-07-20 20:09:47.069704 UTC - Status: IMAGING 2026-07-20 20:09:49.890752 UTC - Status: IMAGING 2026-07-20 20:09:53.759198 UTC - Status: IMAGING 2026-07-20 20:09:57.407878 UTC - Status: IMAGING 2026-07-20 20:10:00.341082 UTC - Status: IMAGING 2026-07-20 20:10:03.568682 UTC - Status: IMAGING 2026-07-20 20:10:06.535059 UTC - Status: IMAGING 2026-07-20 20:10:09.350982 UTC - Status: UP 2026-07-20 20:10:09.351129 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky0jaegne8vvt4tx5936532b 2026-07-20 20:10:09.351217 UTC - Validate resources 2026-07-20 20:10:10.269055 UTC - The fields of the created resource were validated. 2026-07-20 20:10:10.269155 UTC - Check if resources are registered in experiment 2026-07-20 20:10:10.269313 UTC - Run: slices experiment list-resources --format json tst-9788b8a3 2026-07-20 20:10:11.034799 UTC - Status (on expauth): UP 2026-07-20 20:10:11.034978 UTC - Testing extend expires_at (all resources in experiment) 2026-07-20 20:10:11.035140 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-9788b8a3 2026-07-20 20:10:14.787509 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-9788b8a3 tst 2026-07-20 20:10:16.761142 UTC - Run: slices experiment list-resources --format json tst-9788b8a3 2026-07-20 20:10:17.854960 UTC - expires_at (on expauth): 2026-07-20T23:10:00Z (correctly extended) 2026-07-20 20:10:17.855095 UTC - Testing extend expires_at (single resource in experiment) 2026-07-20 20:10:17.855253 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-9788b8a3 2026-07-20 20:10:21.486914 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-9788b8a3 tst 2026-07-20 20:10:22.455974 UTC - Run: slices experiment list-resources --format json tst-9788b8a3 2026-07-20 20:10:23.577402 UTC - expires_at (on expauth): 2026-07-21T00:10:00Z (correctly extended) 2026-07-20 20:10:23.577552 UTC - Testing ssh login 2026-07-20 20:10:23.591405 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-9788b8a3 tst 2026-07-20 20:10:24.780847 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-9788b8a3 tst 2026-07-20 20:10:26.431015 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-9788b8a3 tst 2026-07-20 20:10:27.513427 UTC - Logging in using 'slices bi ssh' 2026-07-20 20:10:27.513518 UTC - Forcing IPv4 only. 2026-07-20 20:10:27.513652 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-9788b8a3 tst -- -4 uname -a 2026-07-20 20:10:33.111326 UTC - Forcing IPv4 only. 2026-07-20 20:10:33.111541 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-9788b8a3 tst -- -4 uptime 2026-07-20 20:10:36.560061 UTC - CLI SSH Test passed. 2026-07-20 20:10:36.560316 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-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-07-20 20:10:36.560354 UTC - Uptime: 20:10:36 up 1 min, 1 user, load average: 0.29, 0.10, 0.03 2026-07-20 20:10:36.560499 UTC - Logging in using SSH over SSH proxy 2026-07-20 20:10:36.560652 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-9788b8a3 tst 2026-07-20 20:10:38.639694 UTC - Added paramiko HostKeyEntry for 192.168.0.147 2026-07-20 20:10:38.639832 UTC - Added paramiko HostKeyEntry for 192.168.0.147 2026-07-20 20:10:38.639990 UTC - Added paramiko HostKeyEntry for 192.168.0.147 2026-07-20 20:10:38.640453 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-20 20:10:38.640533 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-20 20:10:38.640651 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-20 20:10:38.640671 UTC - Connecting to proxy 193.225.251.128:22 2026-07-20 20:10:39.173442 UTC - Connecting to 192.168.0.147:22 over proxy 2026-07-20 20:10:39.975134 UTC - SSH Test output: 2026-07-20 20:10:39.975213 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-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-07-20 20:10:39.975236 UTC - Uptime: 20:10:39 up 1 min, 1 user, load average: 0.27, 0.10, 0.03 2026-07-20 20:10:40.129937 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-20 20:10:40.130066 UTC - lsb_release matches expected value 2026-07-20 20:10:40.130125 UTC - SSH Test passed. 2026-07-20 20:10:40.150023 UTC - Destroying tst-9788b8a3 tst 2026-07-20 20:10:40.154021 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-9788b8a3 tst