--Task-- name: benchmark-400 enabled: True class_name: GatlingTask source_name: overseer-0 source_namespace: >default< target_name: am 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: ['benchmark-300'] preceding_task: benchmark-300 options: {'duration': 3600, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html', 'testCase': 'idc.benchmark.Mix2024', 'testMode': 'open', 'throughput': 400} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock 2025-06-14 01:05:36,549 INFO 2025-06-14 01:05:36,549 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-06-14 01:05:36,549 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-06-14 01:05:36,822 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-06-14 01:05:36,822 INFO [loop_until]: OK (rc = 0) 2025-06-14 01:05:36,822 DEBUG --- stdout --- 2025-06-14 01:05:36,822 DEBUG overseer-0-898c87646-bjhnj 2025-06-14 01:05:36,822 DEBUG --- stderr --- 2025-06-14 01:05:36,822 DEBUG 2025-06-14 01:05:36,822 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-06-14 01:05:36 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-06-14 01:05:36 - INFO: timeout was calculated based on simulation duration parameter 2025-06-14 01:05:36 - INFO: Interval for this Task has changed to 2m (120 seconds) 2025-06-14 01:05:36 - INFO: interval was set to Task default because it was unset, based on self.timeout value because task is allowed to stop by itself Pod log file : /results/orders/benchmark-400/stdout.txt Pod log : /results/orders/benchmark-400 ________________________________________________________________________________ [2025-06-14 01:05:36] benchmark-400 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ /lodestar/lodestar.py perf run-gatling --mvn-quiet --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@tof-10" --results-folder="/results/gatling/benchmark-400" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx4G" --simulation-system-properties="-Dam_host=openam-tof-10.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-tof-10.forgeblocks.com -Dlogin_cookie=7573b68ed0f3690 -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=400 -Duser_password=**** ________________________________________________________________________________ [2025-06-14 01:05:36] benchmark-400 create_order : Create order for overseer with the command to run ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/order.json { "name": "benchmark-400", "command": " /lodestar/lodestar.py perf run-gatling --mvn-quiet --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idc.benchmark.Mix2024@tof-10\" --results-folder=\"/results/gatling/benchmark-400\" --no-reports --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx4G\" --simulation-system-properties=\"-Dam_host=openam-tof-10.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-tof-10.forgeblocks.com -Dlogin_cookie=7573b68ed0f3690 -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=400 -Duser_password=Pa_ssw0rd\"", "out-dir": "/results/orders/benchmark-400" } ________________________________________________________________________________ [2025-06-14 01:05:36] benchmark-400 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-06-14 01:05:36,830 INFO 2025-06-14 01:05:36,830 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-06-14 01:05:36,830 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-06-14 01:05:37,042 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 01:05:37,042 INFO [loop_until]: OK (rc = 0) 2025-06-14 01:05:37,042 DEBUG --- stdout --- 2025-06-14 01:05:37,042 DEBUG WAITING 2025-06-14 01:05:37,042 DEBUG --- stderr --- 2025-06-14 01:05:37,042 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 34 0 --:--:-- --:--:-- --:--:-- 34 ________________________________________________________________________________ [2025-06-14 01:05:37] benchmark-400 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-06-14 01:05:37,043 INFO 2025-06-14 01:05:37,043 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-06-14 01:05:37,043 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-06-14 01:05:37,334 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-06-14 01:05:37,334 INFO [loop_until]: OK (rc = 0) 2025-06-14 01:05:37,334 DEBUG --- stdout --- 2025-06-14 01:05:37,334 DEBUG overseer-0-898c87646-bjhnj 2025-06-14 01:05:37,334 DEBUG --- stderr --- 2025-06-14 01:05:37,334 DEBUG 2025-06-14 01:05:37,335 INFO 2025-06-14 01:05:37,335 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/order.json overseer-0-898c87646-bjhnj:/results/orders/order.json 2025-06-14 01:05:37,335 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-06-14 01:05:38,724 INFO [loop_until]: OK (rc = 0) 2025-06-14 01:05:38,724 DEBUG --- stdout --- 2025-06-14 01:05:38,724 DEBUG 2025-06-14 01:05:38,724 DEBUG --- stderr --- 2025-06-14 01:05:38,724 DEBUG Order has been successfully forwarded to overseer 2025-06-14 01:05:38 - INFO: Check if Gatling simulation started successfully 2025-06-14 01:05:38,725 INFO 2025-06-14 01:05:38,725 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj -- head --lines 5000 /results/orders/benchmark-400/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-06-14 01:05:38,725 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-06-14 01:05:39,473 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-06-14 01:05:45,228 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-06-14 01:05:50,997 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-06-14 01:05:56,744 INFO [loop_until]: Function succeeded after 18s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-06-14 01:06:02,519 INFO [loop_until]: Function succeeded after 23s (rc=0) - expected pattern found 2025-06-14 01:06:02,519 INFO [loop_until]: OK (rc = 0) 2025-06-14 01:06:02,520 DEBUG --- stdout --- 2025-06-14 01:06:02,520 DEBUG 2025-06-14 02:05:40,724 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp6i4gj8b9 2025-06-14 02:05:40,728 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode --quiet -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-400" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-tof-10.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-tof-10.forgeblocks.com -Dlogin_cookie=7573b68ed0f3690 -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=400 -Duser_password=**** 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. Simulation com.forgerock.pyrock.Loadtest started... 2025-06-14 01:06:02,520 DEBUG --- stderr --- 2025-06-14 01:06:02,520 DEBUG ________________________________________________________________________________ [2025-06-14 01:06:02] benchmark-400 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 03s, 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 05s, 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-06-14 02:06:11] benchmark-400 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-06-14 02:06:11,138 INFO 2025-06-14 02:06:11,138 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-06-14 02:06:11,138 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-06-14 02:06:11,437 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-06-14 02:06:11,437 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:11,437 DEBUG --- stdout --- 2025-06-14 02:06:11,437 DEBUG overseer-0-898c87646-bjhnj 2025-06-14 02:06:11,437 DEBUG --- stderr --- 2025-06-14 02:06:11,437 DEBUG 2025-06-14 02:06:11,438 INFO 2025-06-14 02:06:11,438 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj -- rm -f /results/orders/order.json 2025-06-14 02:06:11,438 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-06-14 02:06:12,241 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:12,241 DEBUG --- stdout --- 2025-06-14 02:06:12,241 DEBUG 2025-06-14 02:06:12,241 DEBUG --- stderr --- 2025-06-14 02:06:12,241 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-06-14 02:06:12] benchmark-400 download_logs : Download individual order files ________________________________________________________________________________ 2025-06-14 02:06:12 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/order.json 2025-06-14 02:06:12,242 INFO 2025-06-14 02:06:12,242 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-06-14 02:06:12,242 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-06-14 02:06:12,523 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-06-14 02:06:12,524 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:12,524 DEBUG --- stdout --- 2025-06-14 02:06:12,524 DEBUG overseer-0-898c87646-bjhnj 2025-06-14 02:06:12,524 DEBUG --- stderr --- 2025-06-14 02:06:12,524 DEBUG Checking if file exists on pod 'overseer-0-898c87646-bjhnj', wait max 3 minutes if not. 2025-06-14 02:06:12,524 INFO 2025-06-14 02:06:12,525 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- bash -c 'if [ -f "/results/orders/benchmark-400/rc.txt" ]; then echo "/results/orders/benchmark-400/rc.txt file found"; exit 0; else echo "/results/orders/benchmark-400/rc.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-400/rc.txt file found" 2025-06-14 02:06:12,525 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-06-14 02:06:13,345 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:13,345 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:13,345 DEBUG --- stdout --- 2025-06-14 02:06:13,345 DEBUG /results/orders/benchmark-400/rc.txt file found 2025-06-14 02:06:13,345 DEBUG --- stderr --- 2025-06-14 02:06:13,345 DEBUG 2025-06-14 02:06:13,345 INFO 2025-06-14 02:06:13,346 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- du -k /results/orders/benchmark-400/rc.txt | grep "^\d+ .+$" 2025-06-14 02:06:13,346 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-06-14 02:06:14,172 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:14,172 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:14,172 DEBUG --- stdout --- 2025-06-14 02:06:14,172 DEBUG 4 /results/orders/benchmark-400/rc.txt 2025-06-14 02:06:14,173 DEBUG --- stderr --- 2025-06-14 02:06:14,173 DEBUG - Download file (size 4kB) source : /results/orders/benchmark-400/rc.txt @ overseer-0-898c87646-bjhnj destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/rc.txt 2025-06-14 02:06:14,173 INFO 2025-06-14 02:06:14,173 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-898c87646-bjhnj:/results/orders/benchmark-400/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/rc.txt 2025-06-14 02:06:14,173 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-06-14 02:06:14,905 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:14,905 DEBUG --- stdout --- 2025-06-14 02:06:14,905 DEBUG tar: Removing leading `/' from member names 2025-06-14 02:06:14,906 DEBUG --- stderr --- 2025-06-14 02:06:14,906 DEBUG 2025-06-14 02:06:14,906 INFO 2025-06-14 02:06:14,906 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-06-14 02:06:14,906 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-06-14 02:06:15,186 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-06-14 02:06:15,186 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:15,186 DEBUG --- stdout --- 2025-06-14 02:06:15,186 DEBUG overseer-0-898c87646-bjhnj 2025-06-14 02:06:15,186 DEBUG --- stderr --- 2025-06-14 02:06:15,186 DEBUG Checking if file exists on pod 'overseer-0-898c87646-bjhnj', wait max 3 minutes if not. 2025-06-14 02:06:15,187 INFO 2025-06-14 02:06:15,187 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- bash -c 'if [ -f "/results/orders/benchmark-400/stderr.txt" ]; then echo "/results/orders/benchmark-400/stderr.txt file found"; exit 0; else echo "/results/orders/benchmark-400/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-400/stderr.txt file found" 2025-06-14 02:06:15,187 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-06-14 02:06:16,038 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:16,038 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:16,038 DEBUG --- stdout --- 2025-06-14 02:06:16,038 DEBUG /results/orders/benchmark-400/stderr.txt file found 2025-06-14 02:06:16,038 DEBUG --- stderr --- 2025-06-14 02:06:16,038 DEBUG 2025-06-14 02:06:16,038 INFO 2025-06-14 02:06:16,038 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- du -k /results/orders/benchmark-400/stderr.txt | grep "^\d+ .+$" 2025-06-14 02:06:16,038 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-06-14 02:06:16,840 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:16,840 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:16,840 DEBUG --- stdout --- 2025-06-14 02:06:16,840 DEBUG 0 /results/orders/benchmark-400/stderr.txt 2025-06-14 02:06:16,840 DEBUG --- stderr --- 2025-06-14 02:06:16,840 DEBUG - Download file (size 0B) source : /results/orders/benchmark-400/stderr.txt @ overseer-0-898c87646-bjhnj destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/stderr.txt 2025-06-14 02:06:16,841 INFO 2025-06-14 02:06:16,841 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-898c87646-bjhnj:/results/orders/benchmark-400/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/stderr.txt 2025-06-14 02:06:16,841 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-06-14 02:06:17,569 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:17,569 DEBUG --- stdout --- 2025-06-14 02:06:17,569 DEBUG tar: Removing leading `/' from member names 2025-06-14 02:06:17,569 DEBUG --- stderr --- 2025-06-14 02:06:17,569 DEBUG 2025-06-14 02:06:17,569 INFO 2025-06-14 02:06:17,569 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-06-14 02:06:17,569 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-06-14 02:06:17,857 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-06-14 02:06:17,857 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:17,857 DEBUG --- stdout --- 2025-06-14 02:06:17,857 DEBUG overseer-0-898c87646-bjhnj 2025-06-14 02:06:17,857 DEBUG --- stderr --- 2025-06-14 02:06:17,857 DEBUG Checking if file exists on pod 'overseer-0-898c87646-bjhnj', wait max 3 minutes if not. 2025-06-14 02:06:17,858 INFO 2025-06-14 02:06:17,858 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- bash -c 'if [ -f "/results/orders/benchmark-400/stdout.txt" ]; then echo "/results/orders/benchmark-400/stdout.txt file found"; exit 0; else echo "/results/orders/benchmark-400/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-400/stdout.txt file found" 2025-06-14 02:06:17,858 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-06-14 02:06:18,674 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:18,674 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:18,674 DEBUG --- stdout --- 2025-06-14 02:06:18,674 DEBUG /results/orders/benchmark-400/stdout.txt file found 2025-06-14 02:06:18,674 DEBUG --- stderr --- 2025-06-14 02:06:18,674 DEBUG 2025-06-14 02:06:18,675 INFO 2025-06-14 02:06:18,675 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- du -k /results/orders/benchmark-400/stdout.txt | grep "^\d+ .+$" 2025-06-14 02:06:18,675 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-06-14 02:06:19,563 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:19,563 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:19,563 DEBUG --- stdout --- 2025-06-14 02:06:19,563 DEBUG 37824 /results/orders/benchmark-400/stdout.txt 2025-06-14 02:06:19,563 DEBUG --- stderr --- 2025-06-14 02:06:19,563 DEBUG - Download file (size 37.824MB) source : /results/orders/benchmark-400/stdout.txt @ overseer-0-898c87646-bjhnj destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/stdout.txt 2025-06-14 02:06:19,564 INFO 2025-06-14 02:06:19,564 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-898c87646-bjhnj:/results/orders/benchmark-400/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/stdout.txt 2025-06-14 02:06:19,564 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-06-14 02:06:21,728 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:21,728 DEBUG --- stdout --- 2025-06-14 02:06:21,728 DEBUG tar: Removing leading `/' from member names 2025-06-14 02:06:21,728 DEBUG --- stderr --- 2025-06-14 02:06:21,728 DEBUG ________________________________________________________________________________ [2025-06-14 02:06:21] benchmark-400 show_cmd : Display order command ________________________________________________________________________________ 2025-06-14 02:06:21,729 INFO 2025-06-14 02:06:21,729 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-06-14 02:06:21,729 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-06-14 02:06:22,044 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-06-14 02:06:22,044 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:22,044 DEBUG --- stdout --- 2025-06-14 02:06:22,044 DEBUG overseer-0-898c87646-bjhnj 2025-06-14 02:06:22,044 DEBUG --- stderr --- 2025-06-14 02:06:22,044 DEBUG Checking if file exists on pod 'overseer-0-898c87646-bjhnj', wait max 3 minutes if not. 2025-06-14 02:06:22,045 INFO 2025-06-14 02:06:22,045 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- bash -c 'if [ -f "/results/orders/benchmark-400/cmd.txt" ]; then echo "/results/orders/benchmark-400/cmd.txt file found"; exit 0; else echo "/results/orders/benchmark-400/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/benchmark-400/cmd.txt file found" 2025-06-14 02:06:22,045 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-06-14 02:06:22,860 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:22,860 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:22,860 DEBUG --- stdout --- 2025-06-14 02:06:22,860 DEBUG /results/orders/benchmark-400/cmd.txt file found 2025-06-14 02:06:22,860 DEBUG --- stderr --- 2025-06-14 02:06:22,860 DEBUG 2025-06-14 02:06:22,860 INFO 2025-06-14 02:06:22,860 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-898c87646-bjhnj --stdin -- du -k /results/orders/benchmark-400/cmd.txt | grep "^\d+ .+$" 2025-06-14 02:06:22,860 INFO [loop_until]: (max_time=240, interval=10, expected_rc=[0] 2025-06-14 02:06:23,682 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-06-14 02:06:23,682 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:23,682 DEBUG --- stdout --- 2025-06-14 02:06:23,682 DEBUG 4 /results/orders/benchmark-400/cmd.txt 2025-06-14 02:06:23,682 DEBUG --- stderr --- 2025-06-14 02:06:23,682 DEBUG - Download file (size 4kB) source : /results/orders/benchmark-400/cmd.txt @ overseer-0-898c87646-bjhnj destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/cmd.txt 2025-06-14 02:06:23,683 INFO 2025-06-14 02:06:23,683 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-898c87646-bjhnj:/results/orders/benchmark-400/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/cmd.txt 2025-06-14 02:06:23,683 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-06-14 02:06:24,486 INFO [loop_until]: OK (rc = 0) 2025-06-14 02:06:24,487 DEBUG --- stdout --- 2025-06-14 02:06:24,487 DEBUG tar: Removing leading `/' from member names 2025-06-14 02:06:24,487 DEBUG --- stderr --- 2025-06-14 02:06:24,487 DEBUG 2025-06-14 02:06:24,487 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/cmd.txt is small (1 lines), printing all lines: 2025-06-14 02:06:24,487 INFO ----- output ----- /lodestar/lodestar.py perf run-gatling --mvn-quiet --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idc.benchmark.Mix2024@tof-10" --results-folder="/results/gatling/benchmark-400" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx4G" --simulation-system-properties="-Dam_host=openam-tof-10.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=M@ythe4th -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-tof-10.forgeblocks.com -Dlogin_cookie=7573b68ed0f3690 -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=400 -Duser_password=Pa_ssw0rd" ________________________________________________________________________________ [2025-06-14 02:06:24] benchmark-400 show_rc : Display rc order ________________________________________________________________________________ 2025-06-14 02:06:24,487 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/rc.txt is small (1 lines), printing all lines: 2025-06-14 02:06:24,487 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-06-14 02:06:24] benchmark-400 show_stdout : Display stdout order ________________________________________________________________________________ 2025-06-14 02:06:24,588 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input file (/mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/stdout.txt is 791163 lines): 2025-06-14 02:06:24,687 INFO ----- output ----- 2025-06-14 02:05:40,724 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp6i4gj8b9 2025-06-14 02:05:40,728 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode --quiet -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/benchmark-400" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx4G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-tof-10.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dduration=3600 -Didc=true -Didm_host=openam-tof-10.forgeblocks.com -Dlogin_cookie=7573b68ed0f3690 -Dnum_users=10000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=idc.benchmark.Mix2024 -DtestMode=open -Dthroughput=400 -Duser_password=**** 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. Simulation com.forgerock.pyrock.Loadtest started... ================================================================================ 2025-06-14 01:06:03 GMT 5s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=993 KO=0 ) > authAsPolicyAdmin (OK=1 KO=0 ) > restLoginInitiate (OK=94 KO=0 ) > restLoginUsernamePasswordCallback (OK=90 KO=0 ) > Skip 2FA (OK=24 KO=0 ) > User Authorize PKCE stage (OK=95 KO=0 ) > userRestlogin (OK=60 KO=0 ) > User AccessToken PKCE stage (OK=91 KO=0 ) > tokenUserinfo (OK=32 KO=0 ) > RootUserinfo (OK=40 KO=0 ) > EvalPolicy (OK=57 KO=0 ) > loginTreeWorkflow_restLoginInitiate (OK=5 KO=0 ) > getIdToken (OK=4 KO=0 ) > loginTreeWorkflow_restLoginUsernamePasswordCallback (OK=5 KO=0 ) > getIdToken Redirect 1 (OK=4 KO=0 ) > UI-Post-Login - stage 1 (OK=29 KO=0 ) > createOrganization (OK=4 KO=0 ) > UI-Post-Login - stage 1 Redirect 1 (OK=27 KO=0 ) > queryOrganization (OK=4 KO=0 ) > UI AM idFromSession (OK=24 KO=0 ) > UI AM validateGoto (OK=24 KO=0 ) > deleteOrganization (OK=4 KO=0 ) > UI-Post-Login - stage 2 (OK=22 KO=0 ) > UI-Post-Login - stage 2 Redirect 1 (OK=18 KO=0 ) > UI Enduser appAuthHelper1 (OK=16 KO=0 ) > UI Enduser appAuthHelper2 (OK=16 KO=0 ) > UI-Post-Login - stage 3 (OK=14 KO=0 ) > UI-Post-Login - stage 3 Redirect 1 (OK=12 KO=0 ) > UI Enduser sessioncheck (OK=12 KO=0 ) > UI IDM uiconfig (OK=12 KO=0 ) > UI IDM version (OK=12 KO=0 ) > UI IDM features (OK=12 KO=0 ) > UI IDM login (OK=12 KO=0 ) > UI IDM privilege (OK=12 KO=0 ) > UI IDM dashboard (OK=12 KO=0 ) > UI IDM user (OK=11 KO=0 ) > UI IDM managed user schema (OK=11 KO=0 ) > UI IDM oidcToken (OK=11 KO=0 ) > userinfo (OK=10 KO=0 ) > UI-Logout (OK=10 KO=0 ) > UI-Logout Redirect 1 (OK=10 KO=0 ) > UI AM revoke1 (OK=10 KO=0 ) > UI AM endsession (OK=10 KO=0 ) > UI AM revoke2 (OK=10 KO=0 ) ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ---- idc.benchmark.Mix2024 ----------------------------------------------------- [- ] 0% waiting: 1446120 / active: 57 / done: 109 ================================================================================ ================================================================================ 2025-06-14 01:06:08 GMT 10s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=5629 KO=0 ) > authAsPolicyAdmin (OK=1 KO=0 ) > restLoginInitiate (OK=398 KO=0 ) > restLoginUsernamePasswordCallback (OK=386 KO=0 ) > Skip 2FA (OK=124 KO=0 ) > User Authorize PKCE stage (OK=478 KO=0 ) > userRestlogin (OK=233 KO=0 ) > User AccessToken PKCE stage (OK=471 KO=0 ) > tokenUserinfo (OK=121 KO=0 ) > RootUserinfo (OK=277 KO=0 ) > EvalPolicy (OK=231 KO=0 ) > loginTreeWorkflow_restLoginInitiate (OK=21 KO=0 ) > getIdToken (OK=30 KO=0 ) > loginTreeWorkflow_restLoginUsernamePasswordCallback (OK=20 KO=0 ) > getIdToken Redirect 1 (OK=30 KO=0 ) > UI-Post-Login - stage 1 (OK=130 KO=0 ) > createOrganization (OK=30 KO=0 ) > UI-Post-Login - stage 1 Redirect 1 (OK=127 KO=0 ) > queryOrganization (OK=30 KO=0 ) > UI AM idFromSession (OK=122 KO=0 ) > UI AM validateGoto (OK=122 KO=0 ) > deleteOrganization (OK=29 KO=0 ) > UI-Post-Login - stage 2 (OK=116 KO=0 ) > UI-Post-Login - stage 2 Redirect 1 (OK=113 KO=0 ) > UI Enduser appAuthHelper1 (OK=110 KO=0 ) > UI Enduser appAuthHelper2 (OK=110 KO=0 ) > UI-Post-Login - stage 3 (OK=105 KO=0 ) > UI-Post-Login - stage 3 Redirect 1 (OK=102 KO=0 ) > UI Enduser sessioncheck (OK=102 KO=0 ) > UI IDM uiconfig (OK=102 KO=0 ) > UI IDM version (OK=102 KO=0 ) > UI IDM features (OK=102 KO=0 ) > UI IDM login (OK=102 KO=0 ) > UI IDM privilege (OK=102 KO=0 ) [...] UI IDM features: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1433650,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJiNjcxM2IxMC0wZGFjLTRiNTktYjFhZC1hOGY2M2U4ODAxZDQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiOTVkNWVkZWItYmRlZC00NGY3LWFlMjAtNGY2OWI1OTk2MmJlLTEwMDI0MDA1MSIsInN1Ym5hbWUiOiJiNjcxM2IxMC0wZGFjLTRiNTktYjFhZC1hOGY2M2U4ODAxZDQiLCJpc3MiOiJodHRwczovL29wZW5hbS10b2YtMTAuZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIvcmVhbG1zL3Jvb3QvcmVhbG1zL2FscGhhIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiVHZ5cjUyTm1FcUFtalBWN2FpVkRIMUs3c1djIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiZW5kVXNlclVJQ2xpZW50IiwiYXVkIjoiZW5kVXNlclVJQ2xpZW50IiwibmJmIjoxNzQ5ODY2NzU3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQ5ODY2NzU2LCJyZWFsbSI6Ii9hbHBoYSIsImV4cCI6MTc0OTg3MDM1NywiaWF0IjoxNzQ5ODY2NzU3LCJleHBpcmVzX2luIjozNjAwLCJqdGkiOiJYeGpqZjYyeW5HTUd6Mk1JS1hGNVBBOXR4enMifQ.TpEeJtZFOjQke9LKFJciVcS-dquhQhyvNPKzEy1PiVc, username -> user.988277, tokenIdCookieName -> amlbcookie, policyEvalTokenId -> , access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJiNjcxM2IxMC0wZGFjLTRiNTktYjFhZC1hOGY2M2U4ODAxZDQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMWM0YWQwZmEtOTlmNS00MjZiLTgzNDQtNmYxNzg5NTU2ZTUzLTk5ODIzNDMyIiwic3VibmFtZSI6ImI2NzEzYjEwLTBkYWMtNGI1OS1iMWFkLWE4ZjYzZTg4MDFkNCIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXRvZi0xMC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMi9yZWFsbXMvcm9vdC9yZWFsbXMvYWxwaGEiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJzUlR2Sk9LaXhIcURNQ2Y0dHJCcUV1bFR3Y2ciLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJlbmRVc2VyVUlDbGllbnQiLCJhdWQiOiJlbmRVc2VyVUlDbGllbnQiLCJuYmYiOjE3NDk4NjY3NTcsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3NDk4NjY3NTYsInJlYWxtIjoiL2FscGhhIiwiZXhwIjoxNzQ5ODcwMzU3LCJpYXQiOjE3NDk4NjY3NTcsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6InVuNkh3WEdhVWhrQVVkZHkwYlJHMkt3WmN5YyJ9.7_mjnvlIE0y1ncGO32gAsgef0nFFExvf6_bfniFdz6Y, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@6769893, gatling.http.referer -> https://openam-tof-10.forgeblocks.com/am/, authcode -> kHph7NsLgMBPD77Nqd9qGoqlkzQ, callbacks -> {"tokenId":"Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-tof-10.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866756971), CookieKey(7573b68ed0f3690,openam-tof-10.forgeblocks.com,/) -> StoredCookie(7573b68ed0f3690=Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866756971))), user_uuid -> b6713b10-0dac-4b59-b1ad-a8f63e8801d4, password -> Pa_ssw0rd, challenge -> FdIVAi_Lw20XPtagovurEvkvEps2J5tcv-UZ6RNfDRU, gatling.http.cache.baseUrl -> https://openam-tof-10.forgeblocks.com:443, fake-ip -> 42.42.42.42, verifier -> LTgxODczMjA5MTc0NTI3NTQ4NjA, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@7e2046ae, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@ef328ae, tokenId -> Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/64.0.3282.140 Safari/537.36 Edge/17.17134),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007d7ad8698000@40d6c418,io.netty.channel.epoll.EpollEventLoop@14f5da2c) ========================= HTTP request: GET https://openam-tof-10.forgeblocks.com/openidm/info/features?_queryFilter=true headers: 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 referer: https://openam-tof-10.forgeblocks.com/am/ Authorization: Bearer eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJiNjcxM2IxMC0wZGFjLTRiNTktYjFhZC1hOGY2M2U4ODAxZDQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMWM0YWQwZmEtOTlmNS00MjZiLTgzNDQtNmYxNzg5NTU2ZTUzLTk5ODIzNDMyIiwic3VibmFtZSI6ImI2NzEzYjEwLTBkYWMtNGI1OS1iMWFkLWE4ZjYzZTg4MDFkNCIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXRvZi0xMC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMi9yZWFsbXMvcm9vdC9yZWFsbXMvYWxwaGEiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJzUlR2Sk9LaXhIcURNQ2Y0dHJCcUV1bFR3Y2ciLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJlbmRVc2VyVUlDbGllbnQiLCJhdWQiOiJlbmRVc2VyVUlDbGllbnQiLCJuYmYiOjE3NDk4NjY3NTcsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3NDk4NjY3NTYsInJlYWxtIjoiL2FscGhhIiwiZXhwIjoxNzQ5ODcwMzU3LCJpYXQiOjE3NDk4NjY3NTcsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6InVuNkh3WEdhVWhrQVVkZHkwYlJHMkt3WmN5YyJ9.7_mjnvlIE0y1ncGO32gAsgef0nFFExvf6_bfniFdz6Y Accept-Api-Version: accept: */* cookie: amlbcookie=01; 7573b68ed0f3690=Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..* host: openam-tof-10.forgeblocks.com cookies: amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 7573b68ed0f3690=Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 03:05:58.201 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI IDM version' failed for user 1433650: j.i.IOException: Premature close 03:05:58.201 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UI IDM version: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1433650,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJiNjcxM2IxMC0wZGFjLTRiNTktYjFhZC1hOGY2M2U4ODAxZDQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiOTVkNWVkZWItYmRlZC00NGY3LWFlMjAtNGY2OWI1OTk2MmJlLTEwMDI0MDA1MSIsInN1Ym5hbWUiOiJiNjcxM2IxMC0wZGFjLTRiNTktYjFhZC1hOGY2M2U4ODAxZDQiLCJpc3MiOiJodHRwczovL29wZW5hbS10b2YtMTAuZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIvcmVhbG1zL3Jvb3QvcmVhbG1zL2FscGhhIiwidG9rZW5OYW1lIjoiYWNjZXNzX3Rva2VuIiwidG9rZW5fdHlwZSI6IkJlYXJlciIsImF1dGhHcmFudElkIjoiVHZ5cjUyTm1FcUFtalBWN2FpVkRIMUs3c1djIiwibm9uY2UiOiIxMjM0IiwiY2xpZW50X2lkIjoiZW5kVXNlclVJQ2xpZW50IiwiYXVkIjoiZW5kVXNlclVJQ2xpZW50IiwibmJmIjoxNzQ5ODY2NzU3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQ5ODY2NzU2LCJyZWFsbSI6Ii9hbHBoYSIsImV4cCI6MTc0OTg3MDM1NywiaWF0IjoxNzQ5ODY2NzU3LCJleHBpcmVzX2luIjozNjAwLCJqdGkiOiJYeGpqZjYyeW5HTUd6Mk1JS1hGNVBBOXR4enMifQ.TpEeJtZFOjQke9LKFJciVcS-dquhQhyvNPKzEy1PiVc, username -> user.988277, tokenIdCookieName -> amlbcookie, policyEvalTokenId -> , access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiJiNjcxM2IxMC0wZGFjLTRiNTktYjFhZC1hOGY2M2U4ODAxZDQiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMWM0YWQwZmEtOTlmNS00MjZiLTgzNDQtNmYxNzg5NTU2ZTUzLTk5ODIzNDMyIiwic3VibmFtZSI6ImI2NzEzYjEwLTBkYWMtNGI1OS1iMWFkLWE4ZjYzZTg4MDFkNCIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXRvZi0xMC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMi9yZWFsbXMvcm9vdC9yZWFsbXMvYWxwaGEiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJzUlR2Sk9LaXhIcURNQ2Y0dHJCcUV1bFR3Y2ciLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJlbmRVc2VyVUlDbGllbnQiLCJhdWQiOiJlbmRVc2VyVUlDbGllbnQiLCJuYmYiOjE3NDk4NjY3NTcsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3NDk4NjY3NTYsInJlYWxtIjoiL2FscGhhIiwiZXhwIjoxNzQ5ODcwMzU3LCJpYXQiOjE3NDk4NjY3NTcsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6InVuNkh3WEdhVWhrQVVkZHkwYlJHMkt3WmN5YyJ9.7_mjnvlIE0y1ncGO32gAsgef0nFFExvf6_bfniFdz6Y, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@6769893, gatling.http.referer -> https://openam-tof-10.forgeblocks.com/am/, authcode -> kHph7NsLgMBPD77Nqd9qGoqlkzQ, callbacks -> {"tokenId":"Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-tof-10.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866756971), CookieKey(7573b68ed0f3690,openam-tof-10.forgeblocks.com,/) -> StoredCookie(7573b68ed0f3690=Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866756971))), user_uuid -> b6713b10-0dac-4b59-b1ad-a8f63e8801d4, password -> Pa_ssw0rd, challenge -> FdIVAi_Lw20XPtagovurEvkvEps2J5tcv-UZ6RNfDRU, gatling.http.cache.baseUrl -> https://openam-tof-10.forgeblocks.com:443, fake-ip -> 42.42.42.42, verifier -> LTgxODczMjA5MTc0NTI3NTQ4NjA, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@7e2046ae, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@ef328ae, tokenId -> Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/64.0.3282.140 Safari/537.36 Edge/17.17134),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007d7ad8698000@40d6c418,io.netty.channel.epoll.EpollEventLoop@14f5da2c) ========================= HTTP request: GET https://openam-tof-10.forgeblocks.com/openidm/info/version headers: 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 referer: https://openam-tof-10.forgeblocks.com/am/ Accept-Api-Version: accept: */* cookie: amlbcookie=01; 7573b68ed0f3690=Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..* host: openam-tof-10.forgeblocks.com cookies: amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 7573b68ed0f3690=Zxj9oY0yJLtP2osFafTsyaiKlUo.*AAJTSQACMDIAAlNLABxoMVR5ODVXSW5uTXA2NjVoUWlyd0g3bnJlSFU9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 03:05:58.202 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI IDM privilege' failed for user 1433682: j.i.IOException: Premature close 03:05:58.202 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UI IDM privilege: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1433682,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiIyZmUyYjExMy02MTA0LTRmMzYtOGM4My0wZmZkZTU4NjQ3OTgiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiMWM0YWQwZmEtOTlmNS00MjZiLTgzNDQtNmYxNzg5NTU2ZTUzLTk5ODE4OTI3Iiwic3VibmFtZSI6IjJmZTJiMTEzLTYxMDQtNGYzNi04YzgzLTBmZmRlNTg2NDc5OCIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXRvZi0xMC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMi9yZWFsbXMvcm9vdC9yZWFsbXMvYWxwaGEiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJfOEx0amJoQmNNZmViNTlDUE0xVjM3d3dQMGMiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJlbmRVc2VyVUlDbGllbnQiLCJhdWQiOiJlbmRVc2VyVUlDbGllbnQiLCJuYmYiOjE3NDk4NjY3NTcsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJvcGVuaWQiLCJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3NDk4NjY3NTYsInJlYWxtIjoiL2FscGhhIiwiZXhwIjoxNzQ5ODcwMzU3LCJpYXQiOjE3NDk4NjY3NTcsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6IjBWY3VDWUF0MDJCbmNPeENIZzMzMlB0U2VabyJ9.WHLpSFB4_zzHrWvc2js9HEllCFm1Q6YqMd5xEX2RSf4, username -> user.2080069, tokenIdCookieName -> amlbcookie, policyEvalTokenId -> , access_token_2 -> eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiIyZmUyYjExMy02MTA0LTRmMzYtOGM4My0wZmZkZTU4NjQ3OTgiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiZmY3MTA1ZDYtMmNiMS00ZTE3LWIyYmItZDkyY2YyMDkzMDU4LTk4OTg2MDM2Iiwic3VibmFtZSI6IjJmZTJiMTEzLTYxMDQtNGYzNi04YzgzLTBmZmRlNTg2NDc5OCIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXRvZi0xMC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMi9yZWFsbXMvcm9vdC9yZWFsbXMvYWxwaGEiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJReEFtVFpUZzVRN3dCeUpLNHhLYkdYOTd3RVUiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJlbmRVc2VyVUlDbGllbnQiLCJhdWQiOiJlbmRVc2VyVUlDbGllbnQiLCJuYmYiOjE3NDk4NjY3NTcsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3NDk4NjY3NTYsInJlYWxtIjoiL2FscGhhIiwiZXhwIjoxNzQ5ODcwMzU3LCJpYXQiOjE3NDk4NjY3NTcsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6IkdFcWtxV3U5OFU2T0F4S2hhaG8xMjJ3b2JDSSJ9.x_tX6sLexvVbYaEwhK77HEWm-x0vKNKJYvBY8GpI2M8, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@5ee1cd5f, gatling.http.referer -> https://openam-tof-10.forgeblocks.com/am/, authcode -> GDmJB43z79FAcKAuI5ORHIn4KvE, callbacks -> {"tokenId":"G6mcsFWr3oeDENyCIduSKbfDOBY.*AAJTSQACMDIAAlNLABxaOVl0OGdDeXN1UWdOYmtUSjBhNnhKbnZaUjQ9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-tof-10.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866757036), CookieKey(7573b68ed0f3690,openam-tof-10.forgeblocks.com,/) -> StoredCookie(7573b68ed0f3690=G6mcsFWr3oeDENyCIduSKbfDOBY.*AAJTSQACMDIAAlNLABxaOVl0OGdDeXN1UWdOYmtUSjBhNnhKbnZaUjQ9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866757036))), user_uuid -> 2fe2b113-6104-4f36-8c83-0ffde5864798, password -> Pa_ssw0rd, challenge -> e1xGhVqVT4cA0VcaWu2c5XrlRevoXhw6zLKIfirzRJA, gatling.http.cache.baseUrl -> https://openam-tof-10.forgeblocks.com:443, fake-ip -> 42.42.42.42, verifier -> ODU2MDQ1MjQxNDU1MTgzNjI3OA, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@6ce17410, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@10884a14, tokenId -> G6mcsFWr3oeDENyCIduSKbfDOBY.*AAJTSQACMDIAAlNLABxaOVl0OGdDeXN1UWdOYmtUSjBhNnhKbnZaUjQ9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/58.0.3029.110 Safari/537.3),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007d7ad8698000@40d6c418,io.netty.channel.epoll.EpollEventLoop@14f5da2c) ========================= HTTP request: POST https://openam-tof-10.forgeblocks.com/openidm/privilege?_action=listPrivileges headers: 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 referer: https://openam-tof-10.forgeblocks.com/am/ Authorization: Bearer eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzdWIiOiIyZmUyYjExMy02MTA0LTRmMzYtOGM4My0wZmZkZTU4NjQ3OTgiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiZmY3MTA1ZDYtMmNiMS00ZTE3LWIyYmItZDkyY2YyMDkzMDU4LTk4OTg2MDM2Iiwic3VibmFtZSI6IjJmZTJiMTEzLTYxMDQtNGYzNi04YzgzLTBmZmRlNTg2NDc5OCIsImlzcyI6Imh0dHBzOi8vb3BlbmFtLXRvZi0xMC5mb3JnZWJsb2Nrcy5jb206NDQzL2FtL29hdXRoMi9yZWFsbXMvcm9vdC9yZWFsbXMvYWxwaGEiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJReEFtVFpUZzVRN3dCeUpLNHhLYkdYOTd3RVUiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJlbmRVc2VyVUlDbGllbnQiLCJhdWQiOiJlbmRVc2VyVUlDbGllbnQiLCJuYmYiOjE3NDk4NjY3NTcsImdyYW50X3R5cGUiOiJhdXRob3JpemF0aW9uX2NvZGUiLCJzY29wZSI6WyJmcjppZG06KiJdLCJhdXRoX3RpbWUiOjE3NDk4NjY3NTYsInJlYWxtIjoiL2FscGhhIiwiZXhwIjoxNzQ5ODcwMzU3LCJpYXQiOjE3NDk4NjY3NTcsImV4cGlyZXNfaW4iOjM2MDAsImp0aSI6IkdFcWtxV3U5OFU2T0F4S2hhaG8xMjJ3b2JDSSJ9.x_tX6sLexvVbYaEwhK77HEWm-x0vKNKJYvBY8GpI2M8 Accept-Api-Version: accept: */* cookie: amlbcookie=01; 7573b68ed0f3690=G6mcsFWr3oeDENyCIduSKbfDOBY.*AAJTSQACMDIAAlNLABxaOVl0OGdDeXN1UWdOYmtUSjBhNnhKbnZaUjQ9AAR0eXBlAANDVFMAAlMxAAIwMQ..* origin: https://openam-tof-10.forgeblocks.com host: openam-tof-10.forgeblocks.com content-length: 0 cookies: amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 7573b68ed0f3690=G6mcsFWr3oeDENyCIduSKbfDOBY.*AAJTSQACMDIAAlNLABxaOVl0OGdDeXN1UWdOYmtUSjBhNnhKbnZaUjQ9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 03:05:58.202 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request ' UI AM validateGoto' failed for user 1434034: j.i.IOException: Premature close 03:05:58.202 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: UI AM validateGoto: KO j.i.IOException: Premature close ========================= Session: Session(idc.benchmark.Mix2024,1434034,HashMap(gatling.http.cache.baseUrl -> https://openam-tof-10.forgeblocks.com:443, username -> user.899628, tokenIdCookieName -> amlbcookie, policyEvalTokenId -> , gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@1559a8cf, gatling.http.referer -> https://openam-tof-10.forgeblocks.com/am/, callbacks -> {"tokenId":"9QXvBlzL-OQJswBG6BCph-o7t1M.*AAJTSQACMDIAAlNLABxaTzFMa2pybGJFK2tWNm1VdXlFOVMrYUFlMEE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*","successUrl":"/enduser/?realm=/alpha","realm":"/alpha"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-tof-10.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866757914), CookieKey(7573b68ed0f3690,openam-tof-10.forgeblocks.com,/) -> StoredCookie(7573b68ed0f3690=9QXvBlzL-OQJswBG6BCph-o7t1M.*AAJTSQACMDIAAlNLABxaTzFMa2pybGJFK2tWNm1VdXlFOVMrYUFlMEE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1749866757914))), password -> Pa_ssw0rd, fake-ip -> 42.42.42.42, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@1db1310e, gatling.http.cache.contentCache -> io.gatling.core.util.cache.Cache@534dfec9, tokenId -> 9QXvBlzL-OQJswBG6BCph-o7t1M.*AAJTSQACMDIAAlNLABxaTzFMa2pybGJFK2tWNm1VdXlFOVMrYUFlMEE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, fake-user-agent -> Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11_2) AppleWebKit/601.3.9 (KHTML, like Gecko) Version/9.0.2 Safari/601.3.9),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$821/0x00007d7ad8698000@40d6c418,io.netty.channel.epoll.EpollEventLoop@14f5da2c) ========================= HTTP request: POST https://openam-tof-10.forgeblocks.com/am/json/realms/root/realms/alpha/users?_action=validateGoto headers: 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 Accept-API-Version: resource=2.1, protocol=1.0 referer: https://openam-tof-10.forgeblocks.com/am/ accept: */* cookie: amlbcookie=01; 7573b68ed0f3690=9QXvBlzL-OQJswBG6BCph-o7t1M.*AAJTSQACMDIAAlNLABxaTzFMa2pybGJFK2tWNm1VdXlFOVMrYUFlMEE9AAR0eXBlAANDVFMAAlMxAAIwMQ..* origin: https://openam-tof-10.forgeblocks.com host: openam-tof-10.forgeblocks.com content-length: 0 cookies: amlbcookie=01, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 7573b68ed0f3690=9QXvBlzL-OQJswBG6BCph-o7t1M.*AAJTSQACMDIAAlNLABxaTzFMa2pybGJFK2tWNm1VdXlFOVMrYUFlMEE9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, domain=openam-tof-10.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 2025-06-14 03:05:58,345 INFO Gatling simulation run ended successfully 2025-06-14 03:05:58,346 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-06-14 02:06:24] benchmark-400 show_stderr : Display stderr order ________________________________________________________________________________ 2025-06-14 02:06:24,687 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_benchmark/07_Scenario_benchmark/05_benchmark-400/stderr.txt is small (0 lines), printing all lines: 2025-06-14 02:06:24,687 INFO ----- output ----- ________________________________________________________________________________ [2025-06-14 02:06:24] benchmark-400 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-06-14 02:06:25] benchmark-400 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-06-14 02:06:25] benchmark-400 post : Post method ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped