Run Test: slices-bi-singlenode-login 2026-06-23 17:33:47.876686 CEST - Run: /usr/local/bin/uv pip compile --upgrade /tmp/tmp6lnp5by5.package_name --index=https://doc.slices-ri.eu/pypi/ 2026-06-23 17:33:52.150712 CEST - Run: /usr/local/bin/uv pip sync /opt/slices-monitor-worker/slices_monitor_tests/b2a1c66f-dcdb-4286-a909-20454fdab188/pip_compile_update_slices-cli.txt --index=https://doc.slices-ri.eu/pypi/ 2026-06-23 17:34:00.139538 CEST - Run: slices --version 2026-06-23 17:34:00.354081 CEST - 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-06-23 17:34:00.354399 CEST - Run: slices pubkey list --format text 2026-06-23 17:34:00.919499 CEST - Pubkey already registered 2026-06-23 17:34:00.919767 CEST - Run: slices bi infrastructure list --format csv --all --refresh 2026-06-23 17:34:01.484995 CEST - Refreshed infrastructure list. Total: 24 entries. 2026-06-23 17:34:01.485135 CEST - Check List Flavors 2026-06-23 17:34:01.485296 CEST - Run: slices bi --infra de-munich-bi-vm flavor list -f json 2026-06-23 17:34:02.551676 CEST - Check List DiskImages 2026-06-23 17:34:02.551870 CEST - Run: slices bi --infra de-munich-bi-vm diskimage list -f json 2026-06-23 17:34:03.217525 CEST - Requesting resources 2026-06-23 17:34:03.217856 CEST - Cloudinit user data: #!/bin/sh echo "Hello World. The time is now $(date -R)!" | tee '/user_data_output.txt' 2026-06-23 17:34:03.217966 CEST - Run: slices bi --infra de-munich-bi-vm create tst --image 'Ubuntu 24.04.3' --flavor tiny --duration 2h --experiment tst-c3c470bb --user-data /tmp/tmpg9dpr4cx 2026-06-23 17:34:45.488425 CEST - Resource ID: r_de-munich-bi-vm_01kvthw0qjf419r97vvvjj3qvx 2026-06-23 17:34:45.488588 CEST - Step 'Requesting resource' took 42.27 seconds, which is longer than the warning threshold of 30 seconds 2026-06-23 17:34:45.488624 CEST - Waiting until resource ready 2026-06-23 17:34:47.489046 CEST - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-c3c470bb tst 2026-06-23 17:34:48.254962 CEST - Status: IMAGING 2026-06-23 17:34:50.972441 CEST - Status: IMAGING 2026-06-23 17:34:53.789048 CEST - Status: IMAGING 2026-06-23 17:34:56.555101 CEST - Status: IMAGING 2026-06-23 17:34:59.271036 CEST - Status: IMAGING 2026-06-23 17:35:02.040646 CEST - Status: IMAGING 2026-06-23 17:35:04.806804 CEST - Status: IMAGING 2026-06-23 17:35:07.573040 CEST - Status: IMAGING 2026-06-23 17:35:10.339196 CEST - Status: IMAGING 2026-06-23 17:35:13.105887 CEST - Status: IMAGING 2026-06-23 17:35:15.878639 CEST - Status: IMAGING 2026-06-23 17:35:18.652437 CEST - Status: IMAGING 2026-06-23 17:35:21.420222 CEST - Status: IMAGING 2026-06-23 17:35:24.186300 CEST - Status: IMAGING 2026-06-23 17:35:26.952172 CEST - Status: IMAGING 2026-06-23 17:35:29.718306 CEST - Status: IMAGING 2026-06-23 17:35:32.485115 CEST - Status: BOOTING 2026-06-23 17:35:35.201087 CEST - Status: BOOTING 2026-06-23 17:35:37.967058 CEST - Status: BOOTING 2026-06-23 17:35:40.682999 CEST - Status: BOOTING 2026-06-23 17:35:43.449155 CEST - Status: BOOTING 2026-06-23 17:35:46.215254 CEST - Status: BOOTING 2026-06-23 17:35:48.931306 CEST - Status: BOOTING 2026-06-23 17:35:51.697549 CEST - Status: UP 2026-06-23 17:35:51.697628 CEST - Experiment ID: exp_expauth.ilabt.imec.be_01kvthvzvxfpta3bssqf2j612q 2026-06-23 17:35:51.697690 CEST - Validate resources 2026-06-23 17:35:52.414070 CEST - The fields of the created resource were validated. 2026-06-23 17:35:52.414162 CEST - Check if resources are registered in experiment 2026-06-23 17:35:52.414309 CEST - Run: slices experiment list-resources --format json tst-c3c470bb 2026-06-23 17:35:53.029626 CEST - Status (on expauth): UP 2026-06-23 17:35:53.029776 CEST - Testing extend expires_at (all resources in experiment) 2026-06-23 17:35:53.029929 CEST - Run: slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-c3c470bb 2026-06-23 17:36:34.996028 CEST - Run: slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-c3c470bb tst 2026-06-23 17:36:35.762005 CEST - Run: slices experiment list-resources --format json tst-c3c470bb 2026-06-23 17:36:36.377502 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:38.993248 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:41.608969 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:44.224955 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:46.840816 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:49.456620 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:52.072313 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:54.688073 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:57.303833 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:36:59.919558 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:02.536001 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:05.202031 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:07.817811 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:10.483942 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:13.099650 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:15.715425 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:18.331133 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:20.946981 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:23.612944 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:26.228785 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:28.844432 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:31.460227 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:34.076116 CEST - expires_at (on expauth): 2026-06-23T17:34:00Z (not yet extended) 2026-06-23 17:37:36.076399 CEST - Test Failure: After 60.31449 seconds, "slices experiment list-resources" still returned a resource with expires_at not extended: 2026-06-23 17:34:00+00:00 2026-06-23 17:37:36.078108 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/b2a1c66f-dcdb-4286-a909-20454fdab188/step_Checkextendexpire_command_1.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm extend --duration 3h --experiment tst-c3c470bb 2026-06-23 17:37:36.078268 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/b2a1c66f-dcdb-4286-a909-20454fdab188/experiment-extend-all.txt': Extending Experiment container from 2026-06-23 19:34 CEST to 2026-06-23 20:35 CEST... Extending the resources only on infrastructure de-munich-bi-vm. Use slices bi experiment list-resources to verify other infrastructures. 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems 90.0% / informing subsystems 90.0% - informing subsystems 90.0% \ informing subsystems 90.0% | informing subsystems ♻ Resources on infrastructure de-munich-bi-vm now expire on 2026-06-23 20:35 CEST. Overview of extended resources in experiment tst-c3c470bb ┏━━━━━━━━━━━━━━━┳━━━━━━━━━━━━━━━━━┳━━━━━━┳━━━━━━━━┳━━━━━━━━━━━━━┳━━━━━━━━━━━━━━━━━━━━━━━┳━━━━━━━━━━━━━━━━━━━━━━━┓ ┃ Friendly Name ┃ Infra ┃ Type ┃ Status ┃ Description ┃ Created At ┃ Expires At ┃ ┡━━━━━━━━━━━━━━━╇━━━━━━━━━━━━━━━━━╇━━━━━━╇━━━━━━━━╇━━━━━━━━━━━━━╇━━━━━━━━━━━━━━━━━━━━━━━╇━━━━━━━━━━━━━━━━━━━━━━━┩ │ tst │ de-munich-bi-vm │ vm │ up │ Minimal VM │ 2026-06-23 17:34 CEST │ 2026-06-23 19:34 CEST │ └───────────────┴─────────────────┴──────┴────────┴─────────────┴───────────────────────┴───────────────────────┘ 2026-06-23 17:37:36.078373 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/b2a1c66f-dcdb-4286-a909-20454fdab188/step_Checkextendexpire_command_2.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices bi --infra de-munich-bi-vm list-resources --format json --experiment tst-c3c470bb tst 2026-06-23 17:37:36.078435 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/b2a1c66f-dcdb-4286-a909-20454fdab188/list-bi-resources-after-extend_json.txt': [ { "cluster_id": "default", "created_at": "2026-06-23T15:34:05.288321Z", "disk_image_id": "image_de-munich-bi-vm_01kjceghcff5gbwgxyt40nkj7a", "experiment_id": "exp_expauth.ilabt.imec.be_01kvthvzvxfpta3bssqf2j612q", "expires_at": "2026-06-23T18:35:00Z", "flavor_id": "flavor_de-munich-bi-vm_01kjceghd0fh1vh08ygdp4hrn9", "friendly_name": "tst", "id": "r_de-munich-bi-vm_01kvthw0qjf419r97vvvjj3qvx", "network_interfaces": [], "private_ipv4": "172.30.255.13", "private_ipv6": null, "public_ipv4": null, "public_ipv6": null, "ssh_authorized_keys": [ "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINNiZPtQkfCEsc1x2QSwNWekfhWwWZbOvpE8hE0dH253 Wim (ftester) Van de Meerssche" ], "ssh_logins": [ { "host": "172.30.255.13", "port": 22, "username": "ftester", "host_keys": [ "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCsBNsbDPdAqiYKqMWmj4eFMljYAf9a2zx2SvDMG2F0NZlI8yXgYrYPBMahTykHB0ng/b9yI0/EGXnsE2yXBh+KIzN74RjHadOhebGFbv/myBawVI9QFV21Godkn2zeXLlf0LT6D7Jqr2npEIISMhwZr1PmbYluxoV/EX0BG7OFtMl+HpzwQKWg5Opcsj6hiGzkRT3BxSK356UNrAxQRWql18sfPPoxJ6hCy0+y/dgk2deNLV4+yXRmOQNI6w8GjBb2JwrufMPCGoIuKk6R2byJn15pJxZc8bZttShaQ48BWP02KtVJz0hiO23TPd5lgfoB9Mu9WnFj7rBaycm0lz8ooQI43kBEaFGPV6Noj3/KQaxRtrIpG8GpmwpLnqr441BtQRLBcmOIoWolxsuT7ZC8b2gwo414eM2UY8bpydib4i/aDwbxxAQGn6cxO/ZZtL6I7HzTOeyCErESiKvau908ad4OajNMqdbIF1X2Yhdlgw+4q4UazbuxAueynSwOaqU=", "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBEEeKUxSosowPEVo7fbZaVABtKXlEF7Fpht6RTpj4RLkEHyIzgHuNLaGSy2CflxnSaLs3+EHUQobdQJDxe1ouVA=", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIELGPGulYv3GP6FMQbtFMROL2k/RnmwtlrBsXYQ3eRV4" ], "description": "login for the VM through the JumpHost", "jump_proxy": { "host": "tripwire.net.in.tum.de", "port": 10022, "username": "proxy", "host_keys": [ "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDG0Lq9tQhNNac9cAakdBSPzZ4/jYgRWIJ+0liG9c+c59LJltwOwnPYdOWvLv5HsN391E/fUXojP61vipOrMyuIipiEhOLhjAzP5b5R1WW3xWXWn+BWoXfBocPqPk2V/86aruTACox5CN4etwHWtuxkREyHfteVUhbcFHzNm0qYBQnLXDQxkuZOFbVTnYqRXh3pX0PuncJmwBB4IGE15JKs+A3WBFp1vz1Q2UvtH34rY8rmfKW80fFlzqnJqQun8gAHDfIl0Qa3QTxnecaocLolds5NGwHY7QRzW3yA7FirauZEaMho9Mbm9TRNNlEIR043amlrlukbMRLf/KqoyHJH7NZDXSwkcLrjOn5QsuliCbGbhrYlWux/y61719QKyn2XnuDpuOx1eM/7Kk+oHZhgPK6WgdMWmCBU3LaGfzjaCLMvED4lfBgT1nALTsE3KE2cvzbntlb/fHydevrKMmNrc1Em7WXYtGBjXuVs1G/fYAX9IrE8q6jXrSwO9FSZaZU=", "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBCKHIhTPdwDCtXQPH2/CR3MUzZUl3W6WNCrEBxka53WgjdfFtLko21enKbGYxI+POwDdE5sE6eIvjKDsZtFeA2Q=", "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIA8fyPxzW+ozU5ooygHANHFMVUA2xwnFU1TA5eoF3Xef" ], "description": "login for the JumpHost", "jump_proxy": null } } ], "status": "up", "terminated_at": null, "userdata": "#!/bin/sh\necho \"Hello World. The time is now $(date -R)!\" | tee '/user_data_output.txt'", "console_url": null, "machine_id": null, "failure_reason": null, "infra_id": "de-munich-bi-vm", "machine_name": null } ] 2026-06-23 17:37:36.078475 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/b2a1c66f-dcdb-4286-a909-20454fdab188/step_Checkextendexpire_command_3.txt': /opt/slices-monitor-worker/slices-cli-venv/bin/slices experiment list-resources --format json tst-c3c470bb 2026-06-23 17:37:36.078510 CEST - Content of log file '/opt/slices-monitor-worker/slices_monitor_tests/b2a1c66f-dcdb-4286-a909-20454fdab188/experiment-list-resources-after-extend.txt': [ { "id": "r_de-munich-bi-vm_01kvthw0qjf419r97vvvjj3qvx", "created_at": "2026-06-23T15:34:05.288321Z", "created_by": "user_account.ilabt.imec.be_1c3x2sxhmv8dqtmkxh9392sa0g", "experiment_id": "exp_expauth.ilabt.imec.be_01kvthvzvxfpta3bssqf2j612q", "friendly_name": "tst", "project_id": "proj_account.ilabt.imec.be_5pzabws7n79ydsagfg3vntg590", "service_id": "bi", "infra_id": "de-munich-bi-vm", "status": "up", "type": "vm", "description": "Minimal VM", "expires_at": "2026-06-23T17:34:00Z", "terminated_at": null, "terminated_by": null } ] 2026-06-23 17:37:36.078529 CEST - Error in test step 'Check extend expire': "slices experiment list-resources" returned resource with expires_at not extended: 2026-06-23 17:34:00+00:00 2026-06-23 17:37:36.078561 CEST - Step 'Check extend expire' took 103.05 seconds, which is longer than the warning threshold of 40 seconds 2026-06-23 17:37:36.078585 CEST - Testing ssh login 2026-06-23 17:37:36.088601 CEST - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show ssh_config --experiment tst-c3c470bb tst 2026-06-23 17:37:36.954590 CEST - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show server_pubkey_openssh --experiment tst-c3c470bb tst 2026-06-23 17:37:37.821491 CEST - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy off --show proxy_pubkey_openssh --experiment tst-c3c470bb tst 2026-06-23 17:37:38.687435 CEST - Logging in using 'slices bi ssh' 2026-06-23 17:37:38.687532 CEST - Forcing IPv4 only. 2026-06-23 17:37:38.687696 CEST - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-c3c470bb tst -- -4 uname -a 2026-06-23 17:37:41.558164 CEST - Forcing IPv4 only. 2026-06-23 17:37:41.558356 CEST - Run: slices bi --infra de-munich-bi-vm ssh --show nothing --experiment tst-c3c470bb tst -- -4 uptime 2026-06-23 17:37:43.226211 CEST - CLI SSH Test passed. 2026-06-23 17:37:43.226289 CEST - 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-06-23 17:37:43.226306 CEST - Uptime: 15:37:43 up 2 min, 1 user, load average: 0.10, 0.10, 0.04 2026-06-23 17:37:43.226352 CEST - Logging in using SSH over SSH proxy 2026-06-23 17:37:43.226497 CEST - Run: slices bi --infra de-munich-bi-vm ssh --no-exec --proxy on --show proxy_pubkey_openssh --experiment tst-c3c470bb tst 2026-06-23 17:37:44.193460 CEST - Added paramiko HostKeyEntry for 172.30.255.13 2026-06-23 17:37:44.193683 CEST - Added paramiko HostKeyEntry for 172.30.255.13 2026-06-23 17:37:44.193752 CEST - Added paramiko HostKeyEntry for 172.30.255.13 2026-06-23 17:37:44.194043 CEST - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-06-23 17:37:44.194141 CEST - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-06-23 17:37:44.194185 CEST - Added paramiko HostKeyEntry for [tripwire.net.in.tum.de]:10022 2026-06-23 17:37:44.194200 CEST - Connecting to proxy tripwire.net.in.tum.de:10022 2026-06-23 17:37:44.615748 CEST - Connecting to 172.30.255.13:22 over proxy 2026-06-23 17:37:45.360616 CEST - SSH Test output: 2026-06-23 17:37:45.360692 CEST - 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-06-23 17:37:45.360740 CEST - Uptime: 15:37:45 up 2 min, 1 user, load average: 0.10, 0.10, 0.04 2026-06-23 17:37:45.510884 CEST - lsb_release: Ubuntu 24.04.3 LTS 2026-06-23 17:37:45.510962 CEST - lsb_release matches expected value 2026-06-23 17:37:45.510982 CEST - SSH Test passed. 2026-06-23 17:37:45.661954 CEST - Cloud-init user-data: Hello World. The time is now Tue, 23 Jun 2026 15:35:48 +0000! 2026-06-23 17:37:45.668387 CEST - Destroying tst-c3c470bb tst 2026-06-23 17:37:45.668584 CEST - Run: slices bi --infra de-munich-bi-vm destroy --experiment tst-c3c470bb tst 2026-06-23 17:38:29.285591 CEST - Step 'Destroy' took 43.62 seconds, which is longer than the warning threshold of 15 seconds