Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 4.08s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 194ms 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 224ms + 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-11 04:00:41.287944 UTC - Installing Slices CLI (latest stable version). 2026-07-11 04:00:41.288183 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-11 04:00:48.871073 UTC - Slices CLI installed. 2026-07-11 04:00:48.871238 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-11 04:00:48.873769 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-11 04:00:48.874779 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-11 04:00:48.874908 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-11 04:00:48.874938 UTC - Slices CLI exe: 'slices' 2026-07-11 04:00:48.874955 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-11 04:00:48.875069 UTC - Run: slices --version 2026-07-11 04:00:51.544288 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-11 04:00:51.544564 UTC - Run: slices pubkey list --format text 2026-07-11 04:00:52.510539 UTC - Pubkey already registered 2026-07-11 04:00:52.510792 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-11 04:00:53.126052 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-11 04:00:53.126150 UTC - Check List Flavors 2026-07-11 04:00:53.126310 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 flavor list -f json 2026-07-11 04:00:54.793886 UTC - Check List DiskImages 2026-07-11 04:00:54.794080 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 diskimage list -f json 2026-07-11 04:00:55.509509 UTC - Requesting resources 2026-07-11 04:00:55.509998 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-acf1e84d 2026-07-11 04:00:59.682506 UTC - Resource ID: r_fr-sophia2-bi-vm2_01kx7nbvkdf6rsr54d0096petn 2026-07-11 04:00:59.682677 UTC - Waiting until resource ready 2026-07-11 04:01:01.683085 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-acf1e84d tst 2026-07-11 04:01:02.498646 UTC - Status: IMAGING 2026-07-11 04:01:05.264914 UTC - Status: BOOTING 2026-07-11 04:01:08.031100 UTC - Status: BOOTING 2026-07-11 04:01:10.947803 UTC - Status: BOOTING 2026-07-11 04:01:13.764203 UTC - Status: BOOTING 2026-07-11 04:01:16.580573 UTC - Status: BOOTING 2026-07-11 04:01:19.397486 UTC - Status: BOOTING 2026-07-11 04:01:22.215590 UTC - Status: BOOTING 2026-07-11 04:01:25.032082 UTC - Status: UP 2026-07-11 04:01:25.032188 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx7nbt63fq0t04mzp70rb9bw 2026-07-11 04:01:25.032238 UTC - Validate resources 2026-07-11 04:01:25.799012 UTC - The fields of the created resource were validated. 2026-07-11 04:01:25.799189 UTC - Check if resources are registered in experiment 2026-07-11 04:01:25.799455 UTC - Run: slices experiment list-resources --format json tst-acf1e84d 2026-07-11 04:01:26.515658 UTC - Status (on expauth): UP 2026-07-11 04:01:26.515859 UTC - Testing extend expires_at (all resources in experiment) 2026-07-11 04:01:26.516028 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend --duration 3h --experiment tst-acf1e84d 2026-07-11 04:01:29.386888 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-acf1e84d tst 2026-07-11 04:01:30.253632 UTC - Run: slices experiment list-resources --format json tst-acf1e84d 2026-07-11 04:01:30.933970 UTC - expires_at (on expauth): 2026-07-11T07:01:00Z (correctly extended) 2026-07-11 04:01:30.936588 UTC - Testing extend expires_at (single resource in experiment) 2026-07-11 04:01:30.937579 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 extend tst --duration 4h --experiment tst-acf1e84d 2026-07-11 04:01:33.613282 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 list-resources --format json --experiment tst-acf1e84d tst 2026-07-11 04:01:34.429311 UTC - Run: slices experiment list-resources --format json tst-acf1e84d 2026-07-11 04:01:35.094739 UTC - expires_at (on expauth): 2026-07-11T08:01:00Z (correctly extended) 2026-07-11 04:01:35.094905 UTC - Testing ssh login 2026-07-11 04:01:35.107973 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show ssh_config --experiment tst-acf1e84d tst 2026-07-11 04:01:36.023899 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-acf1e84d tst 2026-07-11 04:01:36.940089 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-acf1e84d tst 2026-07-11 04:01:37.856211 UTC - Logging in using 'slices bi ssh' 2026-07-11 04:01:37.856287 UTC - Forcing IPv4 only. 2026-07-11 04:01:37.856423 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-acf1e84d tst -- -4 uname -a 2026-07-11 04:01:40.275643 UTC - Forcing IPv4 only. 2026-07-11 04:01:40.275840 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --show nothing --experiment tst-acf1e84d tst -- -4 uptime 2026-07-11 04:01:42.043947 UTC - CLI SSH Test passed. 2026-07-11 04:01:42.044060 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-11 04:01:42.044084 UTC - Uptime: 04:01:40 up 0 min, 1 user, load average: 0.63, 0.18, 0.06 2026-07-11 04:01:42.044125 UTC - Logging in using SSH over SSH proxy 2026-07-11 04:01:42.044312 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-acf1e84d tst 2026-07-11 04:01:43.065601 UTC - Added paramiko HostKeyEntry for 172.28.9.238 2026-07-11 04:01:43.065859 UTC - Added paramiko HostKeyEntry for 172.28.9.238 2026-07-11 04:01:43.065970 UTC - Added paramiko HostKeyEntry for 172.28.9.238 2026-07-11 04:01:43.066319 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 04:01:43.066412 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 04:01:43.066473 UTC - Added paramiko HostKeyEntry for bastion1.theblueprintfactory.org 2026-07-11 04:01:43.066507 UTC - Connecting to proxy bastion1.theblueprintfactory.org:22 2026-07-11 04:01:43.444014 UTC - Connecting to 172.28.9.238:22 over proxy 2026-07-11 04:01:44.118752 UTC - SSH Test output: 2026-07-11 04:01:44.118889 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-11 04:01:44.118928 UTC - Uptime: 04:01:42 up 0 min, 1 user, load average: 0.58, 0.18, 0.06 2026-07-11 04:01:44.253459 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-11 04:01:44.253559 UTC - lsb_release matches expected value 2026-07-11 04:01:44.253580 UTC - SSH Test passed. 2026-07-11 04:01:44.260601 UTC - Destroying tst-acf1e84d tst 2026-07-11 04:01:44.260826 UTC - Run: slices bi --infra fr-sophia2-bi-vm2 destroy --experiment tst-acf1e84d tst