Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.05s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 235ms 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 474ms + 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-06 04:15:24.955721 UTC - Installing Slices CLI (latest stable version). 2026-08-06 04:15:24.956287 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-06 04:15:32.458056 UTC - Slices CLI installed. 2026-08-06 04:15:32.459425 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-06 04:15:32.462341 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-06 04:15:32.462431 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-06 04:15:32.462845 UTC - which slices: /app/.venv/bin/slices 2026-08-06 04:15:32.462875 UTC - Slices CLI exe: 'slices' 2026-08-06 04:15:32.462891 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-06 04:15:32.463053 UTC - Run: slices --version 2026-08-06 04:15:36.310441 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-06 04:15:36.310723 UTC - Run: slices pubkey list --format text 2026-08-06 04:15:39.002075 UTC - Pubkey already registered 2026-08-06 04:15:39.002423 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-06 04:15:40.177615 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-06 04:15:40.177715 UTC - Check List Flavors 2026-08-06 04:15:40.177874 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-08-06 04:15:41.408276 UTC - Check List DiskImages 2026-08-06 04:15:41.408453 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-08-06 04:15:42.726690 UTC - Requesting resources 2026-08-06 04:15:42.727214 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-e848ccb6 2026-08-06 04:15:44.715248 UTC - Resource ID: r_hu-budapest-bi-vm1_01kzamhhscfng93fsw7q3dv58a 2026-08-06 04:15:44.715712 UTC - Waiting until resource ready 2026-08-06 04:15:46.716090 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-e848ccb6 tst 2026-08-06 04:15:47.688704 UTC - Status: IMAGING 2026-08-06 04:15:50.833678 UTC - Status: IMAGING 2026-08-06 04:15:55.150844 UTC - Status: IMAGING 2026-08-06 04:15:58.170894 UTC - Status: IMAGING 2026-08-06 04:16:01.442832 UTC - Status: IMAGING 2026-08-06 04:16:05.092843 UTC - Status: IMAGING 2026-08-06 04:16:09.336489 UTC - Status: IMAGING 2026-08-06 04:16:12.615609 UTC - Status: IMAGING 2026-08-06 04:16:16.226794 UTC - Status: IMAGING 2026-08-06 04:16:20.365295 UTC - Status: IMAGING 2026-08-06 04:16:23.989817 UTC - Status: IMAGING 2026-08-06 04:16:27.320840 UTC - Status: IMAGING 2026-08-06 04:16:30.542155 UTC - Status: IMAGING 2026-08-06 04:16:33.812863 UTC - Status: IMAGING 2026-08-06 04:16:37.784541 UTC - Status: IMAGING 2026-08-06 04:16:41.617869 UTC - Status: IMAGING 2026-08-06 04:16:45.795384 UTC - Status: IMAGING 2026-08-06 04:16:49.793781 UTC - Status: IMAGING 2026-08-06 04:16:53.418822 UTC - Status: IMAGING 2026-08-06 04:16:56.956944 UTC - Status: IMAGING 2026-08-06 04:17:00.232147 UTC - Status: IMAGING 2026-08-06 04:17:04.195242 UTC - Status: UP 2026-08-06 04:17:04.195339 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kzamhh2vf5yrgpd481cc99hn 2026-08-06 04:17:04.195385 UTC - Validate resources 2026-08-06 04:17:05.578384 UTC - The fields of the created resource were validated. 2026-08-06 04:17:05.583284 UTC - Check if resources are registered in experiment 2026-08-06 04:17:05.584524 UTC - Run: slices experiment list-resources --format json tst-e848ccb6 2026-08-06 04:17:06.558119 UTC - Status (on expauth): UP 2026-08-06 04:17:06.558271 UTC - Testing extend expires_at (all resources in experiment) 2026-08-06 04:17:06.558394 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-e848ccb6 2026-08-06 04:17:07.975915 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-e848ccb6 tst 2026-08-06 04:17:09.413943 UTC - Run: slices experiment list-resources --format json tst-e848ccb6 2026-08-06 04:17:10.330071 UTC - expires_at (on expauth): 2026-08-06T07:17:00Z (correctly extended) 2026-08-06 04:17:10.330177 UTC - Testing extend expires_at (single resource in experiment) 2026-08-06 04:17:10.330365 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-e848ccb6 2026-08-06 04:17:11.963741 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-e848ccb6 tst 2026-08-06 04:17:14.065574 UTC - Run: slices experiment list-resources --format json tst-e848ccb6 2026-08-06 04:17:16.048918 UTC - expires_at (on expauth): 2026-08-06T08:17:00Z (correctly extended) 2026-08-06 04:17:16.049288 UTC - Testing ssh login 2026-08-06 04:17:16.088618 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-e848ccb6 tst 2026-08-06 04:17:18.803924 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-e848ccb6 tst 2026-08-06 04:17:20.752151 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-e848ccb6 tst 2026-08-06 04:17:22.185690 UTC - Logging in using 'slices bi ssh' 2026-08-06 04:17:22.185777 UTC - Forcing IPv4 only. 2026-08-06 04:17:22.185904 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-e848ccb6 tst -- -4 uname -a 2026-08-06 04:17:27.768650 UTC - Forcing IPv4 only. 2026-08-06 04:17:27.768856 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-e848ccb6 tst -- -4 uptime 2026-08-06 04:17:29.888238 UTC - CLI SSH Test passed. 2026-08-06 04:17:29.888313 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-06 04:17:29.888333 UTC - Uptime: 04:17:29 up 1 min, 1 user, load average: 0.63, 0.23, 0.08 2026-08-06 04:17:29.888378 UTC - Logging in using SSH over SSH proxy 2026-08-06 04:17:29.888516 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-e848ccb6 tst 2026-08-06 04:17:31.291587 UTC - Added paramiko HostKeyEntry for 192.168.0.122 2026-08-06 04:17:31.291731 UTC - Added paramiko HostKeyEntry for 192.168.0.122 2026-08-06 04:17:31.291887 UTC - Added paramiko HostKeyEntry for 192.168.0.122 2026-08-06 04:17:31.292170 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-08-06 04:17:31.292248 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-08-06 04:17:31.292376 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-08-06 04:17:31.292405 UTC - Connecting to proxy 193.225.251.128:22 2026-08-06 04:17:31.813526 UTC - Connecting to 192.168.0.122:22 over proxy 2026-08-06 04:17:32.589527 UTC - SSH Test output: 2026-08-06 04:17:32.589603 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-06 04:17:32.589631 UTC - Uptime: 04:17:32 up 1 min, 1 user, load average: 0.58, 0.22, 0.08 2026-08-06 04:17:32.736774 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-06 04:17:32.736865 UTC - lsb_release matches expected value 2026-08-06 04:17:32.736896 UTC - SSH Test passed. 2026-08-06 04:17:32.746275 UTC - Destroying tst-e848ccb6 tst 2026-08-06 04:17:32.746457 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-e848ccb6 tst