--Task-- name: patch-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: ['update-1700'] preceding_task: update-1700 options: {'testMode': 'open', 'testCase': 'idm.ManagedUsersPatch', '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 10:46:17,234 INFO 2025-03-28 10:46:17,234 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 10:46:17,234 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 10:46:17,510 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 10:46:17,510 INFO [loop_until]: OK (rc = 0) 2025-03-28 10:46:17,510 DEBUG --- stdout --- 2025-03-28 10:46:17,510 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 10:46:17,510 DEBUG --- stderr --- 2025-03-28 10:46:17,510 DEBUG 2025-03-28 10:46:17,510 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-03-28 10:46:17 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-03-28 10:46:17 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/patch-500/stdout.txt Pod log : /results/orders/patch-500 ________________________________________________________________________________ [2025-03-28 10:46:17] patch-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.ManagedUsersPatch@perf-200m" --results-folder="/results/gatling/patch-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.ManagedUsersPatch -DtestMode=open -Dthroughput=500 -Duser_password=**** ________________________________________________________________________________ [2025-03-28 10:46:17] patch-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/06_patch-500/order.json { "name": "patch-500", "command": " /lodestar/lodestar.py perf run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idm.ManagedUsersPatch@perf-200m\" --results-folder=\"/results/gatling/patch-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.ManagedUsersPatch -DtestMode=open -Dthroughput=500 -Duser_password=T35!tr0c-k123\"", "out-dir": "/results/orders/patch-500" } ________________________________________________________________________________ [2025-03-28 10:46:17] patch-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 10:46:17,518 INFO 2025-03-28 10:46:17,518 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 10:46:17,518 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 10:46:17,734 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 10:46:17,734 INFO [loop_until]: OK (rc = 0) 2025-03-28 10:46:17,734 DEBUG --- stdout --- 2025-03-28 10:46:17,734 DEBUG WAITING 2025-03-28 10:46:17,734 DEBUG --- stderr --- 2025-03-28 10:46:17,734 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 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2025-03-28 10:46:17] patch-500 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-03-28 10:46:17,734 INFO 2025-03-28 10:46:17,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 10:46:17,734 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 10:46:18,012 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 10:46:18,012 INFO [loop_until]: OK (rc = 0) 2025-03-28 10:46:18,012 DEBUG --- stdout --- 2025-03-28 10:46:18,012 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 10:46:18,012 DEBUG --- stderr --- 2025-03-28 10:46:18,012 DEBUG 2025-03-28 10:46:18,013 INFO 2025-03-28 10:46:18,013 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/06_patch-500/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 10:46:18,013 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 10:46:19,379 INFO [loop_until]: OK (rc = 0) 2025-03-28 10:46:19,379 DEBUG --- stdout --- 2025-03-28 10:46:19,379 DEBUG 2025-03-28 10:46:19,379 DEBUG --- stderr --- 2025-03-28 10:46:19,379 DEBUG Order has been successfully forwarded to overseer 2025-03-28 10:46:19 - INFO: Check if Gatling simulation started successfully 2025-03-28 10:46:19,380 INFO 2025-03-28 10:46:19,380 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv -- head --lines 5000 /results/orders/patch-500/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-03-28 10:46:19,380 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 10:46:20,118 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 10:46:25,900 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 10:46:31,639 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 10:46:37,372 INFO [loop_until]: Function succeeded after 17s (rc=0) - expected pattern found 2025-03-28 10:46:37,372 INFO [loop_until]: OK (rc = 0) 2025-03-28 10:46:37,372 DEBUG --- stdout --- 2025-03-28 10:46:37,372 DEBUG 2025-03-28 10:46:20,116 DEBUG Creating results folder /results/gatling/patch-500 2025-03-28 10:46:20,121 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp4gkf_zon 2025-03-28 10:46:20,124 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/patch-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.ManagedUsersPatch -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/tmp4gkf_zon/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/tmp4gkf_zon/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 10:46:37,373 DEBUG --- stderr --- 2025-03-28 10:46:37,373 DEBUG ________________________________________________________________________________ [2025-03-28 10:46:37] patch-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 06s, 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 11:46:46] patch-500 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-03-28 11:46:46,424 INFO 2025-03-28 11:46:46,424 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 11:46:46,424 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 11:46:46,725 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 11:46:46,725 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:46,725 DEBUG --- stdout --- 2025-03-28 11:46:46,725 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 11:46:46,725 DEBUG --- stderr --- 2025-03-28 11:46:46,725 DEBUG 2025-03-28 11:46:46,726 INFO 2025-03-28 11:46:46,726 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 11:46:46,726 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 11:46:47,495 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:47,495 DEBUG --- stdout --- 2025-03-28 11:46:47,496 DEBUG 2025-03-28 11:46:47,496 DEBUG --- stderr --- 2025-03-28 11:46:47,496 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-03-28 11:46:47] patch-500 download_logs : Download individual order files ________________________________________________________________________________ 2025-03-28 11:46:47 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/order.json 2025-03-28 11:46:47,496 INFO 2025-03-28 11:46:47,496 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 11:46:47,496 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 11:46:47,773 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 11:46:47,773 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:47,773 DEBUG --- stdout --- 2025-03-28 11:46:47,773 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 11:46:47,773 DEBUG --- stderr --- 2025-03-28 11:46:47,773 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 11:46:47,774 INFO 2025-03-28 11:46:47,774 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/patch-500/rc.txt" ]; then echo "/results/orders/patch-500/rc.txt file found"; exit 0; else echo "/results/orders/patch-500/rc.txt file not found"; exit 1; fi' | grep "/results/orders/patch-500/rc.txt file found" 2025-03-28 11:46:47,774 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 11:46:48,567 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 11:46:48,567 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:48,567 DEBUG --- stdout --- 2025-03-28 11:46:48,567 DEBUG /results/orders/patch-500/rc.txt file found 2025-03-28 11:46:48,567 DEBUG --- stderr --- 2025-03-28 11:46:48,567 DEBUG 2025-03-28 11:46:48,568 INFO 2025-03-28 11:46:48,568 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/patch-500/rc.txt 2025-03-28 11:46:49,369 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 11:46:49,369 DEBUG --- stdout --- 2025-03-28 11:46:49,369 DEBUG 4 /results/orders/patch-500/rc.txt 2025-03-28 11:46:49,369 DEBUG --- stderr --- 2025-03-28 11:46:49,369 DEBUG 2025-03-28 11:46:49,369 INFO - Download file (size 4k) source : /results/orders/patch-500/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/rc.txt 2025-03-28 11:46:49,369 INFO 2025-03-28 11:46:49,370 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-500/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/rc.txt 2025-03-28 11:46:49,370 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 11:46:50,100 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:50,101 DEBUG --- stdout --- 2025-03-28 11:46:50,101 DEBUG tar: Removing leading `/' from member names 2025-03-28 11:46:50,101 DEBUG --- stderr --- 2025-03-28 11:46:50,101 DEBUG 2025-03-28 11:46:50,101 INFO 2025-03-28 11:46:50,101 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 11:46:50,102 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 11:46:50,417 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 11:46:50,417 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:50,417 DEBUG --- stdout --- 2025-03-28 11:46:50,417 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 11:46:50,417 DEBUG --- stderr --- 2025-03-28 11:46:50,417 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 11:46:50,419 INFO 2025-03-28 11:46:50,419 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/patch-500/stderr.txt" ]; then echo "/results/orders/patch-500/stderr.txt file found"; exit 0; else echo "/results/orders/patch-500/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/patch-500/stderr.txt file found" 2025-03-28 11:46:50,419 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 11:46:51,218 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 11:46:51,218 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:51,218 DEBUG --- stdout --- 2025-03-28 11:46:51,218 DEBUG /results/orders/patch-500/stderr.txt file found 2025-03-28 11:46:51,218 DEBUG --- stderr --- 2025-03-28 11:46:51,219 DEBUG 2025-03-28 11:46:51,219 INFO 2025-03-28 11:46:51,219 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/patch-500/stderr.txt 2025-03-28 11:46:52,023 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 11:46:52,023 DEBUG --- stdout --- 2025-03-28 11:46:52,023 DEBUG 0 /results/orders/patch-500/stderr.txt 2025-03-28 11:46:52,023 DEBUG --- stderr --- 2025-03-28 11:46:52,023 DEBUG 2025-03-28 11:46:52,023 INFO - Download file (size 0k) source : /results/orders/patch-500/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/stderr.txt 2025-03-28 11:46:52,023 INFO 2025-03-28 11:46:52,023 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-500/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/stderr.txt 2025-03-28 11:46:52,023 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 11:46:52,748 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:52,749 DEBUG --- stdout --- 2025-03-28 11:46:52,749 DEBUG tar: Removing leading `/' from member names 2025-03-28 11:46:52,749 DEBUG --- stderr --- 2025-03-28 11:46:52,749 DEBUG 2025-03-28 11:46:52,749 INFO 2025-03-28 11:46:52,749 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 11:46:52,749 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 11:46:53,027 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 11:46:53,027 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:53,027 DEBUG --- stdout --- 2025-03-28 11:46:53,027 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 11:46:53,027 DEBUG --- stderr --- 2025-03-28 11:46:53,027 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 11:46:53,028 INFO 2025-03-28 11:46:53,028 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/patch-500/stdout.txt" ]; then echo "/results/orders/patch-500/stdout.txt file found"; exit 0; else echo "/results/orders/patch-500/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/patch-500/stdout.txt file found" 2025-03-28 11:46:53,028 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 11:46:53,823 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 11:46:53,823 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:53,823 DEBUG --- stdout --- 2025-03-28 11:46:53,824 DEBUG /results/orders/patch-500/stdout.txt file found 2025-03-28 11:46:53,824 DEBUG --- stderr --- 2025-03-28 11:46:53,824 DEBUG 2025-03-28 11:46:53,824 INFO 2025-03-28 11:46:53,824 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/patch-500/stdout.txt 2025-03-28 11:46:54,623 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 11:46:54,623 DEBUG --- stdout --- 2025-03-28 11:46:54,623 DEBUG 1236 /results/orders/patch-500/stdout.txt 2025-03-28 11:46:54,623 DEBUG --- stderr --- 2025-03-28 11:46:54,623 DEBUG 2025-03-28 11:46:54,623 INFO - Download file (size 1236k) source : /results/orders/patch-500/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/stdout.txt 2025-03-28 11:46:54,624 INFO 2025-03-28 11:46:54,624 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-500/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/stdout.txt 2025-03-28 11:46:54,624 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 11:46:55,861 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:55,861 DEBUG --- stdout --- 2025-03-28 11:46:55,861 DEBUG tar: Removing leading `/' from member names 2025-03-28 11:46:55,861 DEBUG --- stderr --- 2025-03-28 11:46:55,861 DEBUG ________________________________________________________________________________ [2025-03-28 11:46:55] patch-500 show_cmd : Display order command ________________________________________________________________________________ 2025-03-28 11:46:55,862 INFO 2025-03-28 11:46:55,862 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 11:46:55,862 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 11:46:56,138 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 11:46:56,138 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:56,138 DEBUG --- stdout --- 2025-03-28 11:46:56,138 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 11:46:56,138 DEBUG --- stderr --- 2025-03-28 11:46:56,138 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 11:46:56,139 INFO 2025-03-28 11:46:56,139 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/patch-500/cmd.txt" ]; then echo "/results/orders/patch-500/cmd.txt file found"; exit 0; else echo "/results/orders/patch-500/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/patch-500/cmd.txt file found" 2025-03-28 11:46:56,139 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 11:46:56,947 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 11:46:56,947 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:56,947 DEBUG --- stdout --- 2025-03-28 11:46:56,947 DEBUG /results/orders/patch-500/cmd.txt file found 2025-03-28 11:46:56,947 DEBUG --- stderr --- 2025-03-28 11:46:56,947 DEBUG 2025-03-28 11:46:56,947 INFO 2025-03-28 11:46:56,947 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/patch-500/cmd.txt 2025-03-28 11:46:57,751 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 11:46:57,751 DEBUG --- stdout --- 2025-03-28 11:46:57,751 DEBUG 4 /results/orders/patch-500/cmd.txt 2025-03-28 11:46:57,751 DEBUG --- stderr --- 2025-03-28 11:46:57,751 DEBUG 2025-03-28 11:46:57,751 INFO - Download file (size 4k) source : /results/orders/patch-500/cmd.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/cmd.txt 2025-03-28 11:46:57,752 INFO 2025-03-28 11:46:57,752 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-500/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/cmd.txt 2025-03-28 11:46:57,752 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 11:46:58,477 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:58,477 DEBUG --- stdout --- 2025-03-28 11:46:58,477 DEBUG tar: Removing leading `/' from member names 2025-03-28 11:46:58,477 DEBUG --- stderr --- 2025-03-28 11:46:58,477 DEBUG 2025-03-28 11:46:58,477 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/cmd.txt is small (1 lines), printing all lines: 2025-03-28 11:46:58,478 INFO ----- output ----- /lodestar/lodestar.py perf run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idm.ManagedUsersPatch@perf-200m" --results-folder="/results/gatling/patch-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.ManagedUsersPatch -DtestMode=open -Dthroughput=500 -Duser_password=T35!tr0c-k123" ________________________________________________________________________________ [2025-03-28 11:46:58] patch-500 show_rc : Display rc order ________________________________________________________________________________ 2025-03-28 11:46:58,478 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/rc.txt is small (1 lines), printing all lines: 2025-03-28 11:46:58,478 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 11:46:58] patch-500 show_stdout : Display stdout order ________________________________________________________________________________ 2025-03-28 11:46:58,480 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/06_patch-500/stdout.txt is 17022 lines): 2025-03-28 11:46:58,482 INFO ----- output ----- 2025-03-28 10:46:20,116 DEBUG Creating results folder /results/gatling/patch-500 2025-03-28 10:46:20,121 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp4gkf_zon 2025-03-28 10:46:20,124 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/patch-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.ManagedUsersPatch -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/tmp4gkf_zon/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/tmp4gkf_zon/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 10:46:37 GMT 5s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=206 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 ) > PatchManagedUser (OK=201 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 1809221 / active: 7 / done: 201 ================================================================================ ================================================================================ 2025-03-28 10:46:42 GMT 10s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=827 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 ) > PatchManagedUser (OK=822 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 1808596 / active: 11 / done: 822 ================================================================================ ================================================================================ 2025-03-28 10:46:47 GMT 15s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=1861 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 ) > PatchManagedUser (OK=1856 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 1807555 / active: 18 / done: 1856 ================================================================================ ================================================================================ 2025-03-28 10:46:52 GMT 20s elapsed [...] 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY2OTAwOSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJ5QWNQUVZ2LVI1VTFKaWhJTGlra1V5UlhHa0kiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTYyMjkzLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTYyMjkzLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjU4OTMsImlhdCI6MTc0MzE2MjI5MywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidG5qcnVuV0RWZm5GUUlJNklQLUU2QW85RUJBIn0.noMMlH9AHFBMRqhveSMU1brKU5N9bobRNPB8uRoUexBojYfPitFF0lMsQEQqW4zSYjMnGOnZ_xfp_BY6aZc8uLgpAYC4EePLnFgQzedBYssT9DEGaDd0w972Ty2Ha0kIzLWy4-f_W5CIhR-hb8xD5V5iBcGtHC1TfNKedmW04Nh9mRSwtqDfSd9xqsx8nrV7USLa6PdVtrAltDTEo4qx5FO5NzlIt1LjI1Con1FZNFhlW04HPwPZ4q0GhKVwHIN9_9pmvt_x8S5WkSMvSsCL5Mr8JmAe02N-6geqnP3J8bjYCRBjNh5yWtVSr3eZ_bdmIxZLPNwbrXW0AcZCL25aQQ host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "290-781-4077" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 11:46:32.977 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'PatchManagedUser' failed for user 1794221: j.i.IOException: Premature close 11:46:32.977 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,1794245,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY2OTAwOSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJ5QWNQUVZ2LVI1VTFKaWhJTGlra1V5UlhHa0kiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTYyMjkzLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTYyMjkzLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjU4OTMsImlhdCI6MTc0MzE2MjI5MywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidG5qcnVuV0RWZm5GUUlJNklQLUU2QW85RUJBIn0.noMMlH9AHFBMRqhveSMU1brKU5N9bobRNPB8uRoUexBojYfPitFF0lMsQEQqW4zSYjMnGOnZ_xfp_BY6aZc8uLgpAYC4EePLnFgQzedBYssT9DEGaDd0w972Ty2Ha0kIzLWy4-f_W5CIhR-hb8xD5V5iBcGtHC1TfNKedmW04Nh9mRSwtqDfSd9xqsx8nrV7USLa6PdVtrAltDTEo4qx5FO5NzlIt1LjI1Con1FZNFhlW04HPwPZ4q0GhKVwHIN9_9pmvt_x8S5WkSMvSsCL5Mr8JmAe02N-6geqnP3J8bjYCRBjNh5yWtVSr3eZ_bdmIxZLPNwbrXW0AcZCL25aQQ, username -> user.22437514, tokenIdCookieName -> 15892ffd844ef80, id -> 006f1603-3bb8-40c1-9fcc-798bcd134178, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@601b0280, givenname -> Euphemia, tokenId -> sKfzdICRv34hNjHyBszr-ko9Gds.*AAJTSQACMDIAAlNLABx1aUtjYkhzT1hDc1pnemNUcURhMHVkR25zcVk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Beverly, telNum -> 616-626-8381, challenge -> C82vo3c0KavEigmx9X-WTe7khF2dSINktT99n3M8LGA, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.22437514@example.com, verifier -> LTY5ODgxMTUzOTM0MTg4ODI3ODk, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3bc341e7),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007b455c69b068@26ba6179,io.netty.channel.epoll.EpollEventLoop@619bfe29) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/006f1603-3bb8-40c1-9fcc-798bcd134178 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY2OTAwOSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJ5QWNQUVZ2LVI1VTFKaWhJTGlra1V5UlhHa0kiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTYyMjkzLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTYyMjkzLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjU4OTMsImlhdCI6MTc0MzE2MjI5MywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidG5qcnVuV0RWZm5GUUlJNklQLUU2QW85RUJBIn0.noMMlH9AHFBMRqhveSMU1brKU5N9bobRNPB8uRoUexBojYfPitFF0lMsQEQqW4zSYjMnGOnZ_xfp_BY6aZc8uLgpAYC4EePLnFgQzedBYssT9DEGaDd0w972Ty2Ha0kIzLWy4-f_W5CIhR-hb8xD5V5iBcGtHC1TfNKedmW04Nh9mRSwtqDfSd9xqsx8nrV7USLa6PdVtrAltDTEo4qx5FO5NzlIt1LjI1Con1FZNFhlW04HPwPZ4q0GhKVwHIN9_9pmvt_x8S5WkSMvSsCL5Mr8JmAe02N-6geqnP3J8bjYCRBjNh5yWtVSr3eZ_bdmIxZLPNwbrXW0AcZCL25aQQ host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "616-626-8381" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 11:46:32.977 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,1794257,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY2OTAwOSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJ5QWNQUVZ2LVI1VTFKaWhJTGlra1V5UlhHa0kiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTYyMjkzLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTYyMjkzLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjU4OTMsImlhdCI6MTc0MzE2MjI5MywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidG5qcnVuV0RWZm5GUUlJNklQLUU2QW85RUJBIn0.noMMlH9AHFBMRqhveSMU1brKU5N9bobRNPB8uRoUexBojYfPitFF0lMsQEQqW4zSYjMnGOnZ_xfp_BY6aZc8uLgpAYC4EePLnFgQzedBYssT9DEGaDd0w972Ty2Ha0kIzLWy4-f_W5CIhR-hb8xD5V5iBcGtHC1TfNKedmW04Nh9mRSwtqDfSd9xqsx8nrV7USLa6PdVtrAltDTEo4qx5FO5NzlIt1LjI1Con1FZNFhlW04HPwPZ4q0GhKVwHIN9_9pmvt_x8S5WkSMvSsCL5Mr8JmAe02N-6geqnP3J8bjYCRBjNh5yWtVSr3eZ_bdmIxZLPNwbrXW0AcZCL25aQQ, username -> user.9434194, tokenIdCookieName -> 15892ffd844ef80, id -> 006f175f-bf26-45c3-b817-5671eb11820f, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@6f2c9464, givenname -> Celestina, tokenId -> sKfzdICRv34hNjHyBszr-ko9Gds.*AAJTSQACMDIAAlNLABx1aUtjYkhzT1hDc1pnemNUcURhMHVkR25zcVk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Barr, telNum -> 547-854-4777, challenge -> C82vo3c0KavEigmx9X-WTe7khF2dSINktT99n3M8LGA, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.9434194@example.com, verifier -> LTY5ODgxMTUzOTM0MTg4ODI3ODk, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@311d0f87),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007b455c69b068@26ba6179,io.netty.channel.epoll.EpollEventLoop@f79a760) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/006f175f-bf26-45c3-b817-5671eb11820f 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY2OTAwOSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJ5QWNQUVZ2LVI1VTFKaWhJTGlra1V5UlhHa0kiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTYyMjkzLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTYyMjkzLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjU4OTMsImlhdCI6MTc0MzE2MjI5MywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidG5qcnVuV0RWZm5GUUlJNklQLUU2QW85RUJBIn0.noMMlH9AHFBMRqhveSMU1brKU5N9bobRNPB8uRoUexBojYfPitFF0lMsQEQqW4zSYjMnGOnZ_xfp_BY6aZc8uLgpAYC4EePLnFgQzedBYssT9DEGaDd0w972Ty2Ha0kIzLWy4-f_W5CIhR-hb8xD5V5iBcGtHC1TfNKedmW04Nh9mRSwtqDfSd9xqsx8nrV7USLa6PdVtrAltDTEo4qx5FO5NzlIt1LjI1Con1FZNFhlW04HPwPZ4q0GhKVwHIN9_9pmvt_x8S5WkSMvSsCL5Mr8JmAe02N-6geqnP3J8bjYCRBjNh5yWtVSr3eZ_bdmIxZLPNwbrXW0AcZCL25aQQ host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "547-854-4777" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 11:46:32.977 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,1794221,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY2OTAwOSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJ5QWNQUVZ2LVI1VTFKaWhJTGlra1V5UlhHa0kiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTYyMjkzLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTYyMjkzLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjU4OTMsImlhdCI6MTc0MzE2MjI5MywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidG5qcnVuV0RWZm5GUUlJNklQLUU2QW85RUJBIn0.noMMlH9AHFBMRqhveSMU1brKU5N9bobRNPB8uRoUexBojYfPitFF0lMsQEQqW4zSYjMnGOnZ_xfp_BY6aZc8uLgpAYC4EePLnFgQzedBYssT9DEGaDd0w972Ty2Ha0kIzLWy4-f_W5CIhR-hb8xD5V5iBcGtHC1TfNKedmW04Nh9mRSwtqDfSd9xqsx8nrV7USLa6PdVtrAltDTEo4qx5FO5NzlIt1LjI1Con1FZNFhlW04HPwPZ4q0GhKVwHIN9_9pmvt_x8S5WkSMvSsCL5Mr8JmAe02N-6geqnP3J8bjYCRBjNh5yWtVSr3eZ_bdmIxZLPNwbrXW0AcZCL25aQQ, username -> user.6465949, tokenIdCookieName -> 15892ffd844ef80, id -> 006f13b8-d82c-4c75-b24a-26c786e38e48, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@cca7dba, givenname -> Hally, tokenId -> sKfzdICRv34hNjHyBszr-ko9Gds.*AAJTSQACMDIAAlNLABx1aUtjYkhzT1hDc1pnemNUcURhMHVkR25zcVk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Splitt, telNum -> 886-810-5050, challenge -> C82vo3c0KavEigmx9X-WTe7khF2dSINktT99n3M8LGA, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.6465949@example.com, verifier -> LTY5ODgxMTUzOTM0MTg4ODI3ODk, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@ae9b0ff),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007b455c69b068@26ba6179,io.netty.channel.epoll.EpollEventLoop@1e1d3956) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/006f13b8-d82c-4c75-b24a-26c786e38e48 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY2OTAwOSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJ5QWNQUVZ2LVI1VTFKaWhJTGlra1V5UlhHa0kiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTYyMjkzLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTYyMjkzLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjU4OTMsImlhdCI6MTc0MzE2MjI5MywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidG5qcnVuV0RWZm5GUUlJNklQLUU2QW85RUJBIn0.noMMlH9AHFBMRqhveSMU1brKU5N9bobRNPB8uRoUexBojYfPitFF0lMsQEQqW4zSYjMnGOnZ_xfp_BY6aZc8uLgpAYC4EePLnFgQzedBYssT9DEGaDd0w972Ty2Ha0kIzLWy4-f_W5CIhR-hb8xD5V5iBcGtHC1TfNKedmW04Nh9mRSwtqDfSd9xqsx8nrV7USLa6PdVtrAltDTEo4qx5FO5NzlIt1LjI1Con1FZNFhlW04HPwPZ4q0GhKVwHIN9_9pmvt_x8S5WkSMvSsCL5Mr8JmAe02N-6geqnP3J8bjYCRBjNh5yWtVSr3eZ_bdmIxZLPNwbrXW0AcZCL25aQQ host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "886-810-5050" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:00 h [INFO] Finished at: 2025-03-28T11:46:33Z [INFO] ------------------------------------------------------------------------ 2025-03-28 11:46:33,042 INFO Gatling simulation run ended successfully 2025-03-28 11:46:33,042 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-03-28 11:46:58] patch-500 show_stderr : Display stderr order ________________________________________________________________________________ 2025-03-28 11:46:58,483 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/06_patch-500/stderr.txt is small (0 lines), printing all lines: 2025-03-28 11:46:58,483 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 11:46:58] patch-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 11:46:58] patch-500 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-03-28 11:46:58] patch-500 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped