Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 8.18s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 478ms 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.25s + 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-07 20:16:17.837321 UTC - Installing Slices CLI (latest stable version). 2026-08-07 20:16:17.838391 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-07 20:16:24.943364 UTC - Slices CLI installed. 2026-08-07 20:16:24.943676 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-07 20:16:24.945079 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-07 20:16:24.945166 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-07 20:16:24.945241 UTC - which slices: /app/.venv/bin/slices 2026-08-07 20:16:24.945260 UTC - Slices CLI exe: 'slices' 2026-08-07 20:16:24.945278 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-07 20:16:24.945437 UTC - Run: slices --version 2026-08-07 20:16:30.027169 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-07 20:16:30.027833 UTC - Run: slices pubkey list --format text 2026-08-07 20:16:32.622131 UTC - Pubkey already registered 2026-08-07 20:16:32.622352 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-07 20:16:34.875700 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-07 20:16:34.875803 UTC - Check List Flavors 2026-08-07 20:16:34.875954 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-08-07 20:16:36.445818 UTC - Check List DiskImages 2026-08-07 20:16:36.446076 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-08-07 20:16:37.763941 UTC - Requesting resources 2026-08-07 20:16:37.764657 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-08-07 20:16:37.764808 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-22605388 --user-data /tmp/tmphezrtf_g 2026-08-07 20:16:39.568391 UTC - Resource ID: r_de-munich-bi-vm_01kzexxrbnedhabst8d2s0z39x 2026-08-07 20:16:39.568588 UTC - Waiting until resource ready 2026-08-07 20:16:41.568916 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-22605388 tst 2026-08-07 20:16:43.643112 UTC - Status: IMAGING 2026-08-07 20:16:46.970883 UTC - Status: BOOTING 2026-08-07 20:16:50.173170 UTC - Status: BOOTING 2026-08-07 20:16:53.351064 UTC - Status: BOOTING 2026-08-07 20:16:56.374316 UTC - Status: BOOTING 2026-08-07 20:16:59.290819 UTC - Status: BOOTING 2026-08-07 20:17:02.157399 UTC - Status: BOOTING 2026-08-07 20:17:05.329609 UTC - Status: UP 2026-08-07 20:17:05.329711 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kzexxqr8ektrp9bva01vm8bf 2026-08-07 20:17:05.329792 UTC - Validate resources 2026-08-07 20:17:06.196948 UTC - The fields of the created resource were validated. 2026-08-07 20:17:06.197079 UTC - Check if resources are registered in experiment 2026-08-07 20:17:06.197263 UTC - Run: slices experiment list-resources --format json tst-22605388 2026-08-07 20:17:06.913388 UTC - Status (on expauth): UP 2026-08-07 20:17:06.913555 UTC - Testing extend expires_at (all resources in experiment) 2026-08-07 20:17:06.913699 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-22605388 2026-08-07 20:17:08.230493 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-22605388 tst 2026-08-07 20:17:09.149088 UTC - Run: slices experiment list-resources --format json tst-22605388 2026-08-07 20:17:09.864645 UTC - expires_at (on expauth): 2026-08-07T23:17:00Z (correctly extended) 2026-08-07 20:17:09.864823 UTC - Testing extend expires_at (single resource in experiment) 2026-08-07 20:17:09.865044 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-22605388 2026-08-07 20:17:11.386522 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-22605388 tst 2026-08-07 20:17:12.913683 UTC - Run: slices experiment list-resources --format json tst-22605388 2026-08-07 20:17:14.244127 UTC - expires_at (on expauth): 2026-08-08T00:17:00Z (correctly extended) 2026-08-07 20:17:14.244612 UTC - Testing ssh login 2026-08-07 20:17:14.293983 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-22605388 tst 2026-08-07 20:17:16.022090 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-22605388 tst 2026-08-07 20:17:17.308185 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-22605388 tst 2026-08-07 20:17:18.777202 UTC - Logging in using 'slices bi ssh' 2026-08-07 20:17:18.777303 UTC - Forcing IPv4 only. 2026-08-07 20:17:18.777474 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-22605388 tst -- -4 uname -a 2026-08-07 20:17:22.518502 UTC - Forcing IPv4 only. 2026-08-07 20:17:22.518697 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-22605388 tst -- -4 uptime 2026-08-07 20:17:24.437513 UTC - CLI SSH Test passed. 2026-08-07 20:17:24.437606 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-07 20:17:24.437626 UTC - Uptime: 20:17:23 up 0 min, 1 user, load average: 0.25, 0.07, 0.02 2026-08-07 20:17:24.437675 UTC - Logging in using SSH over SSH proxy 2026-08-07 20:17:24.437821 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-22605388 tst 2026-08-07 20:17:25.454957 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-07 20:17:25.455172 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-07 20:17:25.455237 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-07 20:17:25.455507 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-07 20:17:25.455610 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-07 20:17:25.455666 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-07 20:17:25.455701 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-08-07 20:17:25.852442 UTC - Connecting to 172.30.255.5:22 over proxy 2026-08-07 20:17:26.533672 UTC - SSH Test output: 2026-08-07 20:17:26.533746 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-07 20:17:26.533774 UTC - Uptime: 20:17:25 up 0 min, 1 user, load average: 0.25, 0.07, 0.02 2026-08-07 20:17:26.691142 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-07 20:17:26.691230 UTC - lsb_release matches expected value 2026-08-07 20:17:26.691253 UTC - SSH Test passed. 2026-08-07 20:17:26.805762 UTC - Cloud-init user-data: Hello World. The time is now Fri, 07 Aug 2026 20:17:03 +0000! 2026-08-07 20:17:26.814652 UTC - Destroying tst-22605388 tst 2026-08-07 20:17:26.814914 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-22605388 tst