--Task-- name: update-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: ['update-500'] preceding_task: update-500 options: {'testMode': 'open', 'testCase': 'idm.ManagedUsersUpdate', '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 06:43:28,236 INFO 2025-03-28 06:43:28,236 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 06:43:28,236 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 06:43:28,534 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 06:43:28,534 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:28,534 DEBUG --- stdout --- 2025-03-28 06:43:28,534 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 06:43:28,534 DEBUG --- stderr --- 2025-03-28 06:43:28,534 DEBUG 2025-03-28 06:43:28,534 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-03-28 06:43:28 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-03-28 06:43:28 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/update-1000/stdout.txt Pod log : /results/orders/update-1000 ________________________________________________________________________________ [2025-03-28 06:43:28] update-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.ManagedUsersUpdate@perf-200m" --results-folder="/results/gatling/update-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.ManagedUsersUpdate -DtestMode=open -Dthroughput=1000 -Duser_password=**** ________________________________________________________________________________ [2025-03-28 06:43:28] update-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/02_update-1000/order.json { "name": "update-1000", "command": " /lodestar/lodestar.py perf run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idm.ManagedUsersUpdate@perf-200m\" --results-folder=\"/results/gatling/update-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.ManagedUsersUpdate -DtestMode=open -Dthroughput=1000 -Duser_password=T35!tr0c-k123\"", "out-dir": "/results/orders/update-1000" } ________________________________________________________________________________ [2025-03-28 06:43:28] update-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 06:43:28,542 INFO 2025-03-28 06:43:28,542 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 06:43:28,542 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 06:43:28,756 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 06:43:28,756 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:28,756 DEBUG --- stdout --- 2025-03-28 06:43:28,757 DEBUG WAITING 2025-03-28 06:43:28,757 DEBUG --- stderr --- 2025-03-28 06:43:28,757 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 06:43:28] update-1000 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-03-28 06:43:28,757 INFO 2025-03-28 06:43:28,757 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 06:43:28,757 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 06:43:29,035 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 06:43:29,035 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:29,035 DEBUG --- stdout --- 2025-03-28 06:43:29,036 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 06:43:29,036 DEBUG --- stderr --- 2025-03-28 06:43:29,036 DEBUG 2025-03-28 06:43:29,036 INFO 2025-03-28 06:43:29,036 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/02_update-1000/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 06:43:29,037 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 06:43:30,439 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:30,439 DEBUG --- stdout --- 2025-03-28 06:43:30,439 DEBUG 2025-03-28 06:43:30,439 DEBUG --- stderr --- 2025-03-28 06:43:30,439 DEBUG Order has been successfully forwarded to overseer 2025-03-28 06:43:30 - INFO: Check if Gatling simulation started successfully 2025-03-28 06:43:30,439 INFO 2025-03-28 06:43:30,439 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv -- head --lines 5000 /results/orders/update-1000/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-03-28 06:43:30,439 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 06:43:31,175 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 06:43:36,917 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 06:43:42,649 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 06:43:48,388 INFO [loop_until]: Function succeeded after 17s (rc=0) - expected pattern found 2025-03-28 06:43:48,388 INFO [loop_until]: OK (rc = 0) 2025-03-28 06:43:48,388 DEBUG --- stdout --- 2025-03-28 06:43:48,388 DEBUG 2025-03-28 06:43:31,223 DEBUG Creating results folder /results/gatling/update-1000 2025-03-28 06:43:31,229 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp8shgibti 2025-03-28 06:43:31,232 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/update-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.ManagedUsersUpdate -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/tmp8shgibti/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/tmp8shgibti/target/test-classes ... [INFO] compile in 8.3 s [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- [INFO] Running simulation com.forgerock.pyrock.Loadtest. Gatling 3.13.5 is available! (you're using 3.12.0) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Set idVarName to id Simulation com.forgerock.pyrock.Loadtest started... 2025-03-28 06:43:48,389 DEBUG --- stderr --- 2025-03-28 06:43:48,389 DEBUG ________________________________________________________________________________ [2025-03-28 06:43:48] update-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 04s, 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 06s, retry Order is running since 50m 07s, retry Order is running since 52m 07s, retry Order is running since 54m 07s, 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 07:43:57] update-1000 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-03-28 07:43:57,096 INFO 2025-03-28 07:43:57,096 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 07:43:57,096 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 07:43:57,396 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 07:43:57,396 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:43:57,396 DEBUG --- stdout --- 2025-03-28 07:43:57,396 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 07:43:57,396 DEBUG --- stderr --- 2025-03-28 07:43:57,396 DEBUG 2025-03-28 07:43:57,397 INFO 2025-03-28 07:43:57,397 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 07:43:57,397 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 07:43:58,180 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:43:58,180 DEBUG --- stdout --- 2025-03-28 07:43:58,180 DEBUG 2025-03-28 07:43:58,180 DEBUG --- stderr --- 2025-03-28 07:43:58,180 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-03-28 07:43:58] update-1000 download_logs : Download individual order files ________________________________________________________________________________ 2025-03-28 07:43:58 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/order.json 2025-03-28 07:43:58,180 INFO 2025-03-28 07:43:58,181 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 07:43:58,181 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 07:43:58,457 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 07:43:58,457 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:43:58,457 DEBUG --- stdout --- 2025-03-28 07:43:58,457 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 07:43:58,457 DEBUG --- stderr --- 2025-03-28 07:43:58,457 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 07:43:58,458 INFO 2025-03-28 07:43:58,458 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-1000/rc.txt" ]; then echo "/results/orders/update-1000/rc.txt file found"; exit 0; else echo "/results/orders/update-1000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/update-1000/rc.txt file found" 2025-03-28 07:43:58,458 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 07:43:59,255 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 07:43:59,255 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:43:59,255 DEBUG --- stdout --- 2025-03-28 07:43:59,255 DEBUG /results/orders/update-1000/rc.txt file found 2025-03-28 07:43:59,255 DEBUG --- stderr --- 2025-03-28 07:43:59,255 DEBUG 2025-03-28 07:43:59,255 INFO 2025-03-28 07:43:59,256 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-1000/rc.txt 2025-03-28 07:44:00,052 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 07:44:00,053 DEBUG --- stdout --- 2025-03-28 07:44:00,053 DEBUG 4 /results/orders/update-1000/rc.txt 2025-03-28 07:44:00,053 DEBUG --- stderr --- 2025-03-28 07:44:00,053 DEBUG 2025-03-28 07:44:00,053 INFO - Download file (size 4k) source : /results/orders/update-1000/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/rc.txt 2025-03-28 07:44:00,053 INFO 2025-03-28 07:44:00,053 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-1000/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/rc.txt 2025-03-28 07:44:00,053 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 07:44:00,776 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:00,776 DEBUG --- stdout --- 2025-03-28 07:44:00,776 DEBUG tar: Removing leading `/' from member names 2025-03-28 07:44:00,776 DEBUG --- stderr --- 2025-03-28 07:44:00,776 DEBUG 2025-03-28 07:44:00,777 INFO 2025-03-28 07:44:00,777 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 07:44:00,777 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 07:44:01,053 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 07:44:01,053 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:01,053 DEBUG --- stdout --- 2025-03-28 07:44:01,053 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 07:44:01,053 DEBUG --- stderr --- 2025-03-28 07:44:01,053 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 07:44:01,054 INFO 2025-03-28 07:44:01,054 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-1000/stderr.txt" ]; then echo "/results/orders/update-1000/stderr.txt file found"; exit 0; else echo "/results/orders/update-1000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/update-1000/stderr.txt file found" 2025-03-28 07:44:01,054 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 07:44:01,855 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 07:44:01,856 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:01,856 DEBUG --- stdout --- 2025-03-28 07:44:01,856 DEBUG /results/orders/update-1000/stderr.txt file found 2025-03-28 07:44:01,856 DEBUG --- stderr --- 2025-03-28 07:44:01,856 DEBUG 2025-03-28 07:44:01,856 INFO 2025-03-28 07:44:01,856 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-1000/stderr.txt 2025-03-28 07:44:02,662 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 07:44:02,662 DEBUG --- stdout --- 2025-03-28 07:44:02,663 DEBUG 0 /results/orders/update-1000/stderr.txt 2025-03-28 07:44:02,663 DEBUG --- stderr --- 2025-03-28 07:44:02,663 DEBUG 2025-03-28 07:44:02,663 INFO - Download file (size 0k) source : /results/orders/update-1000/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/stderr.txt 2025-03-28 07:44:02,663 INFO 2025-03-28 07:44:02,663 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-1000/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/stderr.txt 2025-03-28 07:44:02,664 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 07:44:03,425 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:03,425 DEBUG --- stdout --- 2025-03-28 07:44:03,425 DEBUG tar: Removing leading `/' from member names 2025-03-28 07:44:03,425 DEBUG --- stderr --- 2025-03-28 07:44:03,425 DEBUG 2025-03-28 07:44:03,426 INFO 2025-03-28 07:44:03,426 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 07:44:03,426 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 07:44:03,705 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 07:44:03,705 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:03,705 DEBUG --- stdout --- 2025-03-28 07:44:03,705 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 07:44:03,705 DEBUG --- stderr --- 2025-03-28 07:44:03,705 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 07:44:03,706 INFO 2025-03-28 07:44:03,706 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-1000/stdout.txt" ]; then echo "/results/orders/update-1000/stdout.txt file found"; exit 0; else echo "/results/orders/update-1000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/update-1000/stdout.txt file found" 2025-03-28 07:44:03,706 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 07:44:04,511 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 07:44:04,511 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:04,511 DEBUG --- stdout --- 2025-03-28 07:44:04,511 DEBUG /results/orders/update-1000/stdout.txt file found 2025-03-28 07:44:04,511 DEBUG --- stderr --- 2025-03-28 07:44:04,511 DEBUG 2025-03-28 07:44:04,511 INFO 2025-03-28 07:44:04,511 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-1000/stdout.txt 2025-03-28 07:44:05,315 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 07:44:05,315 DEBUG --- stdout --- 2025-03-28 07:44:05,315 DEBUG 1756 /results/orders/update-1000/stdout.txt 2025-03-28 07:44:05,315 DEBUG --- stderr --- 2025-03-28 07:44:05,315 DEBUG 2025-03-28 07:44:05,315 INFO - Download file (size 1756k) source : /results/orders/update-1000/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/stdout.txt 2025-03-28 07:44:05,316 INFO 2025-03-28 07:44:05,316 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-1000/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/stdout.txt 2025-03-28 07:44:05,316 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 07:44:06,498 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:06,498 DEBUG --- stdout --- 2025-03-28 07:44:06,498 DEBUG tar: Removing leading `/' from member names 2025-03-28 07:44:06,498 DEBUG --- stderr --- 2025-03-28 07:44:06,498 DEBUG ________________________________________________________________________________ [2025-03-28 07:44:06] update-1000 show_cmd : Display order command ________________________________________________________________________________ 2025-03-28 07:44:06,498 INFO 2025-03-28 07:44:06,498 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 07:44:06,498 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 07:44:06,775 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 07:44:06,775 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:06,775 DEBUG --- stdout --- 2025-03-28 07:44:06,775 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 07:44:06,775 DEBUG --- stderr --- 2025-03-28 07:44:06,775 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 07:44:06,776 INFO 2025-03-28 07:44:06,776 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/update-1000/cmd.txt" ]; then echo "/results/orders/update-1000/cmd.txt file found"; exit 0; else echo "/results/orders/update-1000/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/update-1000/cmd.txt file found" 2025-03-28 07:44:06,776 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 07:44:07,578 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 07:44:07,578 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:07,578 DEBUG --- stdout --- 2025-03-28 07:44:07,579 DEBUG /results/orders/update-1000/cmd.txt file found 2025-03-28 07:44:07,579 DEBUG --- stderr --- 2025-03-28 07:44:07,579 DEBUG 2025-03-28 07:44:07,579 INFO 2025-03-28 07:44:07,579 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/update-1000/cmd.txt 2025-03-28 07:44:08,373 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 07:44:08,373 DEBUG --- stdout --- 2025-03-28 07:44:08,374 DEBUG 4 /results/orders/update-1000/cmd.txt 2025-03-28 07:44:08,374 DEBUG --- stderr --- 2025-03-28 07:44:08,374 DEBUG 2025-03-28 07:44:08,374 INFO - Download file (size 4k) source : /results/orders/update-1000/cmd.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/cmd.txt 2025-03-28 07:44:08,374 INFO 2025-03-28 07:44:08,375 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/update-1000/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/cmd.txt 2025-03-28 07:44:08,375 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 07:44:09,138 INFO [loop_until]: OK (rc = 0) 2025-03-28 07:44:09,138 DEBUG --- stdout --- 2025-03-28 07:44:09,138 DEBUG tar: Removing leading `/' from member names 2025-03-28 07:44:09,138 DEBUG --- stderr --- 2025-03-28 07:44:09,138 DEBUG 2025-03-28 07:44:09,138 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/cmd.txt is small (1 lines), printing all lines: 2025-03-28 07:44:09,138 INFO ----- output ----- /lodestar/lodestar.py perf run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idm.ManagedUsersUpdate@perf-200m" --results-folder="/results/gatling/update-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.ManagedUsersUpdate -DtestMode=open -Dthroughput=1000 -Duser_password=T35!tr0c-k123" ________________________________________________________________________________ [2025-03-28 07:44:09] update-1000 show_rc : Display rc order ________________________________________________________________________________ 2025-03-28 07:44:09,139 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/rc.txt is small (1 lines), printing all lines: 2025-03-28 07:44:09,139 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 07:44:09] update-1000 show_stdout : Display stdout order ________________________________________________________________________________ 2025-03-28 07:44:09,141 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/02_update-1000/stdout.txt is 23374 lines): 2025-03-28 07:44:09,145 INFO ----- output ----- 2025-03-28 06:43:31,223 DEBUG Creating results folder /results/gatling/update-1000 2025-03-28 06:43:31,229 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp8shgibti 2025-03-28 06:43:31,232 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/update-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.ManagedUsersUpdate -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/tmp8shgibti/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/tmp8shgibti/target/test-classes ... [INFO] compile in 8.3 s [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- [INFO] Running simulation com.forgerock.pyrock.Loadtest. Gatling 3.13.5 is available! (you're using 3.12.0) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Set idVarName to id Simulation com.forgerock.pyrock.Loadtest started... ================================================================================ 2025-03-28 06:43:49 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 ) > UpdateManagedUser (OK=403 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersUpdate ---------------------------------------------------- [- ] 0% waiting: 3614505 / active: 13 / done: 403 ================================================================================ ================================================================================ 2025-03-28 06:43:54 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 ) > UpdateManagedUser (OK=1639 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersUpdate ---------------------------------------------------- [- ] 0% waiting: 3613256 / active: 26 / done: 1639 ================================================================================ ================================================================================ 2025-03-28 06:43:59 GMT 15s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=3714 KO=0 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > UpdateManagedUser (OK=3709 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idm.ManagedUsersUpdate ---------------------------------------------------- [- ] 0% waiting: 3611173 / active: 39 / done: 3709 ================================================================================ ================================================================================ 2025-03-28 06:44:04 GMT 20s elapsed [...] <<<<<<<<<<<<<<<<<<<<<<<<< 07:43:44.381 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'UpdateManagedUser' failed for user 3584739: j.i.IOException: Premature close 07:43:44.381 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UpdateManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersUpdate,3584728,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTYzNDk4MSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1c2QxdEN2eHRZbUVLMlhLV0Z0X0hFcjBxT2siLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ3NzI1LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ3NzI1LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNTEzMjUsImlhdCI6MTc0MzE0NzcyNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTDBRTHRjYzdmMUQ2TjByQ0hyVXNudnRGVWljIn0.CWvlsFr5ALOYbdMM5KgnlqmsVHhCjsGi8wZxlc_03rlISjMBi-BtgmyFiKK46uoYb_u28FzB_AhTYhnmnIEYVndvGmIfcGuGBIiqFsOkuM02OTVnmo9l6Df9MZ-Rokzw8pm0r6kIkY4MIsLwcbu_ZST3WGcLgIs0sLoZK2c4ONZesrUWwT1WSOkdqMKR6fN41kT6kX36m1oLNV8Vu1AmmS7Soc2P9utF5Y0pSTc5Ej0sYYrY5_9NhIK5Oh7x-0b2SEo1WrO6Uuc8zIWLYRg5a6ynDVhD0JqT2fJwUlxiznBl4F1YAIZbl_KeDpkppnHxuvDhruzjKtYNY2g91DZFKA, username -> user.61178741, tokenIdCookieName -> 15892ffd844ef80, id -> 00dd5117-5c13-4af2-b76d-d34e81399226, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@1697de4, givenname -> Nicole, tokenId -> -Kq2ALvMgR8loNl3rm4mIMuGjH0.*AAJTSQACMDIAAlNLABw0MjUwaXVHWlIvNUlTU3FET3V5QVNPcE8ydkk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Brum, telNum -> 270-567-7013, challenge -> Ob0OjotzQ9ctKjVBDVZ1I75HIVNj9PiV3wi7uIj1BHQ, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.61178741@example.com, verifier -> LTUyMjg3MDE0MDAyMTI5MzU1ODY, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@4ac39bf9),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007ba3e869b068@13717468,io.netty.channel.epoll.EpollEventLoop@652a7737) ========================= HTTP request: PUT https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/00dd5117-5c13-4af2-b76d-d34e81399226 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTYzNDk4MSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1c2QxdEN2eHRZbUVLMlhLV0Z0X0hFcjBxT2siLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ3NzI1LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ3NzI1LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNTEzMjUsImlhdCI6MTc0MzE0NzcyNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTDBRTHRjYzdmMUQ2TjByQ0hyVXNudnRGVWljIn0.CWvlsFr5ALOYbdMM5KgnlqmsVHhCjsGi8wZxlc_03rlISjMBi-BtgmyFiKK46uoYb_u28FzB_AhTYhnmnIEYVndvGmIfcGuGBIiqFsOkuM02OTVnmo9l6Df9MZ-Rokzw8pm0r6kIkY4MIsLwcbu_ZST3WGcLgIs0sLoZK2c4ONZesrUWwT1WSOkdqMKR6fN41kT6kX36m1oLNV8Vu1AmmS7Soc2P9utF5Y0pSTc5Ej0sYYrY5_9NhIK5Oh7x-0b2SEo1WrO6Uuc8zIWLYRg5a6ynDVhD0JqT2fJwUlxiznBl4F1YAIZbl_KeDpkppnHxuvDhruzjKtYNY2g91DZFKA host: openam-perf-200m.forgeblocks.com content-length: 265 body:StringChunksRequestBody{charset=UTF-8, content={ "_id" : "00dd5117-5c13-4af2-b76d-d34e81399226", "givenName" : "Nicole", "sn" : "Brum", "mail" : "user.61178741@example.com", "telephoneNumber" : "270-567-7013", "description" : "Updated Managed User", "userName" : "user.61178741" }} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 07:43:44.381 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UpdateManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersUpdate,3584730,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTYzNDk4MSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1c2QxdEN2eHRZbUVLMlhLV0Z0X0hFcjBxT2siLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ3NzI1LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ3NzI1LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNTEzMjUsImlhdCI6MTc0MzE0NzcyNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTDBRTHRjYzdmMUQ2TjByQ0hyVXNudnRGVWljIn0.CWvlsFr5ALOYbdMM5KgnlqmsVHhCjsGi8wZxlc_03rlISjMBi-BtgmyFiKK46uoYb_u28FzB_AhTYhnmnIEYVndvGmIfcGuGBIiqFsOkuM02OTVnmo9l6Df9MZ-Rokzw8pm0r6kIkY4MIsLwcbu_ZST3WGcLgIs0sLoZK2c4ONZesrUWwT1WSOkdqMKR6fN41kT6kX36m1oLNV8Vu1AmmS7Soc2P9utF5Y0pSTc5Ej0sYYrY5_9NhIK5Oh7x-0b2SEo1WrO6Uuc8zIWLYRg5a6ynDVhD0JqT2fJwUlxiznBl4F1YAIZbl_KeDpkppnHxuvDhruzjKtYNY2g91DZFKA, username -> user.81072363, tokenIdCookieName -> 15892ffd844ef80, id -> 00dd5184-f543-4f84-9d12-4841fc4b594b, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@7c4e81c4, givenname -> Merdia, tokenId -> -Kq2ALvMgR8loNl3rm4mIMuGjH0.*AAJTSQACMDIAAlNLABw0MjUwaXVHWlIvNUlTU3FET3V5QVNPcE8ydkk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Miezitis, telNum -> 481-353-6628, challenge -> Ob0OjotzQ9ctKjVBDVZ1I75HIVNj9PiV3wi7uIj1BHQ, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.81072363@example.com, verifier -> LTUyMjg3MDE0MDAyMTI5MzU1ODY, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@40f303f5),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007ba3e869b068@13717468,io.netty.channel.epoll.EpollEventLoop@2bef51f2) ========================= HTTP request: PUT https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/00dd5184-f543-4f84-9d12-4841fc4b594b 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTYzNDk4MSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1c2QxdEN2eHRZbUVLMlhLV0Z0X0hFcjBxT2siLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ3NzI1LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ3NzI1LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNTEzMjUsImlhdCI6MTc0MzE0NzcyNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTDBRTHRjYzdmMUQ2TjByQ0hyVXNudnRGVWljIn0.CWvlsFr5ALOYbdMM5KgnlqmsVHhCjsGi8wZxlc_03rlISjMBi-BtgmyFiKK46uoYb_u28FzB_AhTYhnmnIEYVndvGmIfcGuGBIiqFsOkuM02OTVnmo9l6Df9MZ-Rokzw8pm0r6kIkY4MIsLwcbu_ZST3WGcLgIs0sLoZK2c4ONZesrUWwT1WSOkdqMKR6fN41kT6kX36m1oLNV8Vu1AmmS7Soc2P9utF5Y0pSTc5Ej0sYYrY5_9NhIK5Oh7x-0b2SEo1WrO6Uuc8zIWLYRg5a6ynDVhD0JqT2fJwUlxiznBl4F1YAIZbl_KeDpkppnHxuvDhruzjKtYNY2g91DZFKA host: openam-perf-200m.forgeblocks.com content-length: 269 body:StringChunksRequestBody{charset=UTF-8, content={ "_id" : "00dd5184-f543-4f84-9d12-4841fc4b594b", "givenName" : "Merdia", "sn" : "Miezitis", "mail" : "user.81072363@example.com", "telephoneNumber" : "481-353-6628", "description" : "Updated Managed User", "userName" : "user.81072363" }} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 07:43:44.381 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UpdateManagedUser: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersUpdate,3584739,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTYzNDk4MSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1c2QxdEN2eHRZbUVLMlhLV0Z0X0hFcjBxT2siLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ3NzI1LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ3NzI1LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNTEzMjUsImlhdCI6MTc0MzE0NzcyNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTDBRTHRjYzdmMUQ2TjByQ0hyVXNudnRGVWljIn0.CWvlsFr5ALOYbdMM5KgnlqmsVHhCjsGi8wZxlc_03rlISjMBi-BtgmyFiKK46uoYb_u28FzB_AhTYhnmnIEYVndvGmIfcGuGBIiqFsOkuM02OTVnmo9l6Df9MZ-Rokzw8pm0r6kIkY4MIsLwcbu_ZST3WGcLgIs0sLoZK2c4ONZesrUWwT1WSOkdqMKR6fN41kT6kX36m1oLNV8Vu1AmmS7Soc2P9utF5Y0pSTc5Ej0sYYrY5_9NhIK5Oh7x-0b2SEo1WrO6Uuc8zIWLYRg5a6ynDVhD0JqT2fJwUlxiznBl4F1YAIZbl_KeDpkppnHxuvDhruzjKtYNY2g91DZFKA, username -> user.106302338, tokenIdCookieName -> 15892ffd844ef80, id -> 00dd5244-99b9-4914-81ec-95f5d82cd186, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@a28ddf7, givenname -> Camey, tokenId -> -Kq2ALvMgR8loNl3rm4mIMuGjH0.*AAJTSQACMDIAAlNLABw0MjUwaXVHWlIvNUlTU3FET3V5QVNPcE8ydkk9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Rychlicki, telNum -> 738-536-5433, challenge -> Ob0OjotzQ9ctKjVBDVZ1I75HIVNj9PiV3wi7uIj1BHQ, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.106302338@example.com, verifier -> LTUyMjg3MDE0MDAyMTI5MzU1ODY, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3f8b1d26),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$822/0x00007ba3e869b068@13717468,io.netty.channel.epoll.EpollEventLoop@12dae582) ========================= HTTP request: PUT https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/00dd5244-99b9-4914-81ec-95f5d82cd186 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.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTYzNDk4MSIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiI1c2QxdEN2eHRZbUVLMlhLV0Z0X0hFcjBxT2siLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTQ3NzI1LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTQ3NzI1LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxNTEzMjUsImlhdCI6MTc0MzE0NzcyNSwiZXhwaXJlc19pbiI6MzYwMCwianRpIjoiTDBRTHRjYzdmMUQ2TjByQ0hyVXNudnRGVWljIn0.CWvlsFr5ALOYbdMM5KgnlqmsVHhCjsGi8wZxlc_03rlISjMBi-BtgmyFiKK46uoYb_u28FzB_AhTYhnmnIEYVndvGmIfcGuGBIiqFsOkuM02OTVnmo9l6Df9MZ-Rokzw8pm0r6kIkY4MIsLwcbu_ZST3WGcLgIs0sLoZK2c4ONZesrUWwT1WSOkdqMKR6fN41kT6kX36m1oLNV8Vu1AmmS7Soc2P9utF5Y0pSTc5Ej0sYYrY5_9NhIK5Oh7x-0b2SEo1WrO6Uuc8zIWLYRg5a6ynDVhD0JqT2fJwUlxiznBl4F1YAIZbl_KeDpkppnHxuvDhruzjKtYNY2g91DZFKA host: openam-perf-200m.forgeblocks.com content-length: 271 body:StringChunksRequestBody{charset=UTF-8, content={ "_id" : "00dd5244-99b9-4914-81ec-95f5d82cd186", "givenName" : "Camey", "sn" : "Rychlicki", "mail" : "user.106302338@example.com", "telephoneNumber" : "738-536-5433", "description" : "Updated Managed User", "userName" : "user.106302338" }} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:00 h [INFO] Finished at: 2025-03-28T07:43:44Z [INFO] ------------------------------------------------------------------------ 2025-03-28 07:43:44,459 INFO Gatling simulation run ended successfully 2025-03-28 07:43:44,460 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-03-28 07:44:09] update-1000 show_stderr : Display stderr order ________________________________________________________________________________ 2025-03-28 07:44:09,145 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_update-1000/stderr.txt is small (0 lines), printing all lines: 2025-03-28 07:44:09,145 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 07:44:09] update-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 07:44:09] update-1000 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-03-28 07:44:09] update-1000 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped