--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-05-25 04:32:56] Discover_IDC_tenant pre : N/A
________________________________________________________________________________

[2024-05-25 04:32:56] - INFO: Timeout for this Task has changed to 16h (57600 seconds)
[2024-05-25 04:32:56] - INFO: timeout was set to Task default (2x global_duration or 300 seconds (whatever is higher)), because it was unset
________________________________________________________________________________

[2024-05-25 04:32:56] Discover_IDC_tenant step1 : N/A
________________________________________________________________________________

2024-05-25 04:32:56,922 INFO    Deployment was skipped.
2024-05-25 04:33:22,863 INFO    
2024-05-25 04:33:22,863 INFO    *************************************    Creating deployment   *************************************
2024-05-25 04:33:22,863 INFO    Creating IDC type deployment for stack
2024-05-25 04:33:22,864 WARNING the ema key/secret have not been provided so the tenant will be considered as static
2024-05-25 04:33:22,864 INFO    Consider that tenant under tests is static
2024-05-25 04:33:22,990 INFO    IDCDeployment context set to: gke_None_europe-west2_default
2024-05-25 04:33:22,990 INFO    
2024-05-25 04:33:22,991 INFO    [run_command]: kubectl config current-context
2024-05-25 04:33:23,069 INFO    [run_command]: OK (rc = 0 - expected to be in [0])
2024-05-25 04:33:23,069 DEBUG   --- stdout ---
2024-05-25 04:33:23,070 DEBUG   gke_engineeringpit_us-east1-d_xlou-cdm
2024-05-25 04:33:23,070 DEBUG   --- stderr ---
2024-05-25 04:33:23,070 DEBUG   
2024-05-25 04:33:23,070 INFO    
2024-05-25 04:33:23,070 INFO    Getting credentials for default cluster in None project located in europe-west2
2024-05-25 04:33:23,070 INFO    
2024-05-25 04:33:23,070 INFO    [run_command]: gcloud container clusters get-credentials default --zone europe-west2 --project None
2024-05-25 04:33:24,577 ERROR   [run_command]: ERROR
2024-05-25 04:33:24,577 ERROR   --- rc ---
2024-05-25 04:33:24,577 ERROR   returned 1, expected to be in [0]
2024-05-25 04:33:24,577 ERROR   --- stdout ---
2024-05-25 04:33:24,577 ERROR   
2024-05-25 04:33:24,578 ERROR   --- stderr ---
2024-05-25 04:33:24,578 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-05-25 04:33:24,578 INFO    
2024-05-25 04:33:24,578 INFO    Reverting context back to gke_engineeringpit_us-east1-d_xlou-cdm
2024-05-25 04:33:24,578 INFO    
2024-05-25 04:33:24,578 INFO    [loop_until]: kubectl config use-context gke_engineeringpit_us-east1-d_xlou-cdm
2024-05-25 04:33:24,578 INFO    [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-05-25 04:33:24,706 INFO    [loop_until]: OK (rc = 0)
2024-05-25 04:33:24,707 DEBUG   --- stdout ---
2024-05-25 04:33:24,707 DEBUG   Switched to context "gke_engineeringpit_us-east1-d_xlou-cdm".
2024-05-25 04:33:24,707 DEBUG   --- stderr ---
2024-05-25 04:33:24,707 DEBUG   
2024-05-25 04:33:24,707 WARNING unable to retrieve the context for the tenant: ema-perf-3580 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-05-25 04:33:24,707 INFO    
2024-05-25 04:33:24,707 INFO    ***************************    Livecheck stage: After tenant discovery   ***************************
2024-05-25 04:33:24,708 INFO    
2024-05-25 04:33:24,708 INFO    ------------------------    Running AM livecheck   ------------------------
2024-05-25 04:33:24,708 INFO    Livecheck to https://openam-ema-perf-3580.forgeblocks.com/am/json/health/ready
2024-05-25 04:33:24,709 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-3580.forgeblocks.com/am/json/health/ready"
2024-05-25 04:33:24,859 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:24,859 DEBUG   ---  status code  ---
2024-05-25 04:33:24,859 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:24,859 DEBUG   --- http response ---
2024-05-25 04:33:24,859 DEBUG   

2024-05-25 04:33:24,860 INFO    
2024-05-25 04:33:24,860 INFO    ------------------------   Running IDM livecheck   ------------------------
2024-05-25 04:33:24,860 INFO    Livecheck to https://openam-ema-perf-3580.forgeblocks.com/openidm/info/ping
2024-05-25 04:33:24,861 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-3580.forgeblocks.com/openidm/info/ping"
2024-05-25 04:33:24,945 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:24,945 DEBUG   ---  status code  ---
2024-05-25 04:33:24,945 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:24,945 DEBUG   --- http response ---
2024-05-25 04:33:24,946 DEBUG   {
    "_id": "",
    "_rev": "",
    "shortDesc": "OpenIDM ready",
    "state": "ACTIVE_READY"
}

2024-05-25 04:33:24,946 INFO    Create new LoginSession for user "xiaosong.lou@forgerock.com"
2024-05-25 04:33:24,946 INFO    [LoginSession] Get "access_token" token for user "xiaosong.lou@forgerock.com"
2024-05-25 04:33:24,946 INFO    [LoginSession] Obtaining new "access_token" token from server because it was not obtained yet for the user
2024-05-25 04:33:24,946 INFO    [LoginSession] Get "token_id" token for user "xiaosong.lou@forgerock.com"
2024-05-25 04:33:24,946 INFO    [LoginSession] Obtaining new "token_id" token from server because it was not obtained yet for the user
2024-05-25 04:33:24,946 INFO    Authenticate user xiaosong.lou@forgerock.com via REST
2024-05-25 04:33:24,946 INFO    [http_cmd]: curl --insecure -L --request POST  "https://openam-ema-perf-3580.forgeblocks.com/am/json/authenticate?realm=/"
2024-05-25 04:33:26,215 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:26,215 DEBUG   ---  status code  ---
2024-05-25 04:33:26,216 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:26,216 DEBUG   --- http response ---
2024-05-25 04:33:26,216 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (83 lines):
2024-05-25 04:33:26,216 DEBUG   ----- output -----
2024-05-25 04:33:26,216 DEBUG   {
2024-05-25 04:33:26,216 DEBUG       "authId": "eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJvdGsiOiJtaGViMjM4bnM4MmlyZm91ZHJscm9iM2RoaSIsInJlYWxtIjoiLyIsInNlc3Npb25JZCI6IipBQUpUU1FBQ01ESUFCSFI1Y0dVQUNFcFhWRjlCVlZSSUFBSlRNUUFDTURFLipleUowZVhBaU9pSktWMVFpTENKamRIa2lPaUpLVjFRaUxDSmhiR2NpT2lKSVV6STFOaUo5LlpYbEtNR1ZZUVdsUGFVcExWakZSYVV4RFNteGliVTFwVDJsS1FrMVVTVFJSTUVwRVRGVm9WRTFxVlRKSmFYZHBXVmQ0YmtscWIybGFSMng1U1c0d0xpNVVUMDlYTWxjeU1VSTVhbFkwUlZWT2EzbzJXV1ozTGtaTGVURm9OV2R2TFZwbVprMVlVRGx2UVdSeE0zRlRXaTFUUjFKRFYxQmplbXB0TFRJd1QzWTFTWEJVTFU5VlJESlVPWFpUT0hwcVFVRk5ieTFOTFZobk4wSndMVzFMYXpSc1NUUlFlRzFIUjFGTGJEQmpURWRYU1VaVVQzTlhUV2xJZDJOcE1WQm5jMWhwWW5kalRXMTJkSE51ZEVoUGFsUXpkMkZTWlhwd1NubzFhMGRvTUdnMVJIY3daRnB1Vmw5aWFXTnVPR2QzTkVKblVYcEVYMDlNVEVkMGJEaGpOR2RTUVVSUllXSnVOSE5IWHpJemRVNUVMV2xDU0dwb2JXVTRWazkwTURkRU0xQkRWMVJNVTNSbmNEbHJiV3BRZEd3eVdIaHhZMUZMVlhZeVkxWk1ZMEZJT0ZGYVZtWmhTSEp1TlZsMFpHbzNjR0kxV1RoUmFsbGljQzAzY0VoTVR6bFpVMjlJZFROeWJFRTJSamhZUWtZNGRrbEtlVmhNUm5jeVp6STFMWGQyZW0xbWNpMVFPRGxFY1VvMFoxTmthbWxPUlZNMFNFRlllRkprWDNoQlQyVkRhRmwxUnkxSVlVOTRla1JpWm5GbE5UVTFZakpRU2xCRU9UWk9TV0pYUzJFelZ5MUljVTlXU0ZkdFRraEJUbVkwTWswMFlVOWlXbkJVU0dwTGVVOVZhekF0YUVWS1JuQkhlRm94TkVwclJrMVJZVEZFV201SGVHUnFabDh0ZWtWeGRucHNXblpHVlZobWNrNVhhVmhTU214VE1tUkpVMWxMYzNsMVMzQnhPV0ZWYTB4d1dHVk1iMHh0Y1VkNmVuQXlka1JsVDNwelNuUlJYM3BrUkdWS1kxRnFlRm8yTFVwRFQxQkJNek5STWxaUU1tOWFNRzVTVkdsalFqbDBXSGMwVURacmNVUnJhVmczYjJrMVlUQk5PRkUyVUhNelNWVTVNM1ZOU2tkb1oxVkZZbkozVGsxQmEyMUxlWFJSTVV4SFIwcHVSR053TVVaMk9WTlZkamQwYjA5a1RpMVBSalpUZFZOb1pHVXljVUUyTVVSc2JuSkVkRWhRV2t0TU5tSlFUekI2VGxoeVNUSlpNelkyVGs1aVkzQllVRzlyTUVONlZYZHVUMjlhT1VjNFJXMW5jM2RzVTFkdGJFTm5ORmt6VlVkemNrRm1WMEpDVFhCNlowbE5TRUpETmxaclJuZDNYMjFNUmpJeWMxUXpMWFZCWVRCbGFIZDRlR0ZxTVZsYWJITnRWVUUzVlROWVYwSlBhV3QzY0RGT1FsUlpOa2xIVjFsSFpGOTRPVzFhYURsUloyTk9VSEJvWlVvNGNrTkJWa052Ym1GTWRtcHVkVEpWZEhkUVpYaGtNVXBWVVhSNWRHTlVWRVF5UlhGeGFuSjRaazAyWTNnNGRUWkhNMDFtTVVGb1YybEZVWEpuU2xOblRVdENjVU5pZWxoRWJXcDRTV2xUV1dOMmMxazVTM0JsZFdKVVFqbEtZVWh3V1ZSclRHVTNWVEZQVGxsRFdqaGhTMHN0UlcwMlJ6QkZiRVZSWkZkV1NtVXhWbnBqU2xSUGJYcEtNV2g2TmtsS00zTmlNa3BuYW1GQ01ETktVekpaZERsQldrcFdPRXRHUkRGSk5FRmZSM00yTURndFJ6VlBkbnBJYTBWa1gza3lXa1p4YWpOWWJXbEdhelY1T1d4UmFGbGpjRFZLWDA4eVRGTjVRV2h6VFZneFIza3hSVzFWYkdSamFGTmZjMnhtWlVkd2IwdEdVR013Tmtnd1kybFhWR1JhV1dKa01UQlJMWEphTFZwcmIzQXRNRkYyVTFCUmFYcGthRFZrZFRSWU1rVlROSE5TZUhGU1lYSlBOR1pmV0VwRmNFSm1kV2t3TFVwYWRtZFZNRFJVYUZSSFNHUTVNR3c1VDBwRlJHOUtjMHhSTTI5d01sZG1aRGRpZEcwNE5HVnhVakJ4VjJaVlZWZHlOVU5DYlMwd1ZETXphR2huV2tOYU0yd3dhekpZWW1KUGNsWmhZa3c1ZWtGWlVWRmlPWEUxTXpWQk9FRjNkVEpsY0ZBMWRGVnRVbnB2ZGs0MGIyUnJaekppUjFWRVlrMHdZbDlPWDA4eVZVVlVRMDV0VFRWcVoyWnlVMFJtWkY5cFowMW9ZMnc1YUhwd2JVZDJZMkZGZVhWeFh6RjFZVTlPVjJkU09VTm1kbFIwZGxKbE9EWmhjWEIxYUdwdWFuZHhVamQ0TVZCWlVFVk9ZVTFqV25WSVdrc3dkV055YUhGNE9IUXphMUoyWW1sNmMzYzNMV1pHT0hSemIwWlVWa3REUnpCNE1VcFVWV0pLVjA1R2RWSkNVMWRxTmtaUkxWWnZTMEUxWHpsdVF6QjNURGN0ZUZaclZYVkpXakJ2YzJKc1ZXUkxiblV6Y1VkcU0xcFZSekpCUm5oU1VGRjJPVWRyTlVwSWJraDNWM04wY1ZoNlVWZE1WREp1Y0hsMVkxbEpNRVIyTWtkMGFITlRjRVZWTjBKeU4za3hSSHBZYzJac1FrbFFNVGx5WmpRdFRFUk5SVTF2WlVsRU4wMVpkR2wxTlU1bGEwVnFYM1paVkVobldrMXBPVEpWZVhnM2NYTlNRVlpaWmtKT1RtNVVhakZaY25KWWVXWldTMHBZUzJKNFUwWjFUMGc1VjBSQ1luZDZWSEF5ZEV4SVVrTnZOamRHVm0xU1lUVmlRMUJxV2pkM2VYVTNSbEExZVVnMWFISnhORzlPT0VGdFoxbFBaR1ZZTjBGZmRISkNTWHBGWjNSNExVNXdZbUpoT0VFdFN5MVpUbEoyYUV4WWFGcGpMWEl1YTFkemExWlVaVEJZYUdrNU1sWkRWbEZPVkhWb1VRLmF5RzJGYXBPUERZOXpxOHkxT1h4cFJpVGJaQjNLY3Q4Q2MwRmJEWVNmcWsiLCJleHAiOjE3MTY2OTgwMDYsImlhdCI6MTcxNjYxMTYwNn0.J9RHqwBLglAqBGfeNjrKoMYW98GErERgQFp7fDEYDI8",
2024-05-25 04:33:26,216 DEBUG       "callbacks": [
2024-05-25 04:33:26,216 DEBUG           {
2024-05-25 04:33:26,216 DEBUG               "type": "TextOutputCallback",
2024-05-25 04:33:26,216 DEBUG               "output": [
2024-05-25 04:33:26,216 DEBUG                   {
2024-05-25 04:33:26,216 DEBUG                       "name": "message",
2024-05-25 04:33:26,216 DEBUG                       "value": "Loading..."
2024-05-25 04:33:26,216 DEBUG                   },
2024-05-25 04:33:26,216 DEBUG   
2024-05-25 04:33:26,216 DEBUG   
2024-05-25 04:33:26,216 DEBUG   
2024-05-25 04:33:26,216 DEBUG   [...]
2024-05-25 04:33:26,216 DEBUG   
2024-05-25 04:33:26,217 DEBUG   
2024-05-25 04:33:26,217 DEBUG   
2024-05-25 04:33:26,217 DEBUG                       "value": "var setupPage = function() {  var skipInputElem = document.getElementById(\"skip-input-806\");  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-806' 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-806\").onclick = function() {      skipInputElem.value = \"Skip\";      document.getElementById(\"loginButton_0\").click();      return false;    };  };  setTimeout(bindSkipLink, 100);};setupPage();"
2024-05-25 04:33:26,217 DEBUG                   },
2024-05-25 04:33:26,217 DEBUG                   {
2024-05-25 04:33:26,217 DEBUG                       "name": "messageType",
2024-05-25 04:33:26,217 DEBUG                       "value": "4"
2024-05-25 04:33:26,217 DEBUG                   }
2024-05-25 04:33:26,217 DEBUG               ]
2024-05-25 04:33:26,217 DEBUG           }
2024-05-25 04:33:26,217 DEBUG       ]
2024-05-25 04:33:26,217 DEBUG   }
2024-05-25 04:33:26,218 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.eyJvdGsiOiJtaGViMjM4bnM4MmlyZm91ZHJscm9iM2RoaSIsInJlYWxtIjoiLyIsInNlc3Npb25JZCI6IipBQUpUU1FBQ01ESUFCSFI1Y0dVQUNFcFhWRjlCVlZSSUFBSlRNUUFDTURFLipleUowZVhBaU9pSktWMVFpTENKamRIa2lPaUpLVjFRaUxDSmhiR2NpT2lKSVV6STFOaUo5LlpYbEtNR1ZZUVdsUGFVcExWakZSYVV4RFNteGliVTFwVDJsS1FrMVVTVFJSTUVwRVRGVm9WRTFxVlRKSmFYZHBXVmQ0YmtscWIybGFSMng1U1c0d0xpNVVUMDlYTWxjeU1VSTVhbFkwUlZWT2EzbzJXV1ozTGtaTGVURm9OV2R2TFZwbVprMVlVRGx2UVdSeE0zRlRXaTFUUjFKRFYxQmplbXB0TFRJd1QzWTFTWEJVTFU5VlJESlVPWFpUT0hwcVFVRk5ieTFOTFZobk4wSndMVzFMYXpSc1NUUlFlRzFIUjFGTGJEQmpURWRYU1VaVVQzTlhUV2xJZDJOcE1WQm5jMWhwWW5kalRXMTJkSE51ZEVoUGFsUXpkMkZTWlhwd1NubzFhMGRvTUdnMVJIY3daRnB1Vmw5aWFXTnVPR2QzTkVKblVYcEVYMDlNVEVkMGJEaGpOR2RTUVVSUllXSnVOSE5IWHpJemRVNUVMV2xDU0dwb2JXVTRWazkwTURkRU0xQkRWMVJNVTNSbmNEbHJiV3BRZEd3eVdIaHhZMUZMVlhZeVkxWk1ZMEZJT0ZGYVZtWmhTSEp1TlZsMFpHbzNjR0kxV1RoUmFsbGljQzAzY0VoTVR6bFpVMjlJZFROeWJFRTJSamhZUWtZNGRrbEtlVmhNUm5jeVp6STFMWGQyZW0xbWNpMVFPRGxFY1VvMFoxTmthbWxPUlZNMFNFRlllRkprWDNoQlQyVkRhRmwxUnkxSVlVOTRla1JpWm5GbE5UVTFZakpRU2xCRU9UWk9TV0pYUzJFelZ5MUljVTlXU0ZkdFRraEJUbVkwTWswMFlVOWlXbkJVU0dwTGVVOVZhekF0YUVWS1JuQkhlRm94TkVwclJrMVJZVEZFV201SGVHUnFabDh0ZWtWeGRucHNXblpHVlZobWNrNVhhVmhTU214VE1tUkpVMWxMYzNsMVMzQnhPV0ZWYTB4d1dHVk1iMHh0Y1VkNmVuQXlka1JsVDNwelNuUlJYM3BrUkdWS1kxRnFlRm8yTFVwRFQxQkJNek5STWxaUU1tOWFNRzVTVkdsalFqbDBXSGMwVURacmNVUnJhVmczYjJrMVlUQk5PRkUyVUhNelNWVTVNM1ZOU2tkb1oxVkZZbkozVGsxQmEyMUxlWFJSTVV4SFIwcHVSR053TVVaMk9WTlZkamQwYjA5a1RpMVBSalpUZFZOb1pHVXljVUUyTVVSc2JuSkVkRWhRV2t0TU5tSlFUekI2VGxoeVNUSlpNelkyVGs1aVkzQllVRzlyTUVONlZYZHVUMjlhT1VjNFJXMW5jM2RzVTFkdGJFTm5ORmt6VlVkemNrRm1WMEpDVFhCNlowbE5TRUpETmxaclJuZDNYMjFNUmpJeWMxUXpMWFZCWVRCbGFIZDRlR0ZxTVZsYWJITnRWVUUzVlROWVYwSlBhV3QzY0RGT1FsUlpOa2xIVjFsSFpGOTRPVzFhYURsUloyTk9VSEJvWlVvNGNrTkJWa052Ym1GTWRtcHVkVEpWZEhkUVpYaGtNVXBWVVhSNWRHTlVWRVF5UlhGeGFuSjRaazAyWTNnNGRUWkhNMDFtTVVGb1YybEZVWEpuU2xOblRVdENjVU5pZWxoRWJXcDRTV2xUV1dOMmMxazVTM0JsZFdKVVFqbEtZVWh3V1ZSclRHVTNWVEZQVGxsRFdqaGhTMHN0UlcwMlJ6QkZiRVZSWkZkV1NtVXhWbnBqU2xSUGJYcEtNV2g2TmtsS00zTmlNa3BuYW1GQ01ETktVekpaZERsQldrcFdPRXRHUkRGSk5FRmZSM00yTURndFJ6VlBkbnBJYTBWa1gza3lXa1p4YWpOWWJXbEdhelY1T1d4UmFGbGpjRFZLWDA4eVRGTjVRV2h6VFZneFIza3hSVzFWYkdSamFGTmZjMnhtWlVkd2IwdEdVR013Tmtnd1kybFhWR1JhV1dKa01UQlJMWEphTFZwcmIzQXRNRkYyVTFCUmFYcGthRFZrZFRSWU1rVlROSE5TZUhGU1lYSlBOR1pmV0VwRmNFSm1kV2t3TFVwYWRtZFZNRFJVYUZSSFNHUTVNR3c1VDBwRlJHOUtjMHhSTTI5d01sZG1aRGRpZEcwNE5HVnhVakJ4VjJaVlZWZHlOVU5DYlMwd1ZETXphR2huV2tOYU0yd3dhekpZWW1KUGNsWmhZa3c1ZWtGWlVWRmlPWEUxTXpWQk9FRjNkVEpsY0ZBMWRGVnRVbnB2ZGs0MGIyUnJaekppUjFWRVlrMHdZbDlPWDA4eVZVVlVRMDV0VFRWcVoyWnlVMFJtWkY5cFowMW9ZMnc1YUhwd2JVZDJZMkZGZVhWeFh6RjFZVTlPVjJkU09VTm1kbFIwZGxKbE9EWmhjWEIxYUdwdWFuZHhVamQ0TVZCWlVFVk9ZVTFqV25WSVdrc3dkV055YUhGNE9IUXphMUoyWW1sNmMzYzNMV1pHT0hSemIwWlVWa3REUnpCNE1VcFVWV0pLVjA1R2RWSkNVMWRxTmtaUkxWWnZTMEUxWHpsdVF6QjNURGN0ZUZaclZYVkpXakJ2YzJKc1ZXUkxiblV6Y1VkcU0xcFZSekpCUm5oU1VGRjJPVWRyTlVwSWJraDNWM04wY1ZoNlVWZE1WREp1Y0hsMVkxbEpNRVIyTWtkMGFITlRjRVZWTjBKeU4za3hSSHBZYzJac1FrbFFNVGx5WmpRdFRFUk5SVTF2WlVsRU4wMVpkR2wxTlU1bGEwVnFYM1paVkVobldrMXBPVEpWZVhnM2NYTlNRVlpaWmtKT1RtNVVhakZaY25KWWVXWldTMHBZUzJKNFUwWjFUMGc1VjBSQ1luZDZWSEF5ZEV4SVVrTnZOamRHVm0xU1lUVmlRMUJxV2pkM2VYVTNSbEExZVVnMWFISnhORzlPT0VGdFoxbFBaR1ZZTjBGZmRISkNTWHBGWjNSNExVNXdZbUpoT0VFdFN5MVpUbEoyYUV4WWFGcGpMWEl1YTFkemExWlVaVEJZYUdrNU1sWkRWbEZPVkhWb1VRLmF5RzJGYXBPUERZOXpxOHkxT1h4cFJpVGJaQjNLY3Q4Q2MwRmJEWVNmcWsiLCJleHAiOjE3MTY2OTgwMDYsImlhdCI6MTcxNjYxMTYwNn0.J9RHqwBLglAqBGfeNjrKoMYW98GErERgQFp7fDEYDI8", "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-806"}], "input": [{"name": "IDToken3", "value": "Skip"}]}, {"type": "TextOutputCallback", "output": [{"name": "message", "value": "var setupPage = function() {  var skipInputElem = document.getElementById(\"skip-input-806\");  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-806' 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-806\").onclick = function() {      skipInputElem.value = \"Skip\";      document.getElementById(\"loginButton_0\").click();      return false;    };  };  setTimeout(bindSkipLink, 100);};setupPage();"}, {"name": "messageType", "value": "4"}]}]}' "https://openam-ema-perf-3580.forgeblocks.com/am/json/authenticate?realm=/"
2024-05-25 04:33:26,504 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:26,505 DEBUG   ---  status code  ---
2024-05-25 04:33:26,505 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:26,505 DEBUG   --- http response ---
2024-05-25 04:33:26,505 DEBUG   {
    "tokenId": "Qslwv-qQrmEnO_yMdl-FOXRc_HQ.*AAJTSQACMDIAAlNLABxCa3ZkQmFwMWxSTUZjL0lMalVibVZhT1U2aHc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*",
    "successUrl": "/platform",
    "realm": "/"
}

2024-05-25 04:33:26,505 INFO    [LoginSession] Obtaining session info
2024-05-25 04:33:26,506 INFO    [http_cmd]: curl --insecure -L --request POST  "https://openam-ema-perf-3580.forgeblocks.com/am/json/sessions?_action=getSessionInfo"
2024-05-25 04:33:26,736 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:26,736 DEBUG   ---  status code  ---
2024-05-25 04:33:26,736 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:26,736 DEBUG   --- http response ---
2024-05-25 04:33:26,736 DEBUG   {
    "username": "9025fb94-4580-4ea9-9de6-75692e16cfe5",
    "universalId": "id=9025fb94-4580-4ea9-9de6-75692e16cfe5,ou=user,ou=am-config",
    "realm": "/",
    "latestAccessTime": "2024-05-25T04:33:26Z",
    "maxIdleExpirationTime": "2024-05-25T05:03:26Z",
    "maxSessionExpirationTime": "2024-05-25T06:33:25Z",
    "properties": {
        "AMCtxId": "776ae73c-6f7d-4950-922d-51bf4d921f97-930"
    }
}

2024-05-25 04:33:26,738 INFO    Obtain Oauth2 authz code via REST with PKCE flow
2024-05-25 04:33:26,738 DEBUG   Oauth2 authorize for access token
2024-05-25 04:33:26,739 INFO    [http_cmd]: curl --insecure --request POST --cookie "9537f3c44bdb077=Qslwv-qQrmEnO_yMdl-FOXRc_HQ.*AAJTSQACMDIAAlNLABxCa3ZkQmFwMWxSTUZjL0lMalVibVZhT1U2aHc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*" --cookie "amlbcookie=01" --data '{"decision": "Allow", "csrf": "Qslwv-qQrmEnO_yMdl-FOXRc_HQ.*AAJTSQACMDIAAlNLABxCa3ZkQmFwMWxSTUZjL0lMalVibVZhT1U2aHc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*"}' "https://openam-ema-perf-3580.forgeblocks.com/am/oauth2/authorize?client_id=idmAdminClient&scope=openid fr:idm:*&redirect_uri=https://openam-ema-perf-3580.forgeblocks.com/platform/appAuthHelperRedirect.html&response_type=code&realm=/&code_challenge=H8VHP73pYVOJ0f7Y9lG3J5DU3gjTBCElj1L3LM6FgO&code_challenge_method=plain"
2024-05-25 04:33:27,044 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:27,044 DEBUG   ---  status code  ---
2024-05-25 04:33:27,044 DEBUG   http status code is 302 (expected 302)
2024-05-25 04:33:27,044 DEBUG   --- http response ---
2024-05-25 04:33:27,045 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-3580.forgeblocks.com/platform/appAuthHelperRedirect.html?code=WHDGS4u2eELaeDkdd_rE35lW17k&iss=https%3A%2F%2Fopenam-ema-perf-3580.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-3580.forgeblocks.com; Secure; HttpOnly; SameSite=none', 'content-length': '0', 'date': 'Sat, 25 May 2024 04:33:26 GMT', 'x-forgerock-transactionid': '37bf148f-0ad3-440a-8289-39b1579f1c0e', '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-05-25 04:33:27,045 DEBUG   Oauth2 exchange authorize code for access token
2024-05-25 04:33:27,045 INFO    [http_cmd]: curl --insecure -L --request POST  --data '{"grant_type": "authorization_code", "redirect_uri": "https://openam-ema-perf-3580.forgeblocks.com/platform/appAuthHelperRedirect.html", "client_id": "idmAdminClient", "code": "WHDGS4u2eELaeDkdd_rE35lW17k", "code_verifier": "H8VHP73pYVOJ0f7Y9lG3J5DU3gjTBCElj1L3LM6FgO"}' "https://openam-ema-perf-3580.forgeblocks.com/am/oauth2/access_token?realm=/"
2024-05-25 04:33:27,216 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:27,216 DEBUG   ---  status code  ---
2024-05-25 04:33:27,217 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:27,217 DEBUG   --- http response ---
2024-05-25 04:33:27,217 DEBUG   {
    "access_token": "eyJ0eXAiOiJKV1QiLCJraWQiOiJVU3FVTFh6UitmbmFXWklJWSt0cGw1Y1NBMU09IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiI5MDI1ZmI5NC00NTgwLTRlYTktOWRlNi03NTY5MmUxNmNmZTUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNzc2YWU3M2MtNmY3ZC00OTUwLTkyMmQtNTFiZjRkOTIxZjk3LTEwNDMiLCJzdWJuYW1lIjoiOTAyNWZiOTQtNDU4MC00ZWE5LTlkZTYtNzU2OTJlMTZjZmU1IiwiaXNzIjoiaHR0cHM6Ly9vcGVuYW0tZW1hLXBlcmYtMzU4MC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMiIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6IkstRGFEU3plejV2a285ZERlNDhhV0hzbGpaWSIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzE2NjExNjA3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzE2NjExNjA2LCJyZWFsbSI6Ii8iLCJleHAiOjE3MTY2MTUyMDcsImlhdCI6MTcxNjYxMTYwNywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiZXZtY3ZLZVRYYTNtLXQ1NkdxSXdwaXVHRThrIn0.f_ABt3kvWeaEJkiJ7XZOFS3Ck8NK_a-pXL3heINxjhax9FFqFMgLeecao0L7k3lxoBc7Khz5xdbLri7GqZiFnWbhMreZTwQCR3nnSDjvRUoNMYH86DEoK5eJwAnN8YSDcSwVz-qe_lQuEBW6S5pasrmIdOVo5tceP9Y-8K9Dmxx5DanAQJflgRCmgupdP99hG6up8U__g8mNfI2XBmjEGgtChNHlvnNS07RXC0XBRj7sQGfJhNc08Q3mpR12RbxRkjC7p-Zusb6ESZYWz2k90VqevGzh52RabkG2KswZ0O8WMa5s6h8U7EcIR6v27CJr_yWpgGvEnL-dqmjz05Kfyw",
    "scope": "openid fr:idm:*",
    "id_token": "eyJ0eXAiOiJKV1QiLCJraWQiOiJVU3FVTFh6UitmbmFXWklJWSt0cGw1Y1NBMU09IiwiYWxnIjoiUlMyNTYifQ.eyJhdF9oYXNoIjoiZDM0STNkWWpUclhVLXhLQTlOZ19vdyIsInN1YiI6IjkwMjVmYjk0LTQ1ODAtNGVhOS05ZGU2LTc1NjkyZTE2Y2ZlNSIsImF1ZGl0VHJhY2tpbmdJZCI6Ijc3NmFlNzNjLTZmN2QtNDk1MC05MjJkLTUxYmY0ZDkyMWY5Ny0xMDQ2Iiwic3VibmFtZSI6IjkwMjVmYjk0LTQ1ODAtNGVhOS05ZGU2LTc1NjkyZTE2Y2ZlNSIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLWVtYS1wZXJmLTM1ODAuZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJpZF90b2tlbiIsInNpZCI6IlNIclBPd09ucXJYNHZTcm9FUGJBL25zVVJUUTJ2cUVUVXZSTFREZ1J6dU09IiwiYXVkIjoiaWRtQWRtaW5DbGllbnQiLCJjX2hhc2giOiJ0LS1CM3FwUVZxRUJFa1VnbDdHaDlBIiwiYWNyIjoiMCIsIm9yZy5mb3JnZXJvY2sub3BlbmlkY29ubmVjdC5vcHMiOiIteHlKcG1FSkc0SkFLYnJDb2RvcFpaQ3gtVFEiLCJhenAiOiJpZG1BZG1pbkNsaWVudCIsImF1dGhfdGltZSI6MTcxNjYxMTYwNiwicmVhbG0iOiIvIiwiZXhwIjoxNzE2NjE1MjA3LCJ0b2tlblR5cGUiOiJKV1RUb2tlbiIsImlhdCI6MTcxNjYxMTYwN30.mu2UqPZi-RoNG9Qw04pNLHzxPFNyn75gT0Mny5rYUrXEIaVBVjraK2bWWhwf4ku78nfiwleyLeuvfJv7GaPw9f6vZyFiwaytkD5gm28ojI6juZR37n4DFXqY67P6fx4sqiiUaZ6Yx9s7oyLZmEv6sxj4g1SQVyw57gMbcvd0iPvOcYeRm7KDiVLRl1h4pIOFamwd4c-KTQRbIYmh9P-wZRl-4yF3K0jUkI5WMk2lD1JRoPkFGDNcenxuxHc8uIummN54qsndKoQniAbto98dMTIUfuMhPQxxYjy3Rgz1-tQcn6g63qiwo6ap-Nc7OckYph_Le4iDpt1KTRR1WClcSw",
    "token_type": "Bearer",
    "expires_in": 3599
}

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

2024-05-25 04:33:27,338 INFO    Try to create, query and delete a user
2024-05-25 04:33:27,338 INFO    Create user idm_gz7w8zmz4e in IDM
2024-05-25 04:33:27,338 INFO    [http_cmd]: curl --header "Authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiJVU3FVTFh6UitmbmFXWklJWSt0cGw1Y1NBMU09IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiI5MDI1ZmI5NC00NTgwLTRlYTktOWRlNi03NTY5MmUxNmNmZTUiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNzc2YWU3M2MtNmY3ZC00OTUwLTkyMmQtNTFiZjRkOTIxZjk3LTEwNDMiLCJzdWJuYW1lIjoiOTAyNWZiOTQtNDU4MC00ZWE5LTlkZTYtNzU2OTJlMTZjZmU1IiwiaXNzIjoiaHR0cHM6Ly9vcGVuYW0tZW1hLXBlcmYtMzU4MC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMiIsInRva2VuTmFtZSI6ImFjY2Vzc190b2tlbiIsInRva2VuX3R5cGUiOiJCZWFyZXIiLCJhdXRoR3JhbnRJZCI6IkstRGFEU3plejV2a285ZERlNDhhV0hzbGpaWSIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzE2NjExNjA3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzE2NjExNjA2LCJyZWFsbSI6Ii8iLCJleHAiOjE3MTY2MTUyMDcsImlhdCI6MTcxNjYxMTYwNywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiZXZtY3ZLZVRYYTNtLXQ1NkdxSXdwaXVHRThrIn0.f_ABt3kvWeaEJkiJ7XZOFS3Ck8NK_a-pXL3heINxjhax9FFqFMgLeecao0L7k3lxoBc7Khz5xdbLri7GqZiFnWbhMreZTwQCR3nnSDjvRUoNMYH86DEoK5eJwAnN8YSDcSwVz-qe_lQuEBW6S5pasrmIdOVo5tceP9Y-8K9Dmxx5DanAQJflgRCmgupdP99hG6up8U__g8mNfI2XBmjEGgtChNHlvnNS07RXC0XBRj7sQGfJhNc08Q3mpR12RbxRkjC7p-Zusb6ESZYWz2k90VqevGzh52RabkG2KswZ0O8WMa5s6h8U7EcIR6v27CJr_yWpgGvEnL-dqmjz05Kfyw" --header "Content-Type: application/json" --insecure -L --request POST  --data '{"userName": "idm_gz7w8zmz4e", "givenName": "Peter", "sn": "Parker", "password": "T35!tr0c-k123", "telephoneNumber": "6669876987", "description": "IDM Test User", "roles": [], "mail": "idm_gz7w8zmz4e@forgerock.com"}' "https://openam-ema-perf-3580.forgeblocks.com/openidm/managed/alpha_user?_action=create"
2024-05-25 04:33:27,631 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:27,632 DEBUG   ---  status code  ---
2024-05-25 04:33:27,632 DEBUG   http status code is 201 (expected [200, 201])
2024-05-25 04:33:27,632 DEBUG   --- http response ---
2024-05-25 04:33:27,632 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (69 lines):
2024-05-25 04:33:27,632 DEBUG   ----- output -----
2024-05-25 04:33:27,632 DEBUG   {
2024-05-25 04:33:27,632 DEBUG       "_id": "895e7846-1a45-43f7-b18e-a1cd45915e13",
2024-05-25 04:33:27,632 DEBUG       "_rev": "1d1896b6-ecfc-4c50-9668-ec11afd47b38-13198857",
2024-05-25 04:33:27,632 DEBUG       "country": null,
2024-05-25 04:33:27,632 DEBUG       "frUnindexedString1": null,
2024-05-25 04:33:27,632 DEBUG       "mail": "idm_gz7w8zmz4e@forgerock.com",
2024-05-25 04:33:27,632 DEBUG       "memberOfOrgIDs": [],
2024-05-25 04:33:27,632 DEBUG       "frIndexedDate5": null,
2024-05-25 04:33:27,632 DEBUG       "frUnindexedString2": null,
2024-05-25 04:33:27,632 DEBUG       "frIndexedDate4": null,
2024-05-25 04:33:27,632 DEBUG   
2024-05-25 04:33:27,633 DEBUG   
2024-05-25 04:33:27,633 DEBUG   
2024-05-25 04:33:27,633 DEBUG   [...]
2024-05-25 04:33:27,633 DEBUG   
2024-05-25 04:33:27,633 DEBUG   
2024-05-25 04:33:27,633 DEBUG   
2024-05-25 04:33:27,633 DEBUG       "sn": "Parker",
2024-05-25 04:33:27,633 DEBUG       "frUnindexedDate1": null,
2024-05-25 04:33:27,633 DEBUG       "frIndexedInteger5": null,
2024-05-25 04:33:27,633 DEBUG       "preferences": null,
2024-05-25 04:33:27,633 DEBUG       "userName": "idm_gz7w8zmz4e",
2024-05-25 04:33:27,633 DEBUG       "frIndexedDate2": null,
2024-05-25 04:33:27,633 DEBUG       "passwordLastChangedTime": "2024-05-25T04:33:27.326Z",
2024-05-25 04:33:27,633 DEBUG       "frIndexedDate1": null,
2024-05-25 04:33:27,633 DEBUG       "effectiveRoles": []
2024-05-25 04:33:27,633 DEBUG   }
2024-05-25 04:33:27,633 INFO    Query IDM to verify UserID 895e7846-1a45-43f7-b18e-a1cd45915e13 is visible
2024-05-25 04:33:27,633 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-3580.forgeblocks.com/openidm/managed/alpha_user/895e7846-1a45-43f7-b18e-a1cd45915e13"
2024-05-25 04:33:27,734 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:27,734 DEBUG   ---  status code  ---
2024-05-25 04:33:27,734 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:27,734 DEBUG   --- http response ---
2024-05-25 04:33:27,735 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (69 lines):
2024-05-25 04:33:27,735 DEBUG   ----- output -----
2024-05-25 04:33:27,735 DEBUG   {
2024-05-25 04:33:27,735 DEBUG       "_id": "895e7846-1a45-43f7-b18e-a1cd45915e13",
2024-05-25 04:33:27,735 DEBUG       "_rev": "1d1896b6-ecfc-4c50-9668-ec11afd47b38-13198857",
2024-05-25 04:33:27,735 DEBUG       "country": null,
2024-05-25 04:33:27,735 DEBUG       "frUnindexedString1": null,
2024-05-25 04:33:27,735 DEBUG       "mail": "idm_gz7w8zmz4e@forgerock.com",
2024-05-25 04:33:27,735 DEBUG       "memberOfOrgIDs": [],
2024-05-25 04:33:27,735 DEBUG       "frIndexedDate5": null,
2024-05-25 04:33:27,735 DEBUG       "frUnindexedString2": null,
2024-05-25 04:33:27,735 DEBUG       "frIndexedDate4": null,
2024-05-25 04:33:27,735 DEBUG   
2024-05-25 04:33:27,735 DEBUG   
2024-05-25 04:33:27,735 DEBUG   
2024-05-25 04:33:27,735 DEBUG   [...]
2024-05-25 04:33:27,735 DEBUG   
2024-05-25 04:33:27,735 DEBUG   
2024-05-25 04:33:27,735 DEBUG   
2024-05-25 04:33:27,735 DEBUG       "sn": "Parker",
2024-05-25 04:33:27,735 DEBUG       "frUnindexedDate1": null,
2024-05-25 04:33:27,735 DEBUG       "frIndexedInteger5": null,
2024-05-25 04:33:27,735 DEBUG       "preferences": null,
2024-05-25 04:33:27,735 DEBUG       "userName": "idm_gz7w8zmz4e",
2024-05-25 04:33:27,735 DEBUG       "frIndexedDate2": null,
2024-05-25 04:33:27,735 DEBUG       "passwordLastChangedTime": "2024-05-25T04:33:27.326Z",
2024-05-25 04:33:27,735 DEBUG       "frIndexedDate1": null,
2024-05-25 04:33:27,735 DEBUG       "effectiveRoles": []
2024-05-25 04:33:27,735 DEBUG   }
2024-05-25 04:33:27,736 INFO    Authenticate as user idm_gz7w8zmz4e
2024-05-25 04:33:27,737 INFO    [http_cmd]: curl --insecure -L --request POST  "https://openam-ema-perf-3580.forgeblocks.com/openidm/authentication?_action=login"
2024-05-25 04:33:27,827 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:27,827 DEBUG   ---  status code  ---
2024-05-25 04:33:27,827 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:27,827 DEBUG   --- http response ---
2024-05-25 04:33:27,828 DEBUG   {
    "_id": "login",
    "authorization": {
        "id": "anonymous",
        "roles": [
            "internal/role/openidm-reg"
        ],
        "component": "internal/user"
    },
    "authenticationId": "anonymous"
}

2024-05-25 04:33:27,829 INFO    [http_cmd]: curl --insecure -L --request DELETE  "https://openam-ema-perf-3580.forgeblocks.com/openidm/managed/alpha_user/895e7846-1a45-43f7-b18e-a1cd45915e13"
2024-05-25 04:33:27,959 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:27,959 DEBUG   ---  status code  ---
2024-05-25 04:33:27,959 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:27,960 DEBUG   --- http response ---
2024-05-25 04:33:27,960 DEBUG   [print_head_tail]: Print head (10 lines) and tail (10 lines) of input string (69 lines):
2024-05-25 04:33:27,960 DEBUG   ----- output -----
2024-05-25 04:33:27,960 DEBUG   {
2024-05-25 04:33:27,960 DEBUG       "_id": "895e7846-1a45-43f7-b18e-a1cd45915e13",
2024-05-25 04:33:27,960 DEBUG       "_rev": "1d1896b6-ecfc-4c50-9668-ec11afd47b38-13198857",
2024-05-25 04:33:27,960 DEBUG       "country": null,
2024-05-25 04:33:27,960 DEBUG       "frUnindexedString1": null,
2024-05-25 04:33:27,961 DEBUG       "mail": "idm_gz7w8zmz4e@forgerock.com",
2024-05-25 04:33:27,961 DEBUG       "memberOfOrgIDs": [],
2024-05-25 04:33:27,961 DEBUG       "frIndexedDate5": null,
2024-05-25 04:33:27,961 DEBUG       "frUnindexedString2": null,
2024-05-25 04:33:27,961 DEBUG       "frIndexedDate4": null,
2024-05-25 04:33:27,961 DEBUG   
2024-05-25 04:33:27,961 DEBUG   
2024-05-25 04:33:27,961 DEBUG   
2024-05-25 04:33:27,961 DEBUG   [...]
2024-05-25 04:33:27,961 DEBUG   
2024-05-25 04:33:27,961 DEBUG   
2024-05-25 04:33:27,961 DEBUG   
2024-05-25 04:33:27,961 DEBUG       "sn": "Parker",
2024-05-25 04:33:27,961 DEBUG       "frUnindexedDate1": null,
2024-05-25 04:33:27,961 DEBUG       "frIndexedInteger5": null,
2024-05-25 04:33:27,961 DEBUG       "preferences": null,
2024-05-25 04:33:27,961 DEBUG       "userName": "idm_gz7w8zmz4e",
2024-05-25 04:33:27,961 DEBUG       "frIndexedDate2": null,
2024-05-25 04:33:27,961 DEBUG       "passwordLastChangedTime": "2024-05-25T04:33:27.326Z",
2024-05-25 04:33:27,961 DEBUG       "frIndexedDate1": null,
2024-05-25 04:33:27,961 DEBUG       "effectiveRoles": []
2024-05-25 04:33:27,961 DEBUG   }
2024-05-25 04:33:27,962 INFO    
2024-05-25 04:33:27,962 INFO    ---------------------    Running CTSSTORE livecheck   ---------------------
2024-05-25 04:33:27,962 INFO    
2024-05-25 04:33:27,962 INFO    ---------------------   Running USERSTORE livecheck   ---------------------
2024-05-25 04:33:27,962 INFO    
2024-05-25 04:33:27,962 INFO    --------------------   Running PLATFORM-UI livecheck   --------------------
2024-05-25 04:33:27,962 INFO    Livecheck to https://openam-ema-perf-3580.forgeblocks.com/am/XUI
2024-05-25 04:33:27,962 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-3580.forgeblocks.com/am/XUI"
2024-05-25 04:33:28,134 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:28,134 DEBUG   ---  status code  ---
2024-05-25 04:33:28,134 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:28,134 DEBUG   --- http response ---
2024-05-25 04:33:28,135 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"/><title>Login</title><script defer="defer" src="js/chunk-vendors.c0f27c61.js"></script><script defer="defer" src="js/app.8387c6a0.js"></script><link href="css/chunk-vendors.d2b307bd.css" rel="stylesheet"><link href="css/app.3e8eac90.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-05-25 04:33:28,135 INFO    LIVECHECK SUCCEEDED
2024-05-25 04:33:28,135 INFO    
2024-05-25 04:33:28,136 INFO    ******************************   Initializing component pods for AM   ******************************
2024-05-25 04:33:28,136 INFO    
2024-05-25 04:33:28,136 INFO    -----------------------   Get AM software version   -----------------------
2024-05-25 04:33:28,136 INFO    Getting product version from https://openam-ema-perf-3580.forgeblocks.com/am/json/realms/alpha/serverinfo/version
2024-05-25 04:33:28,136 INFO    [LoginSession] Get "token_id" token for user "xiaosong.lou@forgerock.com"
2024-05-25 04:33:28,136 DEBUG   [LoginSession]		re-using "token_id" token that remains valid for 29m 48s
2024-05-25 04:33:28,136 INFO    [http_cmd]: curl --insecure -L --request GET --cookie "9537f3c44bdb077=Qslwv-qQrmEnO_yMdl-FOXRc_HQ.*AAJTSQACMDIAAlNLABxCa3ZkQmFwMWxSTUZjL0lMalVibVZhT1U2aHc9AAR0eXBlAANDVFMAAlMxAAIwMQ..*" --cookie "amlbcookie=01" "https://openam-ema-perf-3580.forgeblocks.com/am/json/realms/alpha/serverinfo/version"
2024-05-25 04:33:28,377 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:28,377 DEBUG   ---  status code  ---
2024-05-25 04:33:28,377 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:28,377 DEBUG   --- http response ---
2024-05-25 04:33:28,378 DEBUG   {
    "_id": "version",
    "_rev": "1802410242",
    "version": "7.5.0-SNAPSHOT",
    "fullVersion": "ForgeRock Access Management 7.5.0-SNAPSHOT Build dae4ef57c87a2904ab66aa3c8a4c1afa83a7d22f (2024-April-30 16:59)",
    "revision": "dae4ef57c87a2904ab66aa3c8a4c1afa83a7d22f",
    "date": "2024-April-30 16:59"
}

