Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 11.26s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 284ms 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.08s + 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-15 04:07:55.093945 UTC - Installing Slices CLI (latest stable version). 2026-07-15 04:07:55.094875 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-15 04:08:43.490857 UTC - Slices CLI installed. 2026-07-15 04:08:43.491063 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-15 04:08:43.492759 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-15 04:08:43.493567 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-15 04:08:43.493684 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-15 04:08:43.493712 UTC - Slices CLI exe: 'slices' 2026-07-15 04:08:43.493730 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-15 04:08:43.493860 UTC - Run: slices --version 2026-07-15 04:08:51.521016 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-15 04:08:51.521282 UTC - Run: slices pubkey list --format text 2026-07-15 04:08:53.250627 UTC - Pubkey already registered 2026-07-15 04:08:53.250908 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-15 04:08:54.787035 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-15 04:08:54.787128 UTC - Check List Flavors 2026-07-15 04:08:54.787280 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-15 04:08:57.403147 UTC - Check List DiskImages 2026-07-15 04:08:57.403329 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-15 04:08:58.068494 UTC - Requesting resources 2026-07-15 04:08:58.069321 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-15 04:08:58.069429 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-fd0cd19d --user-data /tmp/tmpea5mzlj3 2026-07-15 04:09:02.727271 UTC - Resource ID: r_de-munich-bi-vm_01kxhzdf07ffsbp677b6m3c24b 2026-07-15 04:09:02.727421 UTC - Waiting until resource ready 2026-07-15 04:09:04.727738 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-fd0cd19d tst 2026-07-15 04:09:06.134506 UTC - Status: IMAGING 2026-07-15 04:09:09.514060 UTC - Status: BOOTING 2026-07-15 04:09:13.217757 UTC - Status: BOOTING 2026-07-15 04:09:16.749201 UTC - Status: BOOTING 2026-07-15 04:09:20.232207 UTC - Status: BOOTING 2026-07-15 04:09:23.605565 UTC - Status: BOOTING 2026-07-15 04:09:26.756046 UTC - Status: UP 2026-07-15 04:09:26.756140 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxhzddjnetx8wh6mghe0t5ns 2026-07-15 04:09:26.756182 UTC - Validate resources 2026-07-15 04:09:27.525749 UTC - The fields of the created resource were validated. 2026-07-15 04:09:27.525858 UTC - Check if resources are registered in experiment 2026-07-15 04:09:27.526024 UTC - Run: slices experiment list-resources --format json tst-fd0cd19d 2026-07-15 04:09:28.141254 UTC - Status (on expauth): UP 2026-07-15 04:09:28.141397 UTC - Testing extend expires_at (all resources in experiment) 2026-07-15 04:09:28.141521 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-fd0cd19d 2026-07-15 04:09:31.068884 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-fd0cd19d tst 2026-07-15 04:09:32.414148 UTC - Run: slices experiment list-resources --format json tst-fd0cd19d 2026-07-15 04:09:33.633208 UTC - expires_at (on expauth): 2026-07-15T07:09:00Z (correctly extended) 2026-07-15 04:09:33.633308 UTC - Testing extend expires_at (single resource in experiment) 2026-07-15 04:09:33.633446 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-fd0cd19d 2026-07-15 04:09:36.375367 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-fd0cd19d tst 2026-07-15 04:09:37.343006 UTC - Run: slices experiment list-resources --format json tst-fd0cd19d 2026-07-15 04:09:37.964013 UTC - expires_at (on expauth): 2026-07-15T08:09:00Z (correctly extended) 2026-07-15 04:09:37.964388 UTC - Testing ssh login 2026-07-15 04:09:37.977649 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-fd0cd19d tst 2026-07-15 04:09:39.097309 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-fd0cd19d tst 2026-07-15 04:09:40.121453 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-fd0cd19d tst 2026-07-15 04:09:41.044107 UTC - Logging in using 'slices bi ssh' 2026-07-15 04:09:41.044179 UTC - Forcing IPv4 only. 2026-07-15 04:09:41.044303 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-fd0cd19d tst -- -4 uname -a 2026-07-15 04:09:44.075358 UTC - Forcing IPv4 only. 2026-07-15 04:09:44.075577 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-fd0cd19d tst -- -4 uptime 2026-07-15 04:09:45.897645 UTC - CLI SSH Test passed. 2026-07-15 04:09:45.897719 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-15 04:09:45.897738 UTC - Uptime: 04:09:45 up 0 min, 1 user, load average: 0.32, 0.09, 0.03 2026-07-15 04:09:45.897771 UTC - Logging in using SSH over SSH proxy 2026-07-15 04:09:45.897939 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-fd0cd19d tst 2026-07-15 04:09:46.814149 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-15 04:09:46.814367 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-15 04:09:46.814432 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-15 04:09:46.814695 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-15 04:09:46.814788 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-15 04:09:46.814839 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-15 04:09:46.814857 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-15 04:09:47.220553 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-15 04:09:47.903855 UTC - SSH Test output: 2026-07-15 04:09:47.903924 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-15 04:09:47.903945 UTC - Uptime: 04:09:47 up 0 min, 1 user, load average: 0.29, 0.09, 0.03 2026-07-15 04:09:48.041164 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-15 04:09:48.041239 UTC - lsb_release matches expected value 2026-07-15 04:09:48.041258 UTC - SSH Test passed. 2026-07-15 04:09:48.179097 UTC - Cloud-init user-data: Hello World. The time is now Wed, 15 Jul 2026 04:09:25 +0000! 2026-07-15 04:09:48.193137 UTC - Destroying tst-fd0cd19d tst 2026-07-15 04:09:48.193331 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-fd0cd19d tst