Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.36s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 265ms 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 688ms + 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.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.1 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-18 04:02:53.163615 UTC - Installing Slices CLI (latest, with --pre). 2026-07-18 04:02:53.163839 UTC - Run: /usr/local/bin/uv pip install --pre --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-18 04:03:01.960189 UTC - Slices CLI installed. 2026-07-18 04:03:01.960593 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-18 04:03:01.962682 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-18 04:03:01.963760 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-18 04:03:01.963892 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-18 04:03:01.963929 UTC - Slices CLI exe: 'slices' 2026-07-18 04:03:01.963947 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-18 04:03:01.964073 UTC - Run: slices --version 2026-07-18 04:03:08.448641 UTC - version: Slices CLI v2026.2.0b4 Slices CLI core v1.2.5 Slices CLI ai v1.1.0 Slices CLI bi v2.2.0 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-07-18 04:03:08.453747 UTC - Run: slices pubkey list --format text 2026-07-18 04:03:11.110313 UTC - Pubkey already registered 2026-07-18 04:03:11.110565 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-18 04:03:12.132230 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-18 04:03:12.132325 UTC - Check List Flavors 2026-07-18 04:03:12.132471 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-07-18 04:03:24.509603 UTC - Step 'List Flavors' took 12.38 seconds, which is longer than the warning threshold of 5 seconds 2026-07-18 04:03:24.512149 UTC - Check List DiskImages 2026-07-18 04:03:24.512392 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-07-18 04:03:25.590209 UTC - Requesting resources 2026-07-18 04:03:25.590735 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-bc91252d 2026-07-18 04:03:32.716203 UTC - Resource ID: r_be-gent1-bi-vm1_01kxsp9j2tep78epj9h5e0s91s 2026-07-18 04:03:32.716489 UTC - Waiting until resource ready 2026-07-18 04:03:34.716921 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-bc91252d tst 2026-07-18 04:03:36.299644 UTC - Status: IMAGING 2026-07-18 04:03:39.065681 UTC - Status: IMAGING 2026-07-18 04:03:42.697204 UTC - Status: IMAGING 2026-07-18 04:03:45.677526 UTC - Status: BOOTING 2026-07-18 04:03:49.374001 UTC - Status: BOOTING 2026-07-18 04:03:52.993667 UTC - Status: BOOTING 2026-07-18 04:03:57.307351 UTC - Status: UP 2026-07-18 04:03:57.307445 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxsp9ggcf4c8dv4xna1hyj6n 2026-07-18 04:03:57.307489 UTC - Validate resources 2026-07-18 04:03:59.577140 UTC - The fields of the created resource were validated. 2026-07-18 04:03:59.577248 UTC - Check if resources are registered in experiment 2026-07-18 04:03:59.577396 UTC - Run: slices experiment list-resources --format json tst-bc91252d 2026-07-18 04:04:01.421212 UTC - Status (on expauth): UP 2026-07-18 04:04:01.421387 UTC - Testing extend expires_at (all resources in experiment) 2026-07-18 04:04:01.421529 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-bc91252d 2026-07-18 04:04:06.805729 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-bc91252d tst 2026-07-18 04:04:09.771416 UTC - Run: slices experiment list-resources --format json tst-bc91252d 2026-07-18 04:04:11.663327 UTC - expires_at (on expauth): 2026-07-18T07:04:00Z (correctly extended) 2026-07-18 04:04:11.663436 UTC - Testing extend expires_at (single resource in experiment) 2026-07-18 04:04:11.663573 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-bc91252d 2026-07-18 04:04:16.789692 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-bc91252d tst 2026-07-18 04:04:18.406431 UTC - Run: slices experiment list-resources --format json tst-bc91252d 2026-07-18 04:04:20.739103 UTC - expires_at (on expauth): 2026-07-18T08:04:00Z (correctly extended) 2026-07-18 04:04:20.739226 UTC - Testing ssh login 2026-07-18 04:04:20.801463 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-bc91252d tst 2026-07-18 04:04:23.106822 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-bc91252d tst 2026-07-18 04:04:25.529231 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-bc91252d tst 2026-07-18 04:04:28.100392 UTC - Logging in using 'slices bi ssh' 2026-07-18 04:04:28.100503 UTC - Forcing IPv4 only. 2026-07-18 04:04:28.100625 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-bc91252d tst -- -4 uname -a 2026-07-18 04:04:30.967520 UTC - Forcing IPv4 only. 2026-07-18 04:04:30.967785 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-bc91252d tst -- -4 uptime 2026-07-18 04:04:33.340840 UTC - CLI SSH Test passed. 2026-07-18 04:04:33.340927 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-18 04:04:33.340957 UTC - Uptime: 06:04:33 up 0 min, 1 user, load average: 0.08, 0.03, 0.01 2026-07-18 04:04:33.341002 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-07-18 04:04:33.341623 UTC - Added paramiko HostKeyEntry for 10.10.218.122 2026-07-18 04:04:33.341839 UTC - Added paramiko HostKeyEntry for 10.10.218.122 2026-07-18 04:04:33.341909 UTC - Added paramiko HostKeyEntry for 10.10.218.122 2026-07-18 04:04:33.342114 UTC - Connecting to 10.10.218.122:22 2026-07-18 04:04:33.581903 UTC - SSH Test output: 2026-07-18 04:04:33.582003 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-18 04:04:33.582034 UTC - Uptime: 06:04:33 up 0 min, 1 user, load average: 0.08, 0.03, 0.01 2026-07-18 04:04:33.631540 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-18 04:04:33.631621 UTC - lsb_release matches expected value 2026-07-18 04:04:33.631641 UTC - SSH Test passed. 2026-07-18 04:04:33.631724 UTC - Logging in using SSH over SSH proxy 2026-07-18 04:04:33.631900 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-bc91252d tst 2026-07-18 04:04:34.783327 UTC - Added paramiko HostKeyEntry for 10.10.218.122 2026-07-18 04:04:34.783475 UTC - Added paramiko HostKeyEntry for 10.10.218.122 2026-07-18 04:04:34.783528 UTC - Added paramiko HostKeyEntry for 10.10.218.122 2026-07-18 04:04:34.783753 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-18 04:04:34.783802 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-18 04:04:34.783905 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-18 04:04:34.783928 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-07-18 04:04:35.068570 UTC - Connecting to 10.10.218.122:22 over proxy 2026-07-18 04:04:35.353120 UTC - SSH Test output: 2026-07-18 04:04:35.353193 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-18 04:04:35.353212 UTC - Uptime: 06:04:35 up 0 min, 2 users, load average: 0.08, 0.03, 0.01 2026-07-18 04:04:35.410157 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-18 04:04:35.410238 UTC - lsb_release matches expected value 2026-07-18 04:04:35.410258 UTC - SSH Test passed. 2026-07-18 04:04:35.430062 UTC - Destroying tst-bc91252d tst 2026-07-18 04:04:35.430262 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-bc91252d tst