Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 22.12s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 636ms 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 1.51s + 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.0 + typing-extensions==4.16.0 + typing-inspection==0.4.2 Run Test: slices-bi-singlenode-login 2026-07-15 20:08:12.557849 UTC - Installing Slices CLI (latest stable version). 2026-07-15 20:08:12.558292 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-15 20:08:53.033291 UTC - Slices CLI installed. 2026-07-15 20:08:53.033769 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-15 20:08:53.035021 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-15 20:08:53.036408 UTC - which slices: b'/app/.venv/bin/slices\n' 2026-07-15 20:08:53.036567 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-15 20:08:53.036602 UTC - Slices CLI exe: 'slices' 2026-07-15 20:08:53.036619 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-15 20:08:53.036788 UTC - Run: slices --version 2026-07-15 20:08:57.490596 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-15 20:08:57.490998 UTC - Run: slices pubkey list --format text 2026-07-15 20:08:58.763661 UTC - Pubkey already registered 2026-07-15 20:08:58.763915 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-15 20:08:59.647245 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-15 20:08:59.647339 UTC - Check List Flavors 2026-07-15 20:08:59.647491 UTC - Run: slices bi --infra hu-budapest-bi-vm1 flavor list -f json 2026-07-15 20:09:01.276538 UTC - Check List DiskImages 2026-07-15 20:09:01.276754 UTC - Run: slices bi --infra hu-budapest-bi-vm1 diskimage list -f json 2026-07-15 20:09:02.046711 UTC - Requesting resources 2026-07-15 20:09:02.047550 UTC - Run: slices bi --infra hu-budapest-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-d3e44582 2026-07-15 20:09:07.247202 UTC - Resource ID: r_hu-budapest-bi-vm1_01kxkpbdk8e318pcvwg6y4thtj 2026-07-15 20:09:07.247354 UTC - Waiting until resource ready 2026-07-15 20:09:09.247678 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-d3e44582 tst 2026-07-15 20:09:10.601713 UTC - Status: IMAGING 2026-07-15 20:09:13.845781 UTC - Status: IMAGING 2026-07-15 20:09:16.913783 UTC - Status: IMAGING 2026-07-15 20:09:19.782731 UTC - Status: IMAGING 2026-07-15 20:09:22.655941 UTC - Status: IMAGING 2026-07-15 20:09:25.903320 UTC - Status: IMAGING 2026-07-15 20:09:28.937784 UTC - Status: IMAGING 2026-07-15 20:09:31.961226 UTC - Status: IMAGING 2026-07-15 20:09:35.658318 UTC - Status: IMAGING 2026-07-15 20:09:38.532161 UTC - Status: IMAGING 2026-07-15 20:09:41.615315 UTC - Status: IMAGING 2026-07-15 20:09:45.157236 UTC - Status: IMAGING 2026-07-15 20:09:49.055130 UTC - Status: IMAGING 2026-07-15 20:09:51.977622 UTC - Status: IMAGING 2026-07-15 20:09:55.157214 UTC - Status: IMAGING 2026-07-15 20:09:58.139414 UTC - Status: IMAGING 2026-07-15 20:10:01.186004 UTC - Status: IMAGING 2026-07-15 20:10:04.370551 UTC - Status: IMAGING 2026-07-15 20:10:07.738706 UTC - Status: IMAGING 2026-07-15 20:10:11.451117 UTC - Status: IMAGING 2026-07-15 20:10:14.370504 UTC - Status: UP 2026-07-15 20:10:14.370622 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kxkpbbvyfvc9xqy3xdp586wy 2026-07-15 20:10:14.370667 UTC - Validate resources 2026-07-15 20:10:15.186546 UTC - The fields of the created resource were validated. 2026-07-15 20:10:15.186975 UTC - Check if resources are registered in experiment 2026-07-15 20:10:15.187151 UTC - Run: slices experiment list-resources --format json tst-d3e44582 2026-07-15 20:10:16.007108 UTC - Status (on expauth): UP 2026-07-15 20:10:16.007266 UTC - Testing extend expires_at (all resources in experiment) 2026-07-15 20:10:16.007401 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend --duration 3h --experiment tst-d3e44582 2026-07-15 20:10:19.237284 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-d3e44582 tst 2026-07-15 20:10:20.102914 UTC - Run: slices experiment list-resources --format json tst-d3e44582 2026-07-15 20:10:20.997397 UTC - expires_at (on expauth): 2026-07-15T23:10:00Z (correctly extended) 2026-07-15 20:10:20.997490 UTC - Testing extend expires_at (single resource in experiment) 2026-07-15 20:10:20.997623 UTC - Run: slices bi --infra hu-budapest-bi-vm1 extend tst --duration 4h --experiment tst-d3e44582 2026-07-15 20:10:24.330661 UTC - Run: slices bi --infra hu-budapest-bi-vm1 list-resources --format json --experiment tst-d3e44582 tst 2026-07-15 20:10:25.147725 UTC - Run: slices experiment list-resources --format json tst-d3e44582 2026-07-15 20:10:25.867898 UTC - expires_at (on expauth): 2026-07-16T00:10:00Z (correctly extended) 2026-07-15 20:10:25.868011 UTC - Testing ssh login 2026-07-15 20:10:25.884051 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-d3e44582 tst 2026-07-15 20:10:27.389718 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-d3e44582 tst 2026-07-15 20:10:28.941377 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-d3e44582 tst 2026-07-15 20:10:30.528087 UTC - Logging in using 'slices bi ssh' 2026-07-15 20:10:30.528320 UTC - Forcing IPv4 only. 2026-07-15 20:10:30.528465 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-d3e44582 tst -- -4 uname -a 2026-07-15 20:10:35.356271 UTC - Forcing IPv4 only. 2026-07-15 20:10:35.357343 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --show nothing --experiment tst-d3e44582 tst -- -4 uptime 2026-07-15 20:10:38.427294 UTC - CLI SSH Test passed. 2026-07-15 20:10:38.427377 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-15 20:10:38.427397 UTC - Uptime: 20:10:38 up 1 min, 1 user, load average: 0.10, 0.04, 0.01 2026-07-15 20:10:38.427439 UTC - Logging in using SSH over SSH proxy 2026-07-15 20:10:38.427571 UTC - Run: slices bi --infra hu-budapest-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-d3e44582 tst 2026-07-15 20:10:41.118303 UTC - Added paramiko HostKeyEntry for 192.168.0.121 2026-07-15 20:10:41.118474 UTC - Added paramiko HostKeyEntry for 192.168.0.121 2026-07-15 20:10:41.118709 UTC - Added paramiko HostKeyEntry for 192.168.0.121 2026-07-15 20:10:41.121040 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-15 20:10:41.121142 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-15 20:10:41.121322 UTC - Added paramiko HostKeyEntry for 193.225.251.128 2026-07-15 20:10:41.121354 UTC - Connecting to proxy 193.225.251.128:22 2026-07-15 20:10:41.657376 UTC - Connecting to 192.168.0.121:22 over proxy 2026-07-15 20:10:42.385932 UTC - SSH Test output: 2026-07-15 20:10:42.386197 UTC - Uname: Linux 2c1f459e-c69b-436f-aa4f-b148d22ca810-b6fa97cc-9ea7-4f9b-9541-f0 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-15 20:10:42.386236 UTC - Uptime: 20:10:42 up 1 min, 1 user, load average: 0.18, 0.06, 0.02 2026-07-15 20:10:42.614371 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-15 20:10:42.614444 UTC - lsb_release matches expected value 2026-07-15 20:10:42.614463 UTC - SSH Test passed. 2026-07-15 20:10:42.624972 UTC - Destroying tst-d3e44582 tst 2026-07-15 20:10:42.625179 UTC - Run: slices bi --infra hu-budapest-bi-vm1 destroy --experiment tst-d3e44582 tst