Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.23s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 836ms 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 859ms + 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.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-24 04:09:24.261411 UTC - Installing Slices CLI (latest stable version). 2026-07-24 04:09:24.265052 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-24 04:09:29.860284 UTC - Slices CLI installed. 2026-07-24 04:09:29.860458 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-24 04:09:29.863766 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-24 04:09:29.864591 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-24 04:09:29.864795 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-24 04:09:29.864830 UTC - Slices CLI exe: 'slices' 2026-07-24 04:09:29.864849 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-24 04:09:29.864967 UTC - Run: slices --version 2026-07-24 04:09:33.286057 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-24 04:09:33.286354 UTC - Run: slices pubkey list --format text 2026-07-24 04:09:34.302026 UTC - Pubkey already registered 2026-07-24 04:09:34.302277 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-24 04:09:34.867232 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-24 04:09:34.867343 UTC - Check List Flavors 2026-07-24 04:09:34.867515 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-24 04:09:36.685552 UTC - Check List DiskImages 2026-07-24 04:09:36.685789 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-24 04:09:37.781441 UTC - Requesting resources 2026-07-24 04:09:37.781950 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-24 04:09:37.782065 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-8e5c50d7 --user-data /tmp/tmpkh328me6 2026-07-24 04:09:41.627378 UTC - Resource ID: r_de-munich-bi-vm_01ky9514axe9995sz8fwd59jts 2026-07-24 04:09:41.627540 UTC - Waiting until resource ready 2026-07-24 04:09:43.627895 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-8e5c50d7 tst 2026-07-24 04:09:44.448850 UTC - Status: IMAGING 2026-07-24 04:09:47.288077 UTC - Status: BOOTING 2026-07-24 04:09:50.178859 UTC - Status: BOOTING 2026-07-24 04:09:53.338904 UTC - Status: BOOTING 2026-07-24 04:09:56.623067 UTC - Status: BOOTING 2026-07-24 04:09:59.399900 UTC - Status: BOOTING 2026-07-24 04:10:02.426171 UTC - Status: BOOTING 2026-07-24 04:10:05.731193 UTC - Status: UP 2026-07-24 04:10:05.731296 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky95131ffp4av0y28m1s3qpb 2026-07-24 04:10:05.731342 UTC - Validate resources 2026-07-24 04:10:06.605496 UTC - The fields of the created resource were validated. 2026-07-24 04:10:06.605593 UTC - Check if resources are registered in experiment 2026-07-24 04:10:06.605762 UTC - Run: slices experiment list-resources --format json tst-8e5c50d7 2026-07-24 04:10:07.321131 UTC - Status (on expauth): UP 2026-07-24 04:10:07.321256 UTC - Testing extend expires_at (all resources in experiment) 2026-07-24 04:10:07.321379 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-8e5c50d7 2026-07-24 04:10:10.706766 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-8e5c50d7 tst 2026-07-24 04:10:12.121512 UTC - Run: slices experiment list-resources --format json tst-8e5c50d7 2026-07-24 04:10:12.887314 UTC - expires_at (on expauth): 2026-07-24T07:10:00Z (correctly extended) 2026-07-24 04:10:12.887411 UTC - Testing extend expires_at (single resource in experiment) 2026-07-24 04:10:12.887553 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-8e5c50d7 2026-07-24 04:10:15.915319 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-8e5c50d7 tst 2026-07-24 04:10:16.731120 UTC - Run: slices experiment list-resources --format json tst-8e5c50d7 2026-07-24 04:10:17.396435 UTC - expires_at (on expauth): 2026-07-24T08:10:00Z (correctly extended) 2026-07-24 04:10:17.396592 UTC - Testing ssh login 2026-07-24 04:10:17.408061 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-8e5c50d7 tst 2026-07-24 04:10:18.481233 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-8e5c50d7 tst 2026-07-24 04:10:19.547532 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-8e5c50d7 tst 2026-07-24 04:10:21.067735 UTC - Logging in using 'slices bi ssh' 2026-07-24 04:10:21.067890 UTC - Forcing IPv4 only. 2026-07-24 04:10:21.068028 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-8e5c50d7 tst -- -4 uname -a 2026-07-24 04:10:24.547113 UTC - Forcing IPv4 only. 2026-07-24 04:10:24.547492 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-8e5c50d7 tst -- -4 uptime 2026-07-24 04:10:26.738326 UTC - CLI SSH Test passed. 2026-07-24 04:10:26.738404 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-24 04:10:26.738424 UTC - Uptime: 04:10:26 up 0 min, 1 user, load average: 0.25, 0.07, 0.02 2026-07-24 04:10:26.738459 UTC - Logging in using SSH over SSH proxy 2026-07-24 04:10:26.738592 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-8e5c50d7 tst 2026-07-24 04:10:28.578010 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-24 04:10:28.578227 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-24 04:10:28.578287 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-24 04:10:28.578566 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-24 04:10:28.578658 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-24 04:10:28.578713 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-24 04:10:28.578731 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-24 04:10:28.999579 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-24 04:10:29.749395 UTC - SSH Test output: 2026-07-24 04:10:29.749472 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-24 04:10:29.749502 UTC - Uptime: 04:10:28 up 0 min, 1 user, load average: 0.25, 0.07, 0.02 2026-07-24 04:10:29.898979 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-24 04:10:29.899056 UTC - lsb_release matches expected value 2026-07-24 04:10:29.899075 UTC - SSH Test passed. 2026-07-24 04:10:30.048207 UTC - Cloud-init user-data: Hello World. The time is now Fri, 24 Jul 2026 04:10:03 +0000! 2026-07-24 04:10:30.068617 UTC - Destroying tst-8e5c50d7 tst 2026-07-24 04:10:30.073859 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-8e5c50d7 tst