--Task--
              name: Discover_IDC_tenant
           enabled: True
        class_name: DiscoverTenantTask
       source_name: controller
  source_namespace: >default<
       target_name: controller
  target_namespace: >default<
             start: 0.0
              stop: None
           timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow
              loop: False
          interval: None
      dependencies: []
          wait_for: []
    preceding_task: None
           options: {}
        group_name: None
       Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock

________________________________________________________________________________

[2024-07-18 05:36:02] Discover_IDC_tenant pre : N/A
________________________________________________________________________________

2024-07-18 05:36:02 - INFO: Timeout for this Task has changed to 16h (57600 seconds)
2024-07-18 05:36:02 - INFO: timeout was set to Task default (2x global_duration or 300 seconds (whatever is higher)), because it was unset
________________________________________________________________________________

[2024-07-18 05:36:02] Discover_IDC_tenant step1 : N/A
________________________________________________________________________________

2024-07-18 05:36:02,575 INFO    Deployment was skipped.
2024-07-18 05:36:26,194 INFO    
2024-07-18 05:36:26,195 INFO    *************************************    Creating deployment   *************************************
2024-07-18 05:36:26,195 INFO    Creating IDC type deployment for stack
2024-07-18 05:36:26,195 WARNING the ema key/secret have not been provided so the tenant will be considered as static
2024-07-18 05:36:26,195 INFO    Consider that tenant under tests is static
2024-07-18 05:36:26,331 INFO    IDCDeployment context set to: gke_None_europe-west2_default
2024-07-18 05:36:26,332 INFO    
2024-07-18 05:36:26,333 INFO    [run_command]: kubectl config current-context
2024-07-18 05:36:26,418 INFO    [run_command]: OK (rc = 0 - expected to be in [0])
2024-07-18 05:36:26,418 DEBUG   --- stdout ---
2024-07-18 05:36:26,419 DEBUG   gke_engineeringpit_us-east1-d_xlou-cdm
2024-07-18 05:36:26,419 DEBUG   --- stderr ---
2024-07-18 05:36:26,419 DEBUG   
2024-07-18 05:36:26,419 INFO    
2024-07-18 05:36:26,419 INFO    Getting credentials for default cluster in None project located in europe-west2
2024-07-18 05:36:26,419 INFO    
2024-07-18 05:36:26,419 INFO    [run_command]: gcloud container clusters get-credentials default --zone europe-west2 --project None
2024-07-18 05:36:27,561 ERROR   [run_command]: ERROR
2024-07-18 05:36:27,562 ERROR   --- rc ---
2024-07-18 05:36:27,562 ERROR   returned 1, expected to be in [0]
2024-07-18 05:36:27,562 ERROR   --- stdout ---
2024-07-18 05:36:27,562 ERROR   
2024-07-18 05:36:27,562 ERROR   --- stderr ---
2024-07-18 05:36:27,562 ERROR   ERROR: (gcloud) The project property must be set to a valid project ID, not the project name [None]
To set your project, run:

  $ gcloud config set project PROJECT_ID

or to unset it, run:

  $ gcloud config unset project
2024-07-18 05:36:27,562 INFO    
2024-07-18 05:36:27,562 INFO    Reverting context back to gke_engineeringpit_us-east1-d_xlou-cdm
2024-07-18 05:36:27,562 INFO    
2024-07-18 05:36:27,563 INFO    [loop_until]: kubectl config use-context gke_engineeringpit_us-east1-d_xlou-cdm
2024-07-18 05:36:27,563 INFO    [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-07-18 05:36:27,687 INFO    [loop_until]: OK (rc = 0)
2024-07-18 05:36:27,687 DEBUG   --- stdout ---
2024-07-18 05:36:27,688 DEBUG   Switched to context "gke_engineeringpit_us-east1-d_xlou-cdm".
2024-07-18 05:36:27,688 DEBUG   --- stderr ---
2024-07-18 05:36:27,688 DEBUG   
2024-07-18 05:36:27,688 WARNING unable to retrieve the context for the tenant: ema-perf-benchmark with a project id : None, the exception thrown was: (1, , ERROR: (gcloud) The project property must be set to a valid project ID, not the project name [None]
To set your project, run:

  $ gcloud config set project PROJECT_ID

or to unset it, run:

  $ gcloud config unset project
)
2024-07-18 05:36:27,688 INFO    
2024-07-18 05:36:27,688 INFO    ***************************    Livecheck stage: After tenant discovery   ***************************
2024-07-18 05:36:27,688 INFO    
2024-07-18 05:36:27,688 INFO    ------------------------    Running AM livecheck   ------------------------
2024-07-18 05:36:27,689 INFO    Livecheck to https://openam-ema-perf-benchmark.forgeblocks.com/am/json/health/ready
2024-07-18 05:36:27,689 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-benchmark.forgeblocks.com/am/json/health/ready"
2024-07-18 05:36:27,848 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:27,848 DEBUG   ---  status code  ---
2024-07-18 05:36:27,848 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:27,848 DEBUG   --- http response ---
2024-07-18 05:36:27,848 DEBUG   

2024-07-18 05:36:27,849 INFO    
2024-07-18 05:36:27,849 INFO    ------------------------   Running IDM livecheck   ------------------------
2024-07-18 05:36:27,849 INFO    Livecheck to https://openam-ema-perf-benchmark.forgeblocks.com/openidm/info/ping
2024-07-18 05:36:27,849 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-benchmark.forgeblocks.com/openidm/info/ping"
2024-07-18 05:36:27,902 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:27,902 DEBUG   ---  status code  ---
2024-07-18 05:36:27,902 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:27,902 DEBUG   --- http response ---
2024-07-18 05:36:27,903 DEBUG   {
    "_id": "",
    "_rev": "",
    "shortDesc": "OpenIDM ready",
    "state": "ACTIVE_READY"
}

2024-07-18 05:36:27,903 INFO    Create new LoginSession for user "xiaosong.lou@forgerock.com"
2024-07-18 05:36:27,903 INFO    [LoginSession] Get "access_token" token for user "xiaosong.lou@forgerock.com"
2024-07-18 05:36:27,903 INFO    [LoginSession] Obtaining new "access_token" token from server because it was not obtained yet for the user
2024-07-18 05:36:27,903 INFO    [LoginSession] Get "token_id" token for user "xiaosong.lou@forgerock.com"
2024-07-18 05:36:27,903 INFO    [LoginSession] Obtaining new "token_id" token from server because it was not obtained yet for the user
2024-07-18 05:36:27,903 INFO    Authenticate user xiaosong.lou@forgerock.com via REST
2024-07-18 05:36:27,903 INFO    [http_cmd]: curl --insecure -L --request POST  "https://openam-ema-perf-benchmark.forgeblocks.com/am/json/authenticate?realm=/"
2024-07-18 05:36:28,162 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:28,162 DEBUG   ---  status code  ---
2024-07-18 05:36:28,162 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:28,162 DEBUG   --- http response ---
2024-07-18 05:36:28,162 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (83 lines):
2024-07-18 05:36:28,162 DEBUG   ----- output -----
2024-07-18 05:36:28,162 DEBUG   {
2024-07-18 05:36:28,162 DEBUG       "authId": "eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJvdGsiOiJvZHJoaDJyaDBoYmk0c3I3Zm5xaDZtcnUxYSIsInJlYWxtIjoiLyIsInNlc3Npb25JZCI6IipBQUpUU1FBQ01ESUFCSFI1Y0dVQUNFcFhWRjlCVlZSSUFBSlRNUUFDTURFLipleUowZVhBaU9pSktWMVFpTENKamRIa2lPaUpLVjFRaUxDSmhiR2NpT2lKSVV6STFOaUo5LlpYbEtNR1ZZUVdsUGFVcExWakZSYVV4RFNteGliVTFwVDJsS1FrMVVTVFJSTUVwRVRGVm9WRTFxVlRKSmFYZHBXVmQ0YmtscWIybGFSMng1U1c0d0xpNW5VMHRDVWxGcWVHbFVkMFJxY0d0S1dFTklXRkpuTGtwTlNISTNaa2xpTmpkalNsQXliMDQwYUROM09IUjZSazQyTW1KdmIzVTNWR2x3UkVkdFowMTZTamRRTFVWaGFXRnljVko1TjNBdE1GWjFhMUUxUXpWSWMwMXhZbmxtTjBRMVIyUmxXbEEyY0c5WU1HVmFlVmRNZDAxbWEzaHRVMVZNWkRWWk5UVnlNR0ZKVmw5d1VVZFhTWGsxTkc5bVEwSXlPUzFoV210dmVVOUNZMjR6VjNWUmRtMU9VRWREVFdONGMxUlNXbkpJVFVoVWFXd3ROamRhYlhaVFQwUkVURXhMTjNsNVNGWXhjVVZaTWtkd1lXTjNZbGxIVWs1WVgzUTFWMWhVZWpGYWNIZzRWa1JKYld4WFJtWkZhSGt4WTNscFEyeGFSMUIyUkZKR05TMVlSa0psZGpkdldHMDVUMk01V0RSeldVZHhlVGd6TUd4b2RGWm9jRmh2UlZkRWJrVTVhek5NVFd0VVZESTBjV3RaWmxOS1IxWlFOV1p3WkUwM1VEaDVOWEp0ZW5NelJGZDZMVEpqYTNOamFEVjFjVEpVVTBoUVJESm1SRmRoYTI0emRHZzNkMVpxWm5Gb1dIbGxiMmsxZEVOcGR6SkdVazB0V0hKYWIwczRSR1JNYlhkeVduVkJkMHh2UkhkcFV6UlFRamhyTVVkeE1GTTJhRGN5VUZCRVIwczJSVVJOUW13MmNtWXRZa3h3TVZvd1kzUkJiVkp6YVRaSU9VVkpkV3BtWVRGeVpISTRRamxRT0UxSWFGcDVSRzlFTTNZd09IVm9XbVI0U25sRFdtWTNVbXBqVXpSTVdXOHdUMFpLZFc1YVVWSk9iSEpQY1doRE5FWlVPVXMyVldWUGJXVlROWE0yZDJsVlowcGpOM1p2YmsxdlZrOUZkRmwxWnpFMVdFTTJSemRxU1V0MU9ERTRUbXROV0VoTWJqbE9VMUZGUVU1elFWOVBibXBDTVRWdWNscEpaR3RNUVhOdVdESlVNRFJtVFhGaWJEWlVhelZ3ZEhodFZtdE5UV1pmUTB0SE1WTlFSMmxEVlRSQlZrZG5TbWwxVG5WNWNrcFhRbTFtWDFvM01uZFlPRWhZVXpscWVtTnRiR2t4V0RGZlZHY3lTVXhqVEhwemFHcG1iblZQT0VaeGIwNUlabEZKWlZwUFEzcHhkRGRmYVU0dGVWWm9TVWc0VjJSb1ZFWldXbGRoZEhkS2QzRjNTRmgyT1hwclJERkdOQzFKVjNWU1pVTmljV1ZVTlhGTU5tWldiMFJOWmtSQ1dtOUphRXBqU25oVGRsSkVVMWRuT1Rkb2NVOWxORUpVT1hCeWFYTkNMVTFhVG1GV0xXcG9SRjkwVkRnM2RtcFhOVXh4WjBSc1JFOTBaalpmWWtFNGVtZFdVVmxJVTI5UVZsUkJlVmM1U2xRMkxXVkVVRFl5UTNsblV6bG9WVlJ0V210dFJIcDBNV1p0Y0hNNFltTndVVVJ1ZERWMVNWcHBVRXRWYUV4aFFuTlJPRmxCVG1wTFRURTRWemt3YzBoUlRGbEJjazVPTlZObkxYWmhiMk5VYUdwUlYzZGpPRnBVVEdWTExVTjFXV2RtYUVJeFUwMWFWbEk1ZEhSRFkyaHBlbDgwTVdwU2NWOTBZakZHYUdoS2QwbGlVR2hHV1ZwRE5GWmtXVEIyZG5aSFIyMXVjR3h4Wm1wcWIwbGZPRGRZU0VwcllXcDVOMUpVVXpJMU5tbFBiVmw0VGpNM1VreFFUbTlDV0hCWVh6TlRMVmhTUVhsT1F6VTRhWGhmV2xjMVkxbEpkbXBUVGpCWFdFZFlTWFZRZWpoVVNUVTVhMGx3ZDFkNGFITk9URnBCTm1sdGEydGhjVmxQUW1wZlVYZzNObmhpUzI0ek5tVlhNRWhYTldWMVdXc3lXbWMzVUVoclZFWkhSV2w0Y2tKb1NFWm5SRXB5YWxwdFIyTlNaa1o0Wkd0aFlXTmZibXgyWXpsVFpFeENTWGRhY2sxaE9XZzFPVW80UzNaNlVtNDBMWGxqY3paUFRWWmpWemQ1ZEVwTmQyWkRXWE5SUWxOc1lTMUlRa1l5UkVwRFVFTXphbkpXUTAxVVIxVkdhRU5ZWkZkSVFsUlNiMWxPWW1sUU1rNHpURGx2WjAxTlkyWmthVUp4WkMxcGRISTVTVzFZTWpGUFZEaFZjRXhNU0dWNk9HRnljbVpsZFhaT1ZFaDJka3gwWkRKdWREVnFiMjVxYzI5SVNUUlJVVmM0Tm5CNFIySTJkMkZqUzBwMFlqbDNabnA1Y21sQ01USXRaMEZQYkVZMldYSllkV052ZWpnMVZHZEdWR2hUWkZGS09TMHRjSGxsVTFRelRWOVBZVXRUUm5oemVtb3dWMWx2U25sdVpqQnRVMUJwTTE5TU4yRkJZelZrVFZKUlZFVlBkbHBMWW01NFpGazVUVWxTWkdwaFIzbFBjRmhWVWtOcFowRlFka2QzUzFGVVZtUlJTekZpVlVwT1RHbHhkMUIzUm5Bd2FXRlNjbmQyYURaSFNIZFpVR0pqV1c5a1NXdG5WMmRwUldFMFIxazRNVVkwV0ZaMFRHdGxhV1JCUTFGUWEwVnVhamxoWm14dGFIb3RlamxITUcxVlIyZEZaRGhwV2xWS09TMHlNRWwwYmxWeFJVMUlkRTlLYTFGRFYzZFNaSFZHU0d4NmFXTklNWHBxTldsbWIxZDRhakZtZGsxcldFRTBkRTVYWmtSTGJFMW5ZakpwVGsxblJWaEljVFJIZFY5dllVdHhObHBsYWxCTlpWcEplRVZXZWtsMlNEUmpkMUZ0T1ZkRWVUVXdhbWN3TlhaV2FtTmFNSEV1V0dsSU1YUTBjV1ZQYmswMU1XcDBkalpYT1VkTmR3LjVKSlJNNE1PS3VYc2luT2szUjVWbHotODF2MjNsOU5UMVNwdFBLeFFRNGciLCJleHAiOjE3MjEzNjczODgsImlhdCI6MTcyMTI4MDk4OH0.vsETS_hq5hyoPrcDELixm1OxD1SvgNL9lwKy2qo17Fc",
2024-07-18 05:36:28,162 DEBUG       "callbacks": [
2024-07-18 05:36:28,162 DEBUG           {
2024-07-18 05:36:28,162 DEBUG               "type": "TextOutputCallback",
2024-07-18 05:36:28,162 DEBUG               "output": [
2024-07-18 05:36:28,162 DEBUG                   {
2024-07-18 05:36:28,162 DEBUG                       "name": "message",
2024-07-18 05:36:28,163 DEBUG                       "value": "Loading..."
2024-07-18 05:36:28,163 DEBUG                   },
2024-07-18 05:36:28,163 DEBUG   
2024-07-18 05:36:28,163 DEBUG   
2024-07-18 05:36:28,163 DEBUG   
2024-07-18 05:36:28,163 DEBUG   [...]
2024-07-18 05:36:28,163 DEBUG   
2024-07-18 05:36:28,163 DEBUG   
2024-07-18 05:36:28,163 DEBUG   
2024-07-18 05:36:28,163 DEBUG                       "value": "var setupPage = function() {  var skipInputElem = document.getElementById(\"skip-input-177\");  var messageElem;  document.getElementsByClassName(\"callback-component\").forEach(    function (e) {      var m = e.firstElementChild;      if (m.firstChild && m.firstChild.nodeName == \"#text\" && m.firstChild.nodeValue.trim() == \"Loading...\") {        messageElem = m;      }    }  );  if (!skipInputElem || !messageElem) {    return setTimeout(setupPage, 50);  }  var skipContainer = document.createElement(\"div\");  skipContainer.style = \"width:100%\";  skipContainer.innerHTML = \"<button id='skip-link-177' class='btn btn-block btn-link' type=submit>Skip for now</button>\";  skipInputElem.parentNode.append(skipContainer);  messageElem.align = \"center\";  messageElem.innerHTML = \"<h2 class=h2>Set up 2-step verification</h2><div style='margin-bottom:1em;padding:0 1em'>To protect your account, add a second<br>authentication method.<div class='alert alert-warning' style='margin-top:1.5em'>Starting April 2, 2024, you must sign in using<br>2-step verification. Learn more <a class='alert-link' href='https://backstage.forgerock.com/docs/idcloud/latest/product-information/migration-dependent-features/tenant-administrator-mandatory-2-step-verification-faq.html' target=_blank>here</a>.</div></div>\";  var bindSkipLink = function() {    document.getElementById(\"skip-link-177\").onclick = function() {      skipInputElem.value = \"Skip\";      document.getElementById(\"loginButton_0\").click();      return false;    };  };  setTimeout(bindSkipLink, 100);};setupPage();"
2024-07-18 05:36:28,163 DEBUG                   },
2024-07-18 05:36:28,163 DEBUG                   {
2024-07-18 05:36:28,163 DEBUG                       "name": "messageType",
2024-07-18 05:36:28,163 DEBUG                       "value": "4"
2024-07-18 05:36:28,163 DEBUG                   }
2024-07-18 05:36:28,163 DEBUG               ]
2024-07-18 05:36:28,163 DEBUG           }
2024-07-18 05:36:28,163 DEBUG       ]
2024-07-18 05:36:28,163 DEBUG   }
2024-07-18 05:36:28,164 INFO    [http_cmd]: curl --header "Content-Type: application/json" --header "Accept-API-Version: protocol=2.0,resource=1.0" --insecure -L --request POST --cookie "amlbcookie=01" --data '{"authId": "eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJvdGsiOiJvZHJoaDJyaDBoYmk0c3I3Zm5xaDZtcnUxYSIsInJlYWxtIjoiLyIsInNlc3Npb25JZCI6IipBQUpUU1FBQ01ESUFCSFI1Y0dVQUNFcFhWRjlCVlZSSUFBSlRNUUFDTURFLipleUowZVhBaU9pSktWMVFpTENKamRIa2lPaUpLVjFRaUxDSmhiR2NpT2lKSVV6STFOaUo5LlpYbEtNR1ZZUVdsUGFVcExWakZSYVV4RFNteGliVTFwVDJsS1FrMVVTVFJSTUVwRVRGVm9WRTFxVlRKSmFYZHBXVmQ0YmtscWIybGFSMng1U1c0d0xpNW5VMHRDVWxGcWVHbFVkMFJxY0d0S1dFTklXRkpuTGtwTlNISTNaa2xpTmpkalNsQXliMDQwYUROM09IUjZSazQyTW1KdmIzVTNWR2x3UkVkdFowMTZTamRRTFVWaGFXRnljVko1TjNBdE1GWjFhMUUxUXpWSWMwMXhZbmxtTjBRMVIyUmxXbEEyY0c5WU1HVmFlVmRNZDAxbWEzaHRVMVZNWkRWWk5UVnlNR0ZKVmw5d1VVZFhTWGsxTkc5bVEwSXlPUzFoV210dmVVOUNZMjR6VjNWUmRtMU9VRWREVFdONGMxUlNXbkpJVFVoVWFXd3ROamRhYlhaVFQwUkVURXhMTjNsNVNGWXhjVVZaTWtkd1lXTjNZbGxIVWs1WVgzUTFWMWhVZWpGYWNIZzRWa1JKYld4WFJtWkZhSGt4WTNscFEyeGFSMUIyUkZKR05TMVlSa0psZGpkdldHMDVUMk01V0RSeldVZHhlVGd6TUd4b2RGWm9jRmh2UlZkRWJrVTVhek5NVFd0VVZESTBjV3RaWmxOS1IxWlFOV1p3WkUwM1VEaDVOWEp0ZW5NelJGZDZMVEpqYTNOamFEVjFjVEpVVTBoUVJESm1SRmRoYTI0emRHZzNkMVpxWm5Gb1dIbGxiMmsxZEVOcGR6SkdVazB0V0hKYWIwczRSR1JNYlhkeVduVkJkMHh2UkhkcFV6UlFRamhyTVVkeE1GTTJhRGN5VUZCRVIwczJSVVJOUW13MmNtWXRZa3h3TVZvd1kzUkJiVkp6YVRaSU9VVkpkV3BtWVRGeVpISTRRamxRT0UxSWFGcDVSRzlFTTNZd09IVm9XbVI0U25sRFdtWTNVbXBqVXpSTVdXOHdUMFpLZFc1YVVWSk9iSEpQY1doRE5FWlVPVXMyVldWUGJXVlROWE0yZDJsVlowcGpOM1p2YmsxdlZrOUZkRmwxWnpFMVdFTTJSemRxU1V0MU9ERTRUbXROV0VoTWJqbE9VMUZGUVU1elFWOVBibXBDTVRWdWNscEpaR3RNUVhOdVdESlVNRFJtVFhGaWJEWlVhelZ3ZEhodFZtdE5UV1pmUTB0SE1WTlFSMmxEVlRSQlZrZG5TbWwxVG5WNWNrcFhRbTFtWDFvM01uZFlPRWhZVXpscWVtTnRiR2t4V0RGZlZHY3lTVXhqVEhwemFHcG1iblZQT0VaeGIwNUlabEZKWlZwUFEzcHhkRGRmYVU0dGVWWm9TVWc0VjJSb1ZFWldXbGRoZEhkS2QzRjNTRmgyT1hwclJERkdOQzFKVjNWU1pVTmljV1ZVTlhGTU5tWldiMFJOWmtSQ1dtOUphRXBqU25oVGRsSkVVMWRuT1Rkb2NVOWxORUpVT1hCeWFYTkNMVTFhVG1GV0xXcG9SRjkwVkRnM2RtcFhOVXh4WjBSc1JFOTBaalpmWWtFNGVtZFdVVmxJVTI5UVZsUkJlVmM1U2xRMkxXVkVVRFl5UTNsblV6bG9WVlJ0V210dFJIcDBNV1p0Y0hNNFltTndVVVJ1ZERWMVNWcHBVRXRWYUV4aFFuTlJPRmxCVG1wTFRURTRWemt3YzBoUlRGbEJjazVPTlZObkxYWmhiMk5VYUdwUlYzZGpPRnBVVEdWTExVTjFXV2RtYUVJeFUwMWFWbEk1ZEhSRFkyaHBlbDgwTVdwU2NWOTBZakZHYUdoS2QwbGlVR2hHV1ZwRE5GWmtXVEIyZG5aSFIyMXVjR3h4Wm1wcWIwbGZPRGRZU0VwcllXcDVOMUpVVXpJMU5tbFBiVmw0VGpNM1VreFFUbTlDV0hCWVh6TlRMVmhTUVhsT1F6VTRhWGhmV2xjMVkxbEpkbXBUVGpCWFdFZFlTWFZRZWpoVVNUVTVhMGx3ZDFkNGFITk9URnBCTm1sdGEydGhjVmxQUW1wZlVYZzNObmhpUzI0ek5tVlhNRWhYTldWMVdXc3lXbWMzVUVoclZFWkhSV2w0Y2tKb1NFWm5SRXB5YWxwdFIyTlNaa1o0Wkd0aFlXTmZibXgyWXpsVFpFeENTWGRhY2sxaE9XZzFPVW80UzNaNlVtNDBMWGxqY3paUFRWWmpWemQ1ZEVwTmQyWkRXWE5SUWxOc1lTMUlRa1l5UkVwRFVFTXphbkpXUTAxVVIxVkdhRU5ZWkZkSVFsUlNiMWxPWW1sUU1rNHpURGx2WjAxTlkyWmthVUp4WkMxcGRISTVTVzFZTWpGUFZEaFZjRXhNU0dWNk9HRnljbVpsZFhaT1ZFaDJka3gwWkRKdWREVnFiMjVxYzI5SVNUUlJVVmM0Tm5CNFIySTJkMkZqUzBwMFlqbDNabnA1Y21sQ01USXRaMEZQYkVZMldYSllkV052ZWpnMVZHZEdWR2hUWkZGS09TMHRjSGxsVTFRelRWOVBZVXRUUm5oemVtb3dWMWx2U25sdVpqQnRVMUJwTTE5TU4yRkJZelZrVFZKUlZFVlBkbHBMWW01NFpGazVUVWxTWkdwaFIzbFBjRmhWVWtOcFowRlFka2QzUzFGVVZtUlJTekZpVlVwT1RHbHhkMUIzUm5Bd2FXRlNjbmQyYURaSFNIZFpVR0pqV1c5a1NXdG5WMmRwUldFMFIxazRNVVkwV0ZaMFRHdGxhV1JCUTFGUWEwVnVhamxoWm14dGFIb3RlamxITUcxVlIyZEZaRGhwV2xWS09TMHlNRWwwYmxWeFJVMUlkRTlLYTFGRFYzZFNaSFZHU0d4NmFXTklNWHBxTldsbWIxZDRhakZtZGsxcldFRTBkRTVYWmtSTGJFMW5ZakpwVGsxblJWaEljVFJIZFY5dllVdHhObHBsYWxCTlpWcEplRVZXZWtsMlNEUmpkMUZ0T1ZkRWVUVXdhbWN3TlhaV2FtTmFNSEV1V0dsSU1YUTBjV1ZQYmswMU1XcDBkalpYT1VkTmR3LjVKSlJNNE1PS3VYc2luT2szUjVWbHotODF2MjNsOU5UMVNwdFBLeFFRNGciLCJleHAiOjE3MjEzNjczODgsImlhdCI6MTcyMTI4MDk4OH0.vsETS_hq5hyoPrcDELixm1OxD1SvgNL9lwKy2qo17Fc", "callbacks": [{"type": "TextOutputCallback", "output": [{"name": "message", "value": "Loading..."}, {"name": "messageType", "value": "0"}]}, {"type": "ConfirmationCallback", "output": [{"name": "prompt", "value": ""}, {"name": "messageType", "value": 0}, {"name": "options", "value": ["Set up"]}, {"name": "optionType", "value": -1}, {"name": "defaultOption", "value": 0}], "input": [{"name": "IDToken2", "value": 0}]}, {"type": "HiddenValueCallback", "output": [{"name": "value", "value": "false"}, {"name": "id", "value": "skip-input-177"}], "input": [{"name": "IDToken3", "value": "Skip"}]}, {"type": "TextOutputCallback", "output": [{"name": "message", "value": "var setupPage = function() {  var skipInputElem = document.getElementById(\"skip-input-177\");  var messageElem;  document.getElementsByClassName(\"callback-component\").forEach(    function (e) {      var m = e.firstElementChild;      if (m.firstChild && m.firstChild.nodeName == \"#text\" && m.firstChild.nodeValue.trim() == \"Loading...\") {        messageElem = m;      }    }  );  if (!skipInputElem || !messageElem) {    return setTimeout(setupPage, 50);  }  var skipContainer = document.createElement(\"div\");  skipContainer.style = \"width:100%\";  skipContainer.innerHTML = \"<button id='skip-link-177' class='btn btn-block btn-link' type=submit>Skip for now</button>\";  skipInputElem.parentNode.append(skipContainer);  messageElem.align = \"center\";  messageElem.innerHTML = \"<h2 class=h2>Set up 2-step verification</h2><div style='margin-bottom:1em;padding:0 1em'>To protect your account, add a second<br>authentication method.<div class='alert alert-warning' style='margin-top:1.5em'>Starting April 2, 2024, you must sign in using<br>2-step verification. Learn more <a class='alert-link' href='https://backstage.forgerock.com/docs/idcloud/latest/product-information/migration-dependent-features/tenant-administrator-mandatory-2-step-verification-faq.html' target=_blank>here</a>.</div></div>\";  var bindSkipLink = function() {    document.getElementById(\"skip-link-177\").onclick = function() {      skipInputElem.value = \"Skip\";      document.getElementById(\"loginButton_0\").click();      return false;    };  };  setTimeout(bindSkipLink, 100);};setupPage();"}, {"name": "messageType", "value": "4"}]}]}' "https://openam-ema-perf-benchmark.forgeblocks.com/am/json/authenticate?realm=/"
2024-07-18 05:36:28,524 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:28,524 DEBUG   ---  status code  ---
2024-07-18 05:36:28,524 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:28,524 DEBUG   --- http response ---
2024-07-18 05:36:28,524 DEBUG   {
    "tokenId": "bjIwLQplJDzKA2IBOZ428Q09JyU.*AAJTSQACMDIAAlNLABxBZHRaRDNvYUJyR29CYjlzWUNyenZrWXZUdnc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*",
    "successUrl": "/platform",
    "realm": "/"
}

2024-07-18 05:36:28,525 INFO    [LoginSession] Obtaining session info
2024-07-18 05:36:28,525 INFO    [http_cmd]: curl --insecure -L --request POST  "https://openam-ema-perf-benchmark.forgeblocks.com/am/json/sessions?_action=getSessionInfo"
2024-07-18 05:36:28,606 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:28,607 DEBUG   ---  status code  ---
2024-07-18 05:36:28,607 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:28,607 DEBUG   --- http response ---
2024-07-18 05:36:28,607 DEBUG   {
    "username": "cdea75be-25e6-45a6-8089-d5a83193be40",
    "universalId": "id=cdea75be-25e6-45a6-8089-d5a83193be40,ou=user,ou=am-config",
    "realm": "/",
    "latestAccessTime": "2024-07-18T05:36:28Z",
    "maxIdleExpirationTime": "2024-07-18T06:06:28Z",
    "maxSessionExpirationTime": "2024-07-18T07:36:27Z",
    "properties": {
        "AMCtxId": "7c1493f5-1105-4c7e-849d-f6b5b48cc52c-1665"
    }
}

2024-07-18 05:36:28,608 INFO    Obtain Oauth2 authz code via REST with PKCE flow
2024-07-18 05:36:28,609 DEBUG   Oauth2 authorize for access token
2024-07-18 05:36:28,609 INFO    [http_cmd]: curl --insecure --request POST --cookie "0e26551c0104b88=bjIwLQplJDzKA2IBOZ428Q09JyU.*AAJTSQACMDIAAlNLABxBZHRaRDNvYUJyR29CYjlzWUNyenZrWXZUdnc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*" --cookie "amlbcookie=01" --data '{"decision": "Allow", "csrf": "bjIwLQplJDzKA2IBOZ428Q09JyU.*AAJTSQACMDIAAlNLABxBZHRaRDNvYUJyR29CYjlzWUNyenZrWXZUdnc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*"}' "https://openam-ema-perf-benchmark.forgeblocks.com/am/oauth2/authorize?client_id=idmAdminClient&scope=openid fr:idm:*&redirect_uri=https://openam-ema-perf-benchmark.forgeblocks.com/platform/appAuthHelperRedirect.html&response_type=code&realm=/&code_challenge=H8VHP73pYVOJ0f7Y9lG3J5DU3gjTBCElj1L3LM6FgO&code_challenge_method=plain"
2024-07-18 05:36:28,695 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:28,695 DEBUG   ---  status code  ---
2024-07-18 05:36:28,695 DEBUG   http status code is 302 (expected 302)
2024-07-18 05:36:28,695 DEBUG   --- http response ---
2024-07-18 05:36:28,695 DEBUG   {'x-frame-options': 'SAMEORIGIN', 'content-security-policy-report-only': "frame-ancestors 'self'; script-src 'self' 'unsafe-eval' 'unsafe-inline'", 'x-content-type-options': 'nosniff', 'cache-control': 'no-store', 'location': 'https://openam-ema-perf-benchmark.forgeblocks.com/platform/appAuthHelperRedirect.html?code=EQxtW2ialoJ24Z8mA7sKUlz4XG4&iss=https%3A%2F%2Fopenam-ema-perf-benchmark.forgeblocks.com%3A443%2Fam%2Foauth2&client_id=idmAdminClient', 'pragma': 'no-cache', 'set-cookie': 'OAUTH_REQUEST_ATTRIBUTES=DELETED; Expires=Thu, 01 Jan 1970 00:00:00 GMT; Path=/; Domain=openam-ema-perf-benchmark.forgeblocks.com; Secure; HttpOnly; SameSite=none', 'Content-Length': '0', 'date': 'Thu, 18 Jul 2024 05:36:27 GMT', 'x-forgerock-transactionid': '610910ad-a98c-4657-bc06-61eadd99e1c3', 'strict-transport-security': 'max-age=31536000; includeSubDomains; preload;', 'x-robots-tag': 'none', 'Via': '1.1 google', 'Alt-Svc': 'h3=":443"; ma=2592000,h3-29=":443"; ma=2592000'}

