Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 9.81s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 795ms 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.07s + 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.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-07-30 13:09:39.564419 UTC - Installing Slices CLI (latest stable version). 2026-07-30 13:09:39.564656 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-30 13:09:46.008388 UTC - Slices CLI installed. 2026-07-30 13:09:46.009517 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-30 13:09:46.013330 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-30 13:09:46.013403 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-30 13:09:46.013469 UTC - which slices: /app/.venv/bin/slices 2026-07-30 13:09:46.013488 UTC - Slices CLI exe: 'slices' 2026-07-30 13:09:46.013503 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-30 13:09:46.013625 UTC - Run: slices --version 2026-07-30 13:09:51.028386 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-07-30 13:09:51.028660 UTC - Run: slices pubkey list --format text 2026-07-30 13:09:51.948639 UTC - Pubkey already registered 2026-07-30 13:09:51.948890 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-30 13:09:52.564062 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-30 13:09:52.564154 UTC - Check List Flavors 2026-07-30 13:09:52.564308 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-07-30 13:09:53.638580 UTC - Check List DiskImages 2026-07-30 13:09:53.638991 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-07-30 13:09:54.675637 UTC - Requesting resources 2026-07-30 13:09:54.676154 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-667234c3 2026-07-30 13:09:56.405323 UTC - Resource ID: r_ch-geneva-bi-vm1_01kysjan4yedgvdztjc4aha8qp 2026-07-30 13:09:56.405497 UTC - Waiting until resource ready 2026-07-30 13:09:58.405862 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-667234c3 tst 2026-07-30 13:09:59.273902 UTC - Status: IMAGING 2026-07-30 13:10:02.046042 UTC - Status: IMAGING 2026-07-30 13:10:05.806667 UTC - Status: IMAGING 2026-07-30 13:10:08.990352 UTC - Status: IMAGING 2026-07-30 13:10:12.272294 UTC - Status: IMAGING 2026-07-30 13:10:15.609493 UTC - Status: IMAGING 2026-07-30 13:10:18.962527 UTC - Status: IMAGING 2026-07-30 13:10:22.820679 UTC - Status: IMAGING 2026-07-30 13:10:27.230032 UTC - Status: IMAGING 2026-07-30 13:10:31.237267 UTC - Status: IMAGING 2026-07-30 13:10:34.424562 UTC - Status: IMAGING 2026-07-30 13:10:38.491148 UTC - Status: IMAGING 2026-07-30 13:10:41.573917 UTC - Status: IMAGING 2026-07-30 13:10:44.641351 UTC - Status: IMAGING 2026-07-30 13:10:47.790357 UTC - Status: IMAGING 2026-07-30 13:10:51.848032 UTC - Status: IMAGING 2026-07-30 13:10:55.594505 UTC - Status: IMAGING 2026-07-30 13:10:59.351327 UTC - Status: IMAGING 2026-07-30 13:11:03.430539 UTC - Status: IMAGING 2026-07-30 13:11:07.332727 UTC - Status: IMAGING 2026-07-30 13:11:11.246099 UTC - Status: IMAGING 2026-07-30 13:11:14.987125 UTC - Status: IMAGING 2026-07-30 13:11:17.858634 UTC - Status: IMAGING 2026-07-30 13:11:20.674908 UTC - Status: IMAGING 2026-07-30 13:11:23.606575 UTC - Status: IMAGING 2026-07-30 13:11:26.979045 UTC - Status: IMAGING 2026-07-30 13:11:30.465417 UTC - Status: IMAGING 2026-07-30 13:11:33.783040 UTC - Status: IMAGING 2026-07-30 13:11:36.699633 UTC - Status: IMAGING 2026-07-30 13:11:39.716251 UTC - Status: IMAGING 2026-07-30 13:11:42.482978 UTC - Status: UP 2026-07-30 13:11:42.483052 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kysjamnke5nbcxdbra6sy5fj 2026-07-30 13:11:42.483093 UTC - Validate resources 2026-07-30 13:11:43.255612 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-30 13:11:43.255685 UTC - The fields of the created resource were validated. 2026-07-30 13:11:43.255723 UTC - Check if resources are registered in experiment 2026-07-30 13:11:43.255890 UTC - Run: slices experiment list-resources --format json tst-667234c3 2026-07-30 13:11:43.921769 UTC - Status (on expauth): UP 2026-07-30 13:11:43.922017 UTC - Testing extend expires_at (all resources in experiment) 2026-07-30 13:11:43.922365 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-667234c3 2026-07-30 13:11:45.241628 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-667234c3 tst 2026-07-30 13:11:46.108993 UTC - Run: slices experiment list-resources --format json tst-667234c3 2026-07-30 13:11:46.825537 UTC - expires_at (on expauth): 2026-07-30T16:11:00Z (correctly extended) 2026-07-30 13:11:46.825626 UTC - Testing extend expires_at (single resource in experiment) 2026-07-30 13:11:46.825771 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-667234c3 2026-07-30 13:11:47.942266 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-667234c3 tst 2026-07-30 13:11:48.909160 UTC - Run: slices experiment list-resources --format json tst-667234c3 2026-07-30 13:11:49.578332 UTC - expires_at (on expauth): 2026-07-30T17:11:00Z (correctly extended) 2026-07-30 13:11:49.578443 UTC - Testing ssh login 2026-07-30 13:11:49.589748 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-667234c3 tst 2026-07-30 13:11:50.405591 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-667234c3 tst 2026-07-30 13:11:51.221584 UTC - Logging in using 'slices bi ssh' 2026-07-30 13:11:51.221656 UTC - Forcing IPv4 only. 2026-07-30 13:11:51.221783 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-667234c3 tst -- -4 uname -a 2026-07-30 13:11:54.145642 UTC - Forcing IPv4 only. 2026-07-30 13:11:54.145851 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-667234c3 tst -- -4 uptime 2026-07-30 13:11:55.413447 UTC - CLI SSH Test passed. 2026-07-30 13:11:55.413521 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-30 13:11:55.413540 UTC - Uptime: 13:11:55 up 1 min, 1 user, load average: 0.35, 0.10, 0.03 2026-07-30 13:11:55.413573 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-07-30 13:11:55.414029 UTC - Added paramiko HostKeyEntry for 5.53.108.245 2026-07-30 13:11:55.414113 UTC - Added paramiko HostKeyEntry for 5.53.108.245 2026-07-30 13:11:55.414270 UTC - Added paramiko HostKeyEntry for 5.53.108.245 2026-07-30 13:11:55.414438 UTC - Connecting to 5.53.108.245:22 2026-07-30 13:11:55.976416 UTC - SSH Test output: 2026-07-30 13:11:55.976489 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-30 13:11:55.976509 UTC - Uptime: 13:11:55 up 1 min, 1 user, load average: 0.35, 0.10, 0.03 2026-07-30 13:11:56.075132 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-30 13:11:56.075214 UTC - lsb_release matches expected value 2026-07-30 13:11:56.075247 UTC - SSH Test passed. 2026-07-30 13:11:56.075335 UTC - Skip SSH proxy test because no jump proxy 2026-07-30 13:11:56.083717 UTC - Destroying tst-667234c3 tst 2026-07-30 13:11:56.083939 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-667234c3 tst