Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.60s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 497ms 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.25s + 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.3 + 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.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-15 04:07:34.357136 UTC - Installing Slices CLI (latest stable version). 2026-07-15 04:07:34.357581 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-15 04:08:43.135936 UTC - Slices CLI installed. 2026-07-15 04:08:43.139940 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-15 04:08:43.141253 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-15 04:08:43.142278 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-15 04:08:43.142398 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-15 04:08:43.142425 UTC - Slices CLI exe: 'slices' 2026-07-15 04:08:43.142441 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-15 04:08:43.142757 UTC - Run: slices --version 2026-07-15 04:08:51.455096 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-15 04:08:51.455409 UTC - Run: slices pubkey list --format text 2026-07-15 04:08:53.257033 UTC - Pubkey already registered 2026-07-15 04:08:53.257283 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-15 04:08:54.825141 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-15 04:08:54.825230 UTC - Check List Flavors 2026-07-15 04:08:54.825378 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-07-15 04:08:57.453216 UTC - Check List DiskImages 2026-07-15 04:08:57.453389 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-07-15 04:08:58.168760 UTC - Requesting resources 2026-07-15 04:08:58.169570 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-d825b13d 2026-07-15 04:09:02.801749 UTC - Resource ID: r_hu-budapest-bi-vm1_01kxhzdf46efstrcpzd5h10b9j 2026-07-15 04:09:02.801914 UTC - Waiting until resource ready 2026-07-15 04:09:04.802241 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-d825b13d tst 2026-07-15 04:09:06.143904 UTC - Status: IMAGING 2026-07-15 04:09:09.583976 UTC - Status: IMAGING 2026-07-15 04:09:13.405588 UTC - Status: IMAGING 2026-07-15 04:09:16.781604 UTC - Status: IMAGING 2026-07-15 04:09:20.024483 UTC - Status: IMAGING 2026-07-15 04:09:23.302107 UTC - Status: IMAGING 2026-07-15 04:09:26.284395 UTC - Status: IMAGING 2026-07-15 04:09:29.201290 UTC - Status: IMAGING 2026-07-15 04:09:33.088703 UTC - Status: IMAGING 2026-07-15 04:09:36.389241 UTC - Status: IMAGING 2026-07-15 04:09:39.427407 UTC - Status: IMAGING 2026-07-15 04:09:42.572218 UTC - Status: IMAGING 2026-07-15 04:09:45.400710 UTC - Status: IMAGING 2026-07-15 04:09:48.428206 UTC - Status: IMAGING 2026-07-15 04:09:51.298403 UTC - Status: IMAGING 2026-07-15 04:09:54.971755 UTC - Status: IMAGING 2026-07-15 04:09:57.888938 UTC - Status: IMAGING 2026-07-15 04:10:00.706152 UTC - Status: IMAGING 2026-07-15 04:10:03.578628 UTC - Status: IMAGING 2026-07-15 04:10:06.346661 UTC - Status: IMAGING 2026-07-15 04:10:09.484688 UTC - Status: IMAGING 2026-07-15 04:10:12.878703 UTC - Status: IMAGING 2026-07-15 04:10:16.161651 UTC - Status: UP 2026-07-15 04:10:16.161765 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxhzddjges2azwt4egr281bv 2026-07-15 04:10:16.161812 UTC - Validate resources 2026-07-15 04:10:17.608012 UTC - The fields of the created resource were validated. 2026-07-15 04:10:17.608114 UTC - Check if resources are registered in experiment 2026-07-15 04:10:17.608269 UTC - Run: slices experiment list-resources --format json tst-d825b13d 2026-07-15 04:10:18.894618 UTC - Status (on expauth): UP 2026-07-15 04:10:18.894770 UTC - Testing extend expires_at (all resources in experiment) 2026-07-15 04:10:18.894904 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-d825b13d 2026-07-15 04:10:22.219765 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-d825b13d tst 2026-07-15 04:10:23.333919 UTC - Run: slices experiment list-resources --format json tst-d825b13d 2026-07-15 04:10:24.056239 UTC - expires_at (on expauth): 2026-07-15T07:10:00Z (correctly extended) 2026-07-15 04:10:24.056339 UTC - Testing extend expires_at (single resource in experiment) 2026-07-15 04:10:24.056468 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-d825b13d 2026-07-15 04:10:27.180845 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-d825b13d tst 2026-07-15 04:10:28.514187 UTC - Run: slices experiment list-resources --format json tst-d825b13d 2026-07-15 04:10:29.439209 UTC - expires_at (on expauth): 2026-07-15T08:10:00Z (correctly extended) 2026-07-15 04:10:29.439350 UTC - Testing ssh login 2026-07-15 04:10:29.464048 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d825b13d tst 2026-07-15 04:10:30.743936 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d825b13d tst 2026-07-15 04:10:32.234816 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d825b13d tst 2026-07-15 04:10:33.821475 UTC - Logging in using 'slices bi ssh' 2026-07-15 04:10:33.821566 UTC - Forcing IPv4 only. 2026-07-15 04:10:33.821700 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-d825b13d tst -- -4 uname -a 2026-07-15 04:10:40.096282 UTC - Forcing IPv4 only. 2026-07-15 04:10:40.096673 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-d825b13d tst -- -4 uptime 2026-07-15 04:10:43.964082 UTC - CLI SSH Test passed. 2026-07-15 04:10:43.964394 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-15 04:10:43.964430 UTC - Uptime: 04:10:43 up 1 min, 1 user, load average: 0.34, 0.13, 0.04 2026-07-15 04:10:43.964465 UTC - Logging in using SSH over SSH proxy 2026-07-15 04:10:43.964606 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d825b13d tst 2026-07-15 04:10:46.829514 UTC - Added paramiko HostKeyEntry for 192.168.0.74 2026-07-15 04:10:46.829666 UTC - Added paramiko HostKeyEntry for 192.168.0.74 2026-07-15 04:10:46.829837 UTC - Added paramiko HostKeyEntry for 192.168.0.74 2026-07-15 04:10:46.832362 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-15 04:10:46.832444 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-15 04:10:46.832563 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-15 04:10:46.832584 UTC - Connecting to proxy 193.225.251.128:22 2026-07-15 04:10:47.365506 UTC - Connecting to 192.168.0.74:22 over proxy 2026-07-15 04:10:48.154814 UTC - SSH Test output: 2026-07-15 04:10:48.154884 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-15 04:10:48.154905 UTC - Uptime: 04:10:47 up 1 min, 1 user, load average: 0.34, 0.13, 0.04 2026-07-15 04:10:48.304281 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-15 04:10:48.304356 UTC - lsb_release matches expected value 2026-07-15 04:10:48.304377 UTC - SSH Test passed. 2026-07-15 04:10:48.323156 UTC - Destroying tst-d825b13d tst 2026-07-15 04:10:48.323340 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-d825b13d tst