Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 16.78s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 253ms 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 662ms + 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-10 04:07:29.423724 UTC - Installing Slices CLI (latest stable version). 2026-07-10 04:07:29.424003 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-10 04:07:57.864817 UTC - Slices CLI installed. 2026-07-10 04:07:57.867882 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-10 04:07:57.869760 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-10 04:07:57.870905 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-10 04:07:57.871220 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-10 04:07:57.871263 UTC - Slices CLI exe: 'slices' 2026-07-10 04:07:57.871281 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-10 04:07:57.871411 UTC - Run: slices --version 2026-07-10 04:08:04.687060 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-10 04:08:04.687325 UTC - Run: slices pubkey list --format text 2026-07-10 04:08:06.215056 UTC - Pubkey already registered 2026-07-10 04:08:06.215347 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-10 04:08:07.797818 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-10 04:08:07.797902 UTC - Check List Flavors 2026-07-10 04:08:07.798060 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-10 04:08:10.452964 UTC - Check List DiskImages 2026-07-10 04:08:10.453154 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-10 04:08:12.001289 UTC - Requesting resources 2026-07-10 04:08:12.001911 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-10 04:08:12.002057 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-5debdd5e --user-data /tmp/tmplcz5ajp3 2026-07-10 04:08:16.230582 UTC - Resource ID: r_de-munich-bi-vm_01kx53ceqpe38br2tnsdan34cy 2026-07-10 04:08:16.230725 UTC - Waiting until resource ready 2026-07-10 04:08:18.231064 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-5debdd5e tst 2026-07-10 04:08:19.151855 UTC - Status: IMAGING 2026-07-10 04:08:22.615475 UTC - Status: BOOTING 2026-07-10 04:08:25.928263 UTC - Status: BOOTING 2026-07-10 04:08:29.393095 UTC - Status: BOOTING 2026-07-10 04:08:32.534426 UTC - Status: BOOTING 2026-07-10 04:08:35.777053 UTC - Status: BOOTING 2026-07-10 04:08:39.102542 UTC - Status: BOOTING 2026-07-10 04:08:42.195257 UTC - Status: UP 2026-07-10 04:08:42.195336 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx53cdmwfbj9zte5zxxadz53 2026-07-10 04:08:42.195378 UTC - Validate resources 2026-07-10 04:08:43.011622 UTC - The fields of the created resource were validated. 2026-07-10 04:08:43.011751 UTC - Check if resources are registered in experiment 2026-07-10 04:08:43.011939 UTC - Run: slices experiment list-resources --format json tst-5debdd5e 2026-07-10 04:08:43.678649 UTC - Status (on expauth): UP 2026-07-10 04:08:43.678853 UTC - Testing extend expires_at (all resources in experiment) 2026-07-10 04:08:43.679076 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-5debdd5e 2026-07-10 04:08:46.097724 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-5debdd5e tst 2026-07-10 04:08:47.120559 UTC - Run: slices experiment list-resources --format json tst-5debdd5e 2026-07-10 04:08:48.002846 UTC - expires_at (on expauth): 2026-07-10T07:08:00Z (correctly extended) 2026-07-10 04:08:48.002985 UTC - Testing extend expires_at (single resource in experiment) 2026-07-10 04:08:48.003205 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-5debdd5e 2026-07-10 04:08:50.331783 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-5debdd5e tst 2026-07-10 04:08:51.254749 UTC - Run: slices experiment list-resources --format json tst-5debdd5e 2026-07-10 04:08:52.489129 UTC - expires_at (on expauth): 2026-07-10T08:08:00Z (correctly extended) 2026-07-10 04:08:52.489351 UTC - Testing ssh login 2026-07-10 04:08:52.545124 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-5debdd5e tst 2026-07-10 04:08:53.915106 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-5debdd5e tst 2026-07-10 04:08:55.139431 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-5debdd5e tst 2026-07-10 04:08:56.270336 UTC - Logging in using 'slices bi ssh' 2026-07-10 04:08:56.270403 UTC - Forcing IPv4 only. 2026-07-10 04:08:56.270520 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-5debdd5e tst -- -4 uname -a 2026-07-10 04:08:59.833170 UTC - Forcing IPv4 only. 2026-07-10 04:08:59.833377 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-5debdd5e tst -- -4 uptime 2026-07-10 04:09:01.651255 UTC - CLI SSH Test passed. 2026-07-10 04:09:01.651349 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-10 04:09:01.651380 UTC - Uptime: 04:09:00 up 0 min, 1 user, load average: 0.30, 0.09, 0.03 2026-07-10 04:09:01.651423 UTC - Logging in using SSH over SSH proxy 2026-07-10 04:09:01.651577 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-5debdd5e tst 2026-07-10 04:09:02.928357 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-10 04:09:02.928635 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-10 04:09:02.928761 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-10 04:09:02.929200 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-10 04:09:02.929336 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-10 04:09:02.929413 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-10 04:09:02.929442 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-10 04:09:03.328707 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-10 04:09:04.023101 UTC - SSH Test output: 2026-07-10 04:09:04.023181 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-10 04:09:04.023214 UTC - Uptime: 04:09:02 up 0 min, 1 user, load average: 0.30, 0.09, 0.03 2026-07-10 04:09:04.161158 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-10 04:09:04.161238 UTC - lsb_release matches expected value 2026-07-10 04:09:04.161258 UTC - SSH Test passed. 2026-07-10 04:09:04.298968 UTC - Cloud-init user-data: Hello World. The time is now Fri, 10 Jul 2026 04:08:38 +0000! 2026-07-10 04:09:04.308159 UTC - Destroying tst-5debdd5e tst 2026-07-10 04:09:04.308376 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-5debdd5e tst