Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 28.72s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 309ms 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 699ms + 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-12 20:07:49.365484 UTC - Installing Slices CLI (latest stable version). 2026-07-12 20:07:49.365700 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-12 20:08:02.229236 UTC - Slices CLI installed. 2026-07-12 20:08:02.229649 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-12 20:08:02.231688 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-12 20:08:02.232694 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-12 20:08:02.232850 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-12 20:08:02.232877 UTC - Slices CLI exe: 'slices' 2026-07-12 20:08:02.232894 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-12 20:08:02.233013 UTC - Run: slices --version 2026-07-12 20:08:07.668156 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-12 20:08:07.668810 UTC - Run: slices pubkey list --format text 2026-07-12 20:08:09.665093 UTC - Pubkey already registered 2026-07-12 20:08:09.665326 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-12 20:08:11.093849 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-12 20:08:11.093987 UTC - Check List Flavors 2026-07-12 20:08:11.094180 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-12 20:08:12.955129 UTC - Check List DiskImages 2026-07-12 20:08:12.955330 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-12 20:08:14.530206 UTC - Requesting resources 2026-07-12 20:08:14.530734 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-12 20:08:14.530850 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-27f1ed39 --user-data /tmp/tmp43uucgo4 2026-07-12 20:08:18.113702 UTC - Resource ID: r_de-munich-bi-vm_01kxbz3rrsefgvksr1v7xdzbpd 2026-07-12 20:08:18.113923 UTC - Waiting until resource ready 2026-07-12 20:08:20.114289 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-27f1ed39 tst 2026-07-12 20:08:21.030049 UTC - Status: IMAGING 2026-07-12 20:08:24.311741 UTC - Status: BOOTING 2026-07-12 20:08:27.863641 UTC - Status: BOOTING 2026-07-12 20:08:31.040896 UTC - Status: BOOTING 2026-07-12 20:08:34.593274 UTC - Status: BOOTING 2026-07-12 20:08:37.411747 UTC - Status: BOOTING 2026-07-12 20:08:40.693212 UTC - Status: BOOTING 2026-07-12 20:08:43.859614 UTC - Status: UP 2026-07-12 20:08:43.859703 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxbz3qemfvmb1psc7gm638qy 2026-07-12 20:08:43.859744 UTC - Validate resources 2026-07-12 20:08:45.089665 UTC - The fields of the created resource were validated. 2026-07-12 20:08:45.089764 UTC - Check if resources are registered in experiment 2026-07-12 20:08:45.089921 UTC - Run: slices experiment list-resources --format json tst-27f1ed39 2026-07-12 20:08:45.880832 UTC - Status (on expauth): UP 2026-07-12 20:08:45.880974 UTC - Testing extend expires_at (all resources in experiment) 2026-07-12 20:08:45.881097 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-27f1ed39 2026-07-12 20:08:48.709550 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-27f1ed39 tst 2026-07-12 20:08:50.285744 UTC - Run: slices experiment list-resources --format json tst-27f1ed39 2026-07-12 20:08:51.491412 UTC - expires_at (on expauth): 2026-07-12T23:08:00Z (correctly extended) 2026-07-12 20:08:51.491510 UTC - Testing extend expires_at (single resource in experiment) 2026-07-12 20:08:51.491648 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-27f1ed39 2026-07-12 20:08:54.957428 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-27f1ed39 tst 2026-07-12 20:08:55.975408 UTC - Run: slices experiment list-resources --format json tst-27f1ed39 2026-07-12 20:08:56.805748 UTC - expires_at (on expauth): 2026-07-13T00:08:00Z (correctly extended) 2026-07-12 20:08:56.806467 UTC - Testing ssh login 2026-07-12 20:08:56.824479 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-27f1ed39 tst 2026-07-12 20:08:57.840598 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-27f1ed39 tst 2026-07-12 20:08:58.807895 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-27f1ed39 tst 2026-07-12 20:08:59.723723 UTC - Logging in using 'slices bi ssh' 2026-07-12 20:08:59.723793 UTC - Forcing IPv4 only. 2026-07-12 20:08:59.723918 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-27f1ed39 tst -- -4 uname -a 2026-07-12 20:09:02.919173 UTC - Forcing IPv4 only. 2026-07-12 20:09:02.919510 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-27f1ed39 tst -- -4 uptime 2026-07-12 20:09:05.388830 UTC - CLI SSH Test passed. 2026-07-12 20:09:05.388903 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-12 20:09:05.388922 UTC - Uptime: 20:09:04 up 0 min, 1 user, load average: 0.56, 0.17, 0.06 2026-07-12 20:09:05.388954 UTC - Logging in using SSH over SSH proxy 2026-07-12 20:09:05.389134 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-27f1ed39 tst 2026-07-12 20:09:06.305750 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-12 20:09:06.305977 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-12 20:09:06.306047 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-12 20:09:06.306361 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-12 20:09:06.306451 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-12 20:09:06.306502 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-12 20:09:06.306519 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-12 20:09:06.723748 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-12 20:09:07.465373 UTC - SSH Test output: 2026-07-12 20:09:07.465443 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-12 20:09:07.465463 UTC - Uptime: 20:09:06 up 0 min, 1 user, load average: 0.56, 0.17, 0.06 2026-07-12 20:09:07.615062 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-12 20:09:07.615137 UTC - lsb_release matches expected value 2026-07-12 20:09:07.615159 UTC - SSH Test passed. 2026-07-12 20:09:07.765309 UTC - Cloud-init user-data: Hello World. The time is now Sun, 12 Jul 2026 20:08:41 +0000! 2026-07-12 20:09:07.781665 UTC - Destroying tst-27f1ed39 tst 2026-07-12 20:09:07.785478 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-27f1ed39 tst