Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 7.23s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 261ms 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 771ms + annotated-types==0.8.0 + anyio==4.14.2 + authlib==1.7.2 + bcrypt==5.0.0 + certifi==2026.7.22 + 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.3.post1 + pyyaml==6.0.3 + slices-clientlib-bi==5.1.2 + slices-clientlib-core==5.6.0 + slices-monitor-test-runner==0.1.dev192+gcac2d3fe6 (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-31 04:03:04.742120 UTC - Installing Slices CLI (latest, with --pre). 2026-07-31 04:03:04.742357 UTC - Run: /usr/local/bin/uv pip install --pre --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-31 04:03:10.688600 UTC - Slices CLI installed. 2026-07-31 04:03:10.689111 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-31 04:03:10.690742 UTC - ls -a /root/ /scripts/ (error 2): None ls: cannot access '/scripts/': No such file or directory /root/: . .. .cache .local .slices run_test_runner.sh slices-cli-venv 2026-07-31 04:03:10.690811 UTC - env: {'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-31 04:03:10.690878 UTC - which slices: /app/.venv/bin/slices 2026-07-31 04:03:10.690897 UTC - Slices CLI exe: 'slices' 2026-07-31 04:03:10.690913 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-31 04:03:10.691051 UTC - Run: slices --version 2026-07-31 04:03:17.714480 UTC - version: Slices CLI v2026.2.0b6 Slices CLI core v1.2.6 Slices CLI ai v1.1.0 Slices CLI bi v2.2.1 Slices clientlib bi v6.1.1 Slices clientlib core v5.6.0 Slices clientlib ai v1.0.0 2026-07-31 04:03:17.714785 UTC - Run: slices pubkey list --format text 2026-07-31 04:03:20.198673 UTC - Pubkey already registered 2026-07-31 04:03:20.198928 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-31 04:03:21.764974 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-31 04:03:21.765067 UTC - Check List Flavors 2026-07-31 04:03:21.765221 UTC - Run: slices bi --infra be-gent1-bi-vm1 flavor list -f json 2026-07-31 04:03:23.167351 UTC - Check List DiskImages 2026-07-31 04:03:23.167536 UTC - Run: slices bi --infra be-gent1-bi-vm1 diskimage list -f json 2026-07-31 04:03:25.065255 UTC - Requesting resources 2026-07-31 04:03:25.069512 UTC - Run: slices bi --infra be-gent1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-a631a5a5 2026-07-31 04:03:26.661918 UTC - Resource ID: r_be-gent1-bi-vm1_01kyv5eq1afvfbjnz4t2t1446m 2026-07-31 04:03:26.662059 UTC - Waiting until resource ready 2026-07-31 04:03:28.662438 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-a631a5a5 tst 2026-07-31 04:03:30.079139 UTC - Status: IMAGING 2026-07-31 04:03:33.586842 UTC - Status: IMAGING 2026-07-31 04:03:36.627703 UTC - Status: IMAGING 2026-07-31 04:03:40.314452 UTC - Status: BOOTING 2026-07-31 04:03:43.937075 UTC - Status: BOOTING 2026-07-31 04:03:46.803470 UTC - Status: BOOTING 2026-07-31 04:03:49.921257 UTC - Status: INITIALIZING 2026-07-31 04:03:52.855192 UTC - Status: UP 2026-07-31 04:03:52.855276 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kyv5epsqefnsed1ejh7dnbvz 2026-07-31 04:03:52.855319 UTC - Validate resources 2026-07-31 04:03:53.995029 UTC - The fields of the created resource were validated. 2026-07-31 04:03:53.995516 UTC - Check if resources are registered in experiment 2026-07-31 04:03:53.995991 UTC - Run: slices experiment list-resources --format json tst-a631a5a5 2026-07-31 04:03:54.763007 UTC - Status (on expauth): UP 2026-07-31 04:03:54.763160 UTC - Testing extend expires_at (all resources in experiment) 2026-07-31 04:03:54.763288 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend --duration 3h --experiment tst-a631a5a5 2026-07-31 04:03:56.332134 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-a631a5a5 tst 2026-07-31 04:03:57.355286 UTC - Run: slices experiment list-resources --format json tst-a631a5a5 2026-07-31 04:03:58.311983 UTC - expires_at (on expauth): 2026-07-31T07:03:00Z (correctly extended) 2026-07-31 04:03:58.312079 UTC - Testing extend expires_at (single resource in experiment) 2026-07-31 04:03:58.312262 UTC - Run: slices bi --infra be-gent1-bi-vm1 extend tst --duration 4h --experiment tst-a631a5a5 2026-07-31 04:04:00.041008 UTC - Run: slices bi --infra be-gent1-bi-vm1 list-resources --format json --experiment tst-a631a5a5 tst 2026-07-31 04:04:01.007420 UTC - Run: slices experiment list-resources --format json tst-a631a5a5 2026-07-31 04:04:01.774179 UTC - expires_at (on expauth): 2026-07-31T08:03:00Z (correctly extended) 2026-07-31 04:04:01.774305 UTC - Testing ssh login 2026-07-31 04:04:01.785559 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-a631a5a5 tst 2026-07-31 04:04:02.756626 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-a631a5a5 tst 2026-07-31 04:04:03.839233 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-a631a5a5 tst 2026-07-31 04:04:05.118646 UTC - Logging in using 'slices bi ssh' 2026-07-31 04:04:05.118758 UTC - Forcing IPv4 only. 2026-07-31 04:04:05.118940 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-a631a5a5 tst -- -4 uname -a 2026-07-31 04:04:06.838167 UTC - Forcing IPv4 only. 2026-07-31 04:04:06.838345 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --show nothing --experiment tst-a631a5a5 tst -- -4 uptime 2026-07-31 04:04:08.068763 UTC - CLI SSH Test passed. 2026-07-31 04:04:08.068874 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-31 04:04:08.068899 UTC - Uptime: 06:04:07 up 0 min, 1 user, load average: 0.18, 0.05, 0.01 2026-07-31 04:04:08.068946 UTC - Logging in using SSH (extra test: ignore SSH proxy) 2026-07-31 04:04:08.069607 UTC - Added paramiko HostKeyEntry for 10.10.220.36 2026-07-31 04:04:08.070138 UTC - Added paramiko HostKeyEntry for 10.10.220.36 2026-07-31 04:04:08.070252 UTC - Added paramiko HostKeyEntry for 10.10.220.36 2026-07-31 04:04:08.070467 UTC - Connecting to 10.10.220.36:22 2026-07-31 04:04:08.306709 UTC - SSH Test output: 2026-07-31 04:04:08.306793 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-31 04:04:08.306814 UTC - Uptime: 06:04:07 up 0 min, 1 user, load average: 0.18, 0.05, 0.01 2026-07-31 04:04:08.355789 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-31 04:04:08.355905 UTC - lsb_release matches expected value 2026-07-31 04:04:08.355931 UTC - SSH Test passed. 2026-07-31 04:04:08.356032 UTC - Logging in using SSH over SSH proxy 2026-07-31 04:04:08.356203 UTC - Run: slices bi --infra be-gent1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-a631a5a5 tst 2026-07-31 04:04:09.584578 UTC - Added paramiko HostKeyEntry for 10.10.220.36 2026-07-31 04:04:09.584741 UTC - Added paramiko HostKeyEntry for 10.10.220.36 2026-07-31 04:04:09.584797 UTC - Added paramiko HostKeyEntry for 10.10.220.36 2026-07-31 04:04:09.585030 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-31 04:04:09.585080 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-31 04:04:09.585209 UTC - Added paramiko HostKeyEntry for bastion2.slices-be.eu 2026-07-31 04:04:09.585232 UTC - Connecting to proxy bastion2.slices-be.eu:22 2026-07-31 04:04:09.700628 UTC - Connecting to 10.10.220.36:22 over proxy 2026-07-31 04:04:10.009629 UTC - SSH Test output: 2026-07-31 04:04:10.009717 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-31 04:04:10.009750 UTC - Uptime: 06:04:09 up 0 min, 2 users, load average: 0.18, 0.05, 0.01 2026-07-31 04:04:10.045663 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-31 04:04:10.045740 UTC - lsb_release matches expected value 2026-07-31 04:04:10.045760 UTC - SSH Test passed. 2026-07-31 04:04:10.055430 UTC - Destroying tst-a631a5a5 tst 2026-07-31 04:04:10.055615 UTC - Run: slices bi --infra be-gent1-bi-vm1 destroy --experiment tst-a631a5a5 tst