Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.13s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 198ms 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 228ms + 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 04:00:50.995846 UTC - Installing Slices CLI (latest stable version). 2026-07-12 04:00:50.996060 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-12 04:00:56.846911 UTC - Slices CLI installed. 2026-07-12 04:00:56.847649 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 04:00:56.850853 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 04:00:56.852387 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-12 04:00:56.852518 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 04:00:56.852547 UTC - Slices CLI exe: 'slices' 2026-07-12 04:00:56.852564 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-12 04:00:56.852681 UTC - Run: slices --version 2026-07-12 04:00:59.522056 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 04:00:59.522438 UTC - Run: slices pubkey list --format text 2026-07-12 04:01:00.287944 UTC - Pubkey already registered 2026-07-12 04:01:00.288211 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-12 04:01:00.955616 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-12 04:01:00.955732 UTC - Check List Flavors 2026-07-12 04:01:00.955887 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 flavor list -f json 2026-07-12 04:01:02.523164 UTC - Check List DiskImages 2026-07-12 04:01:02.523376 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 diskimage list -f json 2026-07-12 04:01:03.238933 UTC - Requesting resources 2026-07-12 04:01:03.239489 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-ea8aef64 2026-07-12 04:01:07.212188 UTC - Resource ID: r_fr-sophia2-bi-vm2_01kxa7rsxxe2sr4e2j3309gmh2 2026-07-12 04:01:07.212376 UTC - Waiting until resource ready 2026-07-12 04:01:09.212744 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-ea8aef64 tst 2026-07-12 04:01:09.978227 UTC - Status: IMAGING 2026-07-12 04:01:12.744216 UTC - Status: BOOTING 2026-07-12 04:01:15.510514 UTC - Status: BOOTING 2026-07-12 04:01:18.277020 UTC - Status: BOOTING 2026-07-12 04:01:21.093136 UTC - Status: BOOTING 2026-07-12 04:01:23.909640 UTC - Status: BOOTING 2026-07-12 04:01:26.776087 UTC - Status: BOOTING 2026-07-12 04:01:29.592104 UTC - Status: BOOTING 2026-07-12 04:01:32.408269 UTC - Status: BOOTING 2026-07-12 04:01:35.225070 UTC - Status: UP 2026-07-12 04:01:35.225159 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxa7rrhwe8errcra5swsm78y 2026-07-12 04:01:35.225203 UTC - Validate resources 2026-07-12 04:01:36.041564 UTC - The fields of the created resource were validated. 2026-07-12 04:01:36.041691 UTC - Check if resources are registered in experiment 2026-07-12 04:01:36.041881 UTC - Run: slices experiment list-resources --format json tst-ea8aef64 2026-07-12 04:01:36.707541 UTC - Status (on expauth): UP 2026-07-12 04:01:36.707743 UTC - Testing extend expires_at (all resources in experiment) 2026-07-12 04:01:36.707903 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend --duration 3h --experiment tst-ea8aef64 2026-07-12 04:01:39.528886 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-ea8aef64 tst 2026-07-12 04:01:40.294806 UTC - Run: slices experiment list-resources --format json tst-ea8aef64 2026-07-12 04:01:40.960111 UTC - expires_at (on expauth): 2026-07-12T07:01:00Z (correctly extended) 2026-07-12 04:01:40.960213 UTC - Testing extend expires_at (single resource in experiment) 2026-07-12 04:01:40.960378 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend tst --duration 4h --experiment tst-ea8aef64 2026-07-12 04:01:43.630417 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-ea8aef64 tst 2026-07-12 04:01:44.446365 UTC - Run: slices experiment list-resources --format json tst-ea8aef64 2026-07-12 04:01:45.114197 UTC - expires_at (on expauth): 2026-07-12T08:01:00Z (correctly extended) 2026-07-12 04:01:45.114350 UTC - Testing ssh login 2026-07-12 04:01:45.128158 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show ssh_config --experiment tst-ea8aef64 tst 2026-07-12 04:01:46.094419 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-ea8aef64 tst 2026-07-12 04:01:47.010408 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-ea8aef64 tst 2026-07-12 04:01:47.876499 UTC - Logging in using 'slices bi ssh' 2026-07-12 04:01:47.876599 UTC - Forcing IPv4 only. 2026-07-12 04:01:47.876816 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-ea8aef64 tst -- -4 uname -a 2026-07-12 04:01:50.346091 UTC - Forcing IPv4 only. 2026-07-12 04:01:50.346287 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-ea8aef64 tst -- -4 uptime 2026-07-12 04:01:52.114195 UTC - CLI SSH Test passed. 2026-07-12 04:01:52.114280 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 04:01:52.114302 UTC - Uptime: 04:01:51 up 0 min, 1 user, load average: 0.16, 0.04, 0.01 2026-07-12 04:01:52.114351 UTC - Logging in using SSH over SSH proxy 2026-07-12 04:01:52.114511 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-ea8aef64 tst 2026-07-12 04:01:53.131463 UTC - Added paramiko HostKeyEntry for 172.28.10.63 2026-07-12 04:01:53.131690 UTC - Added paramiko HostKeyEntry for 172.28.10.63 2026-07-12 04:01:53.131756 UTC - Added paramiko HostKeyEntry for 172.28.10.63 2026-07-12 04:01:53.132034 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-12 04:01:53.132116 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-12 04:01:53.132165 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-12 04:01:53.132185 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-12 04:01:53.512090 UTC - Connecting to 172.28.10.63:22 over proxy 2026-07-12 04:01:54.192854 UTC - SSH Test output: 2026-07-12 04:01:54.192927 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 04:01:54.192950 UTC - Uptime: 04:01:53 up 0 min, 1 user, load average: 0.14, 0.04, 0.01 2026-07-12 04:01:54.330836 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-12 04:01:54.330932 UTC - lsb_release matches expected value 2026-07-12 04:01:54.330954 UTC - SSH Test passed. 2026-07-12 04:01:54.339163 UTC - Destroying tst-ea8aef64 tst 2026-07-12 04:01:54.339447 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 destroy --experiment tst-ea8aef64 tst