2024-07-18 05:36:28,696 DEBUG   Oauth2 exchange authorize code for access token
2024-07-18 05:36:28,696 INFO    [http_cmd]: curl --insecure -L --request POST  --data '{"grant_type": "authorization_code", "redirect_uri": "https://openam-ema-perf-benchmark.forgeblocks.com/platform/appAuthHelperRedirect.html", "client_id": "idmAdminClient", "code": "EQxtW2ialoJ24Z8mA7sKUlz4XG4", "code_verifier": "H8VHP73pYVOJ0f7Y9lG3J5DU3gjTBCElj1L3LM6FgO"}' "https://openam-ema-perf-benchmark.forgeblocks.com/am/oauth2/access_token?realm=/"
2024-07-18 05:36:28,807 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:28,807 DEBUG   ---  status code  ---
2024-07-18 05:36:28,807 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:28,807 DEBUG   --- http response ---
2024-07-18 05:36:28,808 DEBUG   {
    "access_token": "eyJ0eXAiOiJKV1QiLCJraWQiOiJOZDROaVY1bmlZZ2JyOENwckc1VTNYRGxHdjA9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjZGVhNzViZS0yNWU2LTQ1YTYtODA4OS1kNWE4MzE5M2JlNDAiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMmUyNjdjYjktNGE1NC00NDQ0LTgyYTgtMWNkZjYxYTg2ZWIyLTE0NzAiLCJzdWJuYW1lIjoiY2RlYTc1YmUtMjVlNi00NWE2LTgwODktZDVhODMxOTNiZTQwIiwiaXNzIjoiaHR0cHM6Ly9vcGVuYW0tZW1hLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiUV83VXFNa2xHMk9JMlNyc290MXVIdy1Ca2FrIiwiYXVkIjoiaWRtQWRtaW5DbGllbnQiLCJuYmYiOjE3MjEyODA5ODgsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJvcGVuaWQiLCJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3MjEyODA5ODgsInJlYWxtIjoiLyIsImV4cCI6MTcyMTI4NDU4OCwiaWF0IjoxNzIxMjgwOTg4LCJleHBpcmVzX2luIjozNjAwLCJqdGkiOiJfZTdtVW0zekJVQU16M0N0UFhnSzJzRzRiUW8ifQ.LMxbXua23rG7k0HWYNsL1aM-26O9KhWBFz3VmUMJpH8LBFu078XYzCrykDVcIK-bbSo8AvIa1AJ6ouxBS6w-_-l7YoUvnpYSHlfG7UUp-sGc0ZVoUTBIiPoS6sOzjapTag6UQWBk7CY3CSVQNcGnc2yFhnr9u_5r0wwrnXMqCydeGzu3uyO3TIZESFK4a3YVmYKshafgajZ_WlhEtg3LD54Sov7dHFiOExwJjeEvcidKA6P5cz-dCTeLe9HZ0bVSt-oMR3QKU2ap9R7grSXFX2OmNT6CgN4JX2kclJ-a6Yd02Cw_hKJoUXfVhM8RzVkRsivjAoDHnXr4thsQjo_5Ew",
    "scope": "openid fr:idm:*",
    "id_token": "eyJ0eXAiOiJKV1QiLCJraWQiOiJOZDROaVY1bmlZZ2JyOENwckc1VTNYRGxHdjA9IiwiYWxnIjoiUlMyNTYifQ.eyJhdF9oYXNoIjoiNjVVQmdRWUZ5bTJuTVE2akQ5Z2VTdyIsInN1YiI6ImNkZWE3NWJlLTI1ZTYtNDVhNi04MDg5LWQ1YTgzMTkzYmU0MCIsImF1ZGl0VHJhY2tpbmdJZCI6IjJlMjY3Y2I5LTRhNTQtNDQ0NC04MmE4LTFjZGY2MWE4NmViMi0xNDc0Iiwic3VibmFtZSI6ImNkZWE3NWJlLTI1ZTYtNDVhNi04MDg5LWQ1YTgzMTkzYmU0MCIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLWVtYS1wZXJmLWJlbmNobWFyay5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMiIsInRva2VuTmFtZSI6ImlkX3Rva2VuIiwic2lkIjoiTnZIMG5xWTZGcW1KT2U1TFhiVHR1M0owMUU0ZlZaSTlyaVpXV3MybWdEND0iLCJhdWQiOiJpZG1BZG1pbkNsaWVudCIsImNfaGFzaCI6IkExS0VYWm1Sdl9wZHNESlhUNjlLcnciLCJhY3IiOiIwIiwib3JnLmZvcmdlcm9jay5vcGVuaWRjb25uZWN0Lm9wcyI6InJaVG4zT3Q0MDQ1Q04tZWd1cHI1TmdVODRJRSIsImF6cCI6ImlkbUFkbWluQ2xpZW50IiwiYXV0aF90aW1lIjoxNzIxMjgwOTg4LCJyZWFsbSI6Ii8iLCJleHAiOjE3MjEyODQ1ODgsInRva2VuVHlwZSI6IkpXVFRva2VuIiwiaWF0IjoxNzIxMjgwOTg4fQ.gGgThNjvkRQGAxxqj_32uefAcO_ZCEAesCP2YXodSl622ZZUcnq7IUu0_OOrZoscoe6AVK0CIb0S1dO32velqYpOKSatVXv-0wWzGtRCvi5joafbV3vEmqyiDUvnx9lKwxE6s67HGu09dcsyZ8BPbQDr33IMQeZZcf09QQUu8RFROOwo5ahXQkIBrMvQ_3-Kr1SmVoMUzsMNkTxiFwALpFEhT9txDs8QFBgK2q674IJgQtFQ9Fa-i2Lr90GyteBoeizTRRChF27ORSso-dwSbdOmFepgucJtSbJyIwKLipy_IktnVRG30K1I0VombE3pXaqWj4AuHk3sZoLYYHmnhQ",
    "token_type": "Bearer",
    "expires_in": 3599
}

2024-07-18 05:36:28,808 INFO    Additional check to sync/queue to ensure sync with DS is ok (see LODESTAR-1245)
2024-07-18 05:36:28,809 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-benchmark.forgeblocks.com/openidm/sync/queue?_queryFilter=true&_pageSize=1"
2024-07-18 05:36:28,903 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:28,904 DEBUG   ---  status code  ---
2024-07-18 05:36:28,904 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:28,904 DEBUG   --- http response ---
2024-07-18 05:36:28,904 DEBUG   {
    "result": [],
    "resultCount": 0,
    "pagedResultsCookie": null,
    "totalPagedResultsPolicy": "NONE",
    "totalPagedResults": -1,
    "remainingPagedResults": -1
}

2024-07-18 05:36:28,904 INFO    Try to create, query and delete a user
2024-07-18 05:36:28,905 INFO    Create user idm_udeg91cjhm in IDM
2024-07-18 05:36:28,905 INFO    [http_cmd]: curl --header "Authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiJOZDROaVY1bmlZZ2JyOENwckc1VTNYRGxHdjA9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjZGVhNzViZS0yNWU2LTQ1YTYtODA4OS1kNWE4MzE5M2JlNDAiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMmUyNjdjYjktNGE1NC00NDQ0LTgyYTgtMWNkZjYxYTg2ZWIyLTE0NzAiLCJzdWJuYW1lIjoiY2RlYTc1YmUtMjVlNi00NWE2LTgwODktZDVhODMxOTNiZTQwIiwiaXNzIjoiaHR0cHM6Ly9vcGVuYW0tZW1hLXBlcmYtYmVuY2htYXJrLmZvcmdlYmxvY2tzLmNvbTo0NDMvYW0vb2F1dGgyIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiUV83VXFNa2xHMk9JMlNyc290MXVIdy1Ca2FrIiwiYXVkIjoiaWRtQWRtaW5DbGllbnQiLCJuYmYiOjE3MjEyODA5ODgsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJvcGVuaWQiLCJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3MjEyODA5ODgsInJlYWxtIjoiLyIsImV4cCI6MTcyMTI4NDU4OCwiaWF0IjoxNzIxMjgwOTg4LCJleHBpcmVzX2luIjozNjAwLCJqdGkiOiJfZTdtVW0zekJVQU16M0N0UFhnSzJzRzRiUW8ifQ.LMxbXua23rG7k0HWYNsL1aM-26O9KhWBFz3VmUMJpH8LBFu078XYzCrykDVcIK-bbSo8AvIa1AJ6ouxBS6w-_-l7YoUvnpYSHlfG7UUp-sGc0ZVoUTBIiPoS6sOzjapTag6UQWBk7CY3CSVQNcGnc2yFhnr9u_5r0wwrnXMqCydeGzu3uyO3TIZESFK4a3YVmYKshafgajZ_WlhEtg3LD54Sov7dHFiOExwJjeEvcidKA6P5cz-dCTeLe9HZ0bVSt-oMR3QKU2ap9R7grSXFX2OmNT6CgN4JX2kclJ-a6Yd02Cw_hKJoUXfVhM8RzVkRsivjAoDHnXr4thsQjo_5Ew" --header "Content-Type: application/json" --insecure -L --request POST  --data '{"userName": "idm_udeg91cjhm", "givenName": "Peter", "sn": "Parker", "password": "T35!tr0c-k123", "telephoneNumber": "6669876987", "description": "IDM Test User", "roles": [], "mail": "idm_udeg91cjhm@forgerock.com"}' "https://openam-ema-perf-benchmark.forgeblocks.com/openidm/managed/alpha_user?_action=create"
2024-07-18 05:36:29,347 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:29,347 DEBUG   ---  status code  ---
2024-07-18 05:36:29,347 DEBUG   http status code is 201 (expected [200, 201])
2024-07-18 05:36:29,347 DEBUG   --- http response ---
2024-07-18 05:36:29,347 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (69 lines):
2024-07-18 05:36:29,347 DEBUG   ----- output -----
2024-07-18 05:36:29,348 DEBUG   {
2024-07-18 05:36:29,348 DEBUG       "_id": "823c74a6-dfe6-47f7-a088-536a99eb2e62",
2024-07-18 05:36:29,348 DEBUG       "_rev": "bf5d93ed-c626-40f7-9673-8dbab2520ddf-221",
2024-07-18 05:36:29,348 DEBUG       "country": null,
2024-07-18 05:36:29,348 DEBUG       "frUnindexedString1": null,
2024-07-18 05:36:29,348 DEBUG       "mail": "idm_udeg91cjhm@forgerock.com",
2024-07-18 05:36:29,348 DEBUG       "memberOfOrgIDs": [],
2024-07-18 05:36:29,348 DEBUG       "frIndexedDate5": null,
2024-07-18 05:36:29,348 DEBUG       "frUnindexedString2": null,
2024-07-18 05:36:29,348 DEBUG       "frIndexedDate4": null,
2024-07-18 05:36:29,348 DEBUG   
2024-07-18 05:36:29,348 DEBUG   
2024-07-18 05:36:29,348 DEBUG   
2024-07-18 05:36:29,348 DEBUG   [...]
2024-07-18 05:36:29,348 DEBUG   
2024-07-18 05:36:29,348 DEBUG   
2024-07-18 05:36:29,348 DEBUG   
2024-07-18 05:36:29,348 DEBUG       "sn": "Parker",
2024-07-18 05:36:29,348 DEBUG       "frUnindexedDate1": null,
2024-07-18 05:36:29,348 DEBUG       "frIndexedInteger5": null,
2024-07-18 05:36:29,348 DEBUG       "preferences": null,
2024-07-18 05:36:29,348 DEBUG       "userName": "idm_udeg91cjhm",
2024-07-18 05:36:29,348 DEBUG       "frIndexedDate2": null,
2024-07-18 05:36:29,348 DEBUG       "passwordLastChangedTime": "2024-07-18T05:36:29.025Z",
2024-07-18 05:36:29,348 DEBUG       "frIndexedDate1": null,
2024-07-18 05:36:29,348 DEBUG       "effectiveRoles": []
2024-07-18 05:36:29,348 DEBUG   }
2024-07-18 05:36:29,348 INFO    Query IDM to verify UserID 823c74a6-dfe6-47f7-a088-536a99eb2e62 is visible
2024-07-18 05:36:29,349 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-benchmark.forgeblocks.com/openidm/managed/alpha_user/823c74a6-dfe6-47f7-a088-536a99eb2e62"
2024-07-18 05:36:29,433 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:29,433 DEBUG   ---  status code  ---
2024-07-18 05:36:29,433 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:29,433 DEBUG   --- http response ---
2024-07-18 05:36:29,434 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (69 lines):
2024-07-18 05:36:29,434 DEBUG   ----- output -----
2024-07-18 05:36:29,434 DEBUG   {
2024-07-18 05:36:29,434 DEBUG       "_id": "823c74a6-dfe6-47f7-a088-536a99eb2e62",
2024-07-18 05:36:29,434 DEBUG       "_rev": "bf5d93ed-c626-40f7-9673-8dbab2520ddf-221",
2024-07-18 05:36:29,434 DEBUG       "country": null,
2024-07-18 05:36:29,434 DEBUG       "frUnindexedString1": null,
2024-07-18 05:36:29,434 DEBUG       "mail": "idm_udeg91cjhm@forgerock.com",
2024-07-18 05:36:29,434 DEBUG       "memberOfOrgIDs": [],
2024-07-18 05:36:29,434 DEBUG       "frIndexedDate5": null,
2024-07-18 05:36:29,434 DEBUG       "frUnindexedString2": null,
2024-07-18 05:36:29,434 DEBUG       "frIndexedDate4": null,
2024-07-18 05:36:29,434 DEBUG   
2024-07-18 05:36:29,434 DEBUG   
2024-07-18 05:36:29,434 DEBUG   
2024-07-18 05:36:29,434 DEBUG   [...]
2024-07-18 05:36:29,434 DEBUG   
2024-07-18 05:36:29,434 DEBUG   
2024-07-18 05:36:29,434 DEBUG   
2024-07-18 05:36:29,434 DEBUG       "sn": "Parker",
2024-07-18 05:36:29,434 DEBUG       "frUnindexedDate1": null,
2024-07-18 05:36:29,434 DEBUG       "frIndexedInteger5": null,
2024-07-18 05:36:29,434 DEBUG       "preferences": null,
2024-07-18 05:36:29,434 DEBUG       "userName": "idm_udeg91cjhm",
2024-07-18 05:36:29,434 DEBUG       "frIndexedDate2": null,
2024-07-18 05:36:29,434 DEBUG       "passwordLastChangedTime": "2024-07-18T05:36:29.025Z",
2024-07-18 05:36:29,434 DEBUG       "frIndexedDate1": null,
2024-07-18 05:36:29,435 DEBUG       "effectiveRoles": []
2024-07-18 05:36:29,435 DEBUG   }
2024-07-18 05:36:29,435 INFO    Authenticate as user idm_udeg91cjhm
2024-07-18 05:36:29,435 INFO    [http_cmd]: curl --insecure -L --request POST  "https://openam-ema-perf-benchmark.forgeblocks.com/openidm/authentication?_action=login"
2024-07-18 05:36:29,498 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:29,498 DEBUG   ---  status code  ---
2024-07-18 05:36:29,498 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:29,498 DEBUG   --- http response ---
2024-07-18 05:36:29,498 DEBUG   {
    "_id": "login",
    "authorization": {
        "id": "anonymous",
        "roles": [
            "internal/role/openidm-reg"
        ],
        "component": "internal/user"
    },
    "authenticationId": "anonymous"
}

2024-07-18 05:36:29,499 INFO    [http_cmd]: curl --insecure -L --request DELETE  "https://openam-ema-perf-benchmark.forgeblocks.com/openidm/managed/alpha_user/823c74a6-dfe6-47f7-a088-536a99eb2e62"
2024-07-18 05:36:29,701 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:29,701 DEBUG   ---  status code  ---
2024-07-18 05:36:29,701 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:29,701 DEBUG   --- http response ---
2024-07-18 05:36:29,701 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (69 lines):
2024-07-18 05:36:29,701 DEBUG   ----- output -----
2024-07-18 05:36:29,701 DEBUG   {
2024-07-18 05:36:29,701 DEBUG       "_id": "823c74a6-dfe6-47f7-a088-536a99eb2e62",
2024-07-18 05:36:29,701 DEBUG       "_rev": "bf5d93ed-c626-40f7-9673-8dbab2520ddf-221",
2024-07-18 05:36:29,701 DEBUG       "country": null,
2024-07-18 05:36:29,701 DEBUG       "frUnindexedString1": null,
2024-07-18 05:36:29,701 DEBUG       "mail": "idm_udeg91cjhm@forgerock.com",
2024-07-18 05:36:29,702 DEBUG       "memberOfOrgIDs": [],
2024-07-18 05:36:29,702 DEBUG       "frIndexedDate5": null,
2024-07-18 05:36:29,702 DEBUG       "frUnindexedString2": null,
2024-07-18 05:36:29,702 DEBUG       "frIndexedDate4": null,
2024-07-18 05:36:29,702 DEBUG   
2024-07-18 05:36:29,702 DEBUG   
2024-07-18 05:36:29,702 DEBUG   
2024-07-18 05:36:29,702 DEBUG   [...]
2024-07-18 05:36:29,702 DEBUG   
2024-07-18 05:36:29,702 DEBUG   
2024-07-18 05:36:29,702 DEBUG   
2024-07-18 05:36:29,702 DEBUG       "sn": "Parker",
2024-07-18 05:36:29,702 DEBUG       "frUnindexedDate1": null,
2024-07-18 05:36:29,702 DEBUG       "frIndexedInteger5": null,
2024-07-18 05:36:29,702 DEBUG       "preferences": null,
2024-07-18 05:36:29,702 DEBUG       "userName": "idm_udeg91cjhm",
2024-07-18 05:36:29,702 DEBUG       "frIndexedDate2": null,
2024-07-18 05:36:29,702 DEBUG       "passwordLastChangedTime": "2024-07-18T05:36:29.025Z",
2024-07-18 05:36:29,702 DEBUG       "frIndexedDate1": null,
2024-07-18 05:36:29,702 DEBUG       "effectiveRoles": []
2024-07-18 05:36:29,702 DEBUG   }
2024-07-18 05:36:29,703 INFO    
2024-07-18 05:36:29,703 INFO    ---------------------    Running CTSSTORE livecheck   ---------------------
2024-07-18 05:36:29,703 INFO    
2024-07-18 05:36:29,703 INFO    ---------------------   Running USERSTORE livecheck   ---------------------
2024-07-18 05:36:29,703 INFO    
2024-07-18 05:36:29,703 INFO    --------------------   Running PLATFORM-UI livecheck   --------------------
2024-07-18 05:36:29,703 INFO    Livecheck to https://openam-ema-perf-benchmark.forgeblocks.com/am/XUI
2024-07-18 05:36:29,703 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-benchmark.forgeblocks.com/am/XUI"
2024-07-18 05:36:29,803 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:29,803 DEBUG   ---  status code  ---
2024-07-18 05:36:29,803 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:29,803 DEBUG   --- http response ---
2024-07-18 05:36:29,803 DEBUG   <!doctype html><html lang="en"><head><meta charset="utf-8"/><meta http-equiv="X-UA-Compatible" content="IE=edge"/><meta name="viewport" content="width=device-width,initial-scale=1"/><link data-testid="favicon" id="favicon" rel="icon" href=""/><link rel="stylesheet" href="https://fonts.bunny.net/css2?family=Open+Sans:ital,wght@0,300;0,400;0,600;0,700;1,300;1,400;1,600;1,700&display=swap" integrity="sha256-oKbKpthrdL6iaDNVwyDW6+Y7j85zNJpkXZAtg0qUkpM=" crossorigin="anonymous"/><title>Login</title><script defer="defer" src="js/chunk-vendors.c2c83cac.js"></script><script defer="defer" src="js/app.37aac4e0.js"></script><link href="css/chunk-vendors.d2b307bd.css" rel="stylesheet"><link href="css/app.800690e3.css" rel="stylesheet"></head><body class="fr-body-image" data-testid="fr-body-image"><noscript><strong>We're sorry but login doesn't work properly without JavaScript enabled. Please enable it to continue.</strong></noscript><div id="appRoot" class="h-100"></div><div id="user-theme-script-container"></div></body></html>
[<Response [301]>]

2024-07-18 05:36:29,804 INFO    LIVECHECK SUCCEEDED
2024-07-18 05:36:29,804 INFO    
2024-07-18 05:36:29,804 INFO    ******************************   Initializing component pods for AM   ******************************
2024-07-18 05:36:29,804 INFO    
2024-07-18 05:36:29,804 INFO    -----------------------   Get AM software version   -----------------------
2024-07-18 05:36:29,804 INFO    Getting product version from https://openam-ema-perf-benchmark.forgeblocks.com/am/json/realms/alpha/serverinfo/version
2024-07-18 05:36:29,804 INFO    [LoginSession] Get "token_id" token for user "xiaosong.lou@forgerock.com"
2024-07-18 05:36:29,804 DEBUG   [LoginSession]		re-using "token_id" token that remains valid for 29m 48s
2024-07-18 05:36:29,805 INFO    [http_cmd]: curl --insecure -L --request GET --cookie "0e26551c0104b88=bjIwLQplJDzKA2IBOZ428Q09JyU.*AAJTSQACMDIAAlNLABxBZHRaRDNvYUJyR29CYjlzWUNyenZrWXZUdnc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*" --cookie "amlbcookie=01" "https://openam-ema-perf-benchmark.forgeblocks.com/am/json/realms/alpha/serverinfo/version"
2024-07-18 05:36:29,885 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:29,885 DEBUG   ---  status code  ---
2024-07-18 05:36:29,885 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:29,885 DEBUG   --- http response ---
2024-07-18 05:36:29,885 DEBUG   {
    "_id": "version",
    "_rev": "1157267696",
    "version": "7.6.0-SNAPSHOT",
    "fullVersion": "ForgeRock Access Management 7.6.0-SNAPSHOT Build 3044e8afddd78acfb775451f6053575b124e7cb3 (2024-June-25 16:54)",
    "revision": "3044e8afddd78acfb775451f6053575b124e7cb3",
    "date": "2024-June-25 16:54"
}

2024-07-18 05:36:29,886 INFO    
2024-07-18 05:36:29,886 INFO    *****************************    Initializing component pods for IDM   *****************************
2024-07-18 05:36:29,886 INFO    
2024-07-18 05:36:29,886 INFO    ----------------------    Get IDM software version   ----------------------
2024-07-18 05:36:29,886 INFO    Getting product version from https://openam-ema-perf-benchmark.forgeblocks.com/openidm/info/version
2024-07-18 05:36:29,886 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-benchmark.forgeblocks.com/openidm/info/version"
2024-07-18 05:36:29,948 INFO    [http_cmd]: http status code OK
2024-07-18 05:36:29,948 DEBUG   ---  status code  ---
2024-07-18 05:36:29,948 DEBUG   http status code is 200 (expected 200)
2024-07-18 05:36:29,948 DEBUG   --- http response ---
2024-07-18 05:36:29,948 DEBUG   {
    "_id": "version",
    "productVersion": "7.6.0-2024-4-2-SNAPSHOT",
    "productBuildDate": "20240623235642",
    "productRevision": "9c7bfd5cf8"
}

2024-07-18 05:36:29,948 INFO    
2024-07-18 05:36:29,949 INFO    ***************************   Initializing component pods for CTSSTORE   ***************************
2024-07-18 05:36:29,949 INFO    
2024-07-18 05:36:29,949 INFO    --------------------   Get CTSSTORE software version   --------------------
2024-07-18 05:36:29,949 WARNING Component ctsstore is not in Running state so impossible to get software version
2024-07-18 05:36:29,949 INFO    
2024-07-18 05:36:29,949 INFO    **************************    Initializing component pods for USERSTORE   **************************
2024-07-18 05:36:29,949 INFO    
2024-07-18 05:36:29,949 INFO    -------------------    Get USERSTORE software version   -------------------
2024-07-18 05:36:29,949 WARNING Component userstore is not in Running state so impossible to get software version
2024-07-18 05:36:29,949 INFO    
2024-07-18 05:36:29,949 INFO    *************************    Initializing component pods for PLATFORM-UI   *************************
2024-07-18 05:36:29,949 INFO    
2024-07-18 05:36:29,949 INFO    ------------------    Get PLATFORM-UI software version   ------------------
2024-07-18 05:36:29,949 INFO    Component platform-ui is running in tenant so impossible to get software version
2024-07-18 05:36:29 - INFO: Deployment ready
________________________________________________________________________________

[2024-07-18 05:36:29] Discover_IDC_tenant post : Post method
________________________________________________________________________________

Setting result to PASS
Task has been successfully stopped