--Task-- name: pkce-access-token-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: ['pkce-access-token-200'] preceding_task: pkce-access-token-200 options: {'testCase': 'am.PKCEauthGrantFlow', 'testMode': 'open', 'throughput': 400, 'duration': 3600, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock 2025-03-19 17:12:54,775 INFO 2025-03-19 17:12:54,775 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-19 17:12:54,775 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 17:12:55,053 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 17:12:55,053 INFO [loop_until]: OK (rc = 0) 2025-03-19 17:12:55,053 DEBUG --- stdout --- 2025-03-19 17:12:55,053 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 17:12:55,053 DEBUG --- stderr --- 2025-03-19 17:12:55,053 DEBUG 2025-03-19 17:12:55,053 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-03-19 17:12:55 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2025-03-19 17:12:55 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/pkce-access-token-400/stdout.txt Pod log : /results/orders/pkce-access-token-400 ________________________________________________________________________________ [2025-03-19 17:12:55] pkce-access-token-400 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="am.PKCEauthGrantFlow@perf-200m" --results-folder="/results/gatling/pkce-access-token-400" --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 -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=am.PKCEauthGrantFlow -DtestMode=open -Dthroughput=400 -Duser_password=**** ________________________________________________________________________________ [2025-03-19 17:12:55] pkce-access-token-400 create_order : Create order for overseer with the command to run ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/order.json { "name": "pkce-access-token-400", "command": " /lodestar/lodestar.py perf run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"am.PKCEauthGrantFlow@perf-200m\" --results-folder=\"/results/gatling/pkce-access-token-400\" --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 -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=am.PKCEauthGrantFlow -DtestMode=open -Dthroughput=400 -Duser_password=Pa_ssw0rd\"", "out-dir": "/results/orders/pkce-access-token-400" } ________________________________________________________________________________ [2025-03-19 17:12:55] pkce-access-token-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-03-19 17:12:55,061 INFO 2025-03-19 17:12:55,061 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-19 17:12:55,061 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-19 17:12:55,276 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 17:12:55,276 INFO [loop_until]: OK (rc = 0) 2025-03-19 17:12:55,276 DEBUG --- stdout --- 2025-03-19 17:12:55,276 DEBUG WAITING 2025-03-19 17:12:55,276 DEBUG --- stderr --- 2025-03-19 17:12:55,277 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-19 17:12:55] pkce-access-token-400 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-03-19 17:12:55,277 INFO 2025-03-19 17:12:55,277 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-19 17:12:55,277 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 17:12:55,572 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 17:12:55,572 INFO [loop_until]: OK (rc = 0) 2025-03-19 17:12:55,572 DEBUG --- stdout --- 2025-03-19 17:12:55,572 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 17:12:55,572 DEBUG --- stderr --- 2025-03-19 17:12:55,572 DEBUG 2025-03-19 17:12:55,573 INFO 2025-03-19 17:12:55,573 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-19 17:12:55,573 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 17:12:56,945 INFO [loop_until]: OK (rc = 0) 2025-03-19 17:12:56,945 DEBUG --- stdout --- 2025-03-19 17:12:56,945 DEBUG 2025-03-19 17:12:56,945 DEBUG --- stderr --- 2025-03-19 17:12:56,945 DEBUG Order has been successfully forwarded to overseer 2025-03-19 17:12:56 - INFO: Check if Gatling simulation started successfully 2025-03-19 17:12:56,946 INFO 2025-03-19 17:12:56,946 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv -- head --lines 5000 /results/orders/pkce-access-token-400/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-03-19 17:12:56,946 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-19 17:12:57,680 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-19 17:13:03,429 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-19 17:13:09,170 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-19 17:13:14,908 INFO [loop_until]: Function succeeded after 17s (rc=0) - expected pattern found 2025-03-19 17:13:14,908 INFO [loop_until]: OK (rc = 0) 2025-03-19 17:13:14,908 DEBUG --- stdout --- 2025-03-19 17:13:14,908 DEBUG 2025-03-19 17:12:57,866 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp0oe86f_p 2025-03-19 17:12:57,869 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/pkce-access-token-400" -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 -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=am.PKCEauthGrantFlow -DtestMode=open -Dthroughput=400 -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/tmp0oe86f_p/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/tmp0oe86f_p/target/test-classes ... [INFO] compile in 8.9 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. Simulation com.forgerock.pyrock.Loadtest started... 2025-03-19 17:13:14,908 DEBUG --- stderr --- 2025-03-19 17:13:14,908 DEBUG ________________________________________________________________________________ [2025-03-19 17:13:14] pkce-access-token-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 03s, retry Order is running since 22m 03s, retry Order is running since 24m 03s, retry Order is running since 26m 04s, retry Order is running since 28m 04s, retry Order is running since 30m 04s, retry Order is running since 32m 04s, retry Order is running since 34m 05s, retry Order is running since 36m 05s, retry Order is running since 38m 05s, retry Order is running since 40m 06s, retry Order is running since 42m 06s, retry Order is running since 44m 06s, retry Order is running since 46m 07s, retry Order is running since 48m 07s, retry Order is running since 50m 07s, retry Order is running since 52m 08s, retry Order is running since 54m 08s, retry Order is running since 56m 08s, retry Order is running since 58m 09s, retry PASS : Order stopped by itself after 1h and before timeout (1h 12m) ________________________________________________________________________________ [2025-03-19 18:13:24] pkce-access-token-400 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-03-19 18:13:24,308 INFO 2025-03-19 18:13:24,308 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-19 18:13:24,309 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 18:13:24,613 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 18:13:24,613 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:24,613 DEBUG --- stdout --- 2025-03-19 18:13:24,613 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 18:13:24,613 DEBUG --- stderr --- 2025-03-19 18:13:24,613 DEBUG 2025-03-19 18:13:24,613 INFO 2025-03-19 18:13:24,613 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-19 18:13:24,613 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 18:13:25,488 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:25,488 DEBUG --- stdout --- 2025-03-19 18:13:25,488 DEBUG 2025-03-19 18:13:25,488 DEBUG --- stderr --- 2025-03-19 18:13:25,488 DEBUG Order ran during 1h ________________________________________________________________________________ [2025-03-19 18:13:25] pkce-access-token-400 download_logs : Download individual order files ________________________________________________________________________________ 2025-03-19 18:13:25 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/order.json 2025-03-19 18:13:25,489 INFO 2025-03-19 18:13:25,489 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-19 18:13:25,489 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 18:13:25,767 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 18:13:25,767 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:25,767 DEBUG --- stdout --- 2025-03-19 18:13:25,767 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 18:13:25,767 DEBUG --- stderr --- 2025-03-19 18:13:25,767 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 18:13:25,768 INFO 2025-03-19 18:13:25,768 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/pkce-access-token-400/rc.txt" ]; then echo "/results/orders/pkce-access-token-400/rc.txt file found"; exit 0; else echo "/results/orders/pkce-access-token-400/rc.txt file not found"; exit 1; fi' | grep "/results/orders/pkce-access-token-400/rc.txt file found" 2025-03-19 18:13:25,768 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 18:13:26,580 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 18:13:26,580 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:26,580 DEBUG --- stdout --- 2025-03-19 18:13:26,580 DEBUG /results/orders/pkce-access-token-400/rc.txt file found 2025-03-19 18:13:26,580 DEBUG --- stderr --- 2025-03-19 18:13:26,580 DEBUG 2025-03-19 18:13:26,581 INFO 2025-03-19 18:13:26,581 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/pkce-access-token-400/rc.txt 2025-03-19 18:13:27,383 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 18:13:27,383 DEBUG --- stdout --- 2025-03-19 18:13:27,383 DEBUG 4 /results/orders/pkce-access-token-400/rc.txt 2025-03-19 18:13:27,383 DEBUG --- stderr --- 2025-03-19 18:13:27,383 DEBUG 2025-03-19 18:13:27,383 INFO - Download file (size 4k) source : /results/orders/pkce-access-token-400/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/rc.txt 2025-03-19 18:13:27,384 INFO 2025-03-19 18:13:27,384 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/pkce-access-token-400/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/rc.txt 2025-03-19 18:13:27,384 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 18:13:28,113 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:28,113 DEBUG --- stdout --- 2025-03-19 18:13:28,113 DEBUG tar: Removing leading `/' from member names 2025-03-19 18:13:28,113 DEBUG --- stderr --- 2025-03-19 18:13:28,113 DEBUG 2025-03-19 18:13:28,114 INFO 2025-03-19 18:13:28,114 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-19 18:13:28,114 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 18:13:28,395 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 18:13:28,395 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:28,395 DEBUG --- stdout --- 2025-03-19 18:13:28,395 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 18:13:28,395 DEBUG --- stderr --- 2025-03-19 18:13:28,395 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 18:13:28,396 INFO 2025-03-19 18:13:28,396 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/pkce-access-token-400/stderr.txt" ]; then echo "/results/orders/pkce-access-token-400/stderr.txt file found"; exit 0; else echo "/results/orders/pkce-access-token-400/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/pkce-access-token-400/stderr.txt file found" 2025-03-19 18:13:28,396 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 18:13:29,223 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 18:13:29,223 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:29,223 DEBUG --- stdout --- 2025-03-19 18:13:29,223 DEBUG /results/orders/pkce-access-token-400/stderr.txt file found 2025-03-19 18:13:29,223 DEBUG --- stderr --- 2025-03-19 18:13:29,223 DEBUG 2025-03-19 18:13:29,223 INFO 2025-03-19 18:13:29,223 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/pkce-access-token-400/stderr.txt 2025-03-19 18:13:30,024 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 18:13:30,024 DEBUG --- stdout --- 2025-03-19 18:13:30,024 DEBUG 0 /results/orders/pkce-access-token-400/stderr.txt 2025-03-19 18:13:30,024 DEBUG --- stderr --- 2025-03-19 18:13:30,024 DEBUG 2025-03-19 18:13:30,024 INFO - Download file (size 0k) source : /results/orders/pkce-access-token-400/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/stderr.txt 2025-03-19 18:13:30,025 INFO 2025-03-19 18:13:30,025 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/pkce-access-token-400/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/stderr.txt 2025-03-19 18:13:30,025 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 18:13:30,790 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:30,790 DEBUG --- stdout --- 2025-03-19 18:13:30,791 DEBUG tar: Removing leading `/' from member names 2025-03-19 18:13:30,791 DEBUG --- stderr --- 2025-03-19 18:13:30,791 DEBUG 2025-03-19 18:13:30,791 INFO 2025-03-19 18:13:30,791 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-19 18:13:30,791 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 18:13:31,070 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 18:13:31,070 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:31,070 DEBUG --- stdout --- 2025-03-19 18:13:31,070 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 18:13:31,070 DEBUG --- stderr --- 2025-03-19 18:13:31,070 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 18:13:31,071 INFO 2025-03-19 18:13:31,072 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/pkce-access-token-400/stdout.txt" ]; then echo "/results/orders/pkce-access-token-400/stdout.txt file found"; exit 0; else echo "/results/orders/pkce-access-token-400/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/pkce-access-token-400/stdout.txt file found" 2025-03-19 18:13:31,072 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 18:13:31,874 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 18:13:31,874 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:31,874 DEBUG --- stdout --- 2025-03-19 18:13:31,874 DEBUG /results/orders/pkce-access-token-400/stdout.txt file found 2025-03-19 18:13:31,874 DEBUG --- stderr --- 2025-03-19 18:13:31,874 DEBUG 2025-03-19 18:13:31,874 INFO 2025-03-19 18:13:31,875 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/pkce-access-token-400/stdout.txt 2025-03-19 18:13:32,672 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 18:13:32,673 DEBUG --- stdout --- 2025-03-19 18:13:32,673 DEBUG 1032 /results/orders/pkce-access-token-400/stdout.txt 2025-03-19 18:13:32,673 DEBUG --- stderr --- 2025-03-19 18:13:32,673 DEBUG 2025-03-19 18:13:32,673 INFO - Download file (size 1032k) source : /results/orders/pkce-access-token-400/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/stdout.txt 2025-03-19 18:13:32,674 INFO 2025-03-19 18:13:32,674 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/pkce-access-token-400/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/stdout.txt 2025-03-19 18:13:32,674 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 18:13:33,803 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:33,803 DEBUG --- stdout --- 2025-03-19 18:13:33,803 DEBUG tar: Removing leading `/' from member names 2025-03-19 18:13:33,803 DEBUG --- stderr --- 2025-03-19 18:13:33,803 DEBUG ________________________________________________________________________________ [2025-03-19 18:13:33] pkce-access-token-400 show_cmd : Display order command ________________________________________________________________________________ 2025-03-19 18:13:33,803 INFO 2025-03-19 18:13:33,803 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-19 18:13:33,803 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 18:13:34,085 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 18:13:34,085 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:34,085 DEBUG --- stdout --- 2025-03-19 18:13:34,085 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 18:13:34,085 DEBUG --- stderr --- 2025-03-19 18:13:34,085 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 18:13:34,086 INFO 2025-03-19 18:13:34,086 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/pkce-access-token-400/cmd.txt" ]; then echo "/results/orders/pkce-access-token-400/cmd.txt file found"; exit 0; else echo "/results/orders/pkce-access-token-400/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/pkce-access-token-400/cmd.txt file found" 2025-03-19 18:13:34,086 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 18:13:34,885 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 18:13:34,885 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:34,885 DEBUG --- stdout --- 2025-03-19 18:13:34,885 DEBUG /results/orders/pkce-access-token-400/cmd.txt file found 2025-03-19 18:13:34,885 DEBUG --- stderr --- 2025-03-19 18:13:34,885 DEBUG 2025-03-19 18:13:34,885 INFO 2025-03-19 18:13:34,885 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/pkce-access-token-400/cmd.txt 2025-03-19 18:13:35,689 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 18:13:35,689 DEBUG --- stdout --- 2025-03-19 18:13:35,689 DEBUG 4 /results/orders/pkce-access-token-400/cmd.txt 2025-03-19 18:13:35,689 DEBUG --- stderr --- 2025-03-19 18:13:35,689 DEBUG 2025-03-19 18:13:35,689 INFO - Download file (size 4k) source : /results/orders/pkce-access-token-400/cmd.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/cmd.txt 2025-03-19 18:13:35,690 INFO 2025-03-19 18:13:35,690 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/pkce-access-token-400/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/cmd.txt 2025-03-19 18:13:35,690 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 18:13:36,454 INFO [loop_until]: OK (rc = 0) 2025-03-19 18:13:36,454 DEBUG --- stdout --- 2025-03-19 18:13:36,454 DEBUG tar: Removing leading `/' from member names 2025-03-19 18:13:36,454 DEBUG --- stderr --- 2025-03-19 18:13:36,454 DEBUG 2025-03-19 18:13:36,454 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/cmd.txt is small (1 lines), printing all lines: 2025-03-19 18:13:36,454 INFO ----- output ----- /lodestar/lodestar.py perf run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="am.PKCEauthGrantFlow@perf-200m" --results-folder="/results/gatling/pkce-access-token-400" --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 -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=am.PKCEauthGrantFlow -DtestMode=open -Dthroughput=400 -Duser_password=Pa_ssw0rd" ________________________________________________________________________________ [2025-03-19 18:13:36] pkce-access-token-400 show_rc : Display rc order ________________________________________________________________________________ 2025-03-19 18:13:36,454 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/rc.txt is small (1 lines), printing all lines: 2025-03-19 18:13:36,454 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-19 18:13:36] pkce-access-token-400 show_stdout : Display stdout order ________________________________________________________________________________ 2025-03-19 18:13:36,456 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input file (/mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/stdout.txt is 15481 lines): 2025-03-19 18:13:36,459 INFO ----- output ----- 2025-03-19 17:12:57,866 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp0oe86f_p 2025-03-19 17:12:57,869 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/pkce-access-token-400" -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 -Dduration=3600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=endUserUIClient -Doauth2_redirect_uri=/enduser/appAuthHelperRedirect.html -Drealm=alpha -DtestCase=am.PKCEauthGrantFlow -DtestMode=open -Dthroughput=400 -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/tmp0oe86f_p/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/tmp0oe86f_p/target/test-classes ... [INFO] compile in 8.9 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. Simulation com.forgerock.pyrock.Loadtest started... ================================================================================ 2025-03-19 17:13:16 GMT 5s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=633 KO=0 ) > restLoginInitiate (OK=163 KO=0 ) > restLoginUsernamePasswordCallback (OK=160 KO=0 ) > User Authorize PKCE stage (OK=157 KO=0 ) > User AccessToken PKCE stage (OK=153 KO=0 ) ---- am.PKCEauthGrantFlow ------------------------------------------------------ [- ] 0% waiting: 1445446 / active: 14 / done: 152 ================================================================================ ================================================================================ 2025-03-19 17:13:21 GMT 10s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=2597 KO=0 ) > restLoginInitiate (OK=660 KO=0 ) > restLoginUsernamePasswordCallback (OK=653 KO=0 ) > User Authorize PKCE stage (OK=646 KO=0 ) > User AccessToken PKCE stage (OK=638 KO=0 ) ---- am.PKCEauthGrantFlow ------------------------------------------------------ [- ] 0% waiting: 1444946 / active: 28 / done: 638 ================================================================================ ================================================================================ 2025-03-19 17:13:26 GMT 15s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=5897 KO=0 ) > restLoginInitiate (OK=1490 KO=0 ) > restLoginUsernamePasswordCallback (OK=1479 KO=0 ) > User Authorize PKCE stage (OK=1470 KO=0 ) > User AccessToken PKCE stage (OK=1458 KO=0 ) ---- am.PKCEauthGrantFlow ------------------------------------------------------ [- ] 0% waiting: 1444112 / active: 42 / done: 1458 ================================================================================ ================================================================================ 2025-03-19 17:13:31 GMT 20s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=10521 KO=0 ) > restLoginInitiate (OK=2652 KO=0 ) > restLoginUsernamePasswordCallback (OK=2635 KO=0 ) > User Authorize PKCE stage (OK=2621 KO=0 ) > User AccessToken PKCE stage (OK=2613 KO=0 ) ---- am.PKCEauthGrantFlow ------------------------------------------------------ [- ] 0% waiting: 1442947 / active: 52 / done: 2613 ================================================================================ ================================================================================ 2025-03-19 17:13:36 GMT 25s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=16487 KO=0 ) [...] Session: Session(am.PKCEauthGrantFlow,1433533,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, username -> user.7733412, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@7cbc35e6, fake-user-agent -> Mozilla/5.0 (iPhone; CPU iPhone OS 13_2_3 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/13.0.3 Mobile/15E148 Safari/604.1, password -> Pa_ssw0rd, fake-ip -> 3.121.6.179, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@75c93087),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$787/0x00007ee3e467f388@79d5cd3b,io.netty.channel.epoll.EpollEventLoop@1e1d3956) ========================= HTTP request: POST https://openam-perf-200m.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: content-type: application/json Accept-API-Version: resource=2.0, protocol=1.0 accept: application/json X-Forwarded-For: 3.121.6.179 User-Agent: Mozilla/5.0 (iPhone; CPU iPhone OS 13_2_3 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/13.0.3 Mobile/15E148 Safari/604.1 host: openam-perf-200m.forgeblocks.com content-length: 0 body:StringChunksRequestBody{charset=UTF-8, content=} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 18:13:11.247 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-20' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 18:13:11.247 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-20' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 18:13:11.247 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-20' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 18:13:11.247 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-20' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 18:13:11.247 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'restLoginInitiate' failed for user 1433520: j.i.IOException: Premature close 18:13:11.247 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'restLoginInitiate' failed for user 1433518: j.i.IOException: Premature close 18:13:11.247 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'restLoginInitiate' failed for user 1433541: j.n.c.ClosedChannelException 18:13:11.248 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: restLoginInitiate: KO j.i.IOException: Premature close ========================= Session: Session(am.PKCEauthGrantFlow,1433520,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, username -> user.14722904, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@330dc183, fake-user-agent -> Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/116.0.0.0 Safari/537.36, password -> Pa_ssw0rd, fake-ip -> 42.42.42.42, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@3fa92dd6),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$787/0x00007ee3e467f388@79d5cd3b,io.netty.channel.epoll.EpollEventLoop@636e8cc) ========================= HTTP request: POST https://openam-perf-200m.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: content-type: application/json Accept-API-Version: resource=2.0, protocol=1.0 accept: application/json X-Forwarded-For: 42.42.42.42 User-Agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/116.0.0.0 Safari/537.36 host: openam-perf-200m.forgeblocks.com content-length: 0 body:StringChunksRequestBody{charset=UTF-8, content=} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 18:13:11.248 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: restLoginInitiate: KO j.i.IOException: Premature close ========================= Session: Session(am.PKCEauthGrantFlow,1433518,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, username -> user.36663644, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@785e5c02, fake-user-agent -> Mozilla/5.0 (iPhone; CPU iPhone OS 10_3 like Mac OS X) AppleWebKit/602.1.50 (KHTML, like Gecko) CriOS/56.0.2924.75 Mobile/14E5239e Safari/602.1, password -> Pa_ssw0rd, fake-ip -> 102.54.233.118, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@25b6df9c),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$787/0x00007ee3e467f388@79d5cd3b,io.netty.channel.epoll.EpollEventLoop@4f2c9ba6) ========================= HTTP request: POST https://openam-perf-200m.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: content-type: application/json Accept-API-Version: resource=2.0, protocol=1.0 accept: application/json X-Forwarded-For: 102.54.233.118 User-Agent: Mozilla/5.0 (iPhone; CPU iPhone OS 10_3 like Mac OS X) AppleWebKit/602.1.50 (KHTML, like Gecko) CriOS/56.0.2924.75 Mobile/14E5239e Safari/602.1 host: openam-perf-200m.forgeblocks.com content-length: 0 body:StringChunksRequestBody{charset=UTF-8, content=} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 18:13:11.248 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: restLoginInitiate: KO j.n.c.ClosedChannelException ========================= Session: Session(am.PKCEauthGrantFlow,1433541,HashMap(gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, username -> user.46043786, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@137bf00f, fake-user-agent -> Mozilla/5.0 (Linux; Android 6.0; Nexus 5 Build/MRA58N) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36, password -> Pa_ssw0rd, fake-ip -> 136.242.23.232, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@78292925),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$787/0x00007ee3e467f388@79d5cd3b,io.netty.channel.epoll.EpollEventLoop@619bfe29) ========================= HTTP request: POST https://openam-perf-200m.forgeblocks.com/am/json/realms/root/realms/alpha/authenticate headers: content-type: application/json Accept-API-Version: resource=2.0, protocol=1.0 accept: application/json X-Forwarded-For: 136.242.23.232 User-Agent: Mozilla/5.0 (Linux; Android 6.0; Nexus 5 Build/MRA58N) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.85 Mobile Safari/537.36 host: openam-perf-200m.forgeblocks.com body:StringChunksRequestBody{charset=UTF-8, content=} ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 18:13:11.248 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-20' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 18:13:11.248 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-20' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one 18:13:11.248 [ERROR] i.g.c.a.b.SessionHookBuilder$$anon$1 - 'hook-20' crashed with 'j.u.NoSuchElementException: No attribute named 'callbacks' is defined', forwarding to the next one [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 01:00 h [INFO] Finished at: 2025-03-19T18:13:11Z [INFO] ------------------------------------------------------------------------ 2025-03-19 18:13:11,313 INFO Gatling simulation run ended successfully 2025-03-19 18:13:11,313 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-03-19 18:13:36] pkce-access-token-400 show_stderr : Display stderr order ________________________________________________________________________________ 2025-03-19 18:13:36,459 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/03_pkce-access-token-400/stderr.txt is small (0 lines), printing all lines: 2025-03-19 18:13:36,459 INFO ----- output ----- ________________________________________________________________________________ [2025-03-19 18:13:36] pkce-access-token-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-03-19 18:13:36] pkce-access-token-400 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-03-19 18:13:36] pkce-access-token-400 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped