# Pastebin jzmQ6FeX ironic-python-age…rvice - Ironic Python Agent... [ 104.145770] systemd[1]: Starting ironic-python-agent.service - Ironic Python Agent... Starting nvmf-autoconnect.…stems automatically during boot... [ 104.205661] systemd[1]: Starting nvmf-autoconnect.service - Connect NVMe-oF subsystems automatically during boot... [ 104.219779] systemd[1]: open-iscsi.service - Login to default iSCSI targets was skipped because no trigger condition checks were met. Starting podman-auto-updat…0m - Podman auto-update service... [ 104.297873] systemd[1]: Starting podman-auto-update.service - Podman auto-update service... Starting podman-restart.se…th Restart Policy Set To Always... [ 104.370736] systemd[1]: Starting podman-restart.service - Podman Start All Containers With Restart Policy Set To Always... [ OK ] Started ironic-python-agen…service - Ironic Python Agent. [ 104.785930] systemd[1]: Started ironic-python-agent.service - Ironic Python Agent. [ OK ] Finished nvmf-autoconnect.…systems automatically during boot. [ OK ] Reached target remote-fs-p…eparation for Remote File Systems. [ OK ] Reached target remote-fs.target - Remote File Systems. [ 106.028070] systemd[1]: nvmf-autoconnect.service: Deactivated successfully. [ 106.081523] systemd[1]: Finished nvmf-autoconnect.service - Connect NVMe-oF subsystems automatically during boot. [ OK ] Started cron.service -…kground program processing daemon. [ 106.134680] systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Starting systemd-user-sess…vice - Permit User Sessions... [ 106.167966] systemd[1]: Reached target remote-fs.target - Remote File Systems. [ 106.250190] systemd[1]: Started cron.service - Regular background program processing daemon. [ 106.308868] systemd[1]: systemd-pcrphase.service - TPM2 PCR Barrier (User) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). [ 106.319918] systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... [ 106.577142] cron[553]: (CRON) INFO (pidfile fd = 3) [ 106.764583] cron[553]: (CRON) INFO (Running @reboot jobs) [ OK ] Finished systemd-user-sess…ervice - Permit User Sessions. [ 106.955530] systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. [ OK ] Started getty@tty1.service - Getty on tty1. [ 107.035896] systemd[1]: Started getty@tty1.service - Getty on tty1. [ 107.089269] systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. [ OK ] Started serial-getty@ttyS0…rvice - Serial Getty on ttyS0. [ OK ] Reached target getty.target - Login Prompts. [ 107.102513] systemd[1]: Reached target getty.target - Login Prompts. [ OK ] Reached target multi-user.target - Multi-User System. [ 107.117786] systemd[1]: Reached target multi-user.target - Multi-User System. [ 107.367261] podman[533]: time="2025-02-24T17:19:04Z" level=info msg="/usr/bin/podman filtering at log level info" [ 107.973498] podman[533]: time="2025-02-24T17:19:04Z" level=info msg="[graphdriver] using prior storage driver: overlay" [ 108.186343] podman[533]: time="2025-02-24T17:19:05Z" level=info msg="Setting parallel job count to 4" [ 108.375095] systemd[1]: var-lib-containers-storage-overlay.mount: Deactivated successfully. [ OK ] Finished podman-restart.se…With Restart Policy Set To Always. [ 108.449482] systemd[1]: Finished podman-restart.service - Podman Start All Containers With Restart Policy Set To Always. [ 109.991725] systemd[1]: var-lib-containers-storage-overlay.mount: Deactivated successfully. [ 110.053291] systemd[1]: podman-auto-update.service: Deactivated successfully. [ OK ] Finished podman-auto-updat… - Podman auto-update service. [ 110.064875] systemd[1]: Finished podman-auto-update.service - Podman auto-update service. [ 110.081589] systemd[1]: podman-auto-update.service: Consumed 1.504s CPU time. [ OK ] Reached target graphical.target - Graphical Interface. [ 110.099956] systemd[1]: Reached target graphical.target - Graphical Interface. Starting systemd-update-ut… Record Runlevel Change in UTMP... [ 110.161714] systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... [ 110.562049] systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. [ OK ] Finished systemd-update-ut… - Record Runlevel Change in UTMP. [ 110.573737] systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. [ 110.594951] systemd[1]: Startup finished in 44.024s (kernel) + 1min 6.553s (userspace) = 1min 50.577s. Debian GNU/Linux 12 debian ttyS0 debian login: [ 120.491235] systemd[1]: systemd-hostnamed.service: Deactivated successfully. [ 144.462415] ironic-python-agent[534]: ironic-python-agent: Did not identify any virtual media candidates devices. [ 144.469581] ironic-python-agent[534]: ironic-python-agent: No virtual media device detected [ 144.605295] ironic-python-agent[534]: 2025-02-24 17:19:41.423 534 DEBUG ironic_python_agent.cmd.agent [-] Configuration: run /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/cmd/agent.py:47 [ 144.611188] ironic-python-agent[534]: 2025-02-24 17:19:41.436 534 DEBUG ironic_python_agent.cmd.agent [-] ******************************************************************************** log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2804 [ 144.616084] ironic-python-agent[534]: 2025-02-24 17:19:41.442 534 DEBUG ironic_python_agent.cmd.agent [-] Configuration options gathered from: log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2805 [ 144.625642] ironic-python-agent[534]: 2025-02-24 17:19:41.447 534 DEBUG ironic_python_agent.cmd.agent [-] command line args: ['--config-dir', '/etc/ironic-python-agent.d/'] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2806 [ 144.631524] ironic-python-agent[534]: 2025-02-24 17:19:41.458 534 DEBUG ironic_python_agent.cmd.agent [-] config files: [] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2807 [ 144.636722] ironic-python-agent[534]: 2025-02-24 17:19:41.462 534 DEBUG ironic_python_agent.cmd.agent [-] ================================================================================ log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2809 [ 144.642833] ironic-python-agent[534]: 2025-02-24 17:19:41.469 534 DEBUG ironic_python_agent.cmd.agent [-] advertise_host = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.650539] ironic-python-agent[534]: 2025-02-24 17:19:41.475 534 DEBUG ironic_python_agent.cmd.agent [-] advertise_port = 9999 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.656822] ironic-python-agent[534]: 2025-02-24 17:19:41.482 534 DEBUG ironic_python_agent.cmd.agent [-] advertise_protocol = http log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.662646] ironic-python-agent[534]: 2025-02-24 17:19:41.488 534 DEBUG ironic_python_agent.cmd.agent [-] agent_token = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.668053] ironic-python-agent[534]: 2025-02-24 17:19:41.494 534 DEBUG ironic_python_agent.cmd.agent [-] agent_token_required = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.674258] ironic-python-agent[534]: 2025-02-24 17:19:41.499 534 DEBUG ironic_python_agent.cmd.agent [-] api_url = http://172.31.85.49/baremetal log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.679757] ironic-python-agent[534]: 2025-02-24 17:19:41.505 534 DEBUG ironic_python_agent.cmd.agent [-] auto_tls_allowed_clock_skew = 3600 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.685097] ironic-python-agent[534]: 2025-02-24 17:19:41.511 534 DEBUG ironic_python_agent.cmd.agent [-] cafile = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.698426] ironic-python-agent[534]: 2025-02-24 17:19:41.523 534 DEBUG ironic_python_agent.cmd.agent [-] certfile = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.704821] ironic-python-agent[534]: 2025-02-24 17:19:41.530 534 DEBUG ironic_python_agent.cmd.agent [-] collect_lldp = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.710825] ironic-python-agent[534]: 2025-02-24 17:19:41.537 534 DEBUG ironic_python_agent.cmd.agent [-] config_dir = ['/etc/ironic-python-agent.d/'] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.716053] ironic-python-agent[534]: 2025-02-24 17:19:41.542 534 DEBUG ironic_python_agent.cmd.agent [-] config_drive_rebuild = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.721621] ironic-python-agent[534]: 2025-02-24 17:19:41.547 534 DEBUG ironic_python_agent.cmd.agent [-] config_file = [] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.727237] ironic-python-agent[534]: 2025-02-24 17:19:41.552 534 DEBUG ironic_python_agent.cmd.agent [-] config_source = [] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.732226] ironic-python-agent[534]: 2025-02-24 17:19:41.558 534 DEBUG ironic_python_agent.cmd.agent [-] debug = True log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.739334] ironic-python-agent[534]: 2025-02-24 17:19:41.564 534 DEBUG ironic_python_agent.cmd.agent [-] default_log_levels = ['amqp=WARN', 'amqplib=WARN', 'boto=WARN', 'qpid=WARN', 'sqlalchemy=WARN', 'suds=INFO', 'oslo.messaging=INFO', 'oslo_messaging=INFO', 'iso8601=WARN', 'requests.packages.urllib3.connectionpool=WARN', 'urllib3.connectionpool=WARN', 'websocket=WARN', 'requests.packages.urllib3.util.retry=WARN', 'urllib3.util.retry=WARN', 'keystonemiddleware=WARN', 'routes.middleware=WARN', 'stevedore=WARN', 'taskflow=WARN', 'keystoneauth=WARN', 'oslo.cache=INFO', 'oslo_policy=INFO', 'dogpile.core.dogpile=INFO'] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.777726] ironic-python-agent[534]: 2025-02-24 17:19:41.572 534 DEBUG ironic_python_agent.cmd.agent [-] disable_bootc_deploy = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.779655] ironic-python-agent[534]: 2025-02-24 17:19:41.579 534 DEBUG ironic_python_agent.cmd.agent [-] disable_deep_image_inspection = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.785260] ironic-python-agent[534]: 2025-02-24 17:19:41.585 534 DEBUG ironic_python_agent.cmd.agent [-] disk_wait_attempts = 10 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.786438] ironic-python-agent[534]: 2025-02-24 17:19:41.587 534 DEBUG ironic_python_agent.cmd.agent [-] disk_wait_delay = 3 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.794212] ironic-python-agent[534]: 2025-02-24 17:19:41.594 534 DEBUG ironic_python_agent.cmd.agent [-] enable_auto_tls = True log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.795901] ironic-python-agent[534]: 2025-02-24 17:19:41.601 534 DEBUG ironic_python_agent.cmd.agent [-] enable_vlan_interfaces = log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.801138] ironic-python-agent[534]: 2025-02-24 17:19:41.603 534 DEBUG ironic_python_agent.cmd.agent [-] fail_if_clock_not_set = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.803038] ironic-python-agent[534]: 2025-02-24 17:19:41.609 534 DEBUG ironic_python_agent.cmd.agent [-] global_request_id = req-598753f6-3765-4a9d-a68c-d9fc8d9a99b2 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.809520] ironic-python-agent[534]: 2025-02-24 17:19:41.612 534 DEBUG ironic_python_agent.cmd.agent [-] guard_special_filesystems = True log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.811227] ironic-python-agent[534]: 2025-02-24 17:19:41.619 534 DEBUG ironic_python_agent.cmd.agent [-] hardware_initialization_delay = 0 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.817415] ironic-python-agent[534]: 2025-02-24 17:19:41.620 534 DEBUG ironic_python_agent.cmd.agent [-] http_request_timeout = 30 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.819254] ironic-python-agent[534]: 2025-02-24 17:19:41.628 534 DEBUG ironic_python_agent.cmd.agent [-] ignore_bootloader_failure = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.825307] ironic-python-agent[534]: 2025-02-24 17:19:41.635 534 DEBUG ironic_python_agent.cmd.agent [-] image_download_connection_retries = 9 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.826528] ironic-python-agent[534]: 2025-02-24 17:19:41.641 534 DEBUG ironic_python_agent.cmd.agent [-] image_download_connection_retry_interval = 10 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.833585] ironic-python-agent[534]: 2025-02-24 17:19:41.643 534 DEBUG ironic_python_agent.cmd.agent [-] image_download_connection_timeout = 60 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.835648] ironic-python-agent[534]: 2025-02-24 17:19:41.650 534 DEBUG ironic_python_agent.cmd.agent [-] image_server_auth_strategy = noauth log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.842146] ironic-python-agent[534]: 2025-02-24 17:19:41.652 534 DEBUG ironic_python_agent.cmd.agent [-] image_server_password = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.843352] ironic-python-agent[534]: 2025-02-24 17:19:41.659 534 DEBUG ironic_python_agent.cmd.agent [-] image_server_user = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.849111] ironic-python-agent[534]: 2025-02-24 17:19:41.660 534 DEBUG ironic_python_agent.cmd.agent [-] inject_files_priority = 0 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.850500] ironic-python-agent[534]: 2025-02-24 17:19:41.668 534 DEBUG ironic_python_agent.cmd.agent [-] insecure = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.857253] ironic-python-agent[534]: 2025-02-24 17:19:41.676 534 DEBUG ironic_python_agent.cmd.agent [-] inspection_callback_url = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.859096] ironic-python-agent[534]: 2025-02-24 17:19:41.683 534 DEBUG ironic_python_agent.cmd.agent [-] inspection_collectors = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.865160] ironic-python-agent[534]: 2025-02-24 17:19:41.689 534 DEBUG ironic_python_agent.cmd.agent [-] inspection_dhcp_all_interfaces = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.869208] ironic-python-agent[534]: 2025-02-24 17:19:41.692 534 DEBUG ironic_python_agent.cmd.agent [-] inspection_dhcp_wait_timeout = 60 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.874798] ironic-python-agent[534]: 2025-02-24 17:19:41.700 534 DEBUG ironic_python_agent.cmd.agent [-] instance_format = [instance: %(uuid)s] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.880654] ironic-python-agent[534]: 2025-02-24 17:19:41.706 534 DEBUG ironic_python_agent.cmd.agent [-] instance_uuid_format = [instance: %(uuid)s] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.886314] ironic-python-agent[534]: 2025-02-24 17:19:41.711 534 DEBUG ironic_python_agent.cmd.agent [-] introspection_daemon = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.891266] ironic-python-agent[534]: 2025-02-24 17:19:41.717 534 DEBUG ironic_python_agent.cmd.agent [-] introspection_daemon_post_interval = 300 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.897267] ironic-python-agent[534]: 2025-02-24 17:19:41.723 534 DEBUG ironic_python_agent.cmd.agent [-] ip_lookup_attempts = 6 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.902152] ironic-python-agent[534]: 2025-02-24 17:19:41.728 534 DEBUG ironic_python_agent.cmd.agent [-] ip_lookup_sleep = 10 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.907735] ironic-python-agent[534]: 2025-02-24 17:19:41.733 534 DEBUG ironic_python_agent.cmd.agent [-] ironic_api_version = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.912098] ironic-python-agent[534]: 2025-02-24 17:19:41.739 534 DEBUG ironic_python_agent.cmd.agent [-] keyfile = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.917947] ironic-python-agent[534]: 2025-02-24 17:19:41.744 534 DEBUG ironic_python_agent.cmd.agent [-] listen_host = :: log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.923150] ironic-python-agent[534]: 2025-02-24 17:19:41.750 534 DEBUG ironic_python_agent.cmd.agent [-] listen_port = 9999 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.928768] ironic-python-agent[534]: 2025-02-24 17:19:41.755 534 DEBUG ironic_python_agent.cmd.agent [-] listen_tls = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.933825] ironic-python-agent[534]: 2025-02-24 17:19:41.760 534 DEBUG ironic_python_agent.cmd.agent [-] lldp_timeout = 30.0 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.939410] ironic-python-agent[534]: 2025-02-24 17:19:41.766 534 DEBUG ironic_python_agent.cmd.agent [-] log_color = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.944727] ironic-python-agent[534]: 2025-02-24 17:19:41.771 534 DEBUG ironic_python_agent.cmd.agent [-] log_config_append = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.950106] ironic-python-agent[534]: 2025-02-24 17:19:41.777 534 DEBUG ironic_python_agent.cmd.agent [-] log_date_format = %Y-%m-%d %H:%M:%S log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.958172] ironic-python-agent[534]: 2025-02-24 17:19:41.781 534 DEBUG ironic_python_agent.cmd.agent [-] log_dir = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.959526] ironic-python-agent[534]: 2025-02-24 17:19:41.783 534 DEBUG ironic_python_agent.cmd.agent [-] log_file = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.965312] ironic-python-agent[534]: 2025-02-24 17:19:41.790 534 DEBUG ironic_python_agent.cmd.agent [-] log_rotate_interval = 1 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.974726] ironic-python-agent[534]: 2025-02-24 17:19:41.795 534 DEBUG ironic_python_agent.cmd.agent [-] log_rotate_interval_type = days log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.979890] ironic-python-agent[534]: 2025-02-24 17:19:41.806 534 DEBUG ironic_python_agent.cmd.agent [-] log_rotation_type = none log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.985900] ironic-python-agent[534]: 2025-02-24 17:19:41.811 534 DEBUG ironic_python_agent.cmd.agent [-] logging_context_format_string = %(asctime)s.%(msecs)03d %(process)d %(levelname)s %(name)s [%(global_request_id)s %(request_id)s %(user_identity)s] %(instance)s%(message)s log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.991171] ironic-python-agent[534]: 2025-02-24 17:19:41.817 534 DEBUG ironic_python_agent.cmd.agent [-] logging_debug_format_suffix = %(funcName)s %(pathname)s:%(lineno)d log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 144.995894] ironic-python-agent[534]: 2025-02-24 17:19:41.822 534 DEBUG ironic_python_agent.cmd.agent [-] logging_default_format_string = %(asctime)s.%(msecs)03d %(process)d %(levelname)s %(name)s [-] %(instance)s%(message)s log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.001449] ironic-python-agent[534]: 2025-02-24 17:19:41.828 534 DEBUG ironic_python_agent.cmd.agent [-] logging_exception_prefix = %(asctime)s.%(msecs)03d %(process)d ERROR %(name)s %(instance)s log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.007580] ironic-python-agent[534]: 2025-02-24 17:19:41.833 534 DEBUG ironic_python_agent.cmd.agent [-] logging_user_identity_format = %(user)s %(project)s %(domain)s %(system_scope)s %(user_domain)s %(project_domain)s log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.014243] ironic-python-agent[534]: 2025-02-24 17:19:41.838 534 DEBUG ironic_python_agent.cmd.agent [-] lookup_interval = 1 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.020930] ironic-python-agent[534]: 2025-02-24 17:19:41.840 534 DEBUG ironic_python_agent.cmd.agent [-] lookup_timeout = 600 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.022694] ironic-python-agent[534]: 2025-02-24 17:19:41.846 534 DEBUG ironic_python_agent.cmd.agent [-] max_logfile_count = 30 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.025415] ironic-python-agent[534]: 2025-02-24 17:19:41.847 534 DEBUG ironic_python_agent.cmd.agent [-] max_logfile_size_mb = 200 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.031054] ironic-python-agent[534]: 2025-02-24 17:19:41.856 534 DEBUG ironic_python_agent.cmd.agent [-] md5_enabled = True log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.037142] ironic-python-agent[534]: 2025-02-24 17:19:41.862 534 DEBUG ironic_python_agent.cmd.agent [-] network_interface = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.042364] ironic-python-agent[534]: 2025-02-24 17:19:41.868 534 DEBUG ironic_python_agent.cmd.agent [-] ntp_server = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.049478] ironic-python-agent[534]: 2025-02-24 17:19:41.874 534 DEBUG ironic_python_agent.cmd.agent [-] permitted_image_formats = ['raw', 'gpt', 'qcow2'] log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.054617] ironic-python-agent[534]: 2025-02-24 17:19:41.880 534 DEBUG ironic_python_agent.cmd.agent [-] publish_errors = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.061652] ironic-python-agent[534]: 2025-02-24 17:19:41.885 534 DEBUG ironic_python_agent.cmd.agent [-] rate_limit_burst = 0 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.065709] ironic-python-agent[534]: 2025-02-24 17:19:41.891 534 DEBUG ironic_python_agent.cmd.agent [-] rate_limit_except_level = CRITICAL log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.071559] ironic-python-agent[534]: 2025-02-24 17:19:41.897 534 DEBUG ironic_python_agent.cmd.agent [-] rate_limit_interval = 0 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.077404] ironic-python-agent[534]: 2025-02-24 17:19:41.902 534 DEBUG ironic_python_agent.cmd.agent [-] shell_completion = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.083117] ironic-python-agent[534]: 2025-02-24 17:19:41.909 534 DEBUG ironic_python_agent.cmd.agent [-] syslog_log_facility = LOG_USER log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.088889] ironic-python-agent[534]: 2025-02-24 17:19:41.914 534 DEBUG ironic_python_agent.cmd.agent [-] use_journal = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.094088] ironic-python-agent[534]: 2025-02-24 17:19:41.920 534 DEBUG ironic_python_agent.cmd.agent [-] use_json = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.099158] ironic-python-agent[534]: 2025-02-24 17:19:41.926 534 DEBUG ironic_python_agent.cmd.agent [-] use_stderr = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.106371] ironic-python-agent[534]: 2025-02-24 17:19:41.930 534 DEBUG ironic_python_agent.cmd.agent [-] use_syslog = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.112842] ironic-python-agent[534]: 2025-02-24 17:19:41.932 534 DEBUG ironic_python_agent.cmd.agent [-] watch_log_file = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2817 [ 145.115313] ironic-python-agent[534]: 2025-02-24 17:19:41.938 534 DEBUG ironic_python_agent.cmd.agent [-] oslo_concurrency.disable_process_locking = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.121620] ironic-python-agent[534]: 2025-02-24 17:19:41.947 534 DEBUG ironic_python_agent.cmd.agent [-] oslo_concurrency.lock_path = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.126993] ironic-python-agent[534]: 2025-02-24 17:19:41.953 534 DEBUG ironic_python_agent.cmd.agent [-] disk_utils.bios_boot_partition_size = 1 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.134688] ironic-python-agent[534]: 2025-02-24 17:19:41.960 534 DEBUG ironic_python_agent.cmd.agent [-] disk_utils.dd_block_size = 1M log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.141672] ironic-python-agent[534]: 2025-02-24 17:19:41.966 534 DEBUG ironic_python_agent.cmd.agent [-] disk_utils.efi_system_partition_size = 550 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.146312] ironic-python-agent[534]: 2025-02-24 17:19:41.972 534 DEBUG ironic_python_agent.cmd.agent [-] disk_utils.image_convert_attempts = 3 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.152014] ironic-python-agent[534]: 2025-02-24 17:19:41.977 534 DEBUG ironic_python_agent.cmd.agent [-] disk_utils.image_convert_memory_limit = 2048 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.158355] ironic-python-agent[534]: 2025-02-24 17:19:41.984 534 DEBUG ironic_python_agent.cmd.agent [-] disk_utils.partition_detection_attempts = 3 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.165852] ironic-python-agent[534]: 2025-02-24 17:19:41.989 534 DEBUG ironic_python_agent.cmd.agent [-] disk_utils.partprobe_attempts = 10 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.170611] ironic-python-agent[534]: 2025-02-24 17:19:41.997 534 DEBUG ironic_python_agent.cmd.agent [-] disk_partitioner.check_device_interval = 1 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.176019] ironic-python-agent[534]: 2025-02-24 17:19:42.002 534 DEBUG ironic_python_agent.cmd.agent [-] disk_partitioner.check_device_max_retries = 20 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.182054] ironic-python-agent[534]: 2025-02-24 17:19:42.008 534 DEBUG ironic_python_agent.cmd.agent [-] metrics.backend = noop log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.187372] ironic-python-agent[534]: 2025-02-24 17:19:42.013 534 DEBUG ironic_python_agent.cmd.agent [-] metrics.global_prefix = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.193024] ironic-python-agent[534]: 2025-02-24 17:19:42.018 534 DEBUG ironic_python_agent.cmd.agent [-] metrics.prepend_host = False log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.197946] ironic-python-agent[534]: 2025-02-24 17:19:42.023 534 DEBUG ironic_python_agent.cmd.agent [-] metrics.prepend_host_reverse = True log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.203196] ironic-python-agent[534]: 2025-02-24 17:19:42.029 534 DEBUG ironic_python_agent.cmd.agent [-] metrics_statsd.statsd_host = localhost log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.209128] ironic-python-agent[534]: 2025-02-24 17:19:42.034 534 DEBUG ironic_python_agent.cmd.agent [-] metrics_statsd.statsd_port = 8125 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.214763] ironic-python-agent[534]: 2025-02-24 17:19:42.040 534 DEBUG ironic_python_agent.cmd.agent [-] mdns.interfaces = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.219769] ironic-python-agent[534]: 2025-02-24 17:19:42.046 534 DEBUG ironic_python_agent.cmd.agent [-] mdns.lookup_attempts = 3 log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.226184] ironic-python-agent[534]: 2025-02-24 17:19:42.051 534 DEBUG ironic_python_agent.cmd.agent [-] mdns.params = {} log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.231976] ironic-python-agent[534]: 2025-02-24 17:19:42.057 534 DEBUG ironic_python_agent.cmd.agent [-] ssl.ca_file = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.237962] ironic-python-agent[534]: 2025-02-24 17:19:42.063 534 DEBUG ironic_python_agent.cmd.agent [-] ssl.cert_file = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.243181] ironic-python-agent[534]: 2025-02-24 17:19:42.069 534 DEBUG ironic_python_agent.cmd.agent [-] ssl.ciphers = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.257866] ironic-python-agent[534]: 2025-02-24 17:19:42.081 534 DEBUG ironic_python_agent.cmd.agent [-] ssl.key_file = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.262952] ironic-python-agent[534]: 2025-02-24 17:19:42.088 534 DEBUG ironic_python_agent.cmd.agent [-] ssl.version = None log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2824 [ 145.268749] ironic-python-agent[534]: 2025-02-24 17:19:42.094 534 DEBUG ironic_python_agent.cmd.agent [-] ******************************************************************************** log_opt_values /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_config/cfg.py:2828 [ 145.276943] ironic-python-agent[534]: 2025-02-24 17:19:42.100 534 INFO ironic_python_agent.utils [-] Early logging: Did not identify any virtual media candidates devices. [ 145.282328] ironic-python-agent[534]: 2025-02-24 17:19:42.109 534 INFO ironic_python_agent.utils [-] Early logging: No virtual media device detected [ 145.785186] ironic-python-agent[534]: 2025-02-24 17:19:42.603 534 INFO ironic_python_agent.agent [-] Starting ironic-python-agent version: 10.1.1.dev18 [ 145.925093] ironic-python-agent[534]: 2025-02-24 17:19:42.750 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): readlink -v /sys/class/net/enp2s0/device/driver/module execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 146.065050] ironic-python-agent[534]: 2025-02-24 17:19:42.882 534 DEBUG oslo_concurrency.processutils [-] CMD "readlink -v /sys/class/net/enp2s0/device/driver/module" returned: 0 in 0.133s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 146.071831] ironic-python-agent[534]: 2025-02-24 17:19:42.898 534 DEBUG ironic_python_agent.utils [-] Command stdout is: "../../../../module/virtio_net [ 146.074611] ironic-python-agent[534]: " _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:106 [ 146.079776] ironic-python-agent[534]: 2025-02-24 17:19:42.904 534 DEBUG ironic_python_agent.utils [-] Command stderr is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:113 [ 146.095182] ironic-python-agent[534]: 2025-02-24 17:19:42.919 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): readlink -v /sys/class/net/enp1s0/device/driver/module execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 146.213279] ironic-python-agent[534]: 2025-02-24 17:19:43.037 534 DEBUG oslo_concurrency.processutils [-] CMD "readlink -v /sys/class/net/enp1s0/device/driver/module" returned: 0 in 0.118s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 146.223911] ironic-python-agent[534]: 2025-02-24 17:19:43.050 534 DEBUG ironic_python_agent.utils [-] Command stdout is: "../../../../module/virtio_net [ 146.226404] ironic-python-agent[534]: " _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:106 [ 146.239404] ironic-python-agent[534]: 2025-02-24 17:19:43.064 534 DEBUG ironic_python_agent.utils [-] Command stderr is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:113 [ 146.245248] ironic-python-agent[534]: 2025-02-24 17:19:43.070 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): readlink -v /sys/class/net/lo/device/driver/module execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 146.371662] ironic-python-agent[534]: 2025-02-24 17:19:43.190 534 DEBUG oslo_concurrency.processutils [-] CMD "readlink -v /sys/class/net/lo/device/driver/module" returned: 1 in 0.119s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 146.378280] ironic-python-agent[534]: 2025-02-24 17:19:43.204 534 DEBUG oslo_concurrency.processutils [-] 'readlink -v /sys/class/net/lo/device/driver/module' failed. Not Retrying. execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:423 [ 146.393234] ironic-python-agent[534]: 2025-02-24 17:19:43.211 534 DEBUG ironic_python_agent.utils [-] Command stdout is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:106 [ 146.399812] ironic-python-agent[534]: 2025-02-24 17:19:43.224 534 DEBUG ironic_python_agent.utils [-] Command stderr is: "readlink: /sys/class/net/lo/device/driver/module: No such file or directory [ 146.401673] ironic-python-agent[534]: " _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:113 [ 146.407922] ironic-python-agent[534]: 2025-02-24 17:19:43.233 534 DEBUG root [-] Get driver for interface lo failed. Error: Unexpected error while running command. [ 146.409880] ironic-python-agent[534]: Command: readlink -v /sys/class/net/lo/device/driver/module [ 146.411201] ironic-python-agent[534]: Exit code: 1 [ 146.411936] ironic-python-agent[534]: Stdout: '' [ 146.417678] ironic-python-agent[534]: Stderr: 'readlink: /sys/class/net/lo/device/driver/module: No such file or directory\n' _detect_cna_card /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/hardware_managers/cna.py:40 [ 146.418978] ironic-python-agent[534]: 2025-02-24 17:19:43.241 534 DEBUG root [-] No Intel CNA network card found evaluate_hardware_support /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/hardware_managers/cna.py:88 [ 146.423862] ironic-python-agent[534]: 2025-02-24 17:19:43.250 534 DEBUG root [-] Loading drivers, settling udevs, and generally initializing _initialize_hardware /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/hardware_managers/container.py:30 [ 146.429034] ironic-python-agent[534]: 2025-02-24 17:19:43.254 534 DEBUG root [-] Looking for example device _detect_hardware /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/hardware_managers/container.py:37 [ 146.432714] ironic-python-agent[534]: 2025-02-24 17:19:43.259 534 DEBUG root [-] Found example device, returning SERVICE_PROVIDER evaluate_hardware_support /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/hardware_managers/container.py:70 [ 146.437801] ironic-python-agent[534]: 2025-02-24 17:19:43.263 534 INFO root [-] Hardware manager found: ironic_python_agent.hardware_managers.container:ContainerHardwareManager [ 146.442108] ironic-python-agent[534]: 2025-02-24 17:19:43.269 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): iscsistart -f execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 146.579332] ironic-python-agent[534]: 2025-02-24 17:19:43.404 534 DEBUG oslo_concurrency.processutils [-] CMD "iscsistart -f" returned: 21 in 0.134s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 146.590225] ironic-python-agent[534]: 2025-02-24 17:19:43.416 534 DEBUG oslo_concurrency.processutils [-] 'iscsistart -f' failed. Not Retrying. execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:423 [ 146.596249] ironic-python-agent[534]: 2025-02-24 17:19:43.423 534 DEBUG ironic_python_agent.utils [-] Command stdout is: "Could not get list of targets from firmware. [ 146.598758] ironic-python-agent[534]: " _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:106 [ 146.606759] ironic-python-agent[534]: 2025-02-24 17:19:43.429 534 DEBUG ironic_python_agent.utils [-] Command stderr is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:113 [ 146.613715] ironic-python-agent[534]: 2025-02-24 17:19:43.431 534 DEBUG root [-] No iscsi connection detected. Skipping iscsi. Error: Unexpected error while running command. [ 146.614967] ironic-python-agent[534]: Command: iscsistart -f [ 146.621664] ironic-python-agent[534]: Exit code: 21 [ 146.622676] ironic-python-agent[534]: Stdout: 'Could not get list of targets from firmware.\n' [ 146.623808] ironic-python-agent[534]: Stderr: '' _check_for_iscsi /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/hardware.py:183 [ 146.625428] ironic-python-agent[534]: 2025-02-24 17:19:43.446 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): mdadm --assemble --scan --verbose execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 146.807541] ironic-python-agent[534]: 2025-02-24 17:19:43.628 534 DEBUG oslo_concurrency.processutils [-] CMD "mdadm --assemble --scan --verbose" returned: 1 in 0.182s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 146.814312] ironic-python-agent[534]: 2025-02-24 17:19:43.639 534 DEBUG oslo_concurrency.processutils [-] 'mdadm --assemble --scan --verbose' failed. Not Retrying. execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:423 [ 146.822208] ironic-python-agent[534]: 2025-02-24 17:19:43.646 534 DEBUG ironic_python_agent.utils [-] Command stdout is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:106 [ 146.829091] ironic-python-agent[534]: 2025-02-24 17:19:43.648 534 DEBUG ironic_python_agent.utils [-] Command stderr is: "mdadm: looking for devices for further assembly [ 146.830259] ironic-python-agent[534]: mdadm: no recogniseable superblock on /dev/vda [ 146.830981] ironic-python-agent[534]: mdadm: No arrays found in config file or automatically [ 146.831669] ironic-python-agent[534]: " _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:113 [ 146.837066] ironic-python-agent[534]: 2025-02-24 17:19:43.654 534 INFO root [-] No new RAID devices assembled during start-up [ 146.839029] ironic-python-agent[534]: 2025-02-24 17:19:43.656 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): modprobe ipmi_msghandler execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 146.940605] IPMI message handler: version 39.2 [ 146.966319] ipmi device interface [ 147.049266] ironic-python-agent[534]: 2025-02-24 17:19:43.865 534 DEBUG oslo_concurrency.processutils [-] CMD "modprobe ipmi_msghandler" returned: 0 in 0.208s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 147.056960] ironic-python-agent[534]: 2025-02-24 17:19:43.882 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): modprobe ipmi_devintf execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 147.251273] ironic-python-agent[534]: 2025-02-24 17:19:44.074 534 DEBUG oslo_concurrency.processutils [-] CMD "modprobe ipmi_devintf" returned: 0 in 0.192s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 147.258343] ironic-python-agent[534]: 2025-02-24 17:19:44.083 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): modprobe ipmi_si execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 147.363082] ipmi_si: IPMI System Interface driver [ 147.370440] ipmi_si: Unable to find any System Interface(s) [ 147.459989] ironic-python-agent[534]: 2025-02-24 17:19:44.284 534 DEBUG oslo_concurrency.processutils [-] CMD "modprobe ipmi_si" returned: 1 in 0.201s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 147.466441] ironic-python-agent[534]: 2025-02-24 17:19:44.292 534 DEBUG oslo_concurrency.processutils [-] 'modprobe ipmi_si' failed. Not Retrying. execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:423 [ 147.472367] ironic-python-agent[534]: 2025-02-24 17:19:44.298 534 DEBUG root [-] IPMI driver ipmi_si not supported or not present _load_ipmi_modules /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/hardware.py:138 [ 147.478828] ironic-python-agent[534]: 2025-02-24 17:19:44.305 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): modprobe dm_multipath execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 147.649566] ironic-python-agent[534]: 2025-02-24 17:19:44.473 534 DEBUG oslo_concurrency.processutils [-] CMD "modprobe dm_multipath" returned: 0 in 0.167s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 147.655667] ironic-python-agent[534]: 2025-02-24 17:19:44.482 534 DEBUG ironic_python_agent.utils [-] Command stdout is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:106 [ 147.661564] ironic-python-agent[534]: 2025-02-24 17:19:44.487 534 DEBUG ironic_python_agent.utils [-] Command stderr is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:113 [ 147.667676] ironic-python-agent[534]: 2025-02-24 17:19:44.494 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): modprobe multipath execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 147.893772] ironic-python-agent[534]: 2025-02-24 17:19:44.712 534 DEBUG oslo_concurrency.processutils [-] CMD "modprobe multipath" returned: 0 in 0.217s execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:372 [ 147.900530] ironic-python-agent[534]: 2025-02-24 17:19:44.725 534 DEBUG ironic_python_agent.utils [-] Command stdout is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:106 [ 147.905425] ironic-python-agent[534]: 2025-02-24 17:19:44.731 534 DEBUG ironic_python_agent.utils [-] Command stderr is: "" _log /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:113 [ 147.911611] ironic-python-agent[534]: 2025-02-24 17:19:44.736 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): multipathd execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 147.985984] ironic-python-agent[534]: 2025-02-24 17:19:44.810 534 DEBUG oslo_concurrency.processutils [-] 'multipathd' failed. Not Retrying. execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:423 [ 147.992804] ironic-python-agent[534]: 2025-02-24 17:19:44.818 534 DEBUG ironic_python_agent.utils [-] Command not found: "multipathd" execute /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:124 [ 148.001035] ironic-python-agent[534]: 2025-02-24 17:19:44.823 534 DEBUG ironic_python_agent.utils [-] Command failed: [Errno 2] No such file or directory: 'multipathd' try_execute /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:187 [ 148.006604] ironic-python-agent[534]: 2025-02-24 17:19:44.832 534 DEBUG oslo_concurrency.processutils [-] Running cmd (subprocess): multipath -ll execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:349 [ 148.079721] ironic-python-agent[534]: 2025-02-24 17:19:44.903 534 DEBUG oslo_concurrency.processutils [-] 'multipath -ll' failed. Not Retrying. execute /opt/ironic-python-agent/lib/python3.11/site-packages/oslo_concurrency/processutils.py:423 [ 148.086554] ironic-python-agent[534]: 2025-02-24 17:19:44.912 534 DEBUG ironic_python_agent.utils [-] Command not found: "multipath -ll" execute /opt/ironic-python-agent/lib/python3.11/site-packages/ironic_python_agent/utils.py:124 [ 148.095860] ironic-python-agent[534]: 2025-02-24 17:19:44.918 534 WARNING root [-] Attempted to determine if multipath tools were present. Not detected. Error recorded: [Errno 2] No such file or directory: 'multipath': FileN