Run Test: slices-bi-singlenode-login 2026-04-20 00:29:32.129273 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-20 00:29:36.352066 CEST - Run: slices --version 2026-04-20 00:29:36.566363 CEST - version: Slices CLI v2025.1.5 Slices CLI core v1.1.2 Slices CLI bi v2.0.2 Slices clientlib core v5.5.0 Slices clientlib bi v5.1.2 2026-04-20 00:29:36.566628 CEST - Run: slices pubkey list --format text 2026-04-20 00:29:37.181619 CEST - Pubkey already registered 2026-04-20 00:29:37.181878 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-20 00:29:37.696831 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-20 00:29:37.696941 CEST - Check List Flavors 2026-04-20 00:29:37.697108 CEST - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-04-20 00:29:38.562648 CEST - Check List DiskImages 2026-04-20 00:29:38.562858 CEST - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-04-20 00:29:39.177890 CEST - Requesting resources 2026-04-20 00:29:39.178346 CEST - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-97e23f3d 2026-04-20 00:29:41.146089 CEST - Resource ID: r_ch-geneva-bi-vm1_01kpkxt8ztfv1v10taccqzq19r 2026-04-20 00:29:41.146209 CEST - Waiting until resource ready 2026-04-20 00:29:43.146557 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-97e23f3d tst 2026-04-20 00:29:43.811733 CEST - Status: IMAGING 2026-04-20 00:29:46.477212 CEST - Status: IMAGING 2026-04-20 00:29:49.142774 CEST - Status: IMAGING 2026-04-20 00:29:51.808277 CEST - Status: IMAGING 2026-04-20 00:29:54.473891 CEST - Status: IMAGING 2026-04-20 00:29:57.139339 CEST - Status: IMAGING 2026-04-20 00:29:59.855054 CEST - Status: IMAGING 2026-04-20 00:30:02.520635 CEST - Status: IMAGING 2026-04-20 00:30:05.236257 CEST - Status: IMAGING 2026-04-20 00:30:07.951885 CEST - Status: IMAGING 2026-04-20 00:30:10.667639 CEST - Status: IMAGING 2026-04-20 00:30:13.383392 CEST - Status: IMAGING 2026-04-20 00:30:16.048855 CEST - Status: IMAGING 2026-04-20 00:30:18.765087 CEST - Status: IMAGING 2026-04-20 00:30:21.531238 CEST - Status: IMAGING 2026-04-20 00:30:24.247312 CEST - Status: IMAGING 2026-04-20 00:30:26.963141 CEST - Status: IMAGING 2026-04-20 00:30:29.679360 CEST - Status: IMAGING 2026-04-20 00:30:32.445539 CEST - Status: IMAGING 2026-04-20 00:30:35.211677 CEST - Status: IMAGING 2026-04-20 00:30:38.028455 CEST - Status: IMAGING 2026-04-20 00:30:40.694278 CEST - Status: IMAGING 2026-04-20 00:30:43.359914 CEST - Status: IMAGING 2026-04-20 00:30:46.075841 CEST - Status: IMAGING 2026-04-20 00:30:48.842012 CEST - Status: IMAGING 2026-04-20 00:30:51.507594 CEST - Status: IMAGING 2026-04-20 00:30:54.223387 CEST - Status: IMAGING 2026-04-20 00:30:56.888930 CEST - Status: IMAGING 2026-04-20 00:30:59.554468 CEST - Status: IMAGING 2026-04-20 00:31:02.219986 CEST - Status: IMAGING 2026-04-20 00:31:04.885491 CEST - Status: IMAGING 2026-04-20 00:31:07.550980 CEST - Status: IMAGING 2026-04-20 00:31:10.216457 CEST - Status: IMAGING 2026-04-20 00:31:12.932163 CEST - Status: IMAGING 2026-04-20 00:31:15.597647 CEST - Status: IMAGING 2026-04-20 00:31:18.263158 CEST - Status: IMAGING 2026-04-20 00:31:20.978756 CEST - Status: IMAGING 2026-04-20 00:31:23.644340 CEST - Status: IMAGING 2026-04-20 00:31:26.309806 CEST - Status: IMAGING 2026-04-20 00:31:29.025345 CEST - Status: IMAGING 2026-04-20 00:31:31.690803 CEST - Status: IMAGING 2026-04-20 00:31:34.356342 CEST - Status: UP 2026-04-20 00:31:34.356400 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kpkxt87kfekv4tzv3g73p8ty 2026-04-20 00:31:34.356453 CEST - Validate resources 2026-04-20 00:31:35.073237 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/d9c4fd17-595f-4c6d-a514-2afb48c9725c/step_Validateresources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-97e23f3d tst 2026-04-20 00:31:35.073336 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/d9c4fd17-595f-4c6d-a514-2afb48c9725c/list-resources_json.txt': [ { "cluster_id": "default", "created_at": "2026-04-19T22:29:40.978213Z", "disk_image_id": "image_ch-geneva-bi-vm1_20kfy65vcb9xabdgfszftvdjk6", "experiment_id": "exp_expauth.ilabt.imec.be_01kpkxt87kfekv4tzv3g73p8ty", "expires_at": "2026-04-20T00:29:00Z", "flavor_id": "flavor_ch-geneva-bi-vm1_3rm28rdxe1947bbxqxb7e8xgc5", "friendly_name": "tst", "id": "r_ch-geneva-bi-vm1_01kpkxt8ztfv1v10taccqzq19r", "network_interfaces": [], "private_ipv4": "5.53.108.38", "private_ipv6": null, "public_ipv4": "5.53.108.38", "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [ { "host": "5.53.108.38", "port": 22, "username": "ubuntu", "host_keys": [ "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBLGgzc4xbLWOWGl/2UYdLnHEOmjUnCJf3K4BPpvOMA6Oy5FkTMZ99UNS+M1AmGr96dYtBdD1pooKFr4ityIzLrs=", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILUeh7h7zn4VgTUZKl4WE7bEKkq0lLt3P5oNedtQAxtu", "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC2w8fvawmXx+lMl6PxychL7XwkocdxgyDbbVxuh69/aZBEoYVABX/mfjrYo/aI+/PYMDyHfyoJFwFbJNYzXv47xGNxn7DesVr1wklX0YORAFhUbyxM8xxQ7dhZghKCnaAcSnaOmsElW7GJ6Yq2VdxpqRbAE6CkyxgHNeR99wDXxvJYk5hLMHrLzktu/tI6w2rDO6T/j/pEcqusKrqbALaGC56t/92YTrUsetPahNJM+6iJQejkPV4Qn7L7Uvw9+nnhPrgaFpTTEDu57LScPqwzijAKOMRRJnU1PHdWj6f9C20RqGIbdamFm1UjwfHiRvywCpz+e0OxE4Bh+5CNf5Xm0LnMVUj3l9j0M0ACfl23v2l4iiobzFUHu/CcOi9I7czL+jQSiuXiAB2ftxz4CWwhFsYYIeYjltUi8D5rxXnmH+e1AwyUUI+fkFLrSrnbv2Q63KV4YotID596VNrY3zao8uW58nG595Tmv7BLCCCGdBS78EwVtLUfDkOl9M5a8Mk=" ], "description": null, "jump_proxy": null } ], "status": "up", "terminated_at": null, "userdata": null, "console_url": null, "machine_id": null, "failure_reason": null, "infra_id": "ch-geneva-bi-vm1", "machine_name": null } ] 2026-04-20 00:31:35.073360 CEST - Error in test step 'Validate resources': The resource has a private IPv4 address, but it is NOT a private address: 5.53.108.38 2026-04-20 00:31:35.073388 CEST - Check if resources are registered in experiment 2026-04-20 00:31:35.073514 CEST - Run: slices experiment list-resources --format json tst-97e23f3d 2026-04-20 00:31:35.739966 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/d9c4fd17-595f-4c6d-a514-2afb48c9725c/step_Checkexperimentprint-resources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-97e23f3d 2026-04-20 00:31:35.740047 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/d9c4fd17-595f-4c6d-a514-2afb48c9725c/experiment-list-resources.txt': /opt/slices-monitor-worker/slices-cli-venv/lib/python3.14/site-packages/authlib/_joserfc_helpers.py:8: AuthlibDeprecationWarning: authlib.jose module is deprecated, please use joserfc instead. It will be compatible before version 2.0.0. from authlib.jose import ECKey [ { "id": "r_ch-geneva-bi-vm1_01kpkxt8ztfv1v10taccqzq19r", "created_at": "2026-04-19T22:29:40.978213Z", "created_by": "user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g", "experiment_id": "exp_expauth.ilabt.imec.be_01kpkxt87kfekv4tzv3g73p8ty", "friendly_name": "tst", "project_id": "proj_account.ilabt.imec.be_5pzabws7n79ydsagfg3vntg590", "service_id": "bi", "infra_id": "ch-geneva-bi-vm1", "status": "up", "type": "vm", "description": "Minimal VM", "expires_at": "2026-04-20T00:29:00Z", "terminated_at": null, "terminated_by": null } ] 2026-04-20 00:31:35.740074 CEST - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned invalid json 2026-04-20 00:31:35.740157 CEST - Testing extend expires_at (all resources in experiment) 2026-04-20 00:31:35.740256 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-97e23f3d 2026-04-20 00:32:39.087435 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-97e23f3d tst 2026-04-20 00:32:39.752473 CEST - Testing extend expires_at (single resource in experiment) 2026-04-20 00:32:39.752653 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-97e23f3d 2026-04-20 00:33:28.369911 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-97e23f3d tst 2026-04-20 00:33:29.085370 CEST - Step 'Check extend expire' took 113.35 seconds, which is longer than the warning threshold of 40 seconds 2026-04-20 00:33:29.085437 CEST - Testing ssh login 2026-04-20 00:33:29.095174 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-97e23f3d tst 2026-04-20 00:33:29.810716 CEST - Error in test step 'Require Jump Proxy': No proxy in ComputeResource SSH info. 2026-04-20 00:33:29.810870 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-97e23f3d tst 2026-04-20 00:33:30.526066 CEST - Logging in using 'slices bi ssh' 2026-04-20 00:33:30.526125 CEST - Forcing IPv4 only. 2026-04-20 00:33:30.526259 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-97e23f3d tst -- -4 uname -a 2026-04-20 00:33:32.995420 CEST - Forcing IPv4 only. 2026-04-20 00:33:32.995583 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-97e23f3d tst -- -4 uptime 2026-04-20 00:33:34.061404 CEST - CLI SSH Test passed. 2026-04-20 00:33:34.061458 CEST - 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-04-20 00:33:34.061472 CEST - Uptime: 22:33:34 up 2 min, 2 users, load average: 0.22, 0.34, 0.15 2026-04-20 00:33:34.061501 CEST - Logging in using SSH (no SSH proxy in Resource) 2026-04-20 00:33:34.061916 CEST - Added paramiko HostKeyEntry for 5.53.108.38 2026-04-20 00:33:34.062015 CEST - Added paramiko HostKeyEntry for 5.53.108.38 2026-04-20 00:33:34.062150 CEST - Added paramiko HostKeyEntry for 5.53.108.38 2026-04-20 00:33:34.062298 CEST - Connecting to 5.53.108.38:22 2026-04-20 00:33:34.611072 CEST - SSH Test output: 2026-04-20 00:33:34.611119 CEST - 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-04-20 00:33:34.611132 CEST - Uptime: 22:33:34 up 2 min, 1 user, load average: 0.22, 0.34, 0.15 2026-04-20 00:33:34.707825 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-20 00:33:34.707876 CEST - lsb_release matches expected value 2026-04-20 00:33:34.707888 CEST - SSH Test passed. 2026-04-20 00:33:34.707957 CEST - Skip SSH proxy test because no jump proxy 2026-04-20 00:33:34.714170 CEST - Destroying tst-97e23f3d tst 2026-04-20 00:33:34.714324 CEST - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-97e23f3d tst