Using CPython 3.14.6 interpreter at: /usr/local/bin/python3 Creating virtual environment at: .venv Resolved 32 packages in 6.29s Building slices-monitor-test-runner @ file:///app Built slices-monitor-test-runner @ file:///app Prepared 1 package in 850ms 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.55s + 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.dev179+g419876b58 (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-09 06:03:33.775131 UTC - Installing Slices CLI (latest stable version). 2026-07-09 06:03:33.775703 UTC - Run: /usr/local/bin/uv pip install --index=https://doc.slices-ri.eu/pypi/ slices-cli 2026-07-09 06:03:40.885976 UTC - Slices CLI installed. 2026-07-09 06:03:40.890184 UTC - Slices CLI exe: 'slices' 2026-07-09 06:03:40.890273 UTC - Slices CLI venv path: '/root/slices-cli-venv/' 2026-07-09 06:03:40.890592 UTC - Run: slices --version 2026-07-09 06:03:51.817632 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-09 06:03:51.827302 UTC - Run: slices pubkey list --format text 2026-07-09 06:03:53.768094 UTC - Pubkey already registered 2026-07-09 06:03:53.768425 UTC - Run: slices bi infrastructure list --format csv --all --refresh 2026-07-09 06:03:55.407424 UTC - Refreshed infrastructure list. Total: 24 entries. 2026-07-09 06:03:55.407519 UTC - Check List Flavors 2026-07-09 06:03:55.407682 UTC - Run: slices bi --infra it-genoa1-bi-vm1 flavor list -f json 2026-07-09 06:03:57.741232 UTC - Check List DiskImages 2026-07-09 06:03:57.741422 UTC - Run: slices bi --infra it-genoa1-bi-vm1 diskimage list -f json 2026-07-09 06:03:59.400040 UTC - Requesting resources 2026-07-09 06:03:59.400682 UTC - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-07-09 06:03:59.400941 UTC - Run: slices bi --infra it-genoa1-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-67c69ff5 --user-data /tmp/tmp4oeavhu4 2026-07-09 06:04:02.953790 UTC - Resource ID: r_it-genoa1-bi-vm1_01kx2qkqnaefg8kc1a6e8pfct0 2026-07-09 06:04:02.953974 UTC - Waiting until resource ready 2026-07-09 06:04:04.956078 UTC - Run: slices bi --infra it-genoa1-bi-vm1 list-resources --format json --experiment tst-67c69ff5 tst 2026-07-09 06:04:06.448633 UTC - Status: IMAGING 2026-07-09 06:04:09.743498 UTC - Status: IMAGING 2026-07-09 06:04:13.141169 UTC - Status: BOOTING 2026-07-09 06:04:16.107526 UTC - Status: BOOTING 2026-07-09 06:04:19.129772 UTC - Status: BOOTING 2026-07-09 06:04:22.346384 UTC - Status: BOOTING 2026-07-09 06:04:25.162644 UTC - Status: BOOTING 2026-07-09 06:04:28.029163 UTC - Status: BOOTING 2026-07-09 06:04:30.845437 UTC - Status: BOOTING 2026-07-09 06:04:33.611593 UTC - Status: BOOTING 2026-07-09 06:04:36.427878 UTC - Status: BOOTING 2026-07-09 06:04:39.244393 UTC - Status: UP 2026-07-09 06:04:39.244484 UTC - Experiment ID: exp_expauth.ilabt.imec.be_01kx2qkpgyejg8rgrva6bxne6s 2026-07-09 06:04:39.244540 UTC - Validate resources 2026-07-09 06:04:40.061717 UTC - The fields of the created resource were validated. 2026-07-09 06:04:40.061808 UTC - Check if resources are registered in experiment 2026-07-09 06:04:40.061984 UTC - Run: slices experiment list-resources --format json tst-67c69ff5 2026-07-09 06:04:40.727335 UTC - Status (on expauth): UP 2026-07-09 06:04:40.727562 UTC - Testing extend expires_at (all resources in experiment) 2026-07-09 06:04:40.727741 UTC - Run: slices bi --infra it-genoa1-bi-vm1 extend --duration 3h --experiment tst-67c69ff5 2026-07-09 06:04:43.348584 UTC - Run: slices bi --infra it-genoa1-bi-vm1 list-resources --format json --experiment tst-67c69ff5 tst 2026-07-09 06:04:44.164974 UTC - Run: slices experiment list-resources --format json tst-67c69ff5 2026-07-09 06:04:44.780341 UTC - expires_at (on expauth): 2026-07-09T09:04:00Z (correctly extended) 2026-07-09 06:04:44.780437 UTC - Testing extend expires_at (single resource in experiment) 2026-07-09 06:04:44.780591 UTC - Run: slices bi --infra it-genoa1-bi-vm1 extend tst --duration 4h --experiment tst-67c69ff5 2026-07-09 06:04:47.451366 UTC - Run: slices bi --infra it-genoa1-bi-vm1 list-resources --format json --experiment tst-67c69ff5 tst 2026-07-09 06:04:48.317697 UTC - Run: slices experiment list-resources --format json tst-67c69ff5 2026-07-09 06:04:48.983055 UTC - expires_at (on expauth): 2026-07-09T10:04:00Z (correctly extended) 2026-07-09 06:04:48.983160 UTC - Testing ssh login 2026-07-09 06:04:48.996343 UTC - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-67c69ff5 tst 2026-07-09 06:04:49.962791 UTC - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-67c69ff5 tst 2026-07-09 06:04:50.878955 UTC - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-67c69ff5 tst 2026-07-09 06:04:51.794747 UTC - Logging in using 'slices bi ssh' 2026-07-09 06:04:51.794817 UTC - Forcing IPv4 only. 2026-07-09 06:04:51.794942 UTC - Run: slices bi --infra it-genoa1-bi-vm1 ssh --show nothing --experiment tst-67c69ff5 tst -- -4 uname -a 2026-07-09 06:04:54.565772 UTC - Forcing IPv4 only. 2026-07-09 06:04:54.566008 UTC - Run: slices bi --infra it-genoa1-bi-vm1 ssh --show nothing --experiment tst-67c69ff5 tst -- -4 uptime 2026-07-09 06:04:56.434703 UTC - CLI SSH Test passed. 2026-07-09 06:04:56.434781 UTC - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-07-09 06:04:56.434801 UTC - Uptime: 06:04:56 up 0 min, 2 users, load average: 0.15, 0.04, 0.01 2026-07-09 06:04:56.434836 UTC - Logging in using SSH over SSH proxy 2026-07-09 06:04:56.434977 UTC - Run: slices bi --infra it-genoa1-bi-vm1 ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-67c69ff5 tst 2026-07-09 06:04:57.401597 UTC - Added paramiko HostKeyEntry for 172.30.44.3 2026-07-09 06:04:57.401735 UTC - Added paramiko HostKeyEntry for 172.30.44.3 2026-07-09 06:04:57.401912 UTC - Added paramiko HostKeyEntry for 172.30.44.3 2026-07-09 06:04:57.402160 UTC - Added paramiko HostKeyEntry for slices-bi.tnt-lab.unige.it 2026-07-09 06:04:57.402306 UTC - Added paramiko HostKeyEntry for slices-bi.tnt-lab.unige.it 2026-07-09 06:04:57.402398 UTC - Added paramiko HostKeyEntry for slices-bi.tnt-lab.unige.it 2026-07-09 06:04:57.402423 UTC - Connecting to proxy slices-bi.tnt-lab.unige.it:22 2026-07-09 06:04:57.892674 UTC - Connecting to 172.30.44.3:22 over proxy 2026-07-09 06:04:58.769374 UTC - SSH Test output: 2026-07-09 06:04:58.769447 UTC - Uname: Linux tst 6.8.0-87-generic #88-Ubuntu SMP PREEMPT_DYNAMIC Sat Oct 11 09:28:41 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux 2026-07-09 06:04:58.769467 UTC - Uptime: 06:04:58 up 0 min, 1 user, load average: 0.15, 0.04, 0.01 2026-07-09 06:04:58.957165 UTC - lsb_release: Ubuntu 24.04.3 LTS 2026-07-09 06:04:58.957256 UTC - lsb_release matches expected value 2026-07-09 06:04:58.957278 UTC - SSH Test passed. 2026-07-09 06:04:59.143202 UTC - Cloud-init user-data: Hello World. The time is now Thu, 09 Jul 2026 06:04:38 +0000! 2026-07-09 06:04:59.149839 UTC - Destroying tst-67c69ff5 tst 2026-07-09 06:04:59.150014 UTC - Run: slices bi --infra it-genoa1-bi-vm1 destroy --experiment tst-67c69ff5 tst