Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 15.38s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 319ms 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 813ms + annotated-types==0.7.0 + anyio==4.14.2 + 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.1 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-19 04:08:51.045878 UTC - Installing Slices CLI (latest stable version). 2026-07-19 04:08:51.046135 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-19 04:08:57.228543 UTC - Slices CLI installed. 2026-07-19 04:08:57.229108 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-19 04:08:57.231324 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-19 04:08:57.232918 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-19 04:08:57.233041 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-19 04:08:57.233068 UTC - Slices CLI exe: 'slices' 2026-07-19 04:08:57.233084 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-19 04:08:57.233202 UTC - Run: slices --version 2026-07-19 04:09:00.729018 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-19 04:09:00.729298 UTC - Run: slices pubkey list --format text 2026-07-19 04:09:02.023114 UTC - Pubkey already registered 2026-07-19 04:09:02.023336 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-19 04:09:03.337942 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-19 04:09:03.338043 UTC - Check List Flavors 2026-07-19 04:09:03.338240 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-19 04:09:05.181198 UTC - Check List DiskImages 2026-07-19 04:09:05.181386 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-19 04:09:06.347236 UTC - Requesting resources 2026-07-19 04:09:06.347742 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-19 04:09:06.347857 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-2ada5ec6 --user-data /tmp/tmp9wiopf7q 2026-07-19 04:09:10.679602 UTC - Resource ID: r_de-munich-bi-vm_01kxw90jzcej1a113k94hp1jek 2026-07-19 04:09:10.679754 UTC - Waiting until resource ready 2026-07-19 04:09:12.680172 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-2ada5ec6 tst 2026-07-19 04:09:13.995246 UTC - Status: IMAGING 2026-07-19 04:09:16.977218 UTC - Status: BOOTING 2026-07-19 04:09:20.775906 UTC - Status: BOOTING 2026-07-19 04:09:24.007132 UTC - Status: BOOTING 2026-07-19 04:09:27.817204 UTC - Status: BOOTING 2026-07-19 04:09:31.399135 UTC - Status: BOOTING 2026-07-19 04:09:35.826180 UTC - Status: UP 2026-07-19 04:09:35.826287 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxw90hqbekkr6ebmewnt6nsk 2026-07-19 04:09:35.826334 UTC - Validate resources 2026-07-19 04:09:37.819837 UTC - The fields of the created resource were validated. 2026-07-19 04:09:37.819938 UTC - Check if resources are registered in experiment 2026-07-19 04:09:37.820088 UTC - Run: slices experiment list-resources --format json tst-2ada5ec6 2026-07-19 04:09:39.304206 UTC - Status (on expauth): UP 2026-07-19 04:09:39.304355 UTC - Testing extend expires_at (all resources in experiment) 2026-07-19 04:09:39.304503 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-2ada5ec6 2026-07-19 04:09:42.991409 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-2ada5ec6 tst 2026-07-19 04:09:44.718342 UTC - Run: slices experiment list-resources --format json tst-2ada5ec6 2026-07-19 04:09:45.484202 UTC - expires_at (on expauth): 2026-07-19T07:09:00Z (correctly extended) 2026-07-19 04:09:45.484353 UTC - Testing extend expires_at (single resource in experiment) 2026-07-19 04:09:45.484499 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-2ada5ec6 2026-07-19 04:09:48.308069 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-2ada5ec6 tst 2026-07-19 04:09:49.434263 UTC - Run: slices experiment list-resources --format json tst-2ada5ec6 2026-07-19 04:09:50.474470 UTC - expires_at (on expauth): 2026-07-19T08:09:00Z (correctly extended) 2026-07-19 04:09:50.474587 UTC - Testing ssh login 2026-07-19 04:09:50.506101 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-2ada5ec6 tst 2026-07-19 04:09:51.588934 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-2ada5ec6 tst 2026-07-19 04:09:52.506219 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-2ada5ec6 tst 2026-07-19 04:09:54.026351 UTC - Logging in using 'slices bi ssh' 2026-07-19 04:09:54.026423 UTC - Forcing IPv4 only. 2026-07-19 04:09:54.026823 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-2ada5ec6 tst -- -4 uname -a 2026-07-19 04:09:57.406512 UTC - Forcing IPv4 only. 2026-07-19 04:09:57.406696 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-2ada5ec6 tst -- -4 uptime 2026-07-19 04:09:59.339043 UTC - CLI SSH Test passed. 2026-07-19 04:09:59.339139 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-19 04:09:59.339161 UTC - Uptime: 04:09:58 up 0 min, 1 user, load average: 0.19, 0.06, 0.02 2026-07-19 04:09:59.339196 UTC - Logging in using SSH over SSH proxy 2026-07-19 04:09:59.339339 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-2ada5ec6 tst 2026-07-19 04:10:00.963974 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-19 04:10:00.964184 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-19 04:10:00.964247 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-19 04:10:00.964552 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-19 04:10:00.964645 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-19 04:10:00.964707 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-19 04:10:00.964757 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-19 04:10:01.391614 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-19 04:10:02.157582 UTC - SSH Test output: 2026-07-19 04:10:02.157653 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-19 04:10:02.157672 UTC - Uptime: 04:10:01 up 0 min, 1 user, load average: 0.18, 0.06, 0.02 2026-07-19 04:10:02.306657 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-19 04:10:02.306748 UTC - lsb_release matches expected value 2026-07-19 04:10:02.306769 UTC - SSH Test passed. 2026-07-19 04:10:02.456409 UTC - Cloud-init user-data: Hello World. The time is now Sun, 19 Jul 2026 04:09:33 +0000! 2026-07-19 04:10:02.464948 UTC - Destroying tst-2ada5ec6 tst 2026-07-19 04:10:02.465163 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-2ada5ec6 tst