Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.91s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 263ms 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 281ms + 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.3 Run Test: slices-bi-singlenode-login 2026-08-11 04:30:10.101916 UTC - Installing Slices CLI (latest, with --pre). 2026-08-11 04:30:10.102164 UTC - Run: /usr/local/bin/uv pip install --pre --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-11 04:30:15.379012 UTC - Slices CLI installed. 2026-08-11 04:30:15.379316 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-11 04:30:15.380518 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-11 04:30:15.380593 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-11 04:30:15.380662 UTC - which slices: /app/.venv/bin/slices 2026-08-11 04:30:15.380681 UTC - Slices CLI exe: 'slices' 2026-08-11 04:30:15.380696 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-11 04:30:15.380863 UTC - Run: slices --version 2026-08-11 04:30:18.053400 UTC - version: Slices CLI v2026.2.0b6 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-11 04:30:18.053711 UTC - Run: slices pubkey list --format text 2026-08-11 04:30:18.769187 UTC - Pubkey already registered 2026-08-11 04:30:18.769437 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-11 04:30:19.334790 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-11 04:30:19.334924 UTC - Check List Flavors 2026-08-11 04:30:19.335134 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-08-11 04:30:20.000805 UTC - Check List DiskImages 2026-08-11 04:30:20.001010 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-08-11 04:30:20.623614 UTC - Requesting resources 2026-08-11 04:30:20.624152 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-d1858a22 2026-08-11 04:30:21.690409 UTC - Resource ID: r_be-gent1-bi-vm1_01kzqhbxb4fc0skjky02dssdd4 2026-08-11 04:30:21.690571 UTC - Waiting until resource ready 2026-08-11 04:30:23.690963 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d1858a22 tst 2026-08-11 04:30:24.406752 UTC - Status: IMAGING 2026-08-11 04:30:27.172897 UTC - Status: IMAGING 2026-08-11 04:30:29.889329 UTC - Status: IMAGING 2026-08-11 04:30:32.605349 UTC - Status: BOOTING 2026-08-11 04:30:35.321578 UTC - Status: BOOTING 2026-08-11 04:30:38.037876 UTC - Status: BOOTING 2026-08-11 04:30:40.804167 UTC - Status: BOOTING 2026-08-11 04:30:43.620399 UTC - Status: BOOTING 2026-08-11 04:30:46.497200 UTC - Status: STARTING 2026-08-11 04:30:49.363571 UTC - Status: UP 2026-08-11 04:30:49.363651 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kzqhbx4cf80rjgpzdyhs4weq 2026-08-11 04:30:49.363697 UTC - Validate resources 2026-08-11 04:30:50.129912 UTC - The fields of the created resource were validated. 2026-08-11 04:30:50.130020 UTC - Check if resources are registered in experiment 2026-08-11 04:30:50.130176 UTC - Run: slices experiment list-resources --format json tst-d1858a22 2026-08-11 04:30:50.847916 UTC - Status (on expauth): UP 2026-08-11 04:30:50.848129 UTC - Testing extend expires_at (all resources in experiment) 2026-08-11 04:30:50.848313 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-d1858a22 2026-08-11 04:30:52.417318 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d1858a22 tst 2026-08-11 04:30:53.233410 UTC - Run: slices experiment list-resources --format json tst-d1858a22 2026-08-11 04:30:53.999018 UTC - expires_at (on expauth): 2026-08-11T07:30:00Z (correctly extended) 2026-08-11 04:30:53.999122 UTC - Testing extend expires_at (single resource in experiment) 2026-08-11 04:30:53.999311 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-d1858a22 2026-08-11 04:30:55.936887 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-d1858a22 tst 2026-08-11 04:30:56.727991 UTC - Run: slices experiment list-resources --format json tst-d1858a22 2026-08-11 04:30:57.502001 UTC - expires_at (on expauth): 2026-08-11T08:30:00Z (correctly extended) 2026-08-11 04:30:57.502112 UTC - Testing ssh login 2026-08-11 04:30:57.523781 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d1858a22 tst 2026-08-11 04:30:58.543906 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d1858a22 tst 2026-08-11 04:30:59.637450 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d1858a22 tst 2026-08-11 04:31:00.623061 UTC - Logging in using 'slices bi ssh' 2026-08-11 04:31:00.623146 UTC - Forcing IPv4 only. 2026-08-11 04:31:00.623344 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-d1858a22 tst -- -4 uname -a 2026-08-11 04:31:02.217058 UTC - Forcing IPv4 only. 2026-08-11 04:31:02.217331 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-d1858a22 tst -- -4 uptime 2026-08-11 04:31:03.303545 UTC - CLI SSH Test passed. 2026-08-11 04:31:03.303617 UTC - Uname: Linux tst 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-11 04:31:03.303638 UTC - Uptime: 06:31:02 up 0 min, 1 user, load average: 1.13, 0.30, 0.10 2026-08-11 04:31:03.303672 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-08-11 04:31:03.304143 UTC - Added paramiko HostKeyEntry for 10.10.212.152 2026-08-11 04:31:03.304322 UTC - Added paramiko HostKeyEntry for 10.10.212.152 2026-08-11 04:31:03.304378 UTC - Added paramiko HostKeyEntry for 10.10.212.152 2026-08-11 04:31:03.304742 UTC - Connecting to 10.10.212.152:22 2026-08-11 04:31:03.550876 UTC - SSH Test output: 2026-08-11 04:31:03.550961 UTC - Uname: Linux tst 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-11 04:31:03.550995 UTC - Uptime: 06:31:02 up 0 min, 1 user, load average: 1.13, 0.30, 0.10 2026-08-11 04:31:03.600011 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-11 04:31:03.600089 UTC - lsb_release matches expected value 2026-08-11 04:31:03.600111 UTC - SSH Test passed. 2026-08-11 04:31:03.600198 UTC - Logging in using SSH over SSH proxy 2026-08-11 04:31:03.600345 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d1858a22 tst 2026-08-11 04:31:04.581386 UTC - Added paramiko HostKeyEntry for 10.10.212.152 2026-08-11 04:31:04.581546 UTC - Added paramiko HostKeyEntry for 10.10.212.152 2026-08-11 04:31:04.581603 UTC - Added paramiko HostKeyEntry for 10.10.212.152 2026-08-11 04:31:04.582050 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-11 04:31:04.582154 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-11 04:31:04.582271 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-08-11 04:31:04.582312 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-08-11 04:31:04.859136 UTC - Connecting to 10.10.212.152:22 over proxy 2026-08-11 04:31:05.117168 UTC - SSH Test output: 2026-08-11 04:31:05.117242 UTC - Uname: Linux tst 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-11 04:31:05.117271 UTC - Uptime: 06:31:04 up 0 min, 2 users, load average: 1.13, 0.30, 0.10 2026-08-11 04:31:05.169789 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-11 04:31:05.169867 UTC - lsb_release matches expected value 2026-08-11 04:31:05.169887 UTC - SSH Test passed. 2026-08-11 04:31:05.187597 UTC - Destroying tst-d1858a22 tst 2026-08-11 04:31:05.187814 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-d1858a22 tst