Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.33s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 465ms 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.05s + 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==50.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.dev192+gcac2d3fe6 (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-08-03 20:10:49.941652 UTC - Installing Slices CLI (latest stable version). 2026-08-03 20:10:49.941920 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-03 20:10:55.892428 UTC - Slices CLI installed. 2026-08-03 20:10:55.893618 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-08-03 20:10:55.895186 UTC - ls -a /root/ /scripts/ (error 2): None ls: cannot access '/scripts/': No such file or directory /root/: . .. .cache .local .slices run_test_runner.sh slices-cli-venv 2026-08-03 20:10:55.895265 UTC - env: {'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-08-03 20:10:55.895338 UTC - which slices: /app/.venv/bin/slices 2026-08-03 20:10:55.895358 UTC - Slices CLI exe: 'slices' 2026-08-03 20:10:55.895374 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-03 20:10:55.895512 UTC - Run: slices --version 2026-08-03 20:11:00.960412 UTC - version: Slices CLI v2026.1.3 Slices CLI core v1.2.6 Slices CLI ai v1.1.0 Slices CLI bi v2.2.1 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-08-03 20:11:00.960873 UTC - Run: slices pubkey list --format text 2026-08-03 20:11:02.389054 UTC - Pubkey already registered 2026-08-03 20:11:02.389324 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-03 20:11:03.789396 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-03 20:11:03.789517 UTC - Check List Flavors 2026-08-03 20:11:03.789681 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-08-03 20:11:05.432903 UTC - Check List DiskImages 2026-08-03 20:11:05.433235 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-08-03 20:11:06.227991 UTC - Requesting resources 2026-08-03 20:11:06.229586 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-6041c01e 2026-08-03 20:11:08.108845 UTC - Resource ID: r_ch-geneva-bi-vm1_01kz4m0rpjexs9yh36yys0s6zt 2026-08-03 20:11:08.109005 UTC - Waiting until resource ready 2026-08-03 20:11:10.109340 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-6041c01e tst 2026-08-03 20:11:12.916284 UTC - Status: IMAGING 2026-08-03 20:11:17.189296 UTC - Status: IMAGING 2026-08-03 20:11:21.497201 UTC - Status: IMAGING 2026-08-03 20:11:25.757126 UTC - Status: IMAGING 2026-08-03 20:11:30.393166 UTC - Status: IMAGING 2026-08-03 20:11:35.363747 UTC - Status: IMAGING 2026-08-03 20:11:39.791061 UTC - Status: IMAGING 2026-08-03 20:11:44.541610 UTC - Status: IMAGING 2026-08-03 20:11:49.702484 UTC - Status: IMAGING 2026-08-03 20:11:54.756132 UTC - Status: IMAGING 2026-08-03 20:11:59.617023 UTC - Status: IMAGING 2026-08-03 20:12:03.169259 UTC - Status: IMAGING 2026-08-03 20:12:07.674714 UTC - Status: IMAGING 2026-08-03 20:12:12.500985 UTC - Status: IMAGING 2026-08-03 20:12:17.008525 UTC - Status: IMAGING 2026-08-03 20:12:21.172692 UTC - Status: IMAGING 2026-08-03 20:12:24.666024 UTC - Status: IMAGING 2026-08-03 20:12:28.537569 UTC - Status: IMAGING 2026-08-03 20:12:32.048077 UTC - Status: IMAGING 2026-08-03 20:12:36.123605 UTC - Status: IMAGING 2026-08-03 20:12:39.521681 UTC - Status: IMAGING 2026-08-03 20:12:42.906611 UTC - Status: IMAGING 2026-08-03 20:12:45.874825 UTC - Status: IMAGING 2026-08-03 20:12:48.941904 UTC - Status: IMAGING 2026-08-03 20:12:51.959167 UTC - Status: IMAGING 2026-08-03 20:12:55.349246 UTC - Status: UP 2026-08-03 20:12:55.349387 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kz4m0r8df498s2bhf5xtzkxd 2026-08-03 20:12:55.349440 UTC - Validate resources 2026-08-03 20:12:56.274159 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-08-03 20:12:56.274255 UTC - The fields of the created resource were validated. 2026-08-03 20:12:56.274302 UTC - Check if resources are registered in experiment 2026-08-03 20:12:56.274497 UTC - Run: slices experiment list-resources --format json tst-6041c01e 2026-08-03 20:12:57.090618 UTC - Status (on expauth): UP 2026-08-03 20:12:57.090756 UTC - Testing extend expires_at (all resources in experiment) 2026-08-03 20:12:57.090869 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-6041c01e 2026-08-03 20:12:58.361631 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-6041c01e tst 2026-08-03 20:12:59.378490 UTC - Run: slices experiment list-resources --format json tst-6041c01e 2026-08-03 20:13:00.194406 UTC - expires_at (on expauth): 2026-08-03T23:12:00Z (correctly extended) 2026-08-03 20:13:00.194533 UTC - Testing extend expires_at (single resource in experiment) 2026-08-03 20:13:00.194735 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-6041c01e 2026-08-03 20:13:01.414674 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-6041c01e tst 2026-08-03 20:13:02.389019 UTC - Run: slices experiment list-resources --format json tst-6041c01e 2026-08-03 20:13:03.105083 UTC - expires_at (on expauth): 2026-08-04T00:13:00Z (correctly extended) 2026-08-03 20:13:03.105197 UTC - Testing ssh login 2026-08-03 20:13:03.121768 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-6041c01e tst 2026-08-03 20:13:04.049926 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-6041c01e tst 2026-08-03 20:13:04.915827 UTC - Logging in using 'slices bi ssh' 2026-08-03 20:13:04.915937 UTC - Forcing IPv4 only. 2026-08-03 20:13:04.916089 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-6041c01e tst -- -4 uname -a 2026-08-03 20:13:07.535759 UTC - Forcing IPv4 only. 2026-08-03 20:13:07.535966 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-6041c01e tst -- -4 uptime 2026-08-03 20:13:08.752484 UTC - CLI SSH Test passed. 2026-08-03 20:13:08.752906 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-08-03 20:13:08.752960 UTC - Uptime: 20:13:08 up 1 min, 1 user, load average: 0.55, 0.16, 0.05 2026-08-03 20:13:08.752999 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-08-03 20:13:08.753530 UTC - Added paramiko HostKeyEntry for 5.53.108.251 2026-08-03 20:13:08.753652 UTC - Added paramiko HostKeyEntry for 5.53.108.251 2026-08-03 20:13:08.753834 UTC - Added paramiko HostKeyEntry for 5.53.108.251 2026-08-03 20:13:08.754030 UTC - Connecting to 5.53.108.251:22 2026-08-03 20:13:09.344861 UTC - SSH Test output: 2026-08-03 20:13:09.344937 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-08-03 20:13:09.344959 UTC - Uptime: 20:13:09 up 1 min, 1 user, load average: 0.55, 0.16, 0.05 2026-08-03 20:13:09.443037 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-03 20:13:09.443143 UTC - lsb_release matches expected value 2026-08-03 20:13:09.443167 UTC - SSH Test passed. 2026-08-03 20:13:09.443294 UTC - Skip SSH proxy test because no jump proxy 2026-08-03 20:13:09.452269 UTC - Destroying tst-6041c01e tst 2026-08-03 20:13:09.452513 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-6041c01e tst