--Task-- name: update-500 enabled: True class_name: GatlingTask source_name: overseer-0 source_namespace: >default< target_name: idm target_namespace: >default< start: 0.0 stop: None timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates below loop: False interval: None dependencies: [] wait_for: [] preceding_task: None options: {'testMode': 'open', 'testCase': 'idm.ManagedUsersUpdate', 'duration': 3600, 'throughput': 500, 'java-opts': '-Dcsvfile=/results/idm/user_feeder.csv -Drealm=alpha'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock 2025-03-28 05:42:44,734 INFO 2025-03-28 05:42:44,734 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 05:42:44,734 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 05:42:45,016 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 05:42:45,016 INFO [loop_until]: OK (rc = 0) 2025-03-28 05:42:45,016 DEBUG --- stdout --- 2025-03-28 05:42:45,016 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 05:42:45,016 DEBUG --- stderr --- 2025-03-28 05:42:45,016 DEBUG 2025-03-28 05:42:45,016 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-03-28 05:42:45 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-03-28 05:42:45 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/update-500/stdout.txt Pod log : /results/orders/update-500 2025-03-28 05:42:45 - INFO: Get overseer pod resources requests memory 2025-03-28 05:42:45,604 INFO 2025-03-28 05:42:45,604 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods overseer-0-59c948f569-rgrkv --output jsonpath={.spec.containers[].resources.requests.memory} 2025-03-28 05:42:45,604 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 05:42:45,904 INFO [loop_until]: OK (rc = 0) 2025-03-28 05:42:45,904 DEBUG --- stdout --- 2025-03-28 05:42:45,904 DEBUG 8Gi 2025-03-28 05:42:45,904 DEBUG --- stderr --- 2025-03-28 05:42:45,904 DEBUG ________________________________________________________________________________ [2025-03-28 05:42:45] update-500 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ /lodestar/lodestar.py perf run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idm.ManagedUsersUpdate@perf-200m" --results-folder="/results/gatling/update-500" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx8G" --simulation-system-properties="-Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idm.ManagedUsersUpdate -DtestMode=open -Dthroughput=500 -Duser_password=**** ________________________________________________________________________________ [2025-03-28 05:42:45] update-500 create_order : Create order for overseer with the command to run ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/order.json { "name": "update-500", "command": " /lodestar/lodestar.py perf run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idm.ManagedUsersUpdate@perf-200m\" --results-folder=\"/results/gatling/update-500\" --no-reports --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx8G\" --simulation-system-properties=\"-Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idm.ManagedUsersUpdate -DtestMode=open -Dthroughput=500 -Duser_password=T35!tr0c-k123\"", "out-dir": "/results/orders/update-500" } ________________________________________________________________________________ [2025-03-28 05:42:45] update-500 loop_until_ready : Wait for preceding task to finish if it uses same Overseer as a source, then loop for max_time until Overseer pod status is READY to accept order :param max_time: periodically check overseer status for this many seconds at maximum :param interval: interval between two periodical checks :return: ________________________________________________________________________________ 2025-03-28 05:42:45,911 INFO 2025-03-28 05:42:45,912 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 05:42:45,912 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 05:42:46,222 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 05:42:46,222 INFO [loop_until]: OK (rc = 0) 2025-03-28 05:42:46,222 DEBUG --- stdout --- 2025-03-28 05:42:46,222 DEBUG WAITING 2025-03-28 05:42:46,222 DEBUG --- stderr --- 2025-03-28 05:42:46,222 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 23 0 --:--:-- --:--:-- --:--:-- 23 ________________________________________________________________________________ [2025-03-28 05:42:46] update-500 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-03-28 05:42:46,223 INFO 2025-03-28 05:42:46,223 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 05:42:46,223 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 05:42:46,501 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 05:42:46,501 INFO [loop_until]: OK (rc = 0) 2025-03-28 05:42:46,501 DEBUG --- stdout --- 2025-03-28 05:42:46,501 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 05:42:46,501 DEBUG --- stderr --- 2025-03-28 05:42:46,501 DEBUG 2025-03-28 05:42:46,502 INFO 2025-03-28 05:42:46,502 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 05:42:46,502 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 05:42:47,889 INFO [loop_until]: OK (rc = 0) 2025-03-28 05:42:47,889 DEBUG --- stdout --- 2025-03-28 05:42:47,889 DEBUG 2025-03-28 05:42:47,889 DEBUG --- stderr --- 2025-03-28 05:42:47,889 DEBUG Order has been successfully forwarded to overseer 2025-03-28 05:42:47 - INFO: Check if Gatling simulation started successfully 2025-03-28 05:42:47,889 INFO 2025-03-28 05:42:47,889 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv -- head --lines 5000 /results/orders/update-500/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-03-28 05:42:47,890 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 05:42:48,638 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 05:42:54,377 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 05:43:00,114 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 05:43:05,848 INFO [loop_until]: Function succeeded after 17s (rc=0) - expected pattern found 2025-03-28 05:43:05,848 INFO [loop_until]: OK (rc = 0) 2025-03-28 05:43:05,848 DEBUG --- stdout --- 2025-03-28 05:43:05,848 DEBUG 2025-03-28 05:42:48,897 DEBUG Creating results folder /results/gatling/update-500 2025-03-28 05:42:48,903 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp0_3pm3ov 2025-03-28 05:42:48,905 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/update-500" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx8G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idm.ManagedUsersUpdate -DtestMode=open -Dthroughput=500 -Duser_password=**** [INFO] Scanning for projects... [INFO] [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- [INFO] Building pyrock-gatling-simulation 3.12.0 [INFO] from pom.xml [INFO] --------------------------------[ jar ]--------------------------------- [INFO] [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> [INFO] [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- [INFO] skip non existing resourceDirectory /tmp/tmp0_3pm3ov/src/main/resources [INFO] [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- [INFO] Copying 2 resources from src/test/resources to target/test-classes [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] Nothing to compile - all classes are up to date. [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compiling 38 Scala sources to /tmp/tmp0_3pm3ov/target/test-classes ... [INFO] compile in 8.3 s [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- [INFO] Running simulation com.forgerock.pyrock.Loadtest. Gatling 3.13.5 is available! (you're using 3.12.0) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Set idVarName to id Simulation com.forgerock.pyrock.Loadtest started... 2025-03-28 05:43:05,848 DEBUG --- stderr --- 2025-03-28 05:43:05,848 DEBUG ________________________________________________________________________________ [2025-03-28 05:43:05] update-500 wait_stop_by_itself : Wait for the order to stop by itself ________________________________________________________________________________ Task may stop by itself (no stop defined in configuration file), wait until overseer ends the order - timeout is 1h 12m. Waiting for status (curl --fail --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt) == WAITING Order is running since 2m, retry Order is running since 4m, retry Order is running since 6m, retry Order is running since 8m 01s, retry Order is running since 10m 01s, retry Order is running since 12m 01s, retry Order is running since 14m 02s, retry Order is running since 16m 02s, retry Order is running since 18m 02s, retry Order is running since 20m 02s, retry Order is running since 22m 03s, retry Order is running since 24m 03s, retry Order is running since 26m 03s, retry Order is running since 28m 04s, retry Order is running since 30m 04s, retry Order is running since 32m 04s, retry Order is running since 34m 05s, retry Order is running since 36m 05s, retry Order is running since 38m 05s, retry Order is running since 40m 05s, retry Order is running since 42m 06s, retry Order is running since 44m 06s, retry Order is running since 46m 06s, retry Order is running since 48m 07s, retry Order is running since 50m 07s, retry Order is running since 52m 07s, retry Order is running since 54m 08s, retry Order is running since 56m 08s, retry Order is running since 58m 08s, retry PASS : Order stopped by itself after 1h and before timeout (1h 12m) ________________________________________________________________________________ [2025-03-28 06:43:14] update-500 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-03-28 06:43:14,954 INFO 2025-03-28 06:43:14,955 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 06:43:14,955 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 06:43:15,257 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 06:43:15,257 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:15,257 DEBUG --- stdout --- 2025-03-28 06:43:15,257 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 06:43:15,258 DEBUG --- stderr --- 2025-03-28 06:43:15,258 DEBUG 2025-03-28 06:43:15,258 INFO 2025-03-28 06:43:15,258 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv -- rm -f /results/orders/order.json 2025-03-28 06:43:15,258 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 06:43:16,037 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:16,037 DEBUG --- stdout --- 2025-03-28 06:43:16,037 DEBUG 2025-03-28 06:43:16,037 DEBUG --- stderr --- 2025-03-28 06:43:16,037 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-03-28 06:43:16] update-500 download_logs : Download individual order files ________________________________________________________________________________ 2025-03-28 06:43:16 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/order.json 2025-03-28 06:43:16,038 INFO 2025-03-28 06:43:16,038 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 06:43:16,038 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 06:43:16,317 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 06:43:16,317 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:16,317 DEBUG --- stdout --- 2025-03-28 06:43:16,317 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 06:43:16,317 DEBUG --- stderr --- 2025-03-28 06:43:16,317 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 06:43:16,318 INFO 2025-03-28 06:43:16,318 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-500/rc.txt" ]; then echo "/results/orders/update-500/rc.txt file found"; exit 0; else echo "/results/orders/update-500/rc.txt file not found"; exit 1; fi' | grep "/results/orders/update-500/rc.txt file found" 2025-03-28 06:43:16,318 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 06:43:17,120 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 06:43:17,120 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:17,120 DEBUG --- stdout --- 2025-03-28 06:43:17,120 DEBUG /results/orders/update-500/rc.txt file found 2025-03-28 06:43:17,120 DEBUG --- stderr --- 2025-03-28 06:43:17,120 DEBUG 2025-03-28 06:43:17,120 INFO 2025-03-28 06:43:17,121 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-500/rc.txt 2025-03-28 06:43:17,922 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 06:43:17,922 DEBUG --- stdout --- 2025-03-28 06:43:17,922 DEBUG 4 /results/orders/update-500/rc.txt 2025-03-28 06:43:17,922 DEBUG --- stderr --- 2025-03-28 06:43:17,922 DEBUG 2025-03-28 06:43:17,922 INFO - Download file (size 4k) source : /results/orders/update-500/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/rc.txt 2025-03-28 06:43:17,923 INFO 2025-03-28 06:43:17,923 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-500/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/rc.txt 2025-03-28 06:43:17,923 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 06:43:18,654 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:18,654 DEBUG --- stdout --- 2025-03-28 06:43:18,654 DEBUG tar: Removing leading `/' from member names 2025-03-28 06:43:18,654 DEBUG --- stderr --- 2025-03-28 06:43:18,654 DEBUG 2025-03-28 06:43:18,654 INFO 2025-03-28 06:43:18,654 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 06:43:18,654 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 06:43:18,932 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 06:43:18,932 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:18,932 DEBUG --- stdout --- 2025-03-28 06:43:18,932 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 06:43:18,932 DEBUG --- stderr --- 2025-03-28 06:43:18,932 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 06:43:18,933 INFO 2025-03-28 06:43:18,933 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-500/stderr.txt" ]; then echo "/results/orders/update-500/stderr.txt file found"; exit 0; else echo "/results/orders/update-500/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/update-500/stderr.txt file found" 2025-03-28 06:43:18,933 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 06:43:19,741 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 06:43:19,741 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:19,741 DEBUG --- stdout --- 2025-03-28 06:43:19,741 DEBUG /results/orders/update-500/stderr.txt file found 2025-03-28 06:43:19,741 DEBUG --- stderr --- 2025-03-28 06:43:19,741 DEBUG 2025-03-28 06:43:19,741 INFO 2025-03-28 06:43:19,741 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-500/stderr.txt 2025-03-28 06:43:20,547 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 06:43:20,547 DEBUG --- stdout --- 2025-03-28 06:43:20,547 DEBUG 0 /results/orders/update-500/stderr.txt 2025-03-28 06:43:20,547 DEBUG --- stderr --- 2025-03-28 06:43:20,547 DEBUG 2025-03-28 06:43:20,547 INFO - Download file (size 0k) source : /results/orders/update-500/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/stderr.txt 2025-03-28 06:43:20,548 INFO 2025-03-28 06:43:20,548 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-500/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/stderr.txt 2025-03-28 06:43:20,548 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 06:43:21,270 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:21,270 DEBUG --- stdout --- 2025-03-28 06:43:21,270 DEBUG tar: Removing leading `/' from member names 2025-03-28 06:43:21,270 DEBUG --- stderr --- 2025-03-28 06:43:21,270 DEBUG 2025-03-28 06:43:21,270 INFO 2025-03-28 06:43:21,270 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 06:43:21,270 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 06:43:21,548 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 06:43:21,548 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:21,548 DEBUG --- stdout --- 2025-03-28 06:43:21,548 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 06:43:21,548 DEBUG --- stderr --- 2025-03-28 06:43:21,548 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 06:43:21,549 INFO 2025-03-28 06:43:21,549 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-500/stdout.txt" ]; then echo "/results/orders/update-500/stdout.txt file found"; exit 0; else echo "/results/orders/update-500/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/update-500/stdout.txt file found" 2025-03-28 06:43:21,549 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 06:43:22,343 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 06:43:22,343 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:22,343 DEBUG --- stdout --- 2025-03-28 06:43:22,343 DEBUG /results/orders/update-500/stdout.txt file found 2025-03-28 06:43:22,343 DEBUG --- stderr --- 2025-03-28 06:43:22,343 DEBUG 2025-03-28 06:43:22,343 INFO 2025-03-28 06:43:22,343 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-500/stdout.txt 2025-03-28 06:43:23,141 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 06:43:23,141 DEBUG --- stdout --- 2025-03-28 06:43:23,141 DEBUG 1516 /results/orders/update-500/stdout.txt 2025-03-28 06:43:23,141 DEBUG --- stderr --- 2025-03-28 06:43:23,141 DEBUG 2025-03-28 06:43:23,141 INFO - Download file (size 1516k) source : /results/orders/update-500/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/stdout.txt 2025-03-28 06:43:23,142 INFO 2025-03-28 06:43:23,142 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-500/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/stdout.txt 2025-03-28 06:43:23,142 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 06:43:24,285 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:24,285 DEBUG --- stdout --- 2025-03-28 06:43:24,285 DEBUG tar: Removing leading `/' from member names 2025-03-28 06:43:24,285 DEBUG --- stderr --- 2025-03-28 06:43:24,285 DEBUG ________________________________________________________________________________ [2025-03-28 06:43:24] update-500 show_cmd : Display order command ________________________________________________________________________________ 2025-03-28 06:43:24,286 INFO 2025-03-28 06:43:24,286 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 06:43:24,286 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 06:43:24,563 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 06:43:24,563 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:24,563 DEBUG --- stdout --- 2025-03-28 06:43:24,563 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 06:43:24,563 DEBUG --- stderr --- 2025-03-28 06:43:24,563 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 06:43:24,564 INFO 2025-03-28 06:43:24,564 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-500/cmd.txt" ]; then echo "/results/orders/update-500/cmd.txt file found"; exit 0; else echo "/results/orders/update-500/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/update-500/cmd.txt file found" 2025-03-28 06:43:24,564 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 06:43:25,525 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 06:43:25,525 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:25,525 DEBUG --- stdout --- 2025-03-28 06:43:25,525 DEBUG /results/orders/update-500/cmd.txt file found 2025-03-28 06:43:25,525 DEBUG --- stderr --- 2025-03-28 06:43:25,525 DEBUG 2025-03-28 06:43:25,525 INFO 2025-03-28 06:43:25,526 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-500/cmd.txt 2025-03-28 06:43:26,345 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 06:43:26,346 DEBUG --- stdout --- 2025-03-28 06:43:26,346 DEBUG 4 /results/orders/update-500/cmd.txt 2025-03-28 06:43:26,346 DEBUG --- stderr --- 2025-03-28 06:43:26,346 DEBUG 2025-03-28 06:43:26,346 INFO - Download file (size 4k) source : /results/orders/update-500/cmd.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/cmd.txt 2025-03-28 06:43:26,346 INFO 2025-03-28 06:43:26,346 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-500/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/cmd.txt 2025-03-28 06:43:26,346 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 06:43:27,112 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:27,112 DEBUG --- stdout --- 2025-03-28 06:43:27,112 DEBUG tar: Removing leading `/' from member names 2025-03-28 06:43:27,112 DEBUG --- stderr --- 2025-03-28 06:43:27,112 DEBUG 2025-03-28 06:43:27,112 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/cmd.txt is small (1 lines), printing all lines: 2025-03-28 06:43:27,112 INFO ----- output ----- /lodestar/lodestar.py perf run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idm.ManagedUsersUpdate@perf-200m" --results-folder="/results/gatling/update-500" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx8G" --simulation-system-properties="-Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=M@ythe4th -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idm.ManagedUsersUpdate -DtestMode=open -Dthroughput=500 -Duser_password=T35!tr0c-k123" ________________________________________________________________________________ [2025-03-28 06:43:27] update-500 show_rc : Display rc order ________________________________________________________________________________ 2025-03-28 06:43:27,112 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/rc.txt is small (1 lines), printing all lines: 2025-03-28 06:43:27,112 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 06:43:27] update-500 show_stdout : Display stdout order ________________________________________________________________________________ 2025-03-28 06:43:27,115 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input file (/mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/stdout.txt is 21143 lines): 2025-03-28 06:43:27,118 INFO ----- output ----- 2025-03-28 05:42:48,897 DEBUG Creating results folder /results/gatling/update-500 2025-03-28 05:42:48,903 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp0_3pm3ov 2025-03-28 05:42:48,905 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/update-500" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx8G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idm.ManagedUsersUpdate -DtestMode=open -Dthroughput=500 -Duser_password=**** [INFO] Scanning for projects... [INFO] [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- [INFO] Building pyrock-gatling-simulation 3.12.0 [INFO] from pom.xml [INFO] --------------------------------[ jar ]--------------------------------- [INFO] [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> [INFO] [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- [INFO] skip non existing resourceDirectory /tmp/tmp0_3pm3ov/src/main/resources [INFO] [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- [INFO] Copying 2 resources from src/test/resources to target/test-classes [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] Nothing to compile - all classes are up to date. [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compiling 38 Scala sources to /tmp/tmp0_3pm3ov/target/test-classes ... [INFO] compile in 8.3 s [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- [INFO] Running simulation com.forgerock.pyrock.Loadtest. Gatling 3.13.5 is available! (you're using 3.12.0) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Set idVarName to id Simulation com.forgerock.pyrock.Loadtest started... ================================================================================ 2025-03-28 05:43:06 GMT 5s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=205 KO=0 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > UpdateManagedUser (OK=200 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersUpdate ---------------------------------------------------- [- ] 0% waiting: 1805465 / active: 8 / done: 200 ================================================================================ ================================================================================ 2025-03-28 05:43:11 GMT 10s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=824 KO=0 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > UpdateManagedUser (OK=819 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersUpdate ---------------------------------------------------- [- ] 0% waiting: 1804841 / active: 13 / done: 819 ================================================================================ ================================================================================ 2025-03-28 05:43:16 GMT 15s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=1858 KO=0 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > UpdateManagedUser (OK=1853 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersUpdate ---------------------------------------------------- [- ] 0% waiting: 1803799 / active: 21 / done: 1853 ================================================================================ ================================================================================ 2025-03-28 05:43:21 GMT 20s elapsed [...] 06:43:01.893 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'UpdateManagedUser' failed for user 1790812: j.i.IOException: Premature close 06:43:01.893 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'UpdateManagedUser' failed for user 1790821: j.i.IOException: Premature close 06:43:01.894 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UpdateManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersUpdate,1790802,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNTcyNzU2YzEtN2UwMC00ODRmLWEyMDQtNDc5MTVjZDE4MDA4LTYyNTM0MyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1akJpc3VqQ3FDcE5tNWRpSkNRZ0ZMRU9TU1EiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ0MDgyLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ0MDgyLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNDc2ODIsImlhdCI6MTc0MzE0NDA4MiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiQzBEdE1zaEdYZ0pvb1hiZjY5eWpjLUdzQ0FNIn0.TgaTad1IWUp5ly6HJPtqH-Ezr50-yPzxApJrOUCSdTxXgoeq_PYScj_rFUE_M_FYRVDc0J6GuiBHX_VIz59SDkJWkcXSwsYRc8kY4q2L41OOtHywZgAK_bNgb-ptXjBMhCCFpb1ExRUONb6f1kTKgPsY-6HKq38K3-3qqYUIGcNJnC1jFCt4wEY29EMkt4WwxIpXYcZzmnYXRZ3YW18MQr1lhlAexeyupkP-xxVBtST04Kwfj-t2tz6AwefqEa_oPRdMaZJJmdqEqYCwTUUgjwUHmfcLzl3N2aELHVknUe_2BDuejDCyPgLcGaGFs_yVnI359w0T_Sy_UjAAXhlVmw, username -> user.37572256, tokenIdCookieName -> 15892ffd844ef80, id -> 006df3e7-2d53-48b7-81c0-87e26d3a0057, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@50260867, givenname -> Rao, tokenId -> wCIFAKA_yWwQl5ibdV4gzMKDu5Q.*AAJTSQACMDIAAlNLABxiZE5KZDRJNUdDeEswalJtYWJtZjY5Sk9BYlE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> VanPatten, telNum -> 859-807-4884, challenge -> ommwcWTGWhoYu0Sx2ioSEO1uNgs32J9zWfT8_pF95aA, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.37572256@example.com, verifier -> NzcwNTExNDc1MzYwNjAwNzU0Nw, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@27cecb34),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007c530869b320@1027e5ff,io.netty.channel.epoll.EpollEventLoop@14f5da2c) ========================= HTTP request: PUT https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/006df3e7-2d53-48b7-81c0-87e26d3a0057 headers: if-match: * Content-Type: application/json accept: application/json user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNTcyNzU2YzEtN2UwMC00ODRmLWEyMDQtNDc5MTVjZDE4MDA4LTYyNTM0MyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1akJpc3VqQ3FDcE5tNWRpSkNRZ0ZMRU9TU1EiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ0MDgyLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ0MDgyLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNDc2ODIsImlhdCI6MTc0MzE0NDA4MiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiQzBEdE1zaEdYZ0pvb1hiZjY5eWpjLUdzQ0FNIn0.TgaTad1IWUp5ly6HJPtqH-Ezr50-yPzxApJrOUCSdTxXgoeq_PYScj_rFUE_M_FYRVDc0J6GuiBHX_VIz59SDkJWkcXSwsYRc8kY4q2L41OOtHywZgAK_bNgb-ptXjBMhCCFpb1ExRUONb6f1kTKgPsY-6HKq38K3-3qqYUIGcNJnC1jFCt4wEY29EMkt4WwxIpXYcZzmnYXRZ3YW18MQr1lhlAexeyupkP-xxVBtST04Kwfj-t2tz6AwefqEa_oPRdMaZJJmdqEqYCwTUUgjwUHmfcLzl3N2aELHVknUe_2BDuejDCyPgLcGaGFs_yVnI359w0T_Sy_UjAAXhlVmw host: openam-perf-200m.forgeblocks.com content-length: 267 body:StringChunksRequestBody{charset=UTF-8, content={ "_id" : "006df3e7-2d53-48b7-81c0-87e26d3a0057", "givenName" : "Rao", "sn" : "VanPatten", "mail" : "user.37572256@example.com", "telephoneNumber" : "859-807-4884", "description" : "Updated Managed User", "userName" : "user.37572256" }} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 06:43:01.894 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UpdateManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersUpdate,1790812,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNTcyNzU2YzEtN2UwMC00ODRmLWEyMDQtNDc5MTVjZDE4MDA4LTYyNTM0MyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1akJpc3VqQ3FDcE5tNWRpSkNRZ0ZMRU9TU1EiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ0MDgyLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ0MDgyLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNDc2ODIsImlhdCI6MTc0MzE0NDA4MiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiQzBEdE1zaEdYZ0pvb1hiZjY5eWpjLUdzQ0FNIn0.TgaTad1IWUp5ly6HJPtqH-Ezr50-yPzxApJrOUCSdTxXgoeq_PYScj_rFUE_M_FYRVDc0J6GuiBHX_VIz59SDkJWkcXSwsYRc8kY4q2L41OOtHywZgAK_bNgb-ptXjBMhCCFpb1ExRUONb6f1kTKgPsY-6HKq38K3-3qqYUIGcNJnC1jFCt4wEY29EMkt4WwxIpXYcZzmnYXRZ3YW18MQr1lhlAexeyupkP-xxVBtST04Kwfj-t2tz6AwefqEa_oPRdMaZJJmdqEqYCwTUUgjwUHmfcLzl3N2aELHVknUe_2BDuejDCyPgLcGaGFs_yVnI359w0T_Sy_UjAAXhlVmw, username -> user.57807897, tokenIdCookieName -> 15892ffd844ef80, id -> 006df4da-6ee2-467c-af32-1dc4cc77fd19, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@1aa4c1b7, givenname -> Torcac, tokenId -> wCIFAKA_yWwQl5ibdV4gzMKDu5Q.*AAJTSQACMDIAAlNLABxiZE5KZDRJNUdDeEswalJtYWJtZjY5Sk9BYlE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Tse, telNum -> 461-495-208, challenge -> ommwcWTGWhoYu0Sx2ioSEO1uNgs32J9zWfT8_pF95aA, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.57807897@example.com, verifier -> NzcwNTExNDc1MzYwNjAwNzU0Nw, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@49bc2788),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007c530869b320@1027e5ff,io.netty.channel.epoll.EpollEventLoop@30f5a68a) ========================= HTTP request: PUT https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/006df4da-6ee2-467c-af32-1dc4cc77fd19 headers: if-match: * Content-Type: application/json accept: application/json user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNTcyNzU2YzEtN2UwMC00ODRmLWEyMDQtNDc5MTVjZDE4MDA4LTYyNTM0MyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1akJpc3VqQ3FDcE5tNWRpSkNRZ0ZMRU9TU1EiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ0MDgyLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ0MDgyLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNDc2ODIsImlhdCI6MTc0MzE0NDA4MiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiQzBEdE1zaEdYZ0pvb1hiZjY5eWpjLUdzQ0FNIn0.TgaTad1IWUp5ly6HJPtqH-Ezr50-yPzxApJrOUCSdTxXgoeq_PYScj_rFUE_M_FYRVDc0J6GuiBHX_VIz59SDkJWkcXSwsYRc8kY4q2L41OOtHywZgAK_bNgb-ptXjBMhCCFpb1ExRUONb6f1kTKgPsY-6HKq38K3-3qqYUIGcNJnC1jFCt4wEY29EMkt4WwxIpXYcZzmnYXRZ3YW18MQr1lhlAexeyupkP-xxVBtST04Kwfj-t2tz6AwefqEa_oPRdMaZJJmdqEqYCwTUUgjwUHmfcLzl3N2aELHVknUe_2BDuejDCyPgLcGaGFs_yVnI359w0T_Sy_UjAAXhlVmw host: openam-perf-200m.forgeblocks.com content-length: 263 body:StringChunksRequestBody{charset=UTF-8, content={ "_id" : "006df4da-6ee2-467c-af32-1dc4cc77fd19", "givenName" : "Torcac", "sn" : "Tse", "mail" : "user.57807897@example.com", "telephoneNumber" : "461-495-208", "description" : "Updated Managed User", "userName" : "user.57807897" }} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 06:43:01.894 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UpdateManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersUpdate,1790821,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNTcyNzU2YzEtN2UwMC00ODRmLWEyMDQtNDc5MTVjZDE4MDA4LTYyNTM0MyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1akJpc3VqQ3FDcE5tNWRpSkNRZ0ZMRU9TU1EiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ0MDgyLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ0MDgyLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNDc2ODIsImlhdCI6MTc0MzE0NDA4MiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiQzBEdE1zaEdYZ0pvb1hiZjY5eWpjLUdzQ0FNIn0.TgaTad1IWUp5ly6HJPtqH-Ezr50-yPzxApJrOUCSdTxXgoeq_PYScj_rFUE_M_FYRVDc0J6GuiBHX_VIz59SDkJWkcXSwsYRc8kY4q2L41OOtHywZgAK_bNgb-ptXjBMhCCFpb1ExRUONb6f1kTKgPsY-6HKq38K3-3qqYUIGcNJnC1jFCt4wEY29EMkt4WwxIpXYcZzmnYXRZ3YW18MQr1lhlAexeyupkP-xxVBtST04Kwfj-t2tz6AwefqEa_oPRdMaZJJmdqEqYCwTUUgjwUHmfcLzl3N2aELHVknUe_2BDuejDCyPgLcGaGFs_yVnI359w0T_Sy_UjAAXhlVmw, username -> user.173410223, tokenIdCookieName -> 15892ffd844ef80, id -> 006df5f8-0917-4012-9ba7-b28cd9202810, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@3b71d15, givenname -> Catherine, tokenId -> wCIFAKA_yWwQl5ibdV4gzMKDu5Q.*AAJTSQACMDIAAlNLABxiZE5KZDRJNUdDeEswalJtYWJtZjY5Sk9BYlE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Raiswell4319, telNum -> 476-523-5411, challenge -> ommwcWTGWhoYu0Sx2ioSEO1uNgs32J9zWfT8_pF95aA, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.173410223@example.com, verifier -> NzcwNTExNDc1MzYwNjAwNzU0Nw, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@47def565),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007c530869b320@1027e5ff,io.netty.channel.epoll.EpollEventLoop@619bfe29) ========================= HTTP request: PUT https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/006df5f8-0917-4012-9ba7-b28cd9202810 headers: if-match: * Content-Type: application/json accept: application/json user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiNTcyNzU2YzEtN2UwMC00ODRmLWEyMDQtNDc5MTVjZDE4MDA4LTYyNTM0MyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1akJpc3VqQ3FDcE5tNWRpSkNRZ0ZMRU9TU1EiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ0MDgyLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ0MDgyLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNDc2ODIsImlhdCI6MTc0MzE0NDA4MiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiQzBEdE1zaEdYZ0pvb1hiZjY5eWpjLUdzQ0FNIn0.TgaTad1IWUp5ly6HJPtqH-Ezr50-yPzxApJrOUCSdTxXgoeq_PYScj_rFUE_M_FYRVDc0J6GuiBHX_VIz59SDkJWkcXSwsYRc8kY4q2L41OOtHywZgAK_bNgb-ptXjBMhCCFpb1ExRUONb6f1kTKgPsY-6HKq38K3-3qqYUIGcNJnC1jFCt4wEY29EMkt4WwxIpXYcZzmnYXRZ3YW18MQr1lhlAexeyupkP-xxVBtST04Kwfj-t2tz6AwefqEa_oPRdMaZJJmdqEqYCwTUUgjwUHmfcLzl3N2aELHVknUe_2BDuejDCyPgLcGaGFs_yVnI359w0T_Sy_UjAAXhlVmw host: openam-perf-200m.forgeblocks.com content-length: 278 body:StringChunksRequestBody{charset=UTF-8, content={ "_id" : "006df5f8-0917-4012-9ba7-b28cd9202810", "givenName" : "Catherine", "sn" : "Raiswell4319", "mail" : "user.173410223@example.com", "telephoneNumber" : "476-523-5411", "description" : "Updated Managed User", "userName" : "user.173410223" }} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:00 h [INFO] Finished at: 2025-03-28T06:43:01Z [INFO] ------------------------------------------------------------------------ 2025-03-28 06:43:01,959 INFO Gatling simulation run ended successfully 2025-03-28 06:43:01,959 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-03-28 06:43:27] update-500 show_stderr : Display stderr order ________________________________________________________________________________ 2025-03-28 06:43:27,118 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_update-500/stderr.txt is small (0 lines), printing all lines: 2025-03-28 06:43:27,118 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 06:43:27] update-500 check_rc_and_logs : Check order's outputs ________________________________________________________________________________ CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) PASS: no error found in rc log PASS: no error found in stdout log PASS: no error found in stderr log ________________________________________________________________________________ [2025-03-28 06:43:27] update-500 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-03-28 06:43:27] update-500 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped