--Task-- name: patch-1500 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: ['patch-1000'] preceding_task: patch-1000 options: {'testMode': 'open', 'testCase': 'idm.ManagedUsersPatch', 'duration': 3600, 'throughput': 1500, '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 12:47:41,812 INFO 2025-03-28 12:47:41,812 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 12:47:41,812 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 12:47:42,089 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 12:47:42,089 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:42,089 DEBUG --- stdout --- 2025-03-28 12:47:42,089 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 12:47:42,089 DEBUG --- stderr --- 2025-03-28 12:47:42,089 DEBUG 2025-03-28 12:47:42,089 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-03-28 12:47:42 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-03-28 12:47:42 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/patch-1500/stdout.txt Pod log : /results/orders/patch-1500 ________________________________________________________________________________ [2025-03-28 12:47:42] patch-1500 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-1500" --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=1500 -Duser_password=**** ________________________________________________________________________________ [2025-03-28 12:47:42] patch-1500 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/08_patch-1500/order.json { "name": "patch-1500", "command": " /lodestar/lodestar.py perf run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idm.ManagedUsersPatch@perf-200m\" --results-folder=\"/results/gatling/patch-1500\" --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=1500 -Duser_password=T35!tr0c-k123\"", "out-dir": "/results/orders/patch-1500" } ________________________________________________________________________________ [2025-03-28 12:47:42] patch-1500 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 12:47:42,097 INFO 2025-03-28 12:47:42,097 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 12:47:42,097 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 12:47:42,312 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 12:47:42,312 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:42,312 DEBUG --- stdout --- 2025-03-28 12:47:42,312 DEBUG WAITING 2025-03-28 12:47:42,312 DEBUG --- stderr --- 2025-03-28 12:47:42,312 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 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2025-03-28 12:47:42] patch-1500 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-03-28 12:47:42,312 INFO 2025-03-28 12:47:42,313 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 12:47:42,313 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 12:47:42,591 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 12:47:42,591 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:42,591 DEBUG --- stdout --- 2025-03-28 12:47:42,591 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 12:47:42,591 DEBUG --- stderr --- 2025-03-28 12:47:42,591 DEBUG 2025-03-28 12:47:42,591 INFO 2025-03-28 12:47:42,591 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/08_patch-1500/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 12:47:42,591 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 12:47:43,955 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:43,956 DEBUG --- stdout --- 2025-03-28 12:47:43,956 DEBUG 2025-03-28 12:47:43,956 DEBUG --- stderr --- 2025-03-28 12:47:43,956 DEBUG Order has been successfully forwarded to overseer 2025-03-28 12:47:43 - INFO: Check if Gatling simulation started successfully 2025-03-28 12:47:43,956 INFO 2025-03-28 12:47:43,956 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-1500/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-03-28 12:47:43,956 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 12:47:44,702 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 12:47:50,436 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 12:47:56,175 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 12:48:01,901 INFO [loop_until]: Function succeeded after 17s (rc=0) - expected pattern found 2025-03-28 12:48:01,901 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:48:01,901 DEBUG --- stdout --- 2025-03-28 12:48:01,901 DEBUG 2025-03-28 12:47:44,725 DEBUG Creating results folder /results/gatling/patch-1500 2025-03-28 12:47:44,731 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp2dt9w0z5 2025-03-28 12:47:44,734 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/patch-1500" -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=1500 -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/tmp2dt9w0z5/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/tmp2dt9w0z5/target/test-classes ... [INFO] compile in 9.4 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 12:48:01,901 DEBUG --- stderr --- 2025-03-28 12:48:01,901 DEBUG ________________________________________________________________________________ [2025-03-28 12:48:01] patch-1500 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 03s, 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 13:48:10] patch-1500 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-03-28 13:48:10,883 INFO 2025-03-28 13:48:10,883 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 13:48:10,883 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 13:48:11,192 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 13:48:11,192 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:11,192 DEBUG --- stdout --- 2025-03-28 13:48:11,192 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 13:48:11,192 DEBUG --- stderr --- 2025-03-28 13:48:11,192 DEBUG 2025-03-28 13:48:11,192 INFO 2025-03-28 13:48:11,192 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 13:48:11,192 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 13:48:12,010 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:12,010 DEBUG --- stdout --- 2025-03-28 13:48:12,010 DEBUG 2025-03-28 13:48:12,010 DEBUG --- stderr --- 2025-03-28 13:48:12,010 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-03-28 13:48:12] patch-1500 download_logs : Download individual order files ________________________________________________________________________________ 2025-03-28 13:48:12 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/order.json 2025-03-28 13:48:12,010 INFO 2025-03-28 13:48:12,010 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 13:48:12,010 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 13:48:12,289 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 13:48:12,289 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:12,290 DEBUG --- stdout --- 2025-03-28 13:48:12,290 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 13:48:12,290 DEBUG --- stderr --- 2025-03-28 13:48:12,290 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 13:48:12,291 INFO 2025-03-28 13:48:12,291 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-1500/rc.txt" ]; then echo "/results/orders/patch-1500/rc.txt file found"; exit 0; else echo "/results/orders/patch-1500/rc.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1500/rc.txt file found" 2025-03-28 13:48:12,291 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 13:48:13,085 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 13:48:13,085 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:13,085 DEBUG --- stdout --- 2025-03-28 13:48:13,085 DEBUG /results/orders/patch-1500/rc.txt file found 2025-03-28 13:48:13,085 DEBUG --- stderr --- 2025-03-28 13:48:13,085 DEBUG 2025-03-28 13:48:13,085 INFO 2025-03-28 13:48:13,085 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-1500/rc.txt 2025-03-28 13:48:13,883 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 13:48:13,883 DEBUG --- stdout --- 2025-03-28 13:48:13,883 DEBUG 4 /results/orders/patch-1500/rc.txt 2025-03-28 13:48:13,883 DEBUG --- stderr --- 2025-03-28 13:48:13,883 DEBUG 2025-03-28 13:48:13,883 INFO - Download file (size 4k) source : /results/orders/patch-1500/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/rc.txt 2025-03-28 13:48:13,883 INFO 2025-03-28 13:48:13,883 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1500/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/rc.txt 2025-03-28 13:48:13,884 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 13:48:14,607 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:14,607 DEBUG --- stdout --- 2025-03-28 13:48:14,607 DEBUG tar: Removing leading `/' from member names 2025-03-28 13:48:14,607 DEBUG --- stderr --- 2025-03-28 13:48:14,607 DEBUG 2025-03-28 13:48:14,607 INFO 2025-03-28 13:48:14,607 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 13:48:14,607 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 13:48:14,887 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 13:48:14,887 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:14,887 DEBUG --- stdout --- 2025-03-28 13:48:14,887 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 13:48:14,887 DEBUG --- stderr --- 2025-03-28 13:48:14,887 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 13:48:14,888 INFO 2025-03-28 13:48:14,888 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-1500/stderr.txt" ]; then echo "/results/orders/patch-1500/stderr.txt file found"; exit 0; else echo "/results/orders/patch-1500/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1500/stderr.txt file found" 2025-03-28 13:48:14,888 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 13:48:15,691 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 13:48:15,691 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:15,691 DEBUG --- stdout --- 2025-03-28 13:48:15,691 DEBUG /results/orders/patch-1500/stderr.txt file found 2025-03-28 13:48:15,691 DEBUG --- stderr --- 2025-03-28 13:48:15,691 DEBUG 2025-03-28 13:48:15,691 INFO 2025-03-28 13:48:15,691 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-1500/stderr.txt 2025-03-28 13:48:16,498 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 13:48:16,498 DEBUG --- stdout --- 2025-03-28 13:48:16,498 DEBUG 0 /results/orders/patch-1500/stderr.txt 2025-03-28 13:48:16,498 DEBUG --- stderr --- 2025-03-28 13:48:16,498 DEBUG 2025-03-28 13:48:16,498 INFO - Download file (size 0k) source : /results/orders/patch-1500/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/stderr.txt 2025-03-28 13:48:16,499 INFO 2025-03-28 13:48:16,499 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1500/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/stderr.txt 2025-03-28 13:48:16,499 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 13:48:17,259 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:17,259 DEBUG --- stdout --- 2025-03-28 13:48:17,259 DEBUG tar: Removing leading `/' from member names 2025-03-28 13:48:17,259 DEBUG --- stderr --- 2025-03-28 13:48:17,259 DEBUG 2025-03-28 13:48:17,260 INFO 2025-03-28 13:48:17,260 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 13:48:17,260 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 13:48:17,540 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 13:48:17,540 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:17,540 DEBUG --- stdout --- 2025-03-28 13:48:17,540 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 13:48:17,541 DEBUG --- stderr --- 2025-03-28 13:48:17,541 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 13:48:17,542 INFO 2025-03-28 13:48:17,542 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-1500/stdout.txt" ]; then echo "/results/orders/patch-1500/stdout.txt file found"; exit 0; else echo "/results/orders/patch-1500/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1500/stdout.txt file found" 2025-03-28 13:48:17,542 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 13:48:18,337 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 13:48:18,337 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:18,337 DEBUG --- stdout --- 2025-03-28 13:48:18,337 DEBUG /results/orders/patch-1500/stdout.txt file found 2025-03-28 13:48:18,337 DEBUG --- stderr --- 2025-03-28 13:48:18,337 DEBUG 2025-03-28 13:48:18,337 INFO 2025-03-28 13:48:18,337 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-1500/stdout.txt 2025-03-28 13:48:19,131 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 13:48:19,131 DEBUG --- stdout --- 2025-03-28 13:48:19,131 DEBUG 1744 /results/orders/patch-1500/stdout.txt 2025-03-28 13:48:19,131 DEBUG --- stderr --- 2025-03-28 13:48:19,131 DEBUG 2025-03-28 13:48:19,131 INFO - Download file (size 1744k) source : /results/orders/patch-1500/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/stdout.txt 2025-03-28 13:48:19,132 INFO 2025-03-28 13:48:19,132 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1500/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/stdout.txt 2025-03-28 13:48:19,132 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 13:48:20,295 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:20,295 DEBUG --- stdout --- 2025-03-28 13:48:20,295 DEBUG tar: Removing leading `/' from member names 2025-03-28 13:48:20,295 DEBUG --- stderr --- 2025-03-28 13:48:20,296 DEBUG ________________________________________________________________________________ [2025-03-28 13:48:20] patch-1500 show_cmd : Display order command ________________________________________________________________________________ 2025-03-28 13:48:20,296 INFO 2025-03-28 13:48:20,296 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 13:48:20,296 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 13:48:20,575 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 13:48:20,575 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:20,575 DEBUG --- stdout --- 2025-03-28 13:48:20,575 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 13:48:20,575 DEBUG --- stderr --- 2025-03-28 13:48:20,575 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 13:48:20,576 INFO 2025-03-28 13:48:20,576 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-1500/cmd.txt" ]; then echo "/results/orders/patch-1500/cmd.txt file found"; exit 0; else echo "/results/orders/patch-1500/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1500/cmd.txt file found" 2025-03-28 13:48:20,576 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 13:48:21,374 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 13:48:21,374 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:21,374 DEBUG --- stdout --- 2025-03-28 13:48:21,374 DEBUG /results/orders/patch-1500/cmd.txt file found 2025-03-28 13:48:21,374 DEBUG --- stderr --- 2025-03-28 13:48:21,374 DEBUG 2025-03-28 13:48:21,374 INFO 2025-03-28 13:48:21,374 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-1500/cmd.txt 2025-03-28 13:48:22,169 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 13:48:22,169 DEBUG --- stdout --- 2025-03-28 13:48:22,169 DEBUG 4 /results/orders/patch-1500/cmd.txt 2025-03-28 13:48:22,169 DEBUG --- stderr --- 2025-03-28 13:48:22,169 DEBUG 2025-03-28 13:48:22,169 INFO - Download file (size 4k) source : /results/orders/patch-1500/cmd.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/cmd.txt 2025-03-28 13:48:22,170 INFO 2025-03-28 13:48:22,170 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1500/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/cmd.txt 2025-03-28 13:48:22,170 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 13:48:22,893 INFO [loop_until]: OK (rc = 0) 2025-03-28 13:48:22,893 DEBUG --- stdout --- 2025-03-28 13:48:22,893 DEBUG tar: Removing leading `/' from member names 2025-03-28 13:48:22,893 DEBUG --- stderr --- 2025-03-28 13:48:22,893 DEBUG 2025-03-28 13:48:22,893 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/cmd.txt is small (1 lines), printing all lines: 2025-03-28 13:48:22,893 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-1500" --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=1500 -Duser_password=T35!tr0c-k123" ________________________________________________________________________________ [2025-03-28 13:48:22] patch-1500 show_rc : Display rc order ________________________________________________________________________________ 2025-03-28 13:48:22,894 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/rc.txt is small (1 lines), printing all lines: 2025-03-28 13:48:22,894 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 13:48:22] patch-1500 show_stdout : Display stdout order ________________________________________________________________________________ 2025-03-28 13:48:22,896 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/08_patch-1500/stdout.txt is 21324 lines): 2025-03-28 13:48:22,899 INFO ----- output ----- 2025-03-28 12:47:44,725 DEBUG Creating results folder /results/gatling/patch-1500 2025-03-28 12:47:44,731 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp2dt9w0z5 2025-03-28 12:47:44,734 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/patch-1500" -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=1500 -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/tmp2dt9w0z5/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/tmp2dt9w0z5/target/test-classes ... [INFO] compile in 9.4 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 12:48:04 GMT 5s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=610 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=605 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 5419628 / active: 19 / done: 605 ================================================================================ ================================================================================ 2025-03-28 12:48:09 GMT 10s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=2464 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=2459 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 5417755 / active: 38 / done: 2459 ================================================================================ ================================================================================ 2025-03-28 12:48:14 GMT 15s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=5568 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=5563 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 5414632 / active: 58 / done: 5562 ================================================================================ ================================================================================ 2025-03-28 12:48:19 GMT 20s elapsed [...] 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY4NjM3NyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiIwdkdpOGNYZ3BXamhEajJGR2p0QlNER3QxbTAiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY5NTgwLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY5NTgwLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNzMxODAsImlhdCI6MTc0MzE2OTU4MCwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTERQekI2UjN6WjRKSFRzdTVkQjd6UFpvbHB3In0.mxaeI8WjEfxYp3nfNMBsAvTIwNsipgsTNHL4KStkF3wCBV--xuv7wy0IP1iFbbiKA81iSL_Kl0caXKPomfzBZw-PCDa-z8eG9U4Asllr0PK1sM-6d0aDLPtsFyCdYQhqAQFXZbAgW2llVDZVaTyeE4cUHxLgEyjpknXeIJuHGdbABCTs9ixt8e2_4_ZUcWE4IFfwd7dgVSY3NXrLZdv-SAUmM6BS2BJkm6uocOkdY6sAtBMJQ7tTQrKv_IM5PQS5aaJ3l-AmQupjTvCVKqnwWF9A-j27yRW29wvixExnU_Hk97tWMYh5eHZ1zk7r9uG_mfeIHWfcssrlzB44La2wTA host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "315-385-7044" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 13:47:59.224 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'PatchManagedUser' failed for user 5375466: j.i.IOException: Premature close 13:47:59.225 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,5375426,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY4NjM3NyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiIwdkdpOGNYZ3BXamhEajJGR2p0QlNER3QxbTAiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY5NTgwLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY5NTgwLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNzMxODAsImlhdCI6MTc0MzE2OTU4MCwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTERQekI2UjN6WjRKSFRzdTVkQjd6UFpvbHB3In0.mxaeI8WjEfxYp3nfNMBsAvTIwNsipgsTNHL4KStkF3wCBV--xuv7wy0IP1iFbbiKA81iSL_Kl0caXKPomfzBZw-PCDa-z8eG9U4Asllr0PK1sM-6d0aDLPtsFyCdYQhqAQFXZbAgW2llVDZVaTyeE4cUHxLgEyjpknXeIJuHGdbABCTs9ixt8e2_4_ZUcWE4IFfwd7dgVSY3NXrLZdv-SAUmM6BS2BJkm6uocOkdY6sAtBMJQ7tTQrKv_IM5PQS5aaJ3l-AmQupjTvCVKqnwWF9A-j27yRW29wvixExnU_Hk97tWMYh5eHZ1zk7r9uG_mfeIHWfcssrlzB44La2wTA, username -> user.140041537, tokenIdCookieName -> 15892ffd844ef80, id -> 014b868c-a8b8-4f70-b87e-cdb4a4c329be, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@3870a071, givenname -> Bernardo, tokenId -> 5IFOuIbN2vJr7iRugyU3GXtx_yQ.*AAJTSQACMDIAAlNLABxGUngraTc3VFV0Ym4xNDhTbWE5bnE4NjMxRkU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Benefits1833, telNum -> 655-360-293, challenge -> XUy0ZR4npSk5BkeQ5J44MliopzO8f_H_hMJFsxirN-8, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.140041537@example.com, verifier -> NTk0OTM0NzkwNjY5Mzk5MzQwNQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@689fb8f8),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x0000790ce069b320@540310bb,io.netty.channel.epoll.EpollEventLoop@14f5da2c) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/014b868c-a8b8-4f70-b87e-cdb4a4c329be 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY4NjM3NyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiIwdkdpOGNYZ3BXamhEajJGR2p0QlNER3QxbTAiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY5NTgwLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY5NTgwLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNzMxODAsImlhdCI6MTc0MzE2OTU4MCwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTERQekI2UjN6WjRKSFRzdTVkQjd6UFpvbHB3In0.mxaeI8WjEfxYp3nfNMBsAvTIwNsipgsTNHL4KStkF3wCBV--xuv7wy0IP1iFbbiKA81iSL_Kl0caXKPomfzBZw-PCDa-z8eG9U4Asllr0PK1sM-6d0aDLPtsFyCdYQhqAQFXZbAgW2llVDZVaTyeE4cUHxLgEyjpknXeIJuHGdbABCTs9ixt8e2_4_ZUcWE4IFfwd7dgVSY3NXrLZdv-SAUmM6BS2BJkm6uocOkdY6sAtBMJQ7tTQrKv_IM5PQS5aaJ3l-AmQupjTvCVKqnwWF9A-j27yRW29wvixExnU_Hk97tWMYh5eHZ1zk7r9uG_mfeIHWfcssrlzB44La2wTA host: openam-perf-200m.forgeblocks.com content-length: 97 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "655-360-293" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 13:47:59.225 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,5375466,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY4NjM3NyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiIwdkdpOGNYZ3BXamhEajJGR2p0QlNER3QxbTAiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY5NTgwLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY5NTgwLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNzMxODAsImlhdCI6MTc0MzE2OTU4MCwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTERQekI2UjN6WjRKSFRzdTVkQjd6UFpvbHB3In0.mxaeI8WjEfxYp3nfNMBsAvTIwNsipgsTNHL4KStkF3wCBV--xuv7wy0IP1iFbbiKA81iSL_Kl0caXKPomfzBZw-PCDa-z8eG9U4Asllr0PK1sM-6d0aDLPtsFyCdYQhqAQFXZbAgW2llVDZVaTyeE4cUHxLgEyjpknXeIJuHGdbABCTs9ixt8e2_4_ZUcWE4IFfwd7dgVSY3NXrLZdv-SAUmM6BS2BJkm6uocOkdY6sAtBMJQ7tTQrKv_IM5PQS5aaJ3l-AmQupjTvCVKqnwWF9A-j27yRW29wvixExnU_Hk97tWMYh5eHZ1zk7r9uG_mfeIHWfcssrlzB44La2wTA, username -> user.70216848, tokenIdCookieName -> 15892ffd844ef80, id -> 014b8910-bd3a-4df9-adbb-33bade757156, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@53a230c8, givenname -> March, tokenId -> 5IFOuIbN2vJr7iRugyU3GXtx_yQ.*AAJTSQACMDIAAlNLABxGUngraTc3VFV0Ym4xNDhTbWE5bnE4NjMxRkU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Naujoks, telNum -> 257-284-4510, challenge -> XUy0ZR4npSk5BkeQ5J44MliopzO8f_H_hMJFsxirN-8, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.70216848@example.com, verifier -> NTk0OTM0NzkwNjY5Mzk5MzQwNQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@61eee466),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x0000790ce069b320@540310bb,io.netty.channel.epoll.EpollEventLoop@2bef51f2) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/014b8910-bd3a-4df9-adbb-33bade757156 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY4NjM3NyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiIwdkdpOGNYZ3BXamhEajJGR2p0QlNER3QxbTAiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY5NTgwLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY5NTgwLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNzMxODAsImlhdCI6MTc0MzE2OTU4MCwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTERQekI2UjN6WjRKSFRzdTVkQjd6UFpvbHB3In0.mxaeI8WjEfxYp3nfNMBsAvTIwNsipgsTNHL4KStkF3wCBV--xuv7wy0IP1iFbbiKA81iSL_Kl0caXKPomfzBZw-PCDa-z8eG9U4Asllr0PK1sM-6d0aDLPtsFyCdYQhqAQFXZbAgW2llVDZVaTyeE4cUHxLgEyjpknXeIJuHGdbABCTs9ixt8e2_4_ZUcWE4IFfwd7dgVSY3NXrLZdv-SAUmM6BS2BJkm6uocOkdY6sAtBMJQ7tTQrKv_IM5PQS5aaJ3l-AmQupjTvCVKqnwWF9A-j27yRW29wvixExnU_Hk97tWMYh5eHZ1zk7r9uG_mfeIHWfcssrlzB44La2wTA host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "257-284-4510" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 13:47:59.225 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'PatchManagedUser' failed for user 5375434: j.i.IOException: Premature close 13:47:59.225 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,5375434,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY4NjM3NyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiIwdkdpOGNYZ3BXamhEajJGR2p0QlNER3QxbTAiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY5NTgwLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY5NTgwLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNzMxODAsImlhdCI6MTc0MzE2OTU4MCwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTERQekI2UjN6WjRKSFRzdTVkQjd6UFpvbHB3In0.mxaeI8WjEfxYp3nfNMBsAvTIwNsipgsTNHL4KStkF3wCBV--xuv7wy0IP1iFbbiKA81iSL_Kl0caXKPomfzBZw-PCDa-z8eG9U4Asllr0PK1sM-6d0aDLPtsFyCdYQhqAQFXZbAgW2llVDZVaTyeE4cUHxLgEyjpknXeIJuHGdbABCTs9ixt8e2_4_ZUcWE4IFfwd7dgVSY3NXrLZdv-SAUmM6BS2BJkm6uocOkdY6sAtBMJQ7tTQrKv_IM5PQS5aaJ3l-AmQupjTvCVKqnwWF9A-j27yRW29wvixExnU_Hk97tWMYh5eHZ1zk7r9uG_mfeIHWfcssrlzB44La2wTA, username -> user.88287996, tokenIdCookieName -> 15892ffd844ef80, id -> 014b8756-6003-4c3d-90a8-2505694bcdac, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@77fb0e36, givenname -> Eleonora, tokenId -> 5IFOuIbN2vJr7iRugyU3GXtx_yQ.*AAJTSQACMDIAAlNLABxGUngraTc3VFV0Ym4xNDhTbWE5bnE4NjMxRkU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Gingerich, telNum -> 724-973-3615, challenge -> XUy0ZR4npSk5BkeQ5J44MliopzO8f_H_hMJFsxirN-8, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.88287996@example.com, verifier -> NTk0OTM0NzkwNjY5Mzk5MzQwNQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@2824f9b2),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x0000790ce069b320@540310bb,io.netty.channel.epoll.EpollEventLoop@2bef51f2) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/014b8756-6003-4c3d-90a8-2505694bcdac 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiM2RlMWVkMDktYjhlZi00YjRmLTkzYWMtMGRmZjkzYmIyMDA2LTY4NjM3NyIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiIwdkdpOGNYZ3BXamhEajJGR2p0QlNER3QxbTAiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY5NTgwLCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY5NTgwLCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNzMxODAsImlhdCI6MTc0MzE2OTU4MCwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTERQekI2UjN6WjRKSFRzdTVkQjd6UFpvbHB3In0.mxaeI8WjEfxYp3nfNMBsAvTIwNsipgsTNHL4KStkF3wCBV--xuv7wy0IP1iFbbiKA81iSL_Kl0caXKPomfzBZw-PCDa-z8eG9U4Asllr0PK1sM-6d0aDLPtsFyCdYQhqAQFXZbAgW2llVDZVaTyeE4cUHxLgEyjpknXeIJuHGdbABCTs9ixt8e2_4_ZUcWE4IFfwd7dgVSY3NXrLZdv-SAUmM6BS2BJkm6uocOkdY6sAtBMJQ7tTQrKv_IM5PQS5aaJ3l-AmQupjTvCVKqnwWF9A-j27yRW29wvixExnU_Hk97tWMYh5eHZ1zk7r9uG_mfeIHWfcssrlzB44La2wTA host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "724-973-3615" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:00 h [INFO] Finished at: 2025-03-28T13:47:59Z [INFO] ------------------------------------------------------------------------ 2025-03-28 13:47:59,302 INFO Gatling simulation run ended successfully 2025-03-28 13:47:59,302 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-03-28 13:48:22] patch-1500 show_stderr : Display stderr order ________________________________________________________________________________ 2025-03-28 13:48:22,900 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/08_patch-1500/stderr.txt is small (0 lines), printing all lines: 2025-03-28 13:48:22,900 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 13:48:22] patch-1500 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 13:48:23] patch-1500 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-03-28 13:48:23] patch-1500 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped