Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.43s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 480ms 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 643ms + 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 14:01:16.236496 UTC - Installing Slices CLI (latest stable version). 2026-08-03 14:01:16.236976 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-03 14:01:22.802578 UTC - Slices CLI installed. 2026-08-03 14:01:22.804650 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 14:01:22.812351 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 14:01:22.812469 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 14:01:22.812559 UTC - which slices: /app/.venv/bin/slices 2026-08-03 14:01:22.812580 UTC - Slices CLI exe: 'slices' 2026-08-03 14:01:22.812600 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-03 14:01:22.812829 UTC - Run: slices --version 2026-08-03 14:01:27.467468 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 14:01:27.468136 UTC - Run: slices pubkey list --format text 2026-08-03 14:01:28.538128 UTC - Pubkey already registered 2026-08-03 14:01:28.538409 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-03 14:01:29.356147 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-03 14:01:29.356271 UTC - Check List Flavors 2026-08-03 14:01:29.356421 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-08-03 14:01:30.384325 UTC - Check List DiskImages 2026-08-03 14:01:30.384546 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-08-03 14:01:31.257884 UTC - Requesting resources 2026-08-03 14:01:31.258518 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-4a4e061d 2026-08-03 14:01:32.926407 UTC - Resource ID: r_ch-geneva-bi-vm1_01kz3yw16ke1g9vsn9qcep0rnr 2026-08-03 14:01:32.926724 UTC - Waiting until resource ready 2026-08-03 14:01:34.955068 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-4a4e061d tst 2026-08-03 14:01:36.072312 UTC - Status: IMAGING 2026-08-03 14:01:38.998842 UTC - Status: IMAGING 2026-08-03 14:01:41.967537 UTC - Status: IMAGING 2026-08-03 14:01:45.408804 UTC - Status: IMAGING 2026-08-03 14:01:48.389098 UTC - Status: IMAGING 2026-08-03 14:01:51.760397 UTC - Status: IMAGING 2026-08-03 14:01:54.777472 UTC - Status: IMAGING 2026-08-03 14:01:57.695605 UTC - Status: IMAGING 2026-08-03 14:02:00.614834 UTC - Status: IMAGING 2026-08-03 14:02:03.469081 UTC - Status: IMAGING 2026-08-03 14:02:06.689621 UTC - Status: IMAGING 2026-08-03 14:02:09.756981 UTC - Status: IMAGING 2026-08-03 14:02:12.876981 UTC - Status: IMAGING 2026-08-03 14:02:16.100822 UTC - Status: IMAGING 2026-08-03 14:02:19.019409 UTC - Status: IMAGING 2026-08-03 14:02:21.945908 UTC - Status: IMAGING 2026-08-03 14:02:25.016056 UTC - Status: IMAGING 2026-08-03 14:02:28.065781 UTC - Status: IMAGING 2026-08-03 14:02:31.084270 UTC - Status: IMAGING 2026-08-03 14:02:34.542605 UTC - Status: IMAGING 2026-08-03 14:02:37.459925 UTC - Status: IMAGING 2026-08-03 14:02:40.383097 UTC - Status: IMAGING 2026-08-03 14:02:43.300056 UTC - Status: IMAGING 2026-08-03 14:02:46.420506 UTC - Status: IMAGING 2026-08-03 14:02:49.460636 UTC - Status: IMAGING 2026-08-03 14:02:52.484892 UTC - Status: IMAGING 2026-08-03 14:02:56.252280 UTC - Status: IMAGING 2026-08-03 14:02:59.322194 UTC - Status: IMAGING 2026-08-03 14:03:02.259760 UTC - Status: IMAGING 2026-08-03 14:03:05.427653 UTC - Status: IMAGING 2026-08-03 14:03:08.444523 UTC - Status: IMAGING 2026-08-03 14:03:11.513748 UTC - Status: IMAGING 2026-08-03 14:03:14.783251 UTC - Status: IMAGING 2026-08-03 14:03:17.751488 UTC - Status: IMAGING 2026-08-03 14:03:20.670293 UTC - Status: IMAGING 2026-08-03 14:03:23.837977 UTC - Status: UP 2026-08-03 14:03:23.838098 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kz3yw0ptf929e7a0v42rpfeb 2026-08-03 14:03:23.838156 UTC - Validate resources 2026-08-03 14:03:24.762695 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 14:03:24.762777 UTC - The fields of the created resource were validated. 2026-08-03 14:03:24.762833 UTC - Check if resources are registered in experiment 2026-08-03 14:03:24.762989 UTC - Run: slices experiment list-resources --format json tst-4a4e061d 2026-08-03 14:03:25.729983 UTC - Status (on expauth): UP 2026-08-03 14:03:25.730131 UTC - Testing extend expires_at (all resources in experiment) 2026-08-03 14:03:25.730255 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-4a4e061d 2026-08-03 14:03:27.198456 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-4a4e061d tst 2026-08-03 14:03:28.119150 UTC - Run: slices experiment list-resources --format json tst-4a4e061d 2026-08-03 14:03:29.194632 UTC - expires_at (on expauth): 2026-08-03T17:03:00Z (correctly extended) 2026-08-03 14:03:29.195314 UTC - Testing extend expires_at (single resource in experiment) 2026-08-03 14:03:29.195508 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-4a4e061d 2026-08-03 14:03:30.464575 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-4a4e061d tst 2026-08-03 14:03:31.280642 UTC - Run: slices experiment list-resources --format json tst-4a4e061d 2026-08-03 14:03:32.149055 UTC - expires_at (on expauth): 2026-08-03T18:03:00Z (correctly extended) 2026-08-03 14:03:32.149169 UTC - Testing ssh login 2026-08-03 14:03:32.169909 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-4a4e061d tst 2026-08-03 14:03:33.238022 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-4a4e061d tst 2026-08-03 14:03:34.354488 UTC - Logging in using 'slices bi ssh' 2026-08-03 14:03:34.354573 UTC - Forcing IPv4 only. 2026-08-03 14:03:34.354686 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-4a4e061d tst -- -4 uname -a 2026-08-03 14:03:37.631196 UTC - Forcing IPv4 only. 2026-08-03 14:03:37.631376 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-4a4e061d tst -- -4 uptime 2026-08-03 14:03:38.901124 UTC - CLI SSH Test passed. 2026-08-03 14:03:38.901223 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 14:03:38.901244 UTC - Uptime: 14:03:38 up 1 min, 1 user, load average: 0.28, 0.07, 0.02 2026-08-03 14:03:38.901286 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-08-03 14:03:38.902024 UTC - Added paramiko HostKeyEntry for 5.53.108.225 2026-08-03 14:03:38.902164 UTC - Added paramiko HostKeyEntry for 5.53.108.225 2026-08-03 14:03:38.902333 UTC - Added paramiko HostKeyEntry for 5.53.108.225 2026-08-03 14:03:38.902577 UTC - Connecting to 5.53.108.225:22 2026-08-03 14:03:39.457440 UTC - SSH Test output: 2026-08-03 14:03:39.457537 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 14:03:39.457561 UTC - Uptime: 14:03:39 up 1 min, 1 user, load average: 0.28, 0.07, 0.02 2026-08-03 14:03:39.554939 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-03 14:03:39.555016 UTC - lsb_release matches expected value 2026-08-03 14:03:39.555037 UTC - SSH Test passed. 2026-08-03 14:03:39.555123 UTC - Skip SSH proxy test because no jump proxy 2026-08-03 14:03:39.565867 UTC - Destroying tst-4a4e061d tst 2026-08-03 14:03:39.566125 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-4a4e061d tst