PLAY [Prepare mock iDRAC server] ***********************************************

TASK [Create mock server directory] ********************************************
Thursday 19 March 2026  12:06:49 +0000 (0:00:00.024)       0:00:00.024 ********
changed: [instance]

TASK [Generate self-signed TLS certificate] ************************************
Thursday 19 March 2026  12:06:50 +0000 (0:00:00.333)       0:00:00.358 ********
changed: [instance]

TASK [Copy mock iDRAC server script] *******************************************
Thursday 19 March 2026  12:06:50 +0000 (0:00:00.333)       0:00:00.691 ********
changed: [instance]

TASK [Start mock iDRAC server] *************************************************
Thursday 19 March 2026  12:06:50 +0000 (0:00:00.498)       0:00:01.189 ********
changed: [instance]

TASK [Record mock server PID] **************************************************
Thursday 19 March 2026  12:06:51 +0000 (0:00:00.177)       0:00:01.367 ********
ok: [instance]

TASK [Wait for mock iDRAC to respond] ******************************************
Thursday 19 March 2026  12:06:51 +0000 (0:00:00.207)       0:00:01.574 ********
ok: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=6    changed=4    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0

Thursday 19 March 2026  12:06:51 +0000 (0:00:00.404)       0:00:01.978 ********
===============================================================================
Copy mock iDRAC server script ------------------------------------------- 0.50s
Wait for mock iDRAC to respond ------------------------------------------ 0.40s
Create mock server directory -------------------------------------------- 0.33s
Generate self-signed TLS certificate ------------------------------------ 0.33s
Record mock server PID -------------------------------------------------- 0.21s
Start mock iDRAC server ------------------------------------------------- 0.18s

PLAY [Converge -- test bm_* Redfish tasks against mock iDRAC] ******************

TASK [Test bm_power_off] *******************************************************
Thursday 19 March 2026  12:06:52 +0000 (0:00:00.046)       0:00:00.046 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/molecule/bm_redfish/tasks/test_power_off.yml for instance

TASK [Reset mock to power Off] *************************************************
Thursday 19 March 2026  12:06:52 +0000 (0:00:00.021)       0:00:00.068 ********
ok: [instance]

TASK [Include bm_power_off] ****************************************************
Thursday 19 March 2026  12:06:52 +0000 (0:00:00.405)       0:00:00.473 ********

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:06:52 +0000 (0:00:00.025)       0:00:00.499 ********
ok: [instance]

TASK [bm_sno : Force power off via Redfish] ************************************
Thursday 19 March 2026  12:06:52 +0000 (0:00:00.278)       0:00:00.777 ********
skipping: [instance]

TASK [bm_sno : Wait for host to power off] *************************************
Thursday 19 March 2026  12:06:52 +0000 (0:00:00.014)       0:00:00.792 ********
skipping: [instance]

TASK [Query mock state after power_off (already off)] **************************
Thursday 19 March 2026  12:06:52 +0000 (0:00:00.018)       0:00:00.811 ********
ok: [instance]

TASK [Assert host is still Off] ************************************************
Thursday 19 March 2026  12:06:53 +0000 (0:00:00.280)       0:00:01.091 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Reset mock to power On] **************************************************
Thursday 19 March 2026  12:06:53 +0000 (0:00:00.022)       0:00:01.114 ********
ok: [instance]

TASK [Include bm_power_off] ****************************************************
Thursday 19 March 2026  12:06:53 +0000 (0:00:00.289)       0:00:01.404 ********

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:06:53 +0000 (0:00:00.021)       0:00:01.425 ********
ok: [instance]

TASK [bm_sno : Force power off via Redfish] ************************************
Thursday 19 March 2026  12:06:53 +0000 (0:00:00.316)       0:00:01.742 ********
ok: [instance]

TASK [bm_sno : Wait for host to power off] *************************************
Thursday 19 March 2026  12:06:54 +0000 (0:00:00.321)       0:00:02.064 ********
ok: [instance]

TASK [Query mock state after power_off (was on)] *******************************
Thursday 19 March 2026  12:06:54 +0000 (0:00:00.315)       0:00:02.380 ********
ok: [instance]

TASK [Assert host is now Off] **************************************************
Thursday 19 March 2026  12:06:54 +0000 (0:00:00.295)       0:00:02.675 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Test bm_power_on] ********************************************************
Thursday 19 March 2026  12:06:54 +0000 (0:00:00.023)       0:00:02.699 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/molecule/bm_redfish/tasks/test_power_on.yml for instance

TASK [Reset mock to power On] **************************************************
Thursday 19 March 2026  12:06:54 +0000 (0:00:00.027)       0:00:02.726 ********
ok: [instance]

TASK [Include bm_power_on] *****************************************************
Thursday 19 March 2026  12:06:55 +0000 (0:00:00.303)       0:00:03.030 ********

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:06:55 +0000 (0:00:00.026)       0:00:03.056 ********
ok: [instance]

TASK [bm_sno : Power on bare metal host] ***************************************
Thursday 19 March 2026  12:06:55 +0000 (0:00:00.300)       0:00:03.357 ********
skipping: [instance]

TASK [bm_sno : Wait for host POST to complete] *********************************
Thursday 19 March 2026  12:06:55 +0000 (0:00:00.019)       0:00:03.376 ********
ok: [instance]

TASK [bm_sno : Show POST state] ************************************************
Thursday 19 March 2026  12:06:55 +0000 (0:00:00.316)       0:00:03.693 ********
ok: [instance] => {
    "msg": "POST state: FinishedPost"
}

TASK [Query mock state after power_on (already on)] ****************************
Thursday 19 March 2026  12:06:55 +0000 (0:00:00.034)       0:00:03.728 ********
ok: [instance]

TASK [Assert host is still On with POST complete] ******************************
Thursday 19 March 2026  12:06:56 +0000 (0:00:00.317)       0:00:04.045 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Reset mock to power Off] *************************************************
Thursday 19 March 2026  12:06:56 +0000 (0:00:00.022)       0:00:04.068 ********
ok: [instance]

TASK [Include bm_power_on] *****************************************************
Thursday 19 March 2026  12:06:56 +0000 (0:00:00.322)       0:00:04.390 ********

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:06:56 +0000 (0:00:00.026)       0:00:04.417 ********
ok: [instance]

TASK [bm_sno : Power on bare metal host] ***************************************
Thursday 19 March 2026  12:06:56 +0000 (0:00:00.301)       0:00:04.718 ********
ok: [instance]

TASK [bm_sno : Wait for host POST to complete] *********************************
Thursday 19 March 2026  12:06:57 +0000 (0:00:00.321)       0:00:05.040 ********
ok: [instance]

TASK [bm_sno : Show POST state] ************************************************
Thursday 19 March 2026  12:06:57 +0000 (0:00:00.316)       0:00:05.357 ********
ok: [instance] => {
    "msg": "POST state: FinishedPost"
}

TASK [Query mock state after power_on (was off)] *******************************
Thursday 19 March 2026  12:06:57 +0000 (0:00:00.041)       0:00:05.398 ********
ok: [instance]

TASK [Assert host is now On with POST complete] ********************************
Thursday 19 March 2026  12:06:57 +0000 (0:00:00.312)       0:00:05.711 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Reset mock to power Off without PostState support] ***********************
Thursday 19 March 2026  12:06:57 +0000 (0:00:00.026)       0:00:05.737 ********
ok: [instance]

TASK [Include bm_power_on] *****************************************************
Thursday 19 March 2026  12:06:58 +0000 (0:00:00.306)       0:00:06.044 ********

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:06:58 +0000 (0:00:00.024)       0:00:06.068 ********
ok: [instance]

TASK [bm_sno : Power on bare metal host] ***************************************
Thursday 19 March 2026  12:06:58 +0000 (0:00:00.315)       0:00:06.384 ********
ok: [instance]

TASK [bm_sno : Wait for host POST to complete] *********************************
Thursday 19 March 2026  12:06:58 +0000 (0:00:00.295)       0:00:06.680 ********
ok: [instance]

TASK [bm_sno : Show POST state] ************************************************
Thursday 19 March 2026  12:06:59 +0000 (0:00:00.340)       0:00:07.021 ********
ok: [instance] => {
    "msg": "POST state: not supported by firmware, used PowerState=On"
}

TASK [Query mock state after power_on (no PostState)] **************************
Thursday 19 March 2026  12:06:59 +0000 (0:00:00.039)       0:00:07.060 ********
ok: [instance]

TASK [Assert host is On (PostState stays null)] ********************************
Thursday 19 March 2026  12:06:59 +0000 (0:00:00.324)       0:00:07.384 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Test bm_check_usb_boot] **************************************************
Thursday 19 March 2026  12:06:59 +0000 (0:00:00.023)       0:00:07.408 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/molecule/bm_redfish/tasks/test_check_usb_boot.yml for instance

TASK [Reset mock with usb_boot Enabled] ****************************************
Thursday 19 March 2026  12:06:59 +0000 (0:00:00.026)       0:00:07.435 ********
ok: [instance]

TASK [Include bm_check_usb_boot] ***********************************************
Thursday 19 March 2026  12:06:59 +0000 (0:00:00.295)       0:00:07.730 ********

TASK [bm_sno : Read GenericUsbBoot BIOS attribute] *****************************
Thursday 19 March 2026  12:06:59 +0000 (0:00:00.026)       0:00:07.757 ********
ok: [instance]

TASK [bm_sno : Set GenericUsbBoot status fact] *********************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.297)       0:00:08.054 ********
ok: [instance]

TASK [bm_sno : Fail if GenericUsbBoot is disabled] *****************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.031)       0:00:08.085 ********
skipping: [instance]

TASK [Assert _usb_boot_enabled is true] ****************************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.030)       0:00:08.115 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Reset mock with usb_boot Disabled] ***************************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.072)       0:00:08.187 ********
ok: [instance]

TASK [Include bm_check_usb_boot (expect failure)] ******************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.318)       0:00:08.506 ********

TASK [bm_sno : Read GenericUsbBoot BIOS attribute] *****************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.041)       0:00:08.547 ********
ok: [instance]

TASK [bm_sno : Set GenericUsbBoot status fact] *********************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.312)       0:00:08.860 ********
ok: [instance]

TASK [bm_sno : Fail if GenericUsbBoot is disabled] *****************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.035)       0:00:08.895 ********
fatal: [instance]: FAILED! => {"changed": false, "msg": "GenericUsbBoot is Disabled in BIOS. VirtualMedia cannot boot host localhost:8443."}

TASK [Assert failure was about GenericUsbBoot] *********************************
Thursday 19 March 2026  12:07:00 +0000 (0:00:00.037)       0:00:08.933 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Test bm_ensure_usb_boot] *************************************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.022)       0:00:08.956 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/molecule/bm_redfish/tasks/test_ensure_usb_boot.yml for instance

TASK [Reset mock with usb_boot Enabled and host Off] ***************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.031)       0:00:08.987 ********
ok: [instance]

TASK [Include bm_ensure_usb_boot] **********************************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.331)       0:00:09.318 ********

TASK [bm_sno : Check current GenericUsbBoot state] *****************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.031)       0:00:09.349 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/tasks/bm_check_usb_boot.yml for instance

TASK [bm_sno : Read GenericUsbBoot BIOS attribute] *****************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.019)       0:00:09.369 ********
ok: [instance]

TASK [bm_sno : Set GenericUsbBoot status fact] *********************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.287)       0:00:09.656 ********
ok: [instance]

TASK [bm_sno : Fail if GenericUsbBoot is disabled] *****************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.033)       0:00:09.689 ********
skipping: [instance]

TASK [Query mock state] ********************************************************
Thursday 19 March 2026  12:07:01 +0000 (0:00:00.031)       0:00:09.721 ********
ok: [instance]

TASK [Assert host stayed Off (no power cycle needed)] **************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.292)       0:00:10.013 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Reset mock with usb_boot Disabled and host Off] **************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.023)       0:00:10.037 ********
ok: [instance]

TASK [Include bm_ensure_usb_boot with auto-enable] *****************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.299)       0:00:10.336 ********

TASK [bm_sno : Check current GenericUsbBoot state] *****************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.030)       0:00:10.367 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/tasks/bm_check_usb_boot.yml for instance

TASK [bm_sno : Read GenericUsbBoot BIOS attribute] *****************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.022)       0:00:10.389 ********
ok: [instance]

TASK [bm_sno : Set GenericUsbBoot status fact] *********************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.289)       0:00:10.679 ********
ok: [instance]

TASK [bm_sno : Fail if GenericUsbBoot is disabled] *****************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.032)       0:00:10.711 ********
fatal: [instance]: FAILED! => {"changed": false, "msg": "GenericUsbBoot is Disabled in BIOS. VirtualMedia cannot boot host localhost:8443."}

TASK [bm_sno : Fail if auto-enable is off] *************************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.029)       0:00:10.741 ********
skipping: [instance]

TASK [bm_sno : Set GenericUsbBoot BIOS attribute] ******************************
Thursday 19 March 2026  12:07:02 +0000 (0:00:00.026)       0:00:10.768 ********
ok: [instance]

TASK [bm_sno : Create BIOS config job to schedule the change] ******************
Thursday 19 March 2026  12:07:03 +0000 (0:00:00.300)       0:00:11.069 ********
ok: [instance]

TASK [bm_sno : Power off before applying BIOS change] **************************
Thursday 19 March 2026  12:07:03 +0000 (0:00:00.281)       0:00:11.351 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/tasks/bm_power_off.yml for instance

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:07:03 +0000 (0:00:00.022)       0:00:11.373 ********
ok: [instance]

