Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.20s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 501ms 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 829ms + 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.1 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-17 04:08:00.402837 UTC - Installing Slices CLI (latest stable version). 2026-07-17 04:08:00.403689 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-17 04:08:07.634692 UTC - Slices CLI installed. 2026-07-17 04:08:07.636563 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-17 04:08:07.640397 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-17 04:08:07.641488 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-17 04:08:07.641658 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-17 04:08:07.641692 UTC - Slices CLI exe: 'slices' 2026-07-17 04:08:07.641710 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-17 04:08:07.641840 UTC - Run: slices --version 2026-07-17 04:08:13.355980 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-17 04:08:13.356478 UTC - Run: slices pubkey list --format text 2026-07-17 04:08:14.848975 UTC - Pubkey already registered 2026-07-17 04:08:14.849491 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-17 04:08:15.776457 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-17 04:08:15.776586 UTC - Check List Flavors 2026-07-17 04:08:15.776875 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-07-17 04:08:18.404397 UTC - Check List DiskImages 2026-07-17 04:08:18.405614 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-07-17 04:08:20.491898 UTC - Requesting resources 2026-07-17 04:08:20.493179 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-cee50309 2026-07-17 04:08:26.584997 UTC - Resource ID: r_hu-budapest-bi-vm1_01kxq45sqye5stet4z97dt2tvw 2026-07-17 04:08:26.586371 UTC - Waiting until resource ready 2026-07-17 04:08:28.586820 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-cee50309 tst 2026-07-17 04:08:30.057087 UTC - Status: IMAGING 2026-07-17 04:08:33.183306 UTC - Status: IMAGING 2026-07-17 04:08:36.105733 UTC - Status: IMAGING 2026-07-17 04:08:39.034213 UTC - Status: IMAGING 2026-07-17 04:08:41.900575 UTC - Status: IMAGING 2026-07-17 04:08:45.226835 UTC - Status: IMAGING 2026-07-17 04:08:48.502367 UTC - Status: IMAGING 2026-07-17 04:08:51.599390 UTC - Status: IMAGING 2026-07-17 04:08:54.567189 UTC - Status: IMAGING 2026-07-17 04:08:57.915223 UTC - Status: IMAGING 2026-07-17 04:09:01.205432 UTC - Status: IMAGING 2026-07-17 04:09:04.183428 UTC - Status: IMAGING 2026-07-17 04:09:07.253079 UTC - Status: IMAGING 2026-07-17 04:09:10.069333 UTC - Status: IMAGING 2026-07-17 04:09:13.247657 UTC - Status: IMAGING 2026-07-17 04:09:16.163966 UTC - Status: IMAGING 2026-07-17 04:09:18.929872 UTC - Status: IMAGING 2026-07-17 04:09:21.802011 UTC - Status: IMAGING 2026-07-17 04:09:25.179135 UTC - Status: IMAGING 2026-07-17 04:09:28.251702 UTC - Status: IMAGING 2026-07-17 04:09:32.013200 UTC - Status: IMAGING 2026-07-17 04:09:35.134054 UTC - Status: IMAGING 2026-07-17 04:09:38.655349 UTC - Status: IMAGING 2026-07-17 04:09:42.031505 UTC - Status: IMAGING 2026-07-17 04:09:46.715327 UTC - Status: IMAGING 2026-07-17 04:09:49.581751 UTC - Status: UP 2026-07-17 04:09:49.581892 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxq45r6kfwrawdpp5vjwv3fb 2026-07-17 04:09:49.581939 UTC - Validate resources 2026-07-17 04:09:50.450321 UTC - The fields of the created resource were validated. 2026-07-17 04:09:50.450434 UTC - Check if resources are registered in experiment 2026-07-17 04:09:50.450645 UTC - Run: slices experiment list-resources --format json tst-cee50309 2026-07-17 04:09:51.491187 UTC - Status (on expauth): UP 2026-07-17 04:09:51.491713 UTC - Testing extend expires_at (all resources in experiment) 2026-07-17 04:09:51.491882 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-cee50309 2026-07-17 04:09:54.869940 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-cee50309 tst 2026-07-17 04:09:56.813614 UTC - Run: slices experiment list-resources --format json tst-cee50309 2026-07-17 04:09:57.683728 UTC - expires_at (on expauth): 2026-07-17T07:09:00Z (correctly extended) 2026-07-17 04:09:57.683844 UTC - Testing extend expires_at (single resource in experiment) 2026-07-17 04:09:57.684002 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-cee50309 2026-07-17 04:10:00.655082 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-cee50309 tst 2026-07-17 04:10:01.683789 UTC - Run: slices experiment list-resources --format json tst-cee50309 2026-07-17 04:10:02.700622 UTC - expires_at (on expauth): 2026-07-17T08:09:00Z (correctly extended) 2026-07-17 04:10:02.700792 UTC - Testing ssh login 2026-07-17 04:10:02.712449 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-cee50309 tst 2026-07-17 04:10:03.679662 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-cee50309 tst 2026-07-17 04:10:05.058903 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-cee50309 tst 2026-07-17 04:10:06.541314 UTC - Logging in using 'slices bi ssh' 2026-07-17 04:10:06.541391 UTC - Forcing IPv4 only. 2026-07-17 04:10:06.541534 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-cee50309 tst -- -4 uname -a 2026-07-17 04:10:12.024628 UTC - Forcing IPv4 only. 2026-07-17 04:10:12.025005 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-cee50309 tst -- -4 uptime 2026-07-17 04:10:14.097393 UTC - CLI SSH Test passed. 2026-07-17 04:10:14.097467 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-17 04:10:14.097496 UTC - Uptime: 04:10:14 up 1 min, 1 user, load average: 0.78, 0.29, 0.10 2026-07-17 04:10:14.097544 UTC - Logging in using SSH over SSH proxy 2026-07-17 04:10:14.097682 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-cee50309 tst 2026-07-17 04:10:15.171247 UTC - Added paramiko HostKeyEntry for 192.168.0.185 2026-07-17 04:10:15.171380 UTC - Added paramiko HostKeyEntry for 192.168.0.185 2026-07-17 04:10:15.171573 UTC - Added paramiko HostKeyEntry for 192.168.0.185 2026-07-17 04:10:15.171844 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-17 04:10:15.171908 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-17 04:10:15.172062 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-17 04:10:15.172094 UTC - Connecting to proxy 193.225.251.128:22 2026-07-17 04:10:15.709640 UTC - Connecting to 192.168.0.185:22 over proxy 2026-07-17 04:10:16.491028 UTC - SSH Test output: 2026-07-17 04:10:16.491102 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-17 04:10:16.491125 UTC - Uptime: 04:10:16 up 1 min, 1 user, load average: 0.78, 0.29, 0.10 2026-07-17 04:10:16.636987 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-17 04:10:16.637070 UTC - lsb_release matches expected value 2026-07-17 04:10:16.637097 UTC - SSH Test passed. 2026-07-17 04:10:16.644913 UTC - Destroying tst-cee50309 tst 2026-07-17 04:10:16.645103 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-cee50309 tst