Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 9.65s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 394ms 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 760ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + cffi==2.1.0 + cryptography==49.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.2 + 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.dev189+g506e4860f (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-07-28 20:10:42.166690 UTC - Installing Slices CLI (latest stable version). 2026-07-28 20:10:42.166985 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-28 20:10:49.807164 UTC - Slices CLI installed. 2026-07-28 20:10:49.812204 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-07-28 20:10:49.814632 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-07-28 20:10:49.814716 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-07-28 20:10:49.814792 UTC - which slices: /app/.venv/bin/slices 2026-07-28 20:10:49.814812 UTC - Slices CLI exe: 'slices' 2026-07-28 20:10:49.814829 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-28 20:10:49.814976 UTC - Run: slices --version 2026-07-28 20:10:59.153246 UTC - version: Slices CLI v2026.1.2 Slices CLI core v1.2.4 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib ai v1.0.0 Slices clientlib core v5.5.1 2026-07-28 20:10:59.157711 UTC - Run: slices pubkey list --format text 2026-07-28 20:11:01.047916 UTC - Pubkey already registered 2026-07-28 20:11:01.048247 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-28 20:11:03.859197 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-28 20:11:03.860333 UTC - Check List Flavors 2026-07-28 20:11:03.860592 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-28 20:11:05.966635 UTC - Check List DiskImages 2026-07-28 20:11:05.966874 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-28 20:11:08.015919 UTC - Requesting resources 2026-07-28 20:11:08.016795 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-28 20:11:08.016940 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-74acca95 --user-data /tmp/tmpmgj17r3y 2026-07-28 20:11:13.570006 UTC - Resource ID: r_de-munich-bi-vm_01kyn5mkkmex9vz6mdxrtef8rj 2026-07-28 20:11:13.571079 UTC - Waiting until resource ready 2026-07-28 20:11:15.571510 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-74acca95 tst 2026-07-28 20:11:17.764043 UTC - Status: BOOTING 2026-07-28 20:11:22.017591 UTC - Status: BOOTING 2026-07-28 20:11:26.355886 UTC - Status: BOOTING 2026-07-28 20:11:30.251051 UTC - Status: BOOTING 2026-07-28 20:11:33.282386 UTC - Status: BOOTING 2026-07-28 20:11:37.095147 UTC - Status: BOOTING 2026-07-28 20:11:40.981143 UTC - Status: UP 2026-07-28 20:11:40.981261 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kyn5mhkxexkv7hks8r3ve02w 2026-07-28 20:11:40.981324 UTC - Validate resources 2026-07-28 20:11:43.243721 UTC - The fields of the created resource were validated. 2026-07-28 20:11:43.243834 UTC - Check if resources are registered in experiment 2026-07-28 20:11:43.243994 UTC - Run: slices experiment list-resources --format json tst-74acca95 2026-07-28 20:11:45.255063 UTC - Status (on expauth): UP 2026-07-28 20:11:45.255214 UTC - Testing extend expires_at (all resources in experiment) 2026-07-28 20:11:45.255339 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-74acca95 2026-07-28 20:11:48.436259 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-74acca95 tst 2026-07-28 20:11:49.667682 UTC - Run: slices experiment list-resources --format json tst-74acca95 2026-07-28 20:11:51.198781 UTC - expires_at (on expauth): 2026-07-28T23:11:00Z (correctly extended) 2026-07-28 20:11:51.198892 UTC - Testing extend expires_at (single resource in experiment) 2026-07-28 20:11:51.199058 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-74acca95 2026-07-28 20:11:53.986956 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-74acca95 tst 2026-07-28 20:11:55.615445 UTC - Run: slices experiment list-resources --format json tst-74acca95 2026-07-28 20:11:57.424246 UTC - expires_at (on expauth): 2026-07-29T00:11:00Z (correctly extended) 2026-07-28 20:11:57.424410 UTC - Testing ssh login 2026-07-28 20:11:57.471529 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-74acca95 tst 2026-07-28 20:11:59.349065 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-74acca95 tst 2026-07-28 20:12:01.469667 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-74acca95 tst 2026-07-28 20:12:03.709091 UTC - Logging in using 'slices bi ssh' 2026-07-28 20:12:03.709169 UTC - Forcing IPv4 only. 2026-07-28 20:12:03.709300 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-74acca95 tst -- -4 uname -a 2026-07-28 20:12:07.839684 UTC - Forcing IPv4 only. 2026-07-28 20:12:07.839879 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-74acca95 tst -- -4 uptime 2026-07-28 20:12:10.459709 UTC - CLI SSH Test passed. 2026-07-28 20:12:10.460598 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-07-28 20:12:10.460655 UTC - Uptime: 20:12:10 up 0 min, 1 user, load average: 0.66, 0.22, 0.08 2026-07-28 20:12:10.460698 UTC - Logging in using SSH over SSH proxy 2026-07-28 20:12:10.460995 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-74acca95 tst 2026-07-28 20:12:11.886119 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-28 20:12:11.886426 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-28 20:12:11.886526 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-28 20:12:11.887760 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-28 20:12:11.887891 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-28 20:12:11.887948 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-28 20:12:11.887967 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-28 20:12:12.284485 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-28 20:12:12.972236 UTC - SSH Test output: 2026-07-28 20:12:12.972365 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-07-28 20:12:12.972413 UTC - Uptime: 20:12:12 up 0 min, 1 user, load average: 0.61, 0.22, 0.08 2026-07-28 20:12:13.109929 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-28 20:12:13.110018 UTC - lsb_release matches expected value 2026-07-28 20:12:13.110038 UTC - SSH Test passed. 2026-07-28 20:12:13.247681 UTC - Cloud-init user-data: Hello World. The time is now Tue, 28 Jul 2026 20:11:35 +0000! 2026-07-28 20:12:13.262022 UTC - Destroying tst-74acca95 tst 2026-07-28 20:12:13.262529 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-74acca95 tst