TASK [bm_sno : Force power off via Redfish] ************************************
Thursday 19 March 2026  12:07:03 +0000 (0:00:00.284)       0:00:11.658 ********
skipping: [instance]

TASK [bm_sno : Wait for host to power off] *************************************
Thursday 19 March 2026  12:07:03 +0000 (0:00:00.019)       0:00:11.677 ********
skipping: [instance]

TASK [bm_sno : Power on to apply BIOS config job during POST] ******************
Thursday 19 March 2026  12:07:03 +0000 (0:00:00.016)       0:00:11.694 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/tasks/bm_power_on.yml for instance

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:07:03 +0000 (0:00:00.024)       0:00:11.718 ********
ok: [instance]

TASK [bm_sno : Power on bare metal host] ***************************************
Thursday 19 March 2026  12:07:04 +0000 (0:00:00.300)       0:00:12.018 ********
ok: [instance]

TASK [bm_sno : Wait for host POST to complete] *********************************
Thursday 19 March 2026  12:07:04 +0000 (0:00:00.318)       0:00:12.336 ********
ok: [instance]

TASK [bm_sno : Show POST state] ************************************************
Thursday 19 March 2026  12:07:04 +0000 (0:00:00.347)       0:00:12.684 ********
ok: [instance] => {
    "msg": "POST state: FinishedPost"
}

TASK [bm_sno : Power off after BIOS change applied] ****************************
Thursday 19 March 2026  12:07:04 +0000 (0:00:00.034)       0:00:12.718 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/tasks/bm_power_off.yml for instance

TASK [bm_sno : Query current power state] **************************************
Thursday 19 March 2026  12:07:04 +0000 (0:00:00.030)       0:00:12.749 ********
ok: [instance]

TASK [bm_sno : Force power off via Redfish] ************************************
Thursday 19 March 2026  12:07:05 +0000 (0:00:00.326)       0:00:13.075 ********
ok: [instance]

TASK [bm_sno : Wait for host to power off] *************************************
Thursday 19 March 2026  12:07:05 +0000 (0:00:00.303)       0:00:13.379 ********
ok: [instance]

TASK [Query mock state after auto-enable] **************************************
Thursday 19 March 2026  12:07:05 +0000 (0:00:00.327)       0:00:13.707 ********
ok: [instance]

TASK [Assert BIOS updated and host left Off] ***********************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.306)       0:00:14.013 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Reset mock with usb_boot Disabled] ***************************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.030)       0:00:14.044 ********
ok: [instance]

TASK [Include bm_ensure_usb_boot without auto-enable (expect failure)] *********
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.315)       0:00:14.359 ********

TASK [bm_sno : Check current GenericUsbBoot state] *****************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.030)       0:00:14.389 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/tasks/bm_check_usb_boot.yml for instance

TASK [bm_sno : Read GenericUsbBoot BIOS attribute] *****************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.021)       0:00:14.411 ********
ok: [instance]

TASK [bm_sno : Set GenericUsbBoot status fact] *********************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.288)       0:00:14.699 ********
ok: [instance]

TASK [bm_sno : Fail if GenericUsbBoot is disabled] *****************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.041)       0:00:14.741 ********
fatal: [instance]: FAILED! => {"changed": false, "msg": "GenericUsbBoot is Disabled in BIOS. VirtualMedia cannot boot host localhost:8443."}

TASK [bm_sno : Fail if auto-enable is off] *************************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.037)       0:00:14.778 ********
fatal: [instance]: FAILED! => {"changed": false, "msg": "GenericUsbBoot is Disabled in BIOS. VirtualMedia cannot boot host localhost:8443. Set cifmw_bm_agent_enable_usb_boot: true in vars.yaml to allow this playbook to enable it automatically (requires a reboot cycle)."}

TASK [Assert failure mentions GenericUsbBoot or auto-enable] *******************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.036)       0:00:14.815 ********
ok: [instance] => {
    "changed": false,
    "msg": "All assertions passed"
}

TASK [Test bm_eject_vmedia] ****************************************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.025)       0:00:14.840 ********
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/bm_sno/molecule/bm_redfish/tasks/test_eject_vmedia.yml for instance

TASK [Reset mock with VirtualMedia inserted] ***********************************
Thursday 19 March 2026  12:07:06 +0000 (0:00:00.033)       0:00:14.873 ********
ok: [instance]

TASK [Include bm_eject_vmedia] *************************************************
Thursday 19 March 2026  12:07:07 +0000 (0:00:00.308)       0:00:15.182 ********

TASK [bm_sno : Eject VirtualMedia] *********************************************
Thursday 19 March 2026  12:07:07 +0000 (0:00:00.030)       0:00:15.213 ********
ok: [instance]

TASK [bm_sno : Wait for VirtualMedia eject to settle] **************************
Thursday 19 March 2026  12:07:07 +0000 (0:00:00.335)       0:00:15.549 ********
Pausing for 5 seconds
ok: [instance]

TASK [bm_sno : Check Remote File Share status] *********************************
Thursday 19 March 2026  12:07:12 +0000 (0:00:05.033)       0:00:20.582 ********
fatal: [instance]: FAILED! => {"censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": true}

PLAY RECAP *********************************************************************
instance                   : ok=76   changed=0    unreachable=0    failed=1    skipped=8    rescued=4    ignored=0

Thursday 19 March 2026  12:07:12 +0000 (0:00:00.293)       0:00:20.876 ********
===============================================================================
bm_sno : Wait for VirtualMedia eject to settle -------------------------- 5.03s
Reset mock to power Off ------------------------------------------------- 0.41s
bm_sno : Wait for host POST to complete --------------------------------- 0.35s
bm_sno : Wait for host POST to complete --------------------------------- 0.34s
bm_sno : Eject VirtualMedia --------------------------------------------- 0.34s
Reset mock with usb_boot Enabled and host Off --------------------------- 0.33s
bm_sno : Wait for host to power off ------------------------------------- 0.33s
bm_sno : Query current power state -------------------------------------- 0.33s
Query mock state after power_on (no PostState) -------------------------- 0.32s
Reset mock to power Off ------------------------------------------------- 0.32s
bm_sno : Force power off via Redfish ------------------------------------ 0.32s
bm_sno : Power on bare metal host --------------------------------------- 0.32s
Reset mock with usb_boot Disabled --------------------------------------- 0.32s
bm_sno : Power on bare metal host --------------------------------------- 0.32s
Query mock state after power_on (already on) ---------------------------- 0.32s
bm_sno : Wait for host POST to complete --------------------------------- 0.32s
bm_sno : Wait for host POST to complete --------------------------------- 0.32s
bm_sno : Query current power state -------------------------------------- 0.32s
bm_sno : Query current power state -------------------------------------- 0.32s
bm_sno : Wait for host to power off ------------------------------------- 0.32s

PLAY [Cleanup mock iDRAC server] ***********************************************

TASK [Stop mock iDRAC server] **************************************************
Thursday 19 March 2026  12:07:13 +0000 (0:00:00.023)       0:00:00.023 ********
ok: [instance]

TASK [Show mock server log] ****************************************************
Thursday 19 March 2026  12:07:13 +0000 (0:00:00.332)       0:00:00.355 ********
ok: [instance]

TASK [Print mock server log] ***************************************************
Thursday 19 March 2026  12:07:13 +0000 (0:00:00.226)       0:00:00.582 ********
ok: [instance] => {
    "_mock_log.stdout_lines": [
        "Mock iDRAC listening on https://0.0.0.0:8443",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /redfish/v1/Systems/System.Embedded.1/Actions/ComputerSystem.Reset HTTP/1.1\" 204 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /redfish/v1/Systems/System.Embedded.1/Actions/ComputerSystem.Reset HTTP/1.1\" 204 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /redfish/v1/Systems/System.Embedded.1/Actions/ComputerSystem.Reset HTTP/1.1\" 204 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1/Bios HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1/Bios HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1/Bios HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1/Bios HTTP/1.1\" 200 -",
        "[mock-idrac] \"PATCH /redfish/v1/Systems/System.Embedded.1/Bios/Settings HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /redfish/v1/Managers/iDRAC.Embedded.1/Jobs HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /redfish/v1/Systems/System.Embedded.1/Actions/ComputerSystem.Reset HTTP/1.1\" 204 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /redfish/v1/Systems/System.Embedded.1/Actions/ComputerSystem.Reset HTTP/1.1\" 204 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1 HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /test/state HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"GET /redfish/v1/Systems/System.Embedded.1/Bios HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /test/reset HTTP/1.1\" 200 -",
        "[mock-idrac] \"POST /redfish/v1/Managers/iDRAC.Embedded.1/VirtualMedia/CD/Actions/VirtualMedia.EjectMedia HTTP/1.1\" 204 -"
    ]
}

PLAY RECAP *********************************************************************
instance                   : ok=3    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0

Thursday 19 March 2026  12:07:14 +0000 (0:00:00.042)       0:00:00.624 ********
===============================================================================
Stop mock iDRAC server -------------------------------------------------- 0.33s
Show mock server log ---------------------------------------------------- 0.23s
Print mock server log --------------------------------------------------- 0.04s