Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.57s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 246ms 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 871ms + 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:26:00.071665 UTC - Installing Slices CLI (latest stable version). 2026-08-09 13:26:00.071895 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-09 13:26:05.459282 UTC - Slices CLI installed. 2026-08-09 13:26:05.459768 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:26:05.461635 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:26:05.461699 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:26:05.461766 UTC - which slices: /app/.venv/bin/slices 2026-08-09 13:26:05.461785 UTC - Slices CLI exe: 'slices' 2026-08-09 13:26:05.461800 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-09 13:26:05.461951 UTC - Run: slices --version 2026-08-09 13:26:11.644220 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:26:11.644484 UTC - Run: slices pubkey list --format text 2026-08-09 13:26:13.136982 UTC - Pubkey already registered 2026-08-09 13:26:13.137238 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-09 13:26:14.391548 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-09 13:26:14.391668 UTC - Check List Flavors 2026-08-09 13:26:14.391846 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-08-09 13:26:15.568923 UTC - Check List DiskImages 2026-08-09 13:26:15.569428 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-08-09 13:26:16.995767 UTC - Requesting resources 2026-08-09 13:26:17.043128 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-08-09 13:26:17.043362 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-96463f79 --user-data /tmp/tmpp6qkwno7 2026-08-09 13:26:19.469644 UTC - Resource ID: r_de-munich-bi-vm_01kzkb7vabf4hakz37c7jvmckg 2026-08-09 13:26:19.469785 UTC - Waiting until resource ready 2026-08-09 13:26:21.470135 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-96463f79 tst 2026-08-09 13:26:22.744101 UTC - Status: IMAGING 2026-08-09 13:26:25.921315 UTC - Status: BOOTING 2026-08-09 13:26:29.490176 UTC - Status: BOOTING 2026-08-09 13:26:33.021641 UTC - Status: BOOTING 2026-08-09 13:26:36.043694 UTC - Status: BOOTING 2026-08-09 13:26:39.475415 UTC - Status: BOOTING 2026-08-09 13:26:43.021053 UTC - Status: BOOTING 2026-08-09 13:26:46.503179 UTC - Status: UP 2026-08-09 13:26:46.503252 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kzkb7tr5fska2kc7sptkrq4v 2026-08-09 13:26:46.503293 UTC - Validate resources 2026-08-09 13:26:48.525026 UTC - The fields of the created resource were validated. 2026-08-09 13:26:48.525158 UTC - Check if resources are registered in experiment 2026-08-09 13:26:48.525322 UTC - Run: slices experiment list-resources --format json tst-96463f79 2026-08-09 13:26:49.899618 UTC - Status (on expauth): UP 2026-08-09 13:26:49.899750 UTC - Testing extend expires_at (all resources in experiment) 2026-08-09 13:26:49.899887 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-96463f79 2026-08-09 13:26:51.860606 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-96463f79 tst 2026-08-09 13:26:53.527295 UTC - Run: slices experiment list-resources --format json tst-96463f79 2026-08-09 13:26:55.147815 UTC - expires_at (on expauth): 2026-08-09T16:26:00Z (correctly extended) 2026-08-09 13:26:55.147905 UTC - Testing extend expires_at (single resource in experiment) 2026-08-09 13:26:55.148056 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-96463f79 2026-08-09 13:26:56.959353 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-96463f79 tst 2026-08-09 13:26:58.130019 UTC - Run: slices experiment list-resources --format json tst-96463f79 2026-08-09 13:26:59.221680 UTC - expires_at (on expauth): 2026-08-09T17:26:00Z (correctly extended) 2026-08-09 13:26:59.221806 UTC - Testing ssh login 2026-08-09 13:26:59.245389 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-96463f79 tst 2026-08-09 13:27:00.832825 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-96463f79 tst 2026-08-09 13:27:02.163002 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-96463f79 tst 2026-08-09 13:27:03.281920 UTC - Logging in using 'slices bi ssh' 2026-08-09 13:27:03.282001 UTC - Forcing IPv4 only. 2026-08-09 13:27:03.282145 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-96463f79 tst -- -4 uname -a 2026-08-09 13:27:06.256512 UTC - Forcing IPv4 only. 2026-08-09 13:27:06.256691 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-96463f79 tst -- -4 uptime 2026-08-09 13:27:08.081139 UTC - CLI SSH Test passed. 2026-08-09 13:27:08.081223 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-09 13:27:08.081244 UTC - Uptime: 13:27:06 up 0 min, 1 user, load average: 0.39, 0.12, 0.04 2026-08-09 13:27:08.081280 UTC - Logging in using SSH over SSH proxy 2026-08-09 13:27:08.081428 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-96463f79 tst 2026-08-09 13:27:09.099381 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-09 13:27:09.099599 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-09 13:27:09.099661 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-09 13:27:09.099948 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-09 13:27:09.100046 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-09 13:27:09.100135 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-09 13:27:09.100158 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-08-09 13:27:09.488451 UTC - Connecting to 172.30.255.5:22 over proxy 2026-08-09 13:27:10.176866 UTC - SSH Test output: 2026-08-09 13:27:10.176943 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-09 13:27:10.176964 UTC - Uptime: 13:27:10 up 0 min, 1 user, load average: 0.36, 0.12, 0.04 2026-08-09 13:27:10.314631 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-09 13:27:10.314708 UTC - lsb_release matches expected value 2026-08-09 13:27:10.314728 UTC - SSH Test passed. 2026-08-09 13:27:10.452441 UTC - Cloud-init user-data: Hello World. The time is now Sun, 09 Aug 2026 13:26:42 +0000! 2026-08-09 13:27:10.464413 UTC - Destroying tst-96463f79 tst 2026-08-09 13:27:10.464610 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-96463f79 tst