Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 11.19s 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 684ms + annotated-types==0.7.0 + anyio==4.14.1 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.6.17 + 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.3 + 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.2 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev187+g005dd054e (from file:///app) + tomli-w==1.2.0 + tomlkit==0.15.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-10 20:07:35.992870 UTC - Installing Slices CLI (latest stable version). 2026-07-10 20:07:35.993114 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-10 20:07:49.889154 UTC - Slices CLI installed. 2026-07-10 20:07:49.889371 UTC - PATH: {'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-10 20:07:49.891142 UTC - ls -a /root/ /scripts/ (error 2): None b"ls: cannot access '/scripts/': No such file or directory\n/root/:\n.\n..\n.cache\n.local\n.slices\nrun_test_runner.sh\nslices-cli-venv\n" 2026-07-10 20:07:49.892158 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-10 20:07:49.892278 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-10 20:07:49.892306 UTC - Slices CLI exe: 'slices' 2026-07-10 20:07:49.892324 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-10 20:07:49.892447 UTC - Run: slices --version 2026-07-10 20:07:53.505939 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-10 20:07:53.506225 UTC - Run: slices pubkey list --format text 2026-07-10 20:07:54.523186 UTC - Pubkey already registered 2026-07-10 20:07:54.523424 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-10 20:07:55.697430 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-10 20:07:55.697536 UTC - Check List Flavors 2026-07-10 20:07:55.697717 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-10 20:07:57.709394 UTC - Check List DiskImages 2026-07-10 20:07:57.709588 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-10 20:07:59.833086 UTC - Requesting resources 2026-07-10 20:07:59.833849 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-10 20:07:59.834016 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-800a33e9 --user-data /tmp/tmpfq2flmoe 2026-07-10 20:08:04.458183 UTC - Resource ID: r_de-munich-bi-vm_01kx6t9xe7fdrahvnm8h2ejfc2 2026-07-10 20:08:04.458349 UTC - Waiting until resource ready 2026-07-10 20:08:06.458665 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-800a33e9 tst 2026-07-10 20:08:08.142031 UTC - Status: IMAGING 2026-07-10 20:08:11.308775 UTC - Status: BOOTING 2026-07-10 20:08:15.227708 UTC - Status: BOOTING 2026-07-10 20:08:18.686079 UTC - Status: BOOTING 2026-07-10 20:08:22.679690 UTC - Status: BOOTING 2026-07-10 20:08:26.689240 UTC - Status: BOOTING 2026-07-10 20:08:30.325430 UTC - Status: UP 2026-07-10 20:08:30.325504 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx6t9vk8e0z8sg3fptm6pr79 2026-07-10 20:08:30.325545 UTC - Validate resources 2026-07-10 20:08:31.657457 UTC - The fields of the created resource were validated. 2026-07-10 20:08:31.657556 UTC - Check if resources are registered in experiment 2026-07-10 20:08:31.657712 UTC - Run: slices experiment list-resources --format json tst-800a33e9 2026-07-10 20:08:32.687673 UTC - Status (on expauth): UP 2026-07-10 20:08:32.687830 UTC - Testing extend expires_at (all resources in experiment) 2026-07-10 20:08:32.687998 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-800a33e9 2026-07-10 20:08:35.795639 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-800a33e9 tst 2026-07-10 20:08:37.431306 UTC - Run: slices experiment list-resources --format json tst-800a33e9 2026-07-10 20:08:38.313265 UTC - expires_at (on expauth): 2026-07-10T23:08:00Z (correctly extended) 2026-07-10 20:08:38.313363 UTC - Testing extend expires_at (single resource in experiment) 2026-07-10 20:08:38.313502 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-800a33e9 2026-07-10 20:08:40.889376 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-800a33e9 tst 2026-07-10 20:08:42.025337 UTC - Run: slices experiment list-resources --format json tst-800a33e9 2026-07-10 20:08:42.742223 UTC - expires_at (on expauth): 2026-07-11T00:08:00Z (correctly extended) 2026-07-10 20:08:42.742348 UTC - Testing ssh login 2026-07-10 20:08:42.765357 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-800a33e9 tst 2026-07-10 20:08:43.788620 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-800a33e9 tst 2026-07-10 20:08:44.961501 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-800a33e9 tst 2026-07-10 20:08:46.400218 UTC - Logging in using 'slices bi ssh' 2026-07-10 20:08:46.400289 UTC - Forcing IPv4 only. 2026-07-10 20:08:46.400413 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-800a33e9 tst -- -4 uname -a 2026-07-10 20:08:50.131927 UTC - Forcing IPv4 only. 2026-07-10 20:08:50.132302 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-800a33e9 tst -- -4 uptime 2026-07-10 20:08:52.611711 UTC - CLI SSH Test passed. 2026-07-10 20:08:52.611784 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-10 20:08:52.611802 UTC - Uptime: 20:08:51 up 0 min, 1 user, load average: 0.25, 0.07, 0.02 2026-07-10 20:08:52.611845 UTC - Logging in using SSH over SSH proxy 2026-07-10 20:08:52.611987 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-800a33e9 tst 2026-07-10 20:08:53.754098 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-10 20:08:53.754313 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-10 20:08:53.754378 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-10 20:08:53.754736 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-10 20:08:53.754857 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-10 20:08:53.754915 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-10 20:08:53.754933 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-10 20:08:54.179588 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-10 20:08:54.923031 UTC - SSH Test output: 2026-07-10 20:08:54.923140 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-10 20:08:54.923174 UTC - Uptime: 20:08:54 up 0 min, 1 user, load average: 0.23, 0.07, 0.02 2026-07-10 20:08:55.074177 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-10 20:08:55.074263 UTC - lsb_release matches expected value 2026-07-10 20:08:55.074294 UTC - SSH Test passed. 2026-07-10 20:08:55.224342 UTC - Cloud-init user-data: Hello World. The time is now Fri, 10 Jul 2026 20:08:25 +0000! 2026-07-10 20:08:55.230931 UTC - Destroying tst-800a33e9 tst 2026-07-10 20:08:55.231107 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-800a33e9 tst