Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 17.63s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 802ms 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 933ms + 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.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-21 20:10:01.173493 UTC - Installing Slices CLI (latest stable version). 2026-07-21 20:10:01.173917 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-21 20:10:13.691600 UTC - Slices CLI installed. 2026-07-21 20:10:13.692125 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-21 20:10:13.693958 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-21 20:10:13.695177 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-21 20:10:13.695343 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-21 20:10:13.695373 UTC - Slices CLI exe: 'slices' 2026-07-21 20:10:13.695391 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-21 20:10:13.695529 UTC - Run: slices --version 2026-07-21 20:10:18.367926 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-21 20:10:18.368216 UTC - Run: slices pubkey list --format text 2026-07-21 20:10:20.394220 UTC - Pubkey already registered 2026-07-21 20:10:20.394493 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-21 20:10:21.669220 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-21 20:10:21.669345 UTC - Check List Flavors 2026-07-21 20:10:21.669568 UTC - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-07-21 20:10:24.156451 UTC - Check List DiskImages 2026-07-21 20:10:24.156668 UTC - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-07-21 20:10:26.737852 UTC - Requesting resources 2026-07-21 20:10:26.738560 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-21 20:10:26.738687 UTC - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-32164e0d --user-data /tmp/tmpcr2txd2v 2026-07-21 20:10:35.327540 UTC - Resource ID: r_de-munich-bi-vm_01ky34tdh1ebssy7w51gya2nk8 2026-07-21 20:10:35.328118 UTC - Waiting until resource ready 2026-07-21 20:10:37.328510 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-32164e0d tst 2026-07-21 20:10:39.535449 UTC - Status: IMAGING 2026-07-21 20:10:43.115258 UTC - Status: BOOTING 2026-07-21 20:10:47.632308 UTC - Status: BOOTING 2026-07-21 20:10:51.227926 UTC - Status: BOOTING 2026-07-21 20:10:55.873342 UTC - Status: BOOTING 2026-07-21 20:11:00.779333 UTC - Status: UP 2026-07-21 20:11:00.779422 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01ky34t9x0e9ca15awxgnjnh4q 2026-07-21 20:11:00.779467 UTC - Validate resources 2026-07-21 20:11:02.099431 UTC - The fields of the created resource were validated. 2026-07-21 20:11:02.099564 UTC - Check if resources are registered in experiment 2026-07-21 20:11:02.099796 UTC - Run: slices experiment list-resources --format json tst-32164e0d 2026-07-21 20:11:03.593521 UTC - Status (on expauth): UP 2026-07-21 20:11:03.593721 UTC - Testing extend expires_at (all resources in experiment) 2026-07-21 20:11:03.593913 UTC - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-32164e0d 2026-07-21 20:11:08.229698 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-32164e0d tst 2026-07-21 20:11:10.072021 UTC - Run: slices experiment list-resources --format json tst-32164e0d 2026-07-21 20:11:11.635086 UTC - expires_at (on expauth): 2026-07-21T23:11:00Z (correctly extended) 2026-07-21 20:11:11.635391 UTC - Testing extend expires_at (single resource in experiment) 2026-07-21 20:11:11.635570 UTC - Run: slices bi --infra de-munich-bi-vm extend tst --duration 4h --experiment tst-32164e0d 2026-07-21 20:11:15.664374 UTC - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-32164e0d tst 2026-07-21 20:11:16.954855 UTC - Run: slices experiment list-resources --format json tst-32164e0d 2026-07-21 20:11:17.824650 UTC - expires_at (on expauth): 2026-07-22T00:11:00Z (correctly extended) 2026-07-21 20:11:17.824797 UTC - Testing ssh login 2026-07-21 20:11:17.858299 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-32164e0d tst 2026-07-21 20:11:19.797302 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-32164e0d tst 2026-07-21 20:11:21.266648 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-32164e0d tst 2026-07-21 20:11:23.138544 UTC - Logging in using 'slices bi ssh' 2026-07-21 20:11:23.138708 UTC - Forcing IPv4 only. 2026-07-21 20:11:23.138948 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-32164e0d tst -- -4 uname -a 2026-07-21 20:11:26.617419 UTC - Forcing IPv4 only. 2026-07-21 20:11:26.617671 UTC - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-32164e0d tst -- -4 uptime 2026-07-21 20:11:28.901842 UTC - CLI SSH Test passed. 2026-07-21 20:11:28.901916 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-21 20:11:28.901936 UTC - Uptime: 20:11:28 up 0 min, 1 user, load average: 0.36, 0.12, 0.04 2026-07-21 20:11:28.901971 UTC - Logging in using SSH over SSH proxy 2026-07-21 20:11:28.902106 UTC - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-32164e0d tst 2026-07-21 20:11:30.175643 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-21 20:11:30.175934 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-21 20:11:30.176022 UTC - Added paramiko HostKeyEntry for 172.30.255.5 2026-07-21 20:11:30.176440 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-21 20:11:30.176578 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-21 20:11:30.176645 UTC - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-07-21 20:11:30.176680 UTC - Connecting to proxy tripwire.net.in.tum.de:10022 2026-07-21 20:11:30.584611 UTC - Connecting to 172.30.255.5:22 over proxy 2026-07-21 20:11:31.280534 UTC - SSH Test output: 2026-07-21 20:11:31.281086 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-21 20:11:31.281116 UTC - Uptime: 20:11:31 up 0 min, 1 user, load average: 0.33, 0.11, 0.04 2026-07-21 20:11:31.416285 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-21 20:11:31.416400 UTC - lsb_release matches expected value 2026-07-21 20:11:31.416435 UTC - SSH Test passed. 2026-07-21 20:11:31.554311 UTC - Cloud-init user-data: Hello World. The time is now Tue, 21 Jul 2026 20:10:57 +0000! 2026-07-21 20:11:31.563747 UTC - Destroying tst-32164e0d tst 2026-07-21 20:11:31.563935 UTC - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-32164e0d tst