Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.38s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 282ms 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 825ms + 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==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.3.post1 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev189+g506e4860f (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-28 04:15:47.265322 UTC - Installing Slices CLI (latest stable version). 2026-07-28 04:15:47.265707 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-28 04:15:53.221168 UTC - Slices CLI installed. 2026-07-28 04:15:53.222106 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-28 04:15:53.226215 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-07-28 04:15:53.226331 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-07-28 04:15:53.226407 UTC - which slices: /app/.venv/bin/slices 2026-07-28 04:15:53.226429 UTC - Slices CLI exe: 'slices' 2026-07-28 04:15:53.226444 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-28 04:15:53.226588 UTC - Run: slices --version 2026-07-28 04:15:57.072421 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-28 04:15:57.072912 UTC - Run: slices pubkey list --format text 2026-07-28 04:15:58.189076 UTC - Pubkey already registered 2026-07-28 04:15:58.189309 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-28 04:15:58.854751 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-28 04:15:58.854853 UTC - Check List Flavors 2026-07-28 04:15:58.854994 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-28 04:16:00.174608 UTC - Check List DiskImages 2026-07-28 04:16:00.174795 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-28 04:16:01.097648 UTC - Requesting resources 2026-07-28 04:16:01.098223 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-64fc9329 2026-07-28 04:16:03.924377 UTC - Resource ID: r_ch-geneva-bi-vm1_01kykeznkdf60r75wjfx87jmb0 2026-07-28 04:16:03.924742 UTC - Waiting until resource ready 2026-07-28 04:16:05.925089 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-64fc9329 tst 2026-07-28 04:16:06.741098 UTC - Status: IMAGING 2026-07-28 04:16:09.861109 UTC - Status: IMAGING 2026-07-28 04:16:12.733967 UTC - Status: IMAGING 2026-07-28 04:16:15.701356 UTC - Status: IMAGING 2026-07-28 04:16:18.646039 UTC - Status: IMAGING 2026-07-28 04:16:21.465491 UTC - Status: IMAGING 2026-07-28 04:16:24.897296 UTC - Status: IMAGING 2026-07-28 04:16:27.932117 UTC - Status: IMAGING 2026-07-28 04:16:31.738216 UTC - Status: IMAGING 2026-07-28 04:16:34.606535 UTC - Status: IMAGING 2026-07-28 04:16:37.736381 UTC - Status: IMAGING 2026-07-28 04:16:42.006010 UTC - Status: IMAGING 2026-07-28 04:16:45.533260 UTC - Status: IMAGING 2026-07-28 04:16:49.582478 UTC - Status: IMAGING 2026-07-28 04:16:52.866231 UTC - Status: IMAGING 2026-07-28 04:16:56.049864 UTC - Status: IMAGING 2026-07-28 04:16:59.373813 UTC - Status: IMAGING 2026-07-28 04:17:03.163356 UTC - Status: IMAGING 2026-07-28 04:17:06.453485 UTC - Status: IMAGING 2026-07-28 04:17:09.473114 UTC - Status: IMAGING 2026-07-28 04:17:12.509819 UTC - Status: IMAGING 2026-07-28 04:17:15.426368 UTC - Status: IMAGING 2026-07-28 04:17:19.365268 UTC - Status: IMAGING 2026-07-28 04:17:22.995890 UTC - Status: IMAGING 2026-07-28 04:17:26.944471 UTC - Status: IMAGING 2026-07-28 04:17:30.431634 UTC - Status: IMAGING 2026-07-28 04:17:33.618276 UTC - Status: IMAGING 2026-07-28 04:17:36.792569 UTC - Status: IMAGING 2026-07-28 04:17:40.205300 UTC - Status: IMAGING 2026-07-28 04:17:43.479902 UTC - Status: IMAGING 2026-07-28 04:17:47.008190 UTC - Status: IMAGING 2026-07-28 04:17:50.191517 UTC - Status: IMAGING 2026-07-28 04:17:53.207813 UTC - Status: IMAGING 2026-07-28 04:17:56.128546 UTC - Status: IMAGING 2026-07-28 04:17:59.561063 UTC - Status: IMAGING 2026-07-28 04:18:03.183139 UTC - Status: UP 2026-07-28 04:18:03.183881 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kykezmwnfctvjtskwqvnj3tc 2026-07-28 04:18:03.183950 UTC - Validate resources 2026-07-28 04:18:04.524560 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-28 04:18:04.524668 UTC - The fields of the created resource were validated. 2026-07-28 04:18:04.524709 UTC - Check if resources are registered in experiment 2026-07-28 04:18:04.524914 UTC - Run: slices experiment list-resources --format json tst-64fc9329 2026-07-28 04:18:05.745618 UTC - Status (on expauth): UP 2026-07-28 04:18:05.745754 UTC - Testing extend expires_at (all resources in experiment) 2026-07-28 04:18:05.745888 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-64fc9329 2026-07-28 04:18:08.098810 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-64fc9329 tst 2026-07-28 04:18:09.267278 UTC - Run: slices experiment list-resources --format json tst-64fc9329 2026-07-28 04:18:10.033094 UTC - expires_at (on expauth): 2026-07-28T07:18:00Z (correctly extended) 2026-07-28 04:18:10.033204 UTC - Testing extend expires_at (single resource in experiment) 2026-07-28 04:18:10.033354 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-64fc9329 2026-07-28 04:18:12.006129 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-64fc9329 tst 2026-07-28 04:18:12.826286 UTC - Run: slices experiment list-resources --format json tst-64fc9329 2026-07-28 04:18:13.542412 UTC - expires_at (on expauth): 2026-07-28T08:18:00Z (correctly extended) 2026-07-28 04:18:13.542538 UTC - Testing ssh login 2026-07-28 04:18:13.577781 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-64fc9329 tst 2026-07-28 04:18:14.554146 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-64fc9329 tst 2026-07-28 04:18:15.475907 UTC - Logging in using 'slices bi ssh' 2026-07-28 04:18:15.475984 UTC - Forcing IPv4 only. 2026-07-28 04:18:15.476153 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-64fc9329 tst -- -4 uname -a 2026-07-28 04:18:18.458600 UTC - Forcing IPv4 only. 2026-07-28 04:18:18.458794 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-64fc9329 tst -- -4 uptime 2026-07-28 04:18:19.826278 UTC - CLI SSH Test passed. 2026-07-28 04:18:19.826516 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-07-28 04:18:19.826551 UTC - Uptime: 04:18:19 up 1 min, 1 user, load average: 0.15, 0.06, 0.02 2026-07-28 04:18:19.826586 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-28 04:18:19.827409 UTC - Added paramiko HostKeyEntry for 5.53.108.98 2026-07-28 04:18:19.827521 UTC - Added paramiko HostKeyEntry for 5.53.108.98 2026-07-28 04:18:19.827679 UTC - Added paramiko HostKeyEntry for 5.53.108.98 2026-07-28 04:18:19.827853 UTC - Connecting to 5.53.108.98:22 2026-07-28 04:18:20.388329 UTC - SSH Test output: 2026-07-28 04:18:20.388424 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-07-28 04:18:20.388445 UTC - Uptime: 04:18:20 up 1 min, 1 user, load average: 0.15, 0.06, 0.02 2026-07-28 04:18:20.484403 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-28 04:18:20.484490 UTC - lsb_release matches expected value 2026-07-28 04:18:20.484514 UTC - SSH Test passed. 2026-07-28 04:18:20.484622 UTC - Skip SSH proxy test because no jump proxy 2026-07-28 04:18:20.495462 UTC - Destroying tst-64fc9329 tst 2026-07-28 04:18:20.495644 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-64fc9329 tst