Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 5.58s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 609ms 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 928ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + cffi==2.1.1 + 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.3 + 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-09 13:16:41.082550 UTC - Installing Slices CLI (latest stable version). 2026-08-09 13:16:41.082869 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-09 13:16:49.085457 UTC - Slices CLI installed. 2026-08-09 13:16:49.085744 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-09 13:16:49.089048 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-09 13:16:49.089143 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-09 13:16:49.089220 UTC - which slices: /app/.venv/bin/slices 2026-08-09 13:16:49.089241 UTC - Slices CLI exe: 'slices' 2026-08-09 13:16:49.089256 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-09 13:16:49.089396 UTC - Run: slices --version 2026-08-09 13:16:52.374088 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-09 13:16:52.374761 UTC - Run: slices pubkey list --format text 2026-08-09 13:16:53.646648 UTC - Pubkey already registered 2026-08-09 13:16:53.647717 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-09 13:16:54.470677 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-09 13:16:54.470772 UTC - Check List Flavors 2026-08-09 13:16:54.470924 UTC - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-08-09 13:16:55.953101 UTC - Check List DiskImages 2026-08-09 13:16:55.953528 UTC - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-08-09 13:16:57.323090 UTC - Requesting resources 2026-08-09 13:16:57.324400 UTC - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-c0459fa3 2026-08-09 13:16:59.402154 UTC - Resource ID: r_ch-geneva-bi-vm1_01kzkaprccejh9x42tnrnmxedj 2026-08-09 13:16:59.402314 UTC - Waiting until resource ready 2026-08-09 13:17:01.402704 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-c0459fa3 tst 2026-08-09 13:17:02.824952 UTC - Status: IMAGING 2026-08-09 13:17:06.863785 UTC - Status: IMAGING 2026-08-09 13:17:09.883579 UTC - Status: IMAGING 2026-08-09 13:17:13.233837 UTC - Status: IMAGING 2026-08-09 13:17:16.554886 UTC - Status: IMAGING 2026-08-09 13:17:19.420986 UTC - Status: IMAGING 2026-08-09 13:17:22.696275 UTC - Status: IMAGING 2026-08-09 13:17:25.939786 UTC - Status: IMAGING 2026-08-09 13:17:29.623398 UTC - Status: IMAGING 2026-08-09 13:17:32.602243 UTC - Status: IMAGING 2026-08-09 13:17:36.142725 UTC - Status: IMAGING 2026-08-09 13:17:39.385470 UTC - Status: IMAGING 2026-08-09 13:17:42.946116 UTC - Status: IMAGING 2026-08-09 13:17:46.114371 UTC - Status: IMAGING 2026-08-09 13:17:49.085515 UTC - Status: IMAGING 2026-08-09 13:17:52.210054 UTC - Status: IMAGING 2026-08-09 13:17:55.076225 UTC - Status: IMAGING 2026-08-09 13:17:58.896240 UTC - Status: IMAGING 2026-08-09 13:18:02.353602 UTC - Status: IMAGING 2026-08-09 13:18:05.426466 UTC - Status: IMAGING 2026-08-09 13:18:08.866116 UTC - Status: IMAGING 2026-08-09 13:18:11.946235 UTC - Status: IMAGING 2026-08-09 13:18:15.071582 UTC - Status: IMAGING 2026-08-09 13:18:18.192975 UTC - Status: IMAGING 2026-08-09 13:18:21.367429 UTC - Status: IMAGING 2026-08-09 13:18:24.509074 UTC - Status: IMAGING 2026-08-09 13:18:27.582455 UTC - Status: IMAGING 2026-08-09 13:18:30.599476 UTC - Status: IMAGING 2026-08-09 13:18:33.415584 UTC - Status: IMAGING 2026-08-09 13:18:36.281664 UTC - Status: IMAGING 2026-08-09 13:18:39.348310 UTC - Status: IMAGING 2026-08-09 13:18:42.215241 UTC - Status: IMAGING 2026-08-09 13:18:45.281864 UTC - Status: IMAGING 2026-08-09 13:18:48.097815 UTC - Status: IMAGING 2026-08-09 13:18:50.983269 UTC - Status: UP 2026-08-09 13:18:50.983350 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kzkapqxtekavpcrtqhra513r 2026-08-09 13:18:50.983391 UTC - Validate resources 2026-08-09 13:18:51.853987 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-09 13:18:51.854079 UTC - The fields of the created resource were validated. 2026-08-09 13:18:51.854114 UTC - Check if resources are registered in experiment 2026-08-09 13:18:51.854259 UTC - Run: slices experiment list-resources --format json tst-c0459fa3 2026-08-09 13:18:52.520049 UTC - Status (on expauth): UP 2026-08-09 13:18:52.520189 UTC - Testing extend expires_at (all resources in experiment) 2026-08-09 13:18:52.520314 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-c0459fa3 2026-08-09 13:18:53.636841 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-c0459fa3 tst 2026-08-09 13:18:54.402702 UTC - Run: slices experiment list-resources --format json tst-c0459fa3 2026-08-09 13:18:55.068179 UTC - expires_at (on expauth): 2026-08-09T16:18:00Z (correctly extended) 2026-08-09 13:18:55.068270 UTC - Testing extend expires_at (single resource in experiment) 2026-08-09 13:18:55.068428 UTC - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-c0459fa3 2026-08-09 13:18:56.235182 UTC - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-c0459fa3 tst 2026-08-09 13:18:57.103036 UTC - Run: slices experiment list-resources --format json tst-c0459fa3 2026-08-09 13:18:57.820410 UTC - expires_at (on expauth): 2026-08-09T17:18:00Z (correctly extended) 2026-08-09 13:18:57.820531 UTC - Testing ssh login 2026-08-09 13:18:57.834034 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-c0459fa3 tst 2026-08-09 13:18:58.649891 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-c0459fa3 tst 2026-08-09 13:18:59.515593 UTC - Logging in using 'slices bi ssh' 2026-08-09 13:18:59.515669 UTC - Forcing IPv4 only. 2026-08-09 13:18:59.515813 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-c0459fa3 tst -- -4 uname -a 2026-08-09 13:19:02.788379 UTC - Forcing IPv4 only. 2026-08-09 13:19:02.788546 UTC - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-c0459fa3 tst -- -4 uptime 2026-08-09 13:19:04.205794 UTC - CLI SSH Test passed. 2026-08-09 13:19:04.206051 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-09 13:19:04.206086 UTC - Uptime: 13:19:04 up 1 min, 1 user, load average: 0.32, 0.09, 0.03 2026-08-09 13:19:04.206124 UTC - Logging in using SSH (no SSH proxy in Resource) 2026-08-09 13:19:04.206573 UTC - Added paramiko HostKeyEntry for 5.53.108.177 2026-08-09 13:19:04.206650 UTC - Added paramiko HostKeyEntry for 5.53.108.177 2026-08-09 13:19:04.206788 UTC - Added paramiko HostKeyEntry for 5.53.108.177 2026-08-09 13:19:04.207389 UTC - Connecting to 5.53.108.177:22 2026-08-09 13:19:04.758876 UTC - SSH Test output: 2026-08-09 13:19:04.758949 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-09 13:19:04.758976 UTC - Uptime: 13:19:04 up 1 min, 1 user, load average: 0.32, 0.09, 0.03 2026-08-09 13:19:04.857719 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-09 13:19:04.857811 UTC - lsb_release matches expected value 2026-08-09 13:19:04.857831 UTC - SSH Test passed. 2026-08-09 13:19:04.857915 UTC - Skip SSH proxy test because no jump proxy 2026-08-09 13:19:04.871497 UTC - Destroying tst-c0459fa3 tst 2026-08-09 13:19:04.871741 UTC - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-c0459fa3 tst