Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.86s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 586ms 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.06s + 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-18 20:07:48.679164 UTC - Installing Slices CLI (latest stable version). 2026-07-18 20:07:48.679393 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-18 20:07:57.997800 UTC - Slices CLI installed. 2026-07-18 20:07:58.002773 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-18 20:07:58.006831 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-18 20:07:58.008406 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-18 20:07:58.008593 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-18 20:07:58.008627 UTC - Slices CLI exe: 'slices' 2026-07-18 20:07:58.008646 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-18 20:07:58.008856 UTC - Run: slices --version 2026-07-18 20:08:04.208656 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-18 20:08:04.209011 UTC - Run: slices pubkey list --format text 2026-07-18 20:08:05.224803 UTC - Pubkey already registered 2026-07-18 20:08:05.225045 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-18 20:08:05.894112 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-18 20:08:05.894202 UTC - Check List Flavors 2026-07-18 20:08:05.894356 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-18 20:08:07.229472 UTC - Check List DiskImages 2026-07-18 20:08:07.229666 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-18 20:08:07.847908 UTC - Requesting resources 2026-07-18 20:08:07.848466 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-48be6d80 2026-07-18 20:08:10.919238 UTC - Resource ID: r_ch-geneva-bi-vm1_01kxvdfvqbea0s0dppze9ym797 2026-07-18 20:08:10.919418 UTC - Waiting until resource ready 2026-07-18 20:08:12.919747 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-48be6d80 tst 2026-07-18 20:08:13.735661 UTC - Status: IMAGING 2026-07-18 20:08:16.658706 UTC - Status: IMAGING 2026-07-18 20:08:19.424612 UTC - Status: IMAGING 2026-07-18 20:08:22.290491 UTC - Status: IMAGING 2026-07-18 20:08:25.060221 UTC - Status: IMAGING 2026-07-18 20:08:28.187535 UTC - Status: IMAGING 2026-07-18 20:08:31.069888 UTC - Status: IMAGING 2026-07-18 20:08:34.301316 UTC - Status: IMAGING 2026-07-18 20:08:37.121219 UTC - Status: IMAGING 2026-07-18 20:08:40.974755 UTC - Status: IMAGING 2026-07-18 20:08:44.241038 UTC - Status: IMAGING 2026-07-18 20:08:47.006984 UTC - Status: IMAGING 2026-07-18 20:08:49.937010 UTC - Status: IMAGING 2026-07-18 20:08:53.181424 UTC - Status: IMAGING 2026-07-18 20:08:56.202295 UTC - Status: IMAGING 2026-07-18 20:09:00.028519 UTC - Status: IMAGING 2026-07-18 20:09:03.614211 UTC - Status: IMAGING 2026-07-18 20:09:06.790125 UTC - Status: IMAGING 2026-07-18 20:09:10.164369 UTC - Status: IMAGING 2026-07-18 20:09:13.563750 UTC - Status: IMAGING 2026-07-18 20:09:16.637686 UTC - Status: IMAGING 2026-07-18 20:09:19.468271 UTC - Status: IMAGING 2026-07-18 20:09:22.749257 UTC - Status: IMAGING 2026-07-18 20:09:26.192328 UTC - Status: IMAGING 2026-07-18 20:09:29.755138 UTC - Status: IMAGING 2026-07-18 20:09:33.999930 UTC - Status: IMAGING 2026-07-18 20:09:37.728062 UTC - Status: IMAGING 2026-07-18 20:09:41.681241 UTC - Status: IMAGING 2026-07-18 20:09:44.972675 UTC - Status: IMAGING 2026-07-18 20:09:48.005924 UTC - Status: IMAGING 2026-07-18 20:09:52.156120 UTC - Status: IMAGING 2026-07-18 20:09:55.630182 UTC - Status: IMAGING 2026-07-18 20:09:58.446684 UTC - Status: IMAGING 2026-07-18 20:10:01.765930 UTC - Status: IMAGING 2026-07-18 20:10:05.263424 UTC - Status: IMAGING 2026-07-18 20:10:08.192912 UTC - Status: UP 2026-07-18 20:10:08.192982 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxvdftq5f1cbxtmga2nzy4jt 2026-07-18 20:10:08.193022 UTC - Validate resources 2026-07-18 20:10:09.323485 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-18 20:10:09.323553 UTC - The fields of the created resource were validated. 2026-07-18 20:10:09.323587 UTC - Check if resources are registered in experiment 2026-07-18 20:10:09.323728 UTC - Run: slices experiment list-resources --format json tst-48be6d80 2026-07-18 20:10:10.101892 UTC - Status (on expauth): UP 2026-07-18 20:10:10.102031 UTC - Testing extend expires_at (all resources in experiment) 2026-07-18 20:10:10.102152 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-48be6d80 2026-07-18 20:10:12.973252 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-48be6d80 tst 2026-07-18 20:10:13.738870 UTC - Run: slices experiment list-resources --format json tst-48be6d80 2026-07-18 20:10:14.565821 UTC - expires_at (on expauth): 2026-07-18T23:10:00Z (correctly extended) 2026-07-18 20:10:14.565925 UTC - Testing extend expires_at (single resource in experiment) 2026-07-18 20:10:14.566122 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-48be6d80 2026-07-18 20:10:17.706153 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-48be6d80 tst 2026-07-18 20:10:19.047979 UTC - Run: slices experiment list-resources --format json tst-48be6d80 2026-07-18 20:10:19.877235 UTC - expires_at (on expauth): 2026-07-19T00:10:00Z (correctly extended) 2026-07-18 20:10:19.877379 UTC - Testing ssh login 2026-07-18 20:10:19.889567 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-48be6d80 tst 2026-07-18 20:10:20.709020 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-48be6d80 tst 2026-07-18 20:10:21.776682 UTC - Logging in using 'slices bi ssh' 2026-07-18 20:10:21.776776 UTC - Forcing IPv4 only. 2026-07-18 20:10:21.776916 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-48be6d80 tst -- -4 uname -a 2026-07-18 20:10:24.901966 UTC - Forcing IPv4 only. 2026-07-18 20:10:24.902142 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-48be6d80 tst -- -4 uptime 2026-07-18 20:10:26.118530 UTC - CLI SSH Test passed. 2026-07-18 20:10:26.118699 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-18 20:10:26.118738 UTC - Uptime: 20:10:26 up 1 min, 1 user, load average: 0.19, 0.06, 0.02 2026-07-18 20:10:26.118790 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-18 20:10:26.119488 UTC - Added paramiko HostKeyEntry for 5.53.108.211 2026-07-18 20:10:26.119652 UTC - Added paramiko HostKeyEntry for 5.53.108.211 2026-07-18 20:10:26.119909 UTC - Added paramiko HostKeyEntry for 5.53.108.211 2026-07-18 20:10:26.120178 UTC - Connecting to 5.53.108.211:22 2026-07-18 20:10:26.668372 UTC - SSH Test output: 2026-07-18 20:10:26.668442 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-18 20:10:26.668461 UTC - Uptime: 20:10:26 up 1 min, 1 user, load average: 0.19, 0.06, 0.02 2026-07-18 20:10:26.765478 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-18 20:10:26.765557 UTC - lsb_release matches expected value 2026-07-18 20:10:26.765580 UTC - SSH Test passed. 2026-07-18 20:10:26.765669 UTC - Skip SSH proxy test because no jump proxy 2026-07-18 20:10:26.772184 UTC - Destroying tst-48be6d80 tst 2026-07-18 20:10:26.772368 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-48be6d80 tst