Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 41.77s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 491ms 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 772ms + 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-11 20:08:06.452995 UTC - Installing Slices CLI (latest stable version). 2026-07-11 20:08:06.453227 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-11 20:08:11.974089 UTC - Slices CLI installed. 2026-07-11 20:08:11.974288 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-11 20:08:11.975497 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-11 20:08:11.976380 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-11 20:08:11.976505 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-11 20:08:11.976532 UTC - Slices CLI exe: 'slices' 2026-07-11 20:08:11.976561 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-11 20:08:11.976708 UTC - Run: slices --version 2026-07-11 20:08:16.570663 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-11 20:08:16.570917 UTC - Run: slices pubkey list --format text 2026-07-11 20:08:17.543374 UTC - Pubkey already registered 2026-07-11 20:08:17.543622 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-11 20:08:18.594926 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-11 20:08:18.595016 UTC - Check List Flavors 2026-07-11 20:08:18.595164 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-11 20:08:19.813210 UTC - Check List DiskImages 2026-07-11 20:08:19.813383 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-11 20:08:20.585213 UTC - Requesting resources 2026-07-11 20:08:20.585684 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-11 20:08:20.585802 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-125133ae --user-data /tmp/tmpahrti_t0 2026-07-11 20:08:24.060945 UTC - Resource ID: r_de-munich-bi-vm_01kx9cq7gxetrv7j83pgjgw1mj 2026-07-11 20:08:24.061113 UTC - Waiting until resource ready 2026-07-11 20:08:26.061423 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-125133ae tst 2026-07-11 20:08:27.255271 UTC - Status: IMAGING 2026-07-11 20:08:30.277396 UTC - Status: BOOTING 2026-07-11 20:08:33.444806 UTC - Status: BOOTING 2026-07-11 20:08:37.129841 UTC - Status: BOOTING 2026-07-11 20:08:40.350001 UTC - Status: BOOTING 2026-07-11 20:08:43.235117 UTC - Status: BOOTING 2026-07-11 20:08:46.821703 UTC - Status: BOOTING 2026-07-11 20:08:50.118885 UTC - Status: UP 2026-07-11 20:08:50.118983 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx9cq6cyfcaara6ey9zmy4kg 2026-07-11 20:08:50.119027 UTC - Validate resources 2026-07-11 20:08:51.041780 UTC - The fields of the created resource were validated. 2026-07-11 20:08:51.041895 UTC - Check if resources are registered in experiment 2026-07-11 20:08:51.042071 UTC - Run: slices experiment list-resources --format json tst-125133ae 2026-07-11 20:08:51.818882 UTC - Status (on expauth): UP 2026-07-11 20:08:51.819057 UTC - Testing extend expires_at (all resources in experiment) 2026-07-11 20:08:51.819205 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-125133ae 2026-07-11 20:08:54.500633 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-125133ae tst 2026-07-11 20:08:55.367228 UTC - Run: slices experiment list-resources --format json tst-125133ae 2026-07-11 20:08:56.592627 UTC - expires_at (on expauth): 2026-07-11T23:08:00Z (correctly extended) 2026-07-11 20:08:56.592729 UTC - Testing extend expires_at (single resource in experiment) 2026-07-11 20:08:56.592874 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-125133ae 2026-07-11 20:08:59.641299 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-125133ae tst 2026-07-11 20:09:00.457058 UTC - Run: slices experiment list-resources --format json tst-125133ae 2026-07-11 20:09:01.229653 UTC - expires_at (on expauth): 2026-07-12T00:08:00Z (correctly extended) 2026-07-11 20:09:01.229788 UTC - Testing ssh login 2026-07-11 20:09:01.245721 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-125133ae tst 2026-07-11 20:09:02.366065 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-125133ae tst 2026-07-11 20:09:03.382036 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-125133ae tst 2026-07-11 20:09:04.507956 UTC - Logging in using 'slices bi ssh' 2026-07-11 20:09:04.508024 UTC - Forcing IPv4 only. 2026-07-11 20:09:04.508153 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-125133ae tst -- -4 uname -a 2026-07-11 20:09:07.698809 UTC - Forcing IPv4 only. 2026-07-11 20:09:07.699010 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-125133ae tst -- -4 uptime 2026-07-11 20:09:09.571777 UTC - CLI SSH Test passed. 2026-07-11 20:09:09.571848 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-11 20:09:09.571867 UTC - Uptime: 20:09:08 up 0 min, 1 user, load average: 0.63, 0.19, 0.07 2026-07-11 20:09:09.571900 UTC - Logging in using SSH over SSH proxy 2026-07-11 20:09:09.572042 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-125133ae tst 2026-07-11 20:09:10.494914 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-11 20:09:10.495116 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-11 20:09:10.495174 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-11 20:09:10.495457 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-11 20:09:10.495541 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-11 20:09:10.495617 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-11 20:09:10.495636 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-11 20:09:10.892607 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-11 20:09:11.581307 UTC - SSH Test output: 2026-07-11 20:09:11.581385 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-11 20:09:11.581421 UTC - Uptime: 20:09:10 up 0 min, 1 user, load average: 0.63, 0.19, 0.07 2026-07-11 20:09:11.718143 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-11 20:09:11.718219 UTC - lsb_release matches expected value 2026-07-11 20:09:11.718239 UTC - SSH Test passed. 2026-07-11 20:09:11.856175 UTC - Cloud-init user-data: Hello World. The time is now Sat, 11 Jul 2026 20:08:46 +0000! 2026-07-11 20:09:11.865197 UTC - Destroying tst-125133ae tst 2026-07-11 20:09:11.865377 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-125133ae tst