--Task-- name: patch-1000 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-500'] preceding_task: patch-500 options: {'testMode': 'open', 'testCase': 'idm.ManagedUsersPatch', 'duration': 3600, 'throughput': 1000, '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 11:46:59,536 INFO 2025-03-28 11:46:59,536 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:59,536 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 11:46:59,826 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 11:46:59,826 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:46:59,826 DEBUG --- stdout --- 2025-03-28 11:46:59,826 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 11:46:59,826 DEBUG --- stderr --- 2025-03-28 11:46:59,826 DEBUG 2025-03-28 11:46:59,826 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-03-28 11:46:59 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-03-28 11:46:59 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/patch-1000/stdout.txt Pod log : /results/orders/patch-1000 ________________________________________________________________________________ [2025-03-28 11:46:59] patch-1000 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-1000" --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=1000 -Duser_password=**** ________________________________________________________________________________ [2025-03-28 11:46:59] patch-1000 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/07_patch-1000/order.json { "name": "patch-1000", "command": " /lodestar/lodestar.py perf run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idm.ManagedUsersPatch@perf-200m\" --results-folder=\"/results/gatling/patch-1000\" --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=1000 -Duser_password=T35!tr0c-k123\"", "out-dir": "/results/orders/patch-1000" } ________________________________________________________________________________ [2025-03-28 11:46:59] patch-1000 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 11:46:59,834 INFO 2025-03-28 11:46:59,834 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 11:46:59,834 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 11:47:00,049 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 11:47:00,049 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:47:00,049 DEBUG --- stdout --- 2025-03-28 11:47:00,049 DEBUG WAITING 2025-03-28 11:47:00,049 DEBUG --- stderr --- 2025-03-28 11:47:00,049 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 11:47:00] patch-1000 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-03-28 11:47:00,050 INFO 2025-03-28 11:47:00,050 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:47:00,050 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 11:47:00,333 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 11:47:00,333 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:47:00,333 DEBUG --- stdout --- 2025-03-28 11:47:00,333 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 11:47:00,333 DEBUG --- stderr --- 2025-03-28 11:47:00,333 DEBUG 2025-03-28 11:47:00,334 INFO 2025-03-28 11:47:00,334 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/07_patch-1000/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 11:47:00,334 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 11:47:01,705 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:47:01,705 DEBUG --- stdout --- 2025-03-28 11:47:01,705 DEBUG 2025-03-28 11:47:01,705 DEBUG --- stderr --- 2025-03-28 11:47:01,705 DEBUG Order has been successfully forwarded to overseer 2025-03-28 11:47:01 - INFO: Check if Gatling simulation started successfully 2025-03-28 11:47:01,705 INFO 2025-03-28 11:47:01,705 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-1000/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-03-28 11:47:01,705 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 11:47:02,442 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 11:47:08,270 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 11:47:13,998 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 11:47:19,732 INFO [loop_until]: Function succeeded after 18s (rc=0) - expected pattern found 2025-03-28 11:47:19,732 INFO [loop_until]: OK (rc = 0) 2025-03-28 11:47:19,732 DEBUG --- stdout --- 2025-03-28 11:47:19,732 DEBUG 2025-03-28 11:47:02,424 DEBUG Creating results folder /results/gatling/patch-1000 2025-03-28 11:47:02,429 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmppbc8agaq 2025-03-28 11:47:02,432 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/patch-1000" -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=1000 -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/tmppbc8agaq/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/tmppbc8agaq/target/test-classes ... [INFO] compile in 8.7 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 11:47:19,732 DEBUG --- stderr --- 2025-03-28 11:47:19,732 DEBUG ________________________________________________________________________________ [2025-03-28 11:47:19] patch-1000 wait_stop_by_itself : Wait for the order to stop by itself ________________________________________________________________________________ Task may stop by itself (no stop defined in configuration file), wait until overseer ends the order - timeout is 1h 12m. Waiting for status (curl --fail --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt) == WAITING Order is running since 2m, retry Order is running since 4m, retry Order is running since 6m, retry Order is running since 8m 01s, retry Order is running since 10m 01s, retry Order is running since 12m 01s, retry Order is running since 14m 02s, retry Order is running since 16m 02s, retry Order is running since 18m 02s, retry Order is running since 20m 02s, retry Order is running since 22m 03s, retry Order is running since 24m 03s, retry Order is running since 26m 03s, retry Order is running since 28m 04s, retry Order is running since 30m 04s, retry Order is running since 32m 04s, retry Order is running since 34m 05s, retry Order is running since 36m 05s, retry Order is running since 38m 05s, retry Order is running since 40m 05s, retry Order is running since 42m 06s, retry Order is running since 44m 06s, retry Order is running since 46m 06s, retry Order is running since 48m 07s, retry Order is running since 50m 07s, retry Order is running since 52m 07s, retry Order is running since 54m 08s, retry Order is running since 56m 08s, retry Order is running since 58m 08s, retry PASS : Order stopped by itself after 1h and before timeout (1h 12m) ________________________________________________________________________________ [2025-03-28 12:47:28] patch-1000 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-03-28 12:47:28,622 INFO 2025-03-28 12:47:28,622 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:28,622 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 12:47:28,924 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 12:47:28,925 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:28,925 DEBUG --- stdout --- 2025-03-28 12:47:28,925 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 12:47:28,925 DEBUG --- stderr --- 2025-03-28 12:47:28,925 DEBUG 2025-03-28 12:47:28,925 INFO 2025-03-28 12:47:28,925 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 12:47:28,925 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 12:47:29,704 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:29,704 DEBUG --- stdout --- 2025-03-28 12:47:29,705 DEBUG 2025-03-28 12:47:29,705 DEBUG --- stderr --- 2025-03-28 12:47:29,705 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-03-28 12:47:29] patch-1000 download_logs : Download individual order files ________________________________________________________________________________ 2025-03-28 12:47:29 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/order.json 2025-03-28 12:47:29,706 INFO 2025-03-28 12:47:29,706 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:29,706 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 12:47:29,983 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 12:47:29,983 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:29,983 DEBUG --- stdout --- 2025-03-28 12:47:29,983 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 12:47:29,983 DEBUG --- stderr --- 2025-03-28 12:47:29,983 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 12:47:29,984 INFO 2025-03-28 12:47:29,984 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-1000/rc.txt" ]; then echo "/results/orders/patch-1000/rc.txt file found"; exit 0; else echo "/results/orders/patch-1000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1000/rc.txt file found" 2025-03-28 12:47:29,984 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 12:47:30,790 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 12:47:30,790 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:30,790 DEBUG --- stdout --- 2025-03-28 12:47:30,790 DEBUG /results/orders/patch-1000/rc.txt file found 2025-03-28 12:47:30,790 DEBUG --- stderr --- 2025-03-28 12:47:30,790 DEBUG 2025-03-28 12:47:30,790 INFO 2025-03-28 12:47:30,791 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-1000/rc.txt 2025-03-28 12:47:31,585 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 12:47:31,585 DEBUG --- stdout --- 2025-03-28 12:47:31,585 DEBUG 4 /results/orders/patch-1000/rc.txt 2025-03-28 12:47:31,585 DEBUG --- stderr --- 2025-03-28 12:47:31,585 DEBUG 2025-03-28 12:47:31,585 INFO - Download file (size 4k) source : /results/orders/patch-1000/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/rc.txt 2025-03-28 12:47:31,586 INFO 2025-03-28 12:47:31,586 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1000/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/rc.txt 2025-03-28 12:47:31,586 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 12:47:32,302 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:32,303 DEBUG --- stdout --- 2025-03-28 12:47:32,303 DEBUG tar: Removing leading `/' from member names 2025-03-28 12:47:32,303 DEBUG --- stderr --- 2025-03-28 12:47:32,303 DEBUG 2025-03-28 12:47:32,303 INFO 2025-03-28 12:47:32,303 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:32,303 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 12:47:32,581 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 12:47:32,581 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:32,581 DEBUG --- stdout --- 2025-03-28 12:47:32,581 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 12:47:32,581 DEBUG --- stderr --- 2025-03-28 12:47:32,581 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 12:47:32,582 INFO 2025-03-28 12:47:32,582 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-1000/stderr.txt" ]; then echo "/results/orders/patch-1000/stderr.txt file found"; exit 0; else echo "/results/orders/patch-1000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1000/stderr.txt file found" 2025-03-28 12:47:32,582 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 12:47:33,387 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 12:47:33,387 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:33,387 DEBUG --- stdout --- 2025-03-28 12:47:33,387 DEBUG /results/orders/patch-1000/stderr.txt file found 2025-03-28 12:47:33,387 DEBUG --- stderr --- 2025-03-28 12:47:33,387 DEBUG 2025-03-28 12:47:33,387 INFO 2025-03-28 12:47:33,388 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-1000/stderr.txt 2025-03-28 12:47:34,185 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 12:47:34,185 DEBUG --- stdout --- 2025-03-28 12:47:34,185 DEBUG 0 /results/orders/patch-1000/stderr.txt 2025-03-28 12:47:34,185 DEBUG --- stderr --- 2025-03-28 12:47:34,185 DEBUG 2025-03-28 12:47:34,185 INFO - Download file (size 0k) source : /results/orders/patch-1000/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/stderr.txt 2025-03-28 12:47:34,186 INFO 2025-03-28 12:47:34,186 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1000/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/stderr.txt 2025-03-28 12:47:34,186 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 12:47:34,956 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:34,956 DEBUG --- stdout --- 2025-03-28 12:47:34,956 DEBUG tar: Removing leading `/' from member names 2025-03-28 12:47:34,956 DEBUG --- stderr --- 2025-03-28 12:47:34,956 DEBUG 2025-03-28 12:47:34,957 INFO 2025-03-28 12:47:34,957 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:34,957 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 12:47:35,234 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 12:47:35,234 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:35,234 DEBUG --- stdout --- 2025-03-28 12:47:35,234 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 12:47:35,234 DEBUG --- stderr --- 2025-03-28 12:47:35,234 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 12:47:35,235 INFO 2025-03-28 12:47:35,235 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-1000/stdout.txt" ]; then echo "/results/orders/patch-1000/stdout.txt file found"; exit 0; else echo "/results/orders/patch-1000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1000/stdout.txt file found" 2025-03-28 12:47:35,235 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 12:47:36,036 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 12:47:36,036 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:36,036 DEBUG --- stdout --- 2025-03-28 12:47:36,036 DEBUG /results/orders/patch-1000/stdout.txt file found 2025-03-28 12:47:36,036 DEBUG --- stderr --- 2025-03-28 12:47:36,036 DEBUG 2025-03-28 12:47:36,036 INFO 2025-03-28 12:47:36,036 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-1000/stdout.txt 2025-03-28 12:47:36,833 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 12:47:36,833 DEBUG --- stdout --- 2025-03-28 12:47:36,833 DEBUG 1588 /results/orders/patch-1000/stdout.txt 2025-03-28 12:47:36,833 DEBUG --- stderr --- 2025-03-28 12:47:36,833 DEBUG 2025-03-28 12:47:36,833 INFO - Download file (size 1588k) source : /results/orders/patch-1000/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/stdout.txt 2025-03-28 12:47:36,834 INFO 2025-03-28 12:47:36,834 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1000/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/stdout.txt 2025-03-28 12:47:36,834 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 12:47:37,971 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:37,971 DEBUG --- stdout --- 2025-03-28 12:47:37,971 DEBUG tar: Removing leading `/' from member names 2025-03-28 12:47:37,971 DEBUG --- stderr --- 2025-03-28 12:47:37,971 DEBUG ________________________________________________________________________________ [2025-03-28 12:47:37] patch-1000 show_cmd : Display order command ________________________________________________________________________________ 2025-03-28 12:47:37,971 INFO 2025-03-28 12:47:37,971 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:37,971 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 12:47:38,248 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 12:47:38,248 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:38,248 DEBUG --- stdout --- 2025-03-28 12:47:38,248 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 12:47:38,248 DEBUG --- stderr --- 2025-03-28 12:47:38,248 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 12:47:38,249 INFO 2025-03-28 12:47:38,249 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-1000/cmd.txt" ]; then echo "/results/orders/patch-1000/cmd.txt file found"; exit 0; else echo "/results/orders/patch-1000/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/patch-1000/cmd.txt file found" 2025-03-28 12:47:38,249 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 12:47:39,055 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 12:47:39,055 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:39,055 DEBUG --- stdout --- 2025-03-28 12:47:39,055 DEBUG /results/orders/patch-1000/cmd.txt file found 2025-03-28 12:47:39,055 DEBUG --- stderr --- 2025-03-28 12:47:39,055 DEBUG 2025-03-28 12:47:39,055 INFO 2025-03-28 12:47:39,055 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-1000/cmd.txt 2025-03-28 12:47:39,858 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 12:47:39,858 DEBUG --- stdout --- 2025-03-28 12:47:39,858 DEBUG 4 /results/orders/patch-1000/cmd.txt 2025-03-28 12:47:39,858 DEBUG --- stderr --- 2025-03-28 12:47:39,858 DEBUG 2025-03-28 12:47:39,858 INFO - Download file (size 4k) source : /results/orders/patch-1000/cmd.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/cmd.txt 2025-03-28 12:47:39,859 INFO 2025-03-28 12:47:39,859 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/patch-1000/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/cmd.txt 2025-03-28 12:47:39,859 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 12:47:40,709 INFO [loop_until]: OK (rc = 0) 2025-03-28 12:47:40,709 DEBUG --- stdout --- 2025-03-28 12:47:40,709 DEBUG tar: Removing leading `/' from member names 2025-03-28 12:47:40,709 DEBUG --- stderr --- 2025-03-28 12:47:40,709 DEBUG 2025-03-28 12:47:40,710 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/cmd.txt is small (1 lines), printing all lines: 2025-03-28 12:47:40,710 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-1000" --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=1000 -Duser_password=T35!tr0c-k123" ________________________________________________________________________________ [2025-03-28 12:47:40] patch-1000 show_rc : Display rc order ________________________________________________________________________________ 2025-03-28 12:47:40,710 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/rc.txt is small (1 lines), printing all lines: 2025-03-28 12:47:40,710 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 12:47:40] patch-1000 show_stdout : Display stdout order ________________________________________________________________________________ 2025-03-28 12:47:40,712 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/07_patch-1000/stdout.txt is 20031 lines): 2025-03-28 12:47:40,719 INFO ----- output ----- 2025-03-28 11:47:02,424 DEBUG Creating results folder /results/gatling/patch-1000 2025-03-28 11:47:02,429 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmppbc8agaq 2025-03-28 11:47:02,432 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/patch-1000" -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=1000 -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/tmppbc8agaq/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/tmppbc8agaq/target/test-classes ... [INFO] compile in 8.7 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 11:47:20 GMT 5s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=408 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=403 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 3618131 / active: 13 / done: 403 ================================================================================ ================================================================================ 2025-03-28 11:47:25 GMT 10s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=1644 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=1639 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 3616882 / active: 26 / done: 1639 ================================================================================ ================================================================================ 2025-03-28 11:47:30 GMT 15s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=3715 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=3710 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersPatch ----------------------------------------------------- [- ] 0% waiting: 3614799 / active: 38 / done: 3710 ================================================================================ ================================================================================ 2025-03-28 11:47:35 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTY3ODE1OCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1NWVZZzI4dDR0T1d6czVEVmNuU3BVYlNneG8iLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY1OTM2LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY1OTM2LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjk1MzYsImlhdCI6MTc0MzE2NTkzNiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoieTBBSEppVUJnWnZoT0lpLS1EeFFfcU04dVRjIn0.FtSsVurukzZmsFENXEat1_m2YeRGJ0bQkuhnmWF6n1RNeMDV1U7jMNqp3relqnhx228G6_MOjdQstz_RKncP1ayIU4_2uRbygbzdI4MTObw4URdkCEBWgD0J4evRpfI8m4jqUDV1OQyRVTAzFVHbU4cKpJ1OVmJWiqihVa7qG8rjoNbN2MxvgAT6cRxDo7ud0PqviZIMIjLUkqhu-0yOGxYIqDntIBy0iAvG7hisoKnnS0bvMCKU7gsrb2Bb4XpQMG7W51QyELtdllgjhV-jqV4qZb_gJ4ewA3cJ-56fVSXmCP7jTThZ_W0i2thWa1EJkAwhjDz6mJ6B0_GGzaSJtg host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "482-307-3422" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 12:47:15.970 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,3588458,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTY3ODE1OCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1NWVZZzI4dDR0T1d6czVEVmNuU3BVYlNneG8iLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY1OTM2LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY1OTM2LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjk1MzYsImlhdCI6MTc0MzE2NTkzNiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoieTBBSEppVUJnWnZoT0lpLS1EeFFfcU04dVRjIn0.FtSsVurukzZmsFENXEat1_m2YeRGJ0bQkuhnmWF6n1RNeMDV1U7jMNqp3relqnhx228G6_MOjdQstz_RKncP1ayIU4_2uRbygbzdI4MTObw4URdkCEBWgD0J4evRpfI8m4jqUDV1OQyRVTAzFVHbU4cKpJ1OVmJWiqihVa7qG8rjoNbN2MxvgAT6cRxDo7ud0PqviZIMIjLUkqhu-0yOGxYIqDntIBy0iAvG7hisoKnnS0bvMCKU7gsrb2Bb4XpQMG7W51QyELtdllgjhV-jqV4qZb_gJ4ewA3cJ-56fVSXmCP7jTThZ_W0i2thWa1EJkAwhjDz6mJ6B0_GGzaSJtg, username -> user.143446388, tokenIdCookieName -> 15892ffd844ef80, id -> 00de7f27-4bf1-4c1f-91f4-96a3f2958b5a, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@1e4eef16, givenname -> Dineke, tokenId -> UgfAEPXjsUXcw4xeUfM6zIPezps.*AAJTSQACMDIAAlNLABxrRzY0VnI4aC82Yy8yUkNKdVVyYUZ3RFgzOE09AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Scheible2086, telNum -> 664-166-6122, challenge -> L8Fi9TN2uaASaw9_KUBojhaGQOrsdQCeRX8Um_434-U, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.143446388@example.com, verifier -> NjYxNjU0ODY3OTg2ODY4NjcxOQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3c0eb88b),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007cd04869a6b0@66b9efa0,io.netty.channel.epoll.EpollEventLoop@2bef51f2) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/00de7f27-4bf1-4c1f-91f4-96a3f2958b5a 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTY3ODE1OCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1NWVZZzI4dDR0T1d6czVEVmNuU3BVYlNneG8iLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY1OTM2LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY1OTM2LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjk1MzYsImlhdCI6MTc0MzE2NTkzNiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoieTBBSEppVUJnWnZoT0lpLS1EeFFfcU04dVRjIn0.FtSsVurukzZmsFENXEat1_m2YeRGJ0bQkuhnmWF6n1RNeMDV1U7jMNqp3relqnhx228G6_MOjdQstz_RKncP1ayIU4_2uRbygbzdI4MTObw4URdkCEBWgD0J4evRpfI8m4jqUDV1OQyRVTAzFVHbU4cKpJ1OVmJWiqihVa7qG8rjoNbN2MxvgAT6cRxDo7ud0PqviZIMIjLUkqhu-0yOGxYIqDntIBy0iAvG7hisoKnnS0bvMCKU7gsrb2Bb4XpQMG7W51QyELtdllgjhV-jqV4qZb_gJ4ewA3cJ-56fVSXmCP7jTThZ_W0i2thWa1EJkAwhjDz6mJ6B0_GGzaSJtg host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "664-166-6122" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 12:47:15.970 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,3588484,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTY3ODE1OCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1NWVZZzI4dDR0T1d6czVEVmNuU3BVYlNneG8iLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY1OTM2LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY1OTM2LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjk1MzYsImlhdCI6MTc0MzE2NTkzNiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoieTBBSEppVUJnWnZoT0lpLS1EeFFfcU04dVRjIn0.FtSsVurukzZmsFENXEat1_m2YeRGJ0bQkuhnmWF6n1RNeMDV1U7jMNqp3relqnhx228G6_MOjdQstz_RKncP1ayIU4_2uRbygbzdI4MTObw4URdkCEBWgD0J4evRpfI8m4jqUDV1OQyRVTAzFVHbU4cKpJ1OVmJWiqihVa7qG8rjoNbN2MxvgAT6cRxDo7ud0PqviZIMIjLUkqhu-0yOGxYIqDntIBy0iAvG7hisoKnnS0bvMCKU7gsrb2Bb4XpQMG7W51QyELtdllgjhV-jqV4qZb_gJ4ewA3cJ-56fVSXmCP7jTThZ_W0i2thWa1EJkAwhjDz6mJ6B0_GGzaSJtg, username -> user.26800816, tokenIdCookieName -> 15892ffd844ef80, id -> 00de8195-338f-4cf6-8a25-bb69a042077b, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@18ae2029, givenname -> Luuk, tokenId -> UgfAEPXjsUXcw4xeUfM6zIPezps.*AAJTSQACMDIAAlNLABxrRzY0VnI4aC82Yy8yUkNKdVVyYUZ3RFgzOE09AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Dieter, telNum -> 587-935-4138, challenge -> L8Fi9TN2uaASaw9_KUBojhaGQOrsdQCeRX8Um_434-U, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.26800816@example.com, verifier -> NjYxNjU0ODY3OTg2ODY4NjcxOQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@7dcb32fa),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007cd04869a6b0@66b9efa0,io.netty.channel.epoll.EpollEventLoop@239b0f9d) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/00de8195-338f-4cf6-8a25-bb69a042077b 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTY3ODE1OCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1NWVZZzI4dDR0T1d6czVEVmNuU3BVYlNneG8iLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY1OTM2LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY1OTM2LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjk1MzYsImlhdCI6MTc0MzE2NTkzNiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoieTBBSEppVUJnWnZoT0lpLS1EeFFfcU04dVRjIn0.FtSsVurukzZmsFENXEat1_m2YeRGJ0bQkuhnmWF6n1RNeMDV1U7jMNqp3relqnhx228G6_MOjdQstz_RKncP1ayIU4_2uRbygbzdI4MTObw4URdkCEBWgD0J4evRpfI8m4jqUDV1OQyRVTAzFVHbU4cKpJ1OVmJWiqihVa7qG8rjoNbN2MxvgAT6cRxDo7ud0PqviZIMIjLUkqhu-0yOGxYIqDntIBy0iAvG7hisoKnnS0bvMCKU7gsrb2Bb4XpQMG7W51QyELtdllgjhV-jqV4qZb_gJ4ewA3cJ-56fVSXmCP7jTThZ_W0i2thWa1EJkAwhjDz6mJ6B0_GGzaSJtg host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "587-935-4138" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 12:47:15.970 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'PatchManagedUser' failed for user 3588426: j.i.IOException: Premature close 12:47:15.970 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: PatchManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersPatch,3588426,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTY3ODE1OCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1NWVZZzI4dDR0T1d6czVEVmNuU3BVYlNneG8iLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY1OTM2LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY1OTM2LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjk1MzYsImlhdCI6MTc0MzE2NTkzNiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoieTBBSEppVUJnWnZoT0lpLS1EeFFfcU04dVRjIn0.FtSsVurukzZmsFENXEat1_m2YeRGJ0bQkuhnmWF6n1RNeMDV1U7jMNqp3relqnhx228G6_MOjdQstz_RKncP1ayIU4_2uRbygbzdI4MTObw4URdkCEBWgD0J4evRpfI8m4jqUDV1OQyRVTAzFVHbU4cKpJ1OVmJWiqihVa7qG8rjoNbN2MxvgAT6cRxDo7ud0PqviZIMIjLUkqhu-0yOGxYIqDntIBy0iAvG7hisoKnnS0bvMCKU7gsrb2Bb4XpQMG7W51QyELtdllgjhV-jqV4qZb_gJ4ewA3cJ-56fVSXmCP7jTThZ_W0i2thWa1EJkAwhjDz6mJ6B0_GGzaSJtg, username -> user.84730471, tokenIdCookieName -> 15892ffd844ef80, id -> 00de7ccb-a4ac-4a23-af6f-3d8169856d6e, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@53160526, givenname -> Ashoka, tokenId -> UgfAEPXjsUXcw4xeUfM6zIPezps.*AAJTSQACMDIAAlNLABxrRzY0VnI4aC82Yy8yUkNKdVVyYUZ3RFgzOE09AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Deliva, telNum -> 669-275-6024, challenge -> L8Fi9TN2uaASaw9_KUBojhaGQOrsdQCeRX8Um_434-U, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.84730471@example.com, verifier -> NjYxNjU0ODY3OTg2ODY4NjcxOQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@7c996283),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007cd04869a6b0@66b9efa0,io.netty.channel.epoll.EpollEventLoop@2bef51f2) ========================= HTTP request: PATCH https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/00de7ccb-a4ac-4a23-af6f-3d8169856d6e 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTY3ODE1OCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1NWVZZzI4dDR0T1d6czVEVmNuU3BVYlNneG8iLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTY1OTM2LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTY1OTM2LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNjk1MzYsImlhdCI6MTc0MzE2NTkzNiwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoieTBBSEppVUJnWnZoT0lpLS1EeFFfcU04dVRjIn0.FtSsVurukzZmsFENXEat1_m2YeRGJ0bQkuhnmWF6n1RNeMDV1U7jMNqp3relqnhx228G6_MOjdQstz_RKncP1ayIU4_2uRbygbzdI4MTObw4URdkCEBWgD0J4evRpfI8m4jqUDV1OQyRVTAzFVHbU4cKpJ1OVmJWiqihVa7qG8rjoNbN2MxvgAT6cRxDo7ud0PqviZIMIjLUkqhu-0yOGxYIqDntIBy0iAvG7hisoKnnS0bvMCKU7gsrb2Bb4XpQMG7W51QyELtdllgjhV-jqV4qZb_gJ4ewA3cJ-56fVSXmCP7jTThZ_W0i2thWa1EJkAwhjDz6mJ6B0_GGzaSJtg host: openam-perf-200m.forgeblocks.com content-length: 98 body:StringChunksRequestBody{charset=UTF-8, content=[{ "operation": "replace", "field": "/telephoneNumber", "value": "669-275-6024" }]} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:00 h [INFO] Finished at: 2025-03-28T12:47:16Z [INFO] ------------------------------------------------------------------------ 2025-03-28 12:47:16,034 INFO Gatling simulation run ended successfully 2025-03-28 12:47:16,034 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-03-28 12:47:40] patch-1000 show_stderr : Display stderr order ________________________________________________________________________________ 2025-03-28 12:47:40,719 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/07_patch-1000/stderr.txt is small (0 lines), printing all lines: 2025-03-28 12:47:40,719 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 12:47:40] patch-1000 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 12:47:41] patch-1000 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-03-28 12:47:41] patch-1000 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped