Run Test: slices-bi-singlenode-login 2026-04-18 17:28:54.373134 CEST - Run: /usr/local/bin/uv pip install --upgrade slices-cli --extra-index-url=https://doc.slices-ri.eu/pypi/ 2026-04-18 17:28:57.593979 CEST - Run: slices --version 2026-04-18 17:28:57.808201 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-18 17:28:57.808455 CEST - Run: slices pubkey list --format text 2026-04-18 17:28:58.473621 CEST - Pubkey already registered 2026-04-18 17:28:58.473855 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-04-18 17:28:59.039047 CEST - Refreshed infrastructure list. Total: 22 entries. 2026-04-18 17:28:59.039209 CEST - Check List Flavors 2026-04-18 17:28:59.039415 CEST - Run: slices bi --infra ch-geneva-bi-vm1 flavor list -f json 2026-04-18 17:29:01.458813 CEST - Check List DiskImages 2026-04-18 17:29:01.459030 CEST - Run: slices bi --infra ch-geneva-bi-vm1 diskimage list -f json 2026-04-18 17:29:02.074220 CEST - Requesting resources 2026-04-18 17:29:02.074670 CEST - Run: slices bi --infra ch-geneva-bi-vm1 create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-a882639a 2026-04-18 17:29:03.942303 CEST - Resource ID: r_ch-geneva-bi-vm1_01kpgkbc8kea1sqeekdj6r5r78 2026-04-18 17:29:03.942423 CEST - Waiting until resource ready 2026-04-18 17:29:05.942811 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-a882639a tst 2026-04-18 17:29:06.608096 CEST - Status: IMAGING 2026-04-18 17:29:09.273732 CEST - Status: IMAGING 2026-04-18 17:29:11.989431 CEST - Status: IMAGING 2026-04-18 17:29:14.654977 CEST - Status: IMAGING 2026-04-18 17:29:17.370827 CEST - Status: IMAGING 2026-04-18 17:29:20.036444 CEST - Status: IMAGING 2026-04-18 17:29:22.701885 CEST - Status: IMAGING 2026-04-18 17:29:25.367363 CEST - Status: IMAGING 2026-04-18 17:29:28.032979 CEST - Status: IMAGING 2026-04-18 17:29:30.748532 CEST - Status: IMAGING 2026-04-18 17:29:33.414195 CEST - Status: IMAGING 2026-04-18 17:29:36.079807 CEST - Status: IMAGING 2026-04-18 17:29:38.745330 CEST - Status: IMAGING 2026-04-18 17:29:41.461203 CEST - Status: IMAGING 2026-04-18 17:29:44.226958 CEST - Status: IMAGING 2026-04-18 17:29:46.892641 CEST - Status: IMAGING 2026-04-18 17:29:49.558208 CEST - Status: IMAGING 2026-04-18 17:29:52.273999 CEST - Status: IMAGING 2026-04-18 17:29:54.940043 CEST - Status: IMAGING 2026-04-18 17:29:57.606218 CEST - Status: IMAGING 2026-04-18 17:30:00.322096 CEST - Status: IMAGING 2026-04-18 17:30:03.038027 CEST - Status: IMAGING 2026-04-18 17:30:05.804249 CEST - Status: IMAGING 2026-04-18 17:30:08.570689 CEST - Status: IMAGING 2026-04-18 17:30:11.337128 CEST - Status: IMAGING 2026-04-18 17:30:14.053074 CEST - Status: IMAGING 2026-04-18 17:30:16.768794 CEST - Status: IMAGING 2026-04-18 17:30:19.484569 CEST - Status: IMAGING 2026-04-18 17:30:22.150236 CEST - Status: IMAGING 2026-04-18 17:30:24.865872 CEST - Status: IMAGING 2026-04-18 17:30:27.581676 CEST - Status: IMAGING 2026-04-18 17:30:30.297484 CEST - Status: IMAGING 2026-04-18 17:30:33.013337 CEST - Status: IMAGING 2026-04-18 17:30:35.678990 CEST - Status: IMAGING 2026-04-18 17:30:38.344553 CEST - Status: IMAGING 2026-04-18 17:30:41.010125 CEST - Status: IMAGING 2026-04-18 17:30:43.726037 CEST - Status: IMAGING 2026-04-18 17:30:46.391569 CEST - Status: IMAGING 2026-04-18 17:30:49.057246 CEST - Status: IMAGING 2026-04-18 17:30:51.772843 CEST - Status: IMAGING 2026-04-18 17:30:54.488628 CEST - Status: IMAGING 2026-04-18 17:30:57.154337 CEST - Status: UP 2026-04-18 17:30:57.154394 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kpgkbbgme208wxzapqs5wcxb 2026-04-18 17:30:57.154449 CEST - Validate resources 2026-04-18 17:30:57.821064 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2cd178e8-c0d6-474e-9afa-e0d8742e93d6/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-a882639a tst 2026-04-18 17:30:57.821158 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2cd178e8-c0d6-474e-9afa-e0d8742e93d6/list-resources_json.txt': [ { "cluster_id": "default", "created_at": "2026-04-18T15:29:03.749071Z", "disk_image_id": "image_ch-geneva-bi-vm1_20kfy65vcb9xabdgfszftvdjk6", "experiment_id": "exp_expauth.ilabt.imec.be_01kpgkbbgme208wxzapqs5wcxb", "expires_at": "2026-04-18T17:29:00Z", "flavor_id": "flavor_ch-geneva-bi-vm1_3rm28rdxe1947bbxqxb7e8xgc5", "friendly_name": "tst", "id": "r_ch-geneva-bi-vm1_01kpgkbc8kea1sqeekdj6r5r78", "network_interfaces": [], "private_ipv4": "5.53.108.128", "private_ipv6": null, "public_ipv4": "5.53.108.128", "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [ { "host": "5.53.108.128", "port": 22, "username": "ubuntu", "host_keys": [ "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBOWpwDfMjmKq6XVlFgqPXhjpcc7RWlV2jnGcPjtxA1/DiskW56uzfmGeo4GqJmMe4wVGrkDPa1fiwhDqs8O/G78=", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIB17TaTrunHMz/h4Oo9dZZTJUIPxf3wuU+Fddwh/tyt5", "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDUF2XKBEx4sqm4gOtxlbHiuJsv89A6P74ZDlwZP+6Rm1NQfv+TKoZuysHIurZ5yNO2Q0AeeXBM4gKUysjIBXQ+5DcpRPhJfJaCwLUII8vRg/J0A8Bfa1hHflGxTZ6rrIC1+xoqelABsOBCJywxW8yWOanujOMW3xU/nRR+YJ3YLRLTmCgXP15uyxf4eeepv3RmR5hl69drfb0Jy+E8OcW86VyJGlxW3cmqrx56FyZi/6Hd5Dul3w/USsQ+dFHQig1Jq+aD8K48OokNGsrKx6A3AJPDbHOJsd2gvWsWoXHmFlM3L8QphJu1dboPVCv+/hc14u5dxSyPCRggaEAp5n55VC8xmZCFFnEynTNapdjiuNSmlk4DdoD36oDsmdRQrKcDFuFpe6PwQG8yIpaubbrx4dLwY/y4XkxfPdKc/l2HxmqpabEe3T5Mgmpf5cZfdxJJlTeH6+XuHLGO9Pi1sK7uqxzdBt7BYBvGrdzEoJFmDvgcVILlhlEPNELkGn5yqyE=" ], "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-18 17:30:57.821181 CEST - Error in test step 'Validate resources': The resource has a private IPv4 address, but it is NOT a private address: 5.53.108.128 2026-04-18 17:30:57.821206 CEST - Check if resources are registered in experiment 2026-04-18 17:30:57.821327 CEST - Run: slices experiment list-resources --format json tst-a882639a 2026-04-18 17:30:58.487845 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2cd178e8-c0d6-474e-9afa-e0d8742e93d6/step_Checkexperimentprint-resources_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-a882639a 2026-04-18 17:30:58.487927 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/2cd178e8-c0d6-474e-9afa-e0d8742e93d6/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_01kpgkbc8kea1sqeekdj6r5r78", "created_at": "2026-04-18T15:29:03.749071Z", "created_by": "user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g", "experiment_id": "exp_expauth.ilabt.imec.be_01kpgkbbgme208wxzapqs5wcxb", "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-18T17:29:00Z", "terminated_at": null, "terminated_by": null } ] 2026-04-18 17:30:58.487955 CEST - Error in test step 'Check experiment print-resources': "slices experiment list-resources" returned invalid json 2026-04-18 17:30:58.488068 CEST - Testing extend expires_at (all resources in experiment) 2026-04-18 17:30:58.488179 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend --duration 3h --experiment tst-a882639a 2026-04-18 17:31:55.428209 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-a882639a tst 2026-04-18 17:31:56.093397 CEST - Testing extend expires_at (single resource in experiment) 2026-04-18 17:31:56.093609 CEST - Run: slices bi --infra ch-geneva-bi-vm1 extend tst --duration 4h --experiment tst-a882639a 2026-04-18 17:32:44.816307 CEST - Run: slices bi --infra ch-geneva-bi-vm1 list-resources --format json --experiment tst-a882639a tst 2026-04-18 17:32:45.581797 CEST - Step 'Check extend expire' took 107.09 seconds, which is longer than the warning threshold of 40 seconds 2026-04-18 17:32:45.581879 CEST - Testing ssh login 2026-04-18 17:32:45.592172 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy on --show ssh_config --experiment tst-a882639a tst 2026-04-18 17:32:46.307933 CEST - Error in test step 'Require Jump Proxy': No proxy in ComputeResource SSH info. 2026-04-18 17:32:46.308121 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-a882639a tst 2026-04-18 17:32:47.073724 CEST - Logging in using 'slices bi ssh' 2026-04-18 17:32:47.073785 CEST - Forcing IPv4 only. 2026-04-18 17:32:47.073907 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-a882639a tst -- -4 uname -a 2026-04-18 17:32:49.544039 CEST - Forcing IPv4 only. 2026-04-18 17:32:49.544203 CEST - Run: slices bi --infra ch-geneva-bi-vm1 ssh --show nothing --experiment tst-a882639a tst -- -4 uptime 2026-04-18 17:32:50.610441 CEST - CLI SSH Test passed. 2026-04-18 17:32:50.610495 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-18 17:32:50.610509 CEST - Uptime: 15:32:50 up 2 min, 2 users, load average: 0.10, 0.17, 0.08 2026-04-18 17:32:50.610538 CEST - Logging in using SSH (no SSH proxy in Resource) 2026-04-18 17:32:50.610950 CEST - Added paramiko HostKeyEntry for 5.53.108.128 2026-04-18 17:32:50.611051 CEST - Added paramiko HostKeyEntry for 5.53.108.128 2026-04-18 17:32:50.611188 CEST - Added paramiko HostKeyEntry for 5.53.108.128 2026-04-18 17:32:50.611344 CEST - Connecting to 5.53.108.128:22 2026-04-18 17:32:51.170678 CEST - SSH Test output: 2026-04-18 17:32:51.170728 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-18 17:32:51.170742 CEST - Uptime: 15:32:51 up 2 min, 1 user, load average: 0.10, 0.17, 0.08 2026-04-18 17:32:51.270912 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-04-18 17:32:51.270968 CEST - lsb_release matches expected value 2026-04-18 17:32:51.270980 CEST - SSH Test passed. 2026-04-18 17:32:51.271054 CEST - Skip SSH proxy test because no jump proxy 2026-04-18 17:32:51.277131 CEST - Destroying tst-a882639a tst 2026-04-18 17:32:51.277281 CEST - Run: slices bi --infra ch-geneva-bi-vm1 destroy --experiment tst-a882639a tst