2024-05-25 04:33:28,378 INFO    
2024-05-25 04:33:28,378 INFO    *****************************    Initializing component pods for IDM   *****************************
2024-05-25 04:33:28,378 INFO    
2024-05-25 04:33:28,378 INFO    ----------------------    Get IDM software version   ----------------------
2024-05-25 04:33:28,379 INFO    Getting product version from https://openam-ema-perf-3580.forgeblocks.com/openidm/info/version
2024-05-25 04:33:28,379 INFO    [http_cmd]: curl --insecure -L --request GET  "https://openam-ema-perf-3580.forgeblocks.com/openidm/info/version"
2024-05-25 04:33:28,463 INFO    [http_cmd]: http status code OK
2024-05-25 04:33:28,463 DEBUG   ---  status code  ---
2024-05-25 04:33:28,463 DEBUG   http status code is 200 (expected 200)
2024-05-25 04:33:28,463 DEBUG   --- http response ---
2024-05-25 04:33:28,463 DEBUG   {
    "_id": "version",
    "productVersion": "7.6.0-2024-4-1-SNAPSHOT",
    "productBuildDate": "20240418231546",
    "productRevision": "3761447c8b"
}

2024-05-25 04:33:28,464 INFO    
2024-05-25 04:33:28,464 INFO    ***************************   Initializing component pods for CTSSTORE   ***************************
2024-05-25 04:33:28,464 INFO    
2024-05-25 04:33:28,464 INFO    --------------------   Get CTSSTORE software version   --------------------
2024-05-25 04:33:28,464 WARNING Component ctsstore is not in Running state so impossible to get software version
2024-05-25 04:33:28,464 INFO    
2024-05-25 04:33:28,464 INFO    **************************    Initializing component pods for USERSTORE   **************************
2024-05-25 04:33:28,464 INFO    
2024-05-25 04:33:28,464 INFO    -------------------    Get USERSTORE software version   -------------------
2024-05-25 04:33:28,464 WARNING Component userstore is not in Running state so impossible to get software version
2024-05-25 04:33:28,464 INFO    
2024-05-25 04:33:28,464 INFO    *************************    Initializing component pods for PLATFORM-UI   *************************
2024-05-25 04:33:28,464 INFO    
2024-05-25 04:33:28,464 INFO    ------------------    Get PLATFORM-UI software version   ------------------
2024-05-25 04:33:28,464 INFO    Component platform-ui is running in tenant so impossible to get software version
[2024-05-25 04:33:28] - INFO: Deployment ready
________________________________________________________________________________

[2024-05-25 04:33:28] Discover_IDC_tenant post : Post method
________________________________________________________________________________

Setting result to PASS
Task has been successfully stopped