Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 22.50s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 499ms 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 809ms + 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.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-13 13:08:00.632576 UTC - Installing Slices CLI (latest stable version). 2026-07-13 13:08:00.633524 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-13 13:08:30.775305 UTC - Slices CLI installed. 2026-07-13 13:08:30.780315 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-13 13:08:30.782348 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-13 13:08:30.783757 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-13 13:08:30.783963 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-13 13:08:30.783995 UTC - Slices CLI exe: 'slices' 2026-07-13 13:08:30.784015 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-13 13:08:30.784179 UTC - Run: slices --version 2026-07-13 13:08:37.727074 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-13 13:08:37.727357 UTC - Run: slices pubkey list --format text 2026-07-13 13:08:39.341163 UTC - Pubkey already registered 2026-07-13 13:08:39.341490 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-13 13:08:40.625832 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-13 13:08:40.625931 UTC - Check List Flavors 2026-07-13 13:08:40.626098 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-13 13:08:42.097617 UTC - Check List DiskImages 2026-07-13 13:08:42.097837 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-13 13:08:43.275541 UTC - Requesting resources 2026-07-13 13:08:43.276024 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-13 13:08:43.276137 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-f50553fc --user-data /tmp/tmpqcl81d5_ 2026-07-13 13:08:46.813022 UTC - Resource ID: r_de-munich-bi-vm_01kxdsga9zea0s5v9m27rt6svw 2026-07-13 13:08:46.813207 UTC - Waiting until resource ready 2026-07-13 13:08:48.813486 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-f50553fc tst 2026-07-13 13:08:50.207502 UTC - Status: IMAGING 2026-07-13 13:08:53.135173 UTC - Status: BOOTING 2026-07-13 13:08:56.112493 UTC - Status: BOOTING 2026-07-13 13:08:59.249267 UTC - Status: BOOTING 2026-07-13 13:09:02.788573 UTC - Status: BOOTING 2026-07-13 13:09:06.228579 UTC - Status: BOOTING 2026-07-13 13:09:10.079337 UTC - Status: BOOTING 2026-07-13 13:09:13.323382 UTC - Status: UP 2026-07-13 13:09:13.323453 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxdsg94ye1ssv8kh85w65mzt 2026-07-13 13:09:13.323490 UTC - Validate resources 2026-07-13 13:09:14.249547 UTC - The fields of the created resource were validated. 2026-07-13 13:09:14.249643 UTC - Check if resources are registered in experiment 2026-07-13 13:09:14.249797 UTC - Run: slices experiment list-resources --format json tst-f50553fc 2026-07-13 13:09:15.123124 UTC - Status (on expauth): UP 2026-07-13 13:09:15.123271 UTC - Testing extend expires_at (all resources in experiment) 2026-07-13 13:09:15.123399 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-f50553fc 2026-07-13 13:09:18.495091 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-f50553fc tst 2026-07-13 13:09:21.389173 UTC - Run: slices experiment list-resources --format json tst-f50553fc 2026-07-13 13:09:22.971560 UTC - expires_at (on expauth): 2026-07-13T16:09:00Z (correctly extended) 2026-07-13 13:09:22.971661 UTC - Testing extend expires_at (single resource in experiment) 2026-07-13 13:09:22.971799 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-f50553fc 2026-07-13 13:09:26.373368 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-f50553fc tst 2026-07-13 13:09:27.987857 UTC - Run: slices experiment list-resources --format json tst-f50553fc 2026-07-13 13:09:30.165247 UTC - expires_at (on expauth): 2026-07-13T17:09:00Z (correctly extended) 2026-07-13 13:09:30.165374 UTC - Testing ssh login 2026-07-13 13:09:30.193879 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-f50553fc tst 2026-07-13 13:09:31.987483 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-f50553fc tst 2026-07-13 13:09:34.163274 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-f50553fc tst 2026-07-13 13:09:35.461252 UTC - Logging in using 'slices bi ssh' 2026-07-13 13:09:35.461325 UTC - Forcing IPv4 only. 2026-07-13 13:09:35.461457 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-f50553fc tst -- -4 uname -a 2026-07-13 13:09:39.015127 UTC - Forcing IPv4 only. 2026-07-13 13:09:39.015322 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-f50553fc tst -- -4 uptime 2026-07-13 13:09:41.831074 UTC - CLI SSH Test passed. 2026-07-13 13:09:41.831142 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-13 13:09:41.831161 UTC - Uptime: 13:09:41 up 0 min, 1 user, load average: 0.29, 0.09, 0.03 2026-07-13 13:09:41.831193 UTC - Logging in using SSH over SSH proxy 2026-07-13 13:09:41.831351 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-f50553fc tst 2026-07-13 13:09:44.192894 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-13 13:09:44.193104 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-13 13:09:44.193166 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-13 13:09:44.193452 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-13 13:09:44.193540 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-13 13:09:44.193590 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-13 13:09:44.193608 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-13 13:09:44.592549 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-13 13:09:45.297154 UTC - SSH Test output: 2026-07-13 13:09:45.297235 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-13 13:09:45.297255 UTC - Uptime: 13:09:45 up 0 min, 1 user, load average: 0.29, 0.09, 0.03 2026-07-13 13:09:45.435806 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-13 13:09:45.435882 UTC - lsb_release matches expected value 2026-07-13 13:09:45.435900 UTC - SSH Test passed. 2026-07-13 13:09:45.573773 UTC - Cloud-init user-data: Hello World. The time is now Mon, 13 Jul 2026 13:09:09 +0000! 2026-07-13 13:09:45.587596 UTC - Destroying tst-f50553fc tst 2026-07-13 13:09:45.587772 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-f50553fc tst