Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.52s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 283ms 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 856ms + annotated-types==0.7.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.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-22 20:08:01.850981 UTC - Installing Slices CLI (latest stable version). 2026-07-22 20:08:01.851461 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-22 20:08:11.660237 UTC - Slices CLI installed. 2026-07-22 20:08:11.665607 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-22 20:08:11.667527 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-22 20:08:11.668650 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-22 20:08:11.668795 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-22 20:08:11.668827 UTC - Slices CLI exe: 'slices' 2026-07-22 20:08:11.668843 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-22 20:08:11.669108 UTC - Run: slices --version 2026-07-22 20:08:19.170061 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-22 20:08:19.170357 UTC - Run: slices pubkey list --format text 2026-07-22 20:08:20.871547 UTC - Pubkey already registered 2026-07-22 20:08:20.871785 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-22 20:08:21.750229 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-22 20:08:21.750331 UTC - Check List Flavors 2026-07-22 20:08:21.750476 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-22 20:08:23.124234 UTC - Check List DiskImages 2026-07-22 20:08:23.124455 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-22 20:08:24.402228 UTC - Requesting resources 2026-07-22 20:08:24.411839 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-00c6bff9 2026-07-22 20:08:27.100910 UTC - Resource ID: r_ch-geneva-bi-vm1_01ky5q37a0e61rc00zxdrn37pd 2026-07-22 20:08:27.101088 UTC - Waiting until resource ready 2026-07-22 20:08:29.101537 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-00c6bff9 tst 2026-07-22 20:08:31.381306 UTC - Status: IMAGING 2026-07-22 20:08:34.405159 UTC - Status: IMAGING 2026-07-22 20:08:37.548540 UTC - Status: IMAGING 2026-07-22 20:08:40.947111 UTC - Status: IMAGING 2026-07-22 20:08:44.941025 UTC - Status: IMAGING 2026-07-22 20:08:47.957514 UTC - Status: IMAGING 2026-07-22 20:08:50.823391 UTC - Status: IMAGING 2026-07-22 20:08:54.109942 UTC - Status: IMAGING 2026-07-22 20:08:57.939165 UTC - Status: IMAGING 2026-07-22 20:09:01.917182 UTC - Status: IMAGING 2026-07-22 20:09:05.731899 UTC - Status: IMAGING 2026-07-22 20:09:08.854644 UTC - Status: IMAGING 2026-07-22 20:09:11.820751 UTC - Status: IMAGING 2026-07-22 20:09:14.636835 UTC - Status: IMAGING 2026-07-22 20:09:18.151508 UTC - Status: IMAGING 2026-07-22 20:09:21.218741 UTC - Status: IMAGING 2026-07-22 20:09:24.192995 UTC - Status: IMAGING 2026-07-22 20:09:27.545789 UTC - Status: IMAGING 2026-07-22 20:09:30.741960 UTC - Status: IMAGING 2026-07-22 20:09:33.958621 UTC - Status: IMAGING 2026-07-22 20:09:37.177194 UTC - Status: IMAGING 2026-07-22 20:09:40.335862 UTC - Status: IMAGING 2026-07-22 20:09:44.411295 UTC - Status: IMAGING 2026-07-22 20:09:47.488617 UTC - Status: IMAGING 2026-07-22 20:09:50.956270 UTC - Status: IMAGING 2026-07-22 20:09:54.403890 UTC - Status: IMAGING 2026-07-22 20:09:57.672441 UTC - Status: IMAGING 2026-07-22 20:10:00.803137 UTC - Status: IMAGING 2026-07-22 20:10:03.619671 UTC - Status: IMAGING 2026-07-22 20:10:06.639235 UTC - Status: IMAGING 2026-07-22 20:10:09.897376 UTC - Status: IMAGING 2026-07-22 20:10:13.015123 UTC - Status: IMAGING 2026-07-22 20:10:15.781241 UTC - Status: IMAGING 2026-07-22 20:10:18.647562 UTC - Status: IMAGING 2026-07-22 20:10:21.564066 UTC - Status: IMAGING 2026-07-22 20:10:25.165288 UTC - Status: UP 2026-07-22 20:10:25.165610 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky5q36ggfd59wbb3c8kkb3bv 2026-07-22 20:10:25.165685 UTC - Validate resources 2026-07-22 20:10:26.440866 UTC - "slices bi list-resources" returned resource without private IPv4 address, but with a public IPv4 address. As test_allow_public_ipv4_instead_of_private is set, that is acceptable. 2026-07-22 20:10:26.440977 UTC - The fields of the created resource were validated. 2026-07-22 20:10:26.441023 UTC - Check if resources are registered in experiment 2026-07-22 20:10:26.441201 UTC - Run: slices experiment list-resources --format json tst-00c6bff9 2026-07-22 20:10:27.375794 UTC - Status (on expauth): UP 2026-07-22 20:10:27.375998 UTC - Testing extend expires_at (all resources in experiment) 2026-07-22 20:10:27.376142 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-00c6bff9 2026-07-22 20:10:29.673202 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-00c6bff9 tst 2026-07-22 20:10:31.112685 UTC - Run: slices experiment list-resources --format json tst-00c6bff9 2026-07-22 20:10:32.625950 UTC - expires_at (on expauth): 2026-07-22T23:10:00Z (correctly extended) 2026-07-22 20:10:32.637450 UTC - Testing extend expires_at (single resource in experiment) 2026-07-22 20:10:32.637681 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-00c6bff9 2026-07-22 20:10:35.191328 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-00c6bff9 tst 2026-07-22 20:10:37.001377 UTC - Run: slices experiment list-resources --format json tst-00c6bff9 2026-07-22 20:10:38.839325 UTC - expires_at (on expauth): 2026-07-23T00:10:00Z (correctly extended) 2026-07-22 20:10:38.839453 UTC - Testing ssh login 2026-07-22 20:10:38.871425 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-00c6bff9 tst 2026-07-22 20:10:40.420218 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-00c6bff9 tst 2026-07-22 20:10:41.766170 UTC - Logging in using 'slices bi ssh' 2026-07-22 20:10:41.766254 UTC - Forcing IPv4 only. 2026-07-22 20:10:41.770157 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-00c6bff9 tst -- -4 uname -a 2026-07-22 20:10:45.356085 UTC - Forcing IPv4 only. 2026-07-22 20:10:45.356327 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-00c6bff9 tst -- -4 uptime 2026-07-22 20:10:46.738053 UTC - CLI SSH Test passed. 2026-07-22 20:10:46.738173 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-22 20:10:46.738197 UTC - Uptime: 20:10:46 up 1 min, 1 user, load average: 0.14, 0.04, 0.01 2026-07-22 20:10:46.738249 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-22 20:10:46.738972 UTC - Added paramiko HostKeyEntry for 5.53.108.213 2026-07-22 20:10:46.739117 UTC - Added paramiko HostKeyEntry for 5.53.108.213 2026-07-22 20:10:46.739337 UTC - Added paramiko HostKeyEntry for 5.53.108.213 2026-07-22 20:10:46.739584 UTC - Connecting to 5.53.108.213:22 2026-07-22 20:10:47.306742 UTC - SSH Test output: 2026-07-22 20:10:47.306836 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-22 20:10:47.306873 UTC - Uptime: 20:10:47 up 1 min, 1 user, load average: 0.14, 0.04, 0.01 2026-07-22 20:10:47.406268 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-22 20:10:47.406371 UTC - lsb_release matches expected value 2026-07-22 20:10:47.406394 UTC - SSH Test passed. 2026-07-22 20:10:47.406514 UTC - Skip SSH proxy test because no jump proxy 2026-07-22 20:10:47.416219 UTC - Destroying tst-00c6bff9 tst 2026-07-22 20:10:47.416441 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-00c6bff9 tst