Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.73s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 583ms 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 777ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + 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.3.post1 + 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-26 20:10:35.657051 UTC - Installing Slices CLI (latest stable version). 2026-07-26 20:10:35.657554 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-26 20:10:41.638048 UTC - Slices CLI installed. 2026-07-26 20:10:41.639104 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-26 20:10:41.640590 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-26 20:10:41.641462 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-26 20:10:41.641585 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-26 20:10:41.641612 UTC - Slices CLI exe: 'slices' 2026-07-26 20:10:41.641629 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-26 20:10:41.641755 UTC - Run: slices --version 2026-07-26 20:10:46.467360 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-26 20:10:46.467963 UTC - Run: slices pubkey list --format text 2026-07-26 20:10:47.384570 UTC - Pubkey already registered 2026-07-26 20:10:47.384908 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-26 20:10:48.573750 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-26 20:10:48.573844 UTC - Check List Flavors 2026-07-26 20:10:48.573978 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-07-26 20:10:50.332657 UTC - Check List DiskImages 2026-07-26 20:10:50.332849 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-07-26 20:10:51.299343 UTC - Requesting resources 2026-07-26 20:10:51.300180 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-3cb4b65c 2026-07-26 20:10:53.528071 UTC - Resource ID: r_hu-budapest-bi-vm1_01kyg0tj9aep8tyqtsq8qbsznv 2026-07-26 20:10:53.528440 UTC - Waiting until resource ready 2026-07-26 20:10:55.529449 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-3cb4b65c tst 2026-07-26 20:10:57.477660 UTC - Status: IMAGING 2026-07-26 20:11:01.843005 UTC - Status: IMAGING 2026-07-26 20:11:06.340892 UTC - Status: IMAGING 2026-07-26 20:11:10.535357 UTC - Status: IMAGING 2026-07-26 20:11:15.167845 UTC - Status: IMAGING 2026-07-26 20:11:19.671293 UTC - Status: IMAGING 2026-07-26 20:11:24.043277 UTC - Status: IMAGING 2026-07-26 20:11:28.343160 UTC - Status: IMAGING 2026-07-26 20:11:33.359035 UTC - Status: IMAGING 2026-07-26 20:11:37.003952 UTC - Status: IMAGING 2026-07-26 20:11:40.632361 UTC - Status: IMAGING 2026-07-26 20:11:44.255146 UTC - Status: IMAGING 2026-07-26 20:11:47.797914 UTC - Status: IMAGING 2026-07-26 20:11:50.979907 UTC - Status: IMAGING 2026-07-26 20:11:53.796922 UTC - Status: IMAGING 2026-07-26 20:11:56.821963 UTC - Status: IMAGING 2026-07-26 20:11:59.690277 UTC - Status: IMAGING 2026-07-26 20:12:03.020829 UTC - Status: IMAGING 2026-07-26 20:12:06.037739 UTC - Status: IMAGING 2026-07-26 20:12:09.055656 UTC - Status: IMAGING 2026-07-26 20:12:12.142246 UTC - Status: IMAGING 2026-07-26 20:12:15.974068 UTC - Status: UP 2026-07-26 20:12:15.974209 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kyg0thh5f87a2efe75yzd8ar 2026-07-26 20:12:15.974256 UTC - Validate resources 2026-07-26 20:12:17.809683 UTC - The fields of the created resource were validated. 2026-07-26 20:12:17.809817 UTC - Check if resources are registered in experiment 2026-07-26 20:12:17.810015 UTC - Run: slices experiment list-resources --format json tst-3cb4b65c 2026-07-26 20:12:18.739980 UTC - Status (on expauth): UP 2026-07-26 20:12:18.740188 UTC - Testing extend expires_at (all resources in experiment) 2026-07-26 20:12:18.740348 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-3cb4b65c 2026-07-26 20:12:20.511271 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-3cb4b65c tst 2026-07-26 20:12:22.333656 UTC - Run: slices experiment list-resources --format json tst-3cb4b65c 2026-07-26 20:12:23.855707 UTC - expires_at (on expauth): 2026-07-26T23:12:00Z (correctly extended) 2026-07-26 20:12:23.855815 UTC - Testing extend expires_at (single resource in experiment) 2026-07-26 20:12:23.855946 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-3cb4b65c 2026-07-26 20:12:26.041153 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-3cb4b65c tst 2026-07-26 20:12:27.009394 UTC - Run: slices experiment list-resources --format json tst-3cb4b65c 2026-07-26 20:12:28.992391 UTC - expires_at (on expauth): 2026-07-27T00:12:00Z (correctly extended) 2026-07-26 20:12:28.993440 UTC - Testing ssh login 2026-07-26 20:12:29.016080 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-3cb4b65c tst 2026-07-26 20:12:31.339481 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-3cb4b65c tst 2026-07-26 20:12:33.031406 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-3cb4b65c tst 2026-07-26 20:12:34.648845 UTC - Logging in using 'slices bi ssh' 2026-07-26 20:12:34.648994 UTC - Forcing IPv4 only. 2026-07-26 20:12:34.649254 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-3cb4b65c tst -- -4 uname -a 2026-07-26 20:12:40.433721 UTC - Forcing IPv4 only. 2026-07-26 20:12:40.433912 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-3cb4b65c tst -- -4 uptime 2026-07-26 20:12:43.441101 UTC - CLI SSH Test passed. 2026-07-26 20:12:43.441217 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-07-26 20:12:43.441241 UTC - Uptime: 20:12:43 up 1 min, 1 user, load average: 0.68, 0.27, 0.09 2026-07-26 20:12:43.441291 UTC - Logging in using SSH over SSH proxy 2026-07-26 20:12:43.441500 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-3cb4b65c tst 2026-07-26 20:12:44.819061 UTC - Added paramiko HostKeyEntry for 192.168.0.131 2026-07-26 20:12:44.819270 UTC - Added paramiko HostKeyEntry for 192.168.0.131 2026-07-26 20:12:44.819434 UTC - Added paramiko HostKeyEntry for 192.168.0.131 2026-07-26 20:12:44.819697 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-26 20:12:44.819751 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-26 20:12:44.819886 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-26 20:12:44.819918 UTC - Connecting to proxy 193.225.251.128:22 2026-07-26 20:12:45.349561 UTC - Connecting to 192.168.0.131:22 over proxy 2026-07-26 20:12:46.113989 UTC - SSH Test output: 2026-07-26 20:12:46.114458 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-07-26 20:12:46.114526 UTC - Uptime: 20:12:45 up 1 min, 1 user, load average: 0.68, 0.27, 0.09 2026-07-26 20:12:46.261567 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-26 20:12:46.261642 UTC - lsb_release matches expected value 2026-07-26 20:12:46.261661 UTC - SSH Test passed. 2026-07-26 20:12:46.269155 UTC - Destroying tst-3cb4b65c tst 2026-07-26 20:12:46.269340 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-3cb4b65c tst