Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.08s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 632ms 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.24s + 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-10 20:15:57.497837 UTC - Installing Slices CLI (latest stable version). 2026-08-10 20:15:57.498082 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-08-10 20:16:03.965298 UTC - Slices CLI installed. 2026-08-10 20:16:03.965752 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-10 20:16:03.967534 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-10 20:16:03.967596 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-10 20:16:03.967663 UTC - which slices: /app/.venv/bin/slices 2026-08-10 20:16:03.967683 UTC - Slices CLI exe: 'slices' 2026-08-10 20:16:03.967711 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-08-10 20:16:03.967845 UTC - Run: slices --version 2026-08-10 20:16:10.413789 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-10 20:16:10.414081 UTC - Run: slices pubkey list --format text 2026-08-10 20:16:12.305485 UTC - Pubkey already registered 2026-08-10 20:16:12.305741 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-08-10 20:16:13.722809 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-08-10 20:16:13.722899 UTC - Check List Flavors 2026-08-10 20:16:13.723031 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-08-10 20:16:15.918787 UTC - Check List DiskImages 2026-08-10 20:16:15.918978 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-08-10 20:16:17.384031 UTC - Requesting resources 2026-08-10 20:16:17.384808 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-08-10 20:16:17.384937 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-786453f9 --user-data /tmp/tmpmcstiwqb 2026-08-10 20:16:21.347868 UTC - Resource ID: r_de-munich-bi-vm_01kzpn3bmbe7r9crsyneegwmch 2026-08-10 20:16:21.348019 UTC - Waiting until resource ready 2026-08-10 20:16:23.348351 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-786453f9 tst 2026-08-10 20:16:24.465084 UTC - Status: IMAGING 2026-08-10 20:16:28.753465 UTC - Status: BOOTING 2026-08-10 20:16:32.799963 UTC - Status: BOOTING 2026-08-10 20:16:37.196370 UTC - Status: BOOTING 2026-08-10 20:16:41.496414 UTC - Status: BOOTING 2026-08-10 20:16:45.671234 UTC - Status: BOOTING 2026-08-10 20:16:49.973190 UTC - Status: UP 2026-08-10 20:16:49.973276 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kzpn3a30ec6s53tpqyw04bam 2026-08-10 20:16:49.973329 UTC - Validate resources 2026-08-10 20:16:51.452211 UTC - The fields of the created resource were validated. 2026-08-10 20:16:51.452344 UTC - Check if resources are registered in experiment 2026-08-10 20:16:51.452543 UTC - Run: slices experiment list-resources --format json tst-786453f9 2026-08-10 20:16:52.872497 UTC - Status (on expauth): UP 2026-08-10 20:16:52.872635 UTC - Testing extend expires_at (all resources in experiment) 2026-08-10 20:16:52.872786 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-786453f9 2026-08-10 20:16:55.326942 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-786453f9 tst 2026-08-10 20:16:56.659426 UTC - Run: slices experiment list-resources --format json tst-786453f9 2026-08-10 20:16:58.842052 UTC - expires_at (on expauth): 2026-08-10T23:16:00Z (correctly extended) 2026-08-10 20:16:58.842143 UTC - Testing extend expires_at (single resource in experiment) 2026-08-10 20:16:58.842285 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-786453f9 2026-08-10 20:17:01.400188 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-786453f9 tst 2026-08-10 20:17:03.738600 UTC - Run: slices experiment list-resources --format json tst-786453f9 2026-08-10 20:17:06.085020 UTC - expires_at (on expauth): 2026-08-11T00:17:00Z (correctly extended) 2026-08-10 20:17:06.086438 UTC - Testing ssh login 2026-08-10 20:17:06.128951 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-786453f9 tst 2026-08-10 20:17:08.680152 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-786453f9 tst 2026-08-10 20:17:10.869746 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-786453f9 tst 2026-08-10 20:17:13.062289 UTC - Logging in using 'slices bi ssh' 2026-08-10 20:17:13.062377 UTC - Forcing IPv4 only. 2026-08-10 20:17:13.062528 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-786453f9 tst -- -4 uname -a 2026-08-10 20:17:17.214323 UTC - Forcing IPv4 only. 2026-08-10 20:17:17.214521 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-786453f9 tst -- -4 uptime 2026-08-10 20:17:20.428864 UTC - CLI SSH Test passed. 2026-08-10 20:17:20.428937 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-10 20:17:20.428958 UTC - Uptime: 20:17:20 up 0 min, 1 user, load average: 0.33, 0.11, 0.04 2026-08-10 20:17:20.428993 UTC - Logging in using SSH over SSH proxy 2026-08-10 20:17:20.429144 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-786453f9 tst 2026-08-10 20:17:23.350728 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-10 20:17:23.350965 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-10 20:17:23.351030 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-08-10 20:17:23.351348 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-10 20:17:23.351456 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-10 20:17:23.351528 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-08-10 20:17:23.351550 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-08-10 20:17:23.767536 UTC - Connecting to 172.30.255.5:22 over proxy 2026-08-10 20:17:24.508488 UTC - SSH Test output: 2026-08-10 20:17:24.508560 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-10 20:17:24.508581 UTC - Uptime: 20:17:24 up 0 min, 1 user, load average: 0.30, 0.11, 0.04 2026-08-10 20:17:24.658206 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-08-10 20:17:24.658294 UTC - lsb_release matches expected value 2026-08-10 20:17:24.658313 UTC - SSH Test passed. 2026-08-10 20:17:24.807909 UTC - Cloud-init user-data: Hello World. The time is now Mon, 10 Aug 2026 20:16:43 +0000! 2026-08-10 20:17:24.818184 UTC - Destroying tst-786453f9 tst 2026-08-10 20:17:24.818372 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-786453f9 tst