--Task-- name: Reporting-pkce-access-token-200 enabled: True class_name: GatlingResultTask source_name: overseer-0 source_namespace: >default< target_name: overseer-0 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: ['Logs-parse-pkce-access-token-10', 'Logs-parse-pkce-access-token-200', 'Logs-parse-pkce-access-token-400', 'Logs-parse-pkce-access-token-600', 'Logs-parse-pkce-access-token-800', 'Logs-parse-pkce-access-token-900', 'Reporting-pkce-access-token-10'] preceding_task: None options: {'task_name': 'pkce-access-token-200'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock source (overseer-0) is a component 2025-03-19 21:16:56 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds) 2025-03-19 21:16:56 - INFO: timeout was set to GatlingResultTask default (half of global_duration or 3600 seconds (whatever is higher)), because it was unset Pod stdout file : /results/orders/Reporting-pkce-access-token-200/stdout.txt Pod stderr file : /results/orders/Reporting-pkce-access-token-200/stderr.txt Pod log : /results/orders/Reporting-pkce-access-token-200 ________________________________________________________________________________ [2025-03-19 21:16:56] Reporting-pkce-access-token-200 step1 : Write order for overseer to generate the report ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/order.json { "name": "Reporting-pkce-access-token-200", "command": " /lodestar/lodestar.py perf run-gatling --reports-only=\"/results/gatling/pkce-access-token-200\" --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx8G\" --archive-name=\"pkce-access-token-200.tar.gz\"", "out-dir": "/results/orders/Reporting-pkce-access-token-200" } ________________________________________________________________________________ [2025-03-19 21:16:56] Reporting-pkce-access-token-200 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2025-03-19 21:16:56,993 INFO 2025-03-19 21:16:56,993 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-19 21:16:56,993 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2025-03-19 21:16:57,204 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 21:16:57,204 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:16:57,204 DEBUG --- stdout --- 2025-03-19 21:16:57,204 DEBUG WAITING 2025-03-19 21:16:57,204 DEBUG --- stderr --- 2025-03-19 21:16:57,204 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-03-19 21:16:57] Reporting-pkce-access-token-200 step3 : Send order to overseer ________________________________________________________________________________ 2025-03-19 21:16:57,205 INFO 2025-03-19 21:16:57,205 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 21:16:57,205 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 21:16:57,480 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 21:16:57,480 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:16:57,480 DEBUG --- stdout --- 2025-03-19 21:16:57,480 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 21:16:57,480 DEBUG --- stderr --- 2025-03-19 21:16:57,480 DEBUG 2025-03-19 21:16:57,481 INFO 2025-03-19 21:16:57,481 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/08_Verification/09_Reporting-pkce-access-token-200/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-19 21:16:57,481 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 21:16:58,832 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:16:58,833 DEBUG --- stdout --- 2025-03-19 21:16:58,833 DEBUG 2025-03-19 21:16:58,833 DEBUG --- stderr --- 2025-03-19 21:16:58,833 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2025-03-19 21:16:58] Reporting-pkce-access-token-200 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2025-03-19 21:17:03,833 INFO 2025-03-19 21:17:03,833 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-19 21:17:03,833 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0] 2025-03-19 21:17:04,121 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2025-03-19 21:17:09,334 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry 2025-03-19 21:17:14,546 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry 2025-03-19 21:17:19,758 INFO [loop_until]: Function succeeded after 15s (rc=0) - failed to find expected output: WAITING - retry 2025-03-19 21:17:24,970 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry 2025-03-19 21:17:30,181 INFO [loop_until]: Function succeeded after 26s (rc=0) - expected pattern found 2025-03-19 21:17:30,181 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:30,181 DEBUG --- stdout --- 2025-03-19 21:17:30,181 DEBUG WAITING 2025-03-19 21:17:30,181 DEBUG --- stderr --- 2025-03-19 21:17:30,181 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-03-19 21:17:30] Reporting-pkce-access-token-200 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2025-03-19 21:17:30,182 INFO 2025-03-19 21:17:30,182 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 21:17:30,182 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 21:17:30,457 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 21:17:30,457 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:30,457 DEBUG --- stdout --- 2025-03-19 21:17:30,458 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 21:17:30,458 DEBUG --- stderr --- 2025-03-19 21:17:30,458 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 21:17:30,459 INFO 2025-03-19 21:17:30,459 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/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz" ]; then echo "/results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz file found"; exit 0; else echo "/results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz file found" 2025-03-19 21:17:30,459 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 21:17:31,251 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 21:17:31,251 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:31,251 DEBUG --- stdout --- 2025-03-19 21:17:31,251 DEBUG /results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz file found 2025-03-19 21:17:31,251 DEBUG --- stderr --- 2025-03-19 21:17:31,251 DEBUG 2025-03-19 21:17:31,251 INFO 2025-03-19 21:17:31,252 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz 2025-03-19 21:17:32,034 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 21:17:32,034 DEBUG --- stdout --- 2025-03-19 21:17:32,034 DEBUG 292 /results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz 2025-03-19 21:17:32,034 DEBUG --- stderr --- 2025-03-19 21:17:32,034 DEBUG 2025-03-19 21:17:32,034 INFO - Download file (size 292k) source : /results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/shared/pkce-access-token-200.tar.gz 2025-03-19 21:17:32,035 INFO 2025-03-19 21:17:32,035 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/shared/pkce-access-token-200.tar.gz 2025-03-19 21:17:32,035 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 21:17:33,010 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:33,010 DEBUG --- stdout --- 2025-03-19 21:17:33,011 DEBUG tar: Removing leading `/' from member names 2025-03-19 21:17:33,011 DEBUG --- stderr --- 2025-03-19 21:17:33,011 DEBUG ________________________________________________________________________________ [2025-03-19 21:17:33] Reporting-pkce-access-token-200 step6 : Unzip the result ________________________________________________________________________________ 2025-03-19 21:17:33,011 INFO 2025-03-19 21:17:33,011 INFO [run_command]: tar zxf /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/shared/pkce-access-token-200.tar.gz -C /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/07_Scenario_PKCEAccessToken/02_pkce-access-token-200/gatling 2025-03-19 21:17:33,025 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 21:17:33,025 DEBUG --- stdout --- 2025-03-19 21:17:33,026 DEBUG 2025-03-19 21:17:33,026 DEBUG --- stderr --- 2025-03-19 21:17:33,026 DEBUG 2025-03-19 21:17:33,026 INFO ________________________________________________________________________________ [2025-03-19 21:17:33] Reporting-pkce-access-token-200 step7 : Print rc order ________________________________________________________________________________ 2025-03-19 21:17:33,026 INFO 2025-03-19 21:17:33,026 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 21:17:33,026 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 21:17:33,304 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 21:17:33,304 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:33,304 DEBUG --- stdout --- 2025-03-19 21:17:33,304 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 21:17:33,304 DEBUG --- stderr --- 2025-03-19 21:17:33,304 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 21:17:33,305 INFO 2025-03-19 21:17:33,305 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/Reporting-pkce-access-token-200/rc.txt" ]; then echo "/results/orders/Reporting-pkce-access-token-200/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-pkce-access-token-200/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-pkce-access-token-200/rc.txt file found" 2025-03-19 21:17:33,305 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 21:17:34,095 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 21:17:34,095 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:34,095 DEBUG --- stdout --- 2025-03-19 21:17:34,095 DEBUG /results/orders/Reporting-pkce-access-token-200/rc.txt file found 2025-03-19 21:17:34,095 DEBUG --- stderr --- 2025-03-19 21:17:34,095 DEBUG 2025-03-19 21:17:34,095 INFO 2025-03-19 21:17:34,095 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/Reporting-pkce-access-token-200/rc.txt 2025-03-19 21:17:34,885 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 21:17:34,885 DEBUG --- stdout --- 2025-03-19 21:17:34,885 DEBUG 4 /results/orders/Reporting-pkce-access-token-200/rc.txt 2025-03-19 21:17:34,885 DEBUG --- stderr --- 2025-03-19 21:17:34,885 DEBUG 2025-03-19 21:17:34,885 INFO - Download file (size 4k) source : /results/orders/Reporting-pkce-access-token-200/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/rc.txt 2025-03-19 21:17:34,886 INFO 2025-03-19 21:17:34,886 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-pkce-access-token-200/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/rc.txt 2025-03-19 21:17:34,886 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 21:17:35,636 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:35,636 DEBUG --- stdout --- 2025-03-19 21:17:35,636 DEBUG tar: Removing leading `/' from member names 2025-03-19 21:17:35,636 DEBUG --- stderr --- 2025-03-19 21:17:35,636 DEBUG 2025-03-19 21:17:35,636 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/rc.txt is small (1 lines), printing all lines: 2025-03-19 21:17:35,636 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-19 21:17:35] Reporting-pkce-access-token-200 step8 : Check rc log ________________________________________________________________________________ CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) PASS: no error found in rc log ________________________________________________________________________________ [2025-03-19 21:17:35] Reporting-pkce-access-token-200 step9 : Print stdout order ________________________________________________________________________________ 2025-03-19 21:17:35,919 INFO 2025-03-19 21:17:35,919 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 21:17:35,919 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 21:17:36,194 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 21:17:36,194 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:36,195 DEBUG --- stdout --- 2025-03-19 21:17:36,195 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 21:17:36,195 DEBUG --- stderr --- 2025-03-19 21:17:36,195 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 21:17:36,196 INFO 2025-03-19 21:17:36,196 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/Reporting-pkce-access-token-200/stdout.txt" ]; then echo "/results/orders/Reporting-pkce-access-token-200/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-pkce-access-token-200/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-pkce-access-token-200/stdout.txt file found" 2025-03-19 21:17:36,196 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 21:17:37,014 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 21:17:37,014 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:37,014 DEBUG --- stdout --- 2025-03-19 21:17:37,014 DEBUG /results/orders/Reporting-pkce-access-token-200/stdout.txt file found 2025-03-19 21:17:37,014 DEBUG --- stderr --- 2025-03-19 21:17:37,014 DEBUG 2025-03-19 21:17:37,015 INFO 2025-03-19 21:17:37,015 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/Reporting-pkce-access-token-200/stdout.txt 2025-03-19 21:17:37,805 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 21:17:37,805 DEBUG --- stdout --- 2025-03-19 21:17:37,805 DEBUG 8 /results/orders/Reporting-pkce-access-token-200/stdout.txt 2025-03-19 21:17:37,805 DEBUG --- stderr --- 2025-03-19 21:17:37,805 DEBUG 2025-03-19 21:17:37,805 INFO - Download file (size 8k) source : /results/orders/Reporting-pkce-access-token-200/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/stdout.txt 2025-03-19 21:17:37,806 INFO 2025-03-19 21:17:37,806 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-pkce-access-token-200/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/stdout.txt 2025-03-19 21:17:37,806 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 21:17:38,520 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:38,520 DEBUG --- stdout --- 2025-03-19 21:17:38,520 DEBUG tar: Removing leading `/' from member names 2025-03-19 21:17:38,520 DEBUG --- stderr --- 2025-03-19 21:17:38,520 DEBUG 2025-03-19 21:17:38,520 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/stdout.txt is small (92 lines), printing all lines: 2025-03-19 21:17:38,520 INFO ----- output ----- 2025-03-19 21:16:59,849 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpdei2zc6p 2025-03-19 21:16:59,850 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/pkce-access-token-200/loadtest-20250319161227540" -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx8G" [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/tmpdei2zc6p/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] skip non existing resourceDirectory /tmp/tmpdei2zc6p/src/test/resources [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compile in 0.0 s [INFO] No sources to compile [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 --- 21:17:01,731 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 21:17:01,733 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 21:17:01,733 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 21:17:01,734 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 21:17:01,740 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 21:17:01,740 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 21:17:01,748 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 6 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 21:17:01,748 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 21:17:01,748 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 21:17:01,749 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 21:17:01,752 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.m2/repository/io/gatling/gatling-maven-plugin/4.9.6/gatling-maven-plugin-4.9.6.jar!/logback.xml] 21:17:01,757 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@240237d2 - URL [jar:file:/home/jenkins/.m2/repository/io/gatling/gatling-maven-plugin/4.9.6/gatling-maven-plugin-4.9.6.jar!/logback.xml] is not of type file 21:17:01,804 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 21:17:01,804 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 21:17:01,846 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 21:17:01,847 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 21:17:01,853 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 21:17:01,877 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 21:17:01,877 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 21:17:01,877 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 21:17:01,878 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 21:17:01,878 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 130 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY Parsing log file(s)... Parsing log file(s) done in 25s. Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 2864263 (OK=2864253 KO=10 ) > min response time 35 (OK=40 KO=35 ) > max response time 1384 (OK=1384 KO=245 ) > mean response time 53 (OK=53 KO=59 ) > std deviation 9 (OK=9 KO=62 ) > response time 50th percentile 52 (OK=52 KO=39 ) > response time 75th percentile 56 (OK=56 KO=42 ) > response time 95th percentile 69 (OK=69 KO=155 ) > response time 99th percentile 73 (OK=73 KO=227 ) > mean requests/sec 795.63 (OK=795.63 KO=0 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 2864228 ( 100%) > 800 ms <= t < 1200 ms 24 ( 0%) > t >= 1200 ms 1 ( 0%) > failed 10 ( 0%) ---- Errors -------------------------------------------------------------------- > status.find.is(200), but actually found 502 4 (40.00%) > status.find.is(302), but actually found 502 3 (30.00%) > status.find.in([200, 209], 304), found 502 2 (20.00%) > status.find.is(302), but actually found 400 1 (10.00%) ================================================================================ Reports generated, please open the following file: file:///results/gatling/pkce-access-token-200/loadtest-20250319161227540/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 27.624 s [INFO] Finished at: 2025-03-19T21:17:28Z [INFO] ------------------------------------------------------------------------ 2025-03-19 21:17:28,363 INFO Gatling simulation run ended successfully 2025-03-19 21:17:28,363 INFO Creating archive pkce-access-token-200.tar.gz with report files 2025-03-19 21:17:28,468 INFO Archive /results/gatling/pkce-access-token-200/pkce-access-token-200.tar.gz successfully created ________________________________________________________________________________ [2025-03-19 21:17:38] Reporting-pkce-access-token-200 step10 : Check stdout log and parse its content ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2025-03-19 21:17:38] Reporting-pkce-access-token-200 step11 : Print stderr order ________________________________________________________________________________ 2025-03-19 21:17:38,521 INFO 2025-03-19 21:17:38,521 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 21:17:38,521 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-19 21:17:38,798 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-19 21:17:38,798 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:38,798 DEBUG --- stdout --- 2025-03-19 21:17:38,798 DEBUG overseer-0-59c948f569-rgrkv 2025-03-19 21:17:38,798 DEBUG --- stderr --- 2025-03-19 21:17:38,798 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-19 21:17:38,800 INFO 2025-03-19 21:17:38,800 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/Reporting-pkce-access-token-200/stderr.txt" ]; then echo "/results/orders/Reporting-pkce-access-token-200/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-pkce-access-token-200/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-pkce-access-token-200/stderr.txt file found" 2025-03-19 21:17:38,800 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-19 21:17:39,607 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-19 21:17:39,607 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:39,607 DEBUG --- stdout --- 2025-03-19 21:17:39,607 DEBUG /results/orders/Reporting-pkce-access-token-200/stderr.txt file found 2025-03-19 21:17:39,607 DEBUG --- stderr --- 2025-03-19 21:17:39,607 DEBUG 2025-03-19 21:17:39,607 INFO 2025-03-19 21:17:39,608 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/Reporting-pkce-access-token-200/stderr.txt 2025-03-19 21:17:40,499 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-19 21:17:40,499 DEBUG --- stdout --- 2025-03-19 21:17:40,499 DEBUG 0 /results/orders/Reporting-pkce-access-token-200/stderr.txt 2025-03-19 21:17:40,499 DEBUG --- stderr --- 2025-03-19 21:17:40,499 DEBUG 2025-03-19 21:17:40,499 INFO - Download file (size 0k) source : /results/orders/Reporting-pkce-access-token-200/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/stderr.txt 2025-03-19 21:17:40,500 INFO 2025-03-19 21:17:40,500 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-pkce-access-token-200/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/stderr.txt 2025-03-19 21:17:40,500 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-19 21:17:41,307 INFO [loop_until]: OK (rc = 0) 2025-03-19 21:17:41,307 DEBUG --- stdout --- 2025-03-19 21:17:41,307 DEBUG tar: Removing leading `/' from member names 2025-03-19 21:17:41,307 DEBUG --- stderr --- 2025-03-19 21:17:41,307 DEBUG 2025-03-19 21:17:41,307 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/stderr.txt is small (0 lines), printing all lines: 2025-03-19 21:17:41,307 INFO ----- output ----- ________________________________________________________________________________ [2025-03-19 21:17:41] Reporting-pkce-access-token-200 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2025-03-19 21:17:41] Reporting-pkce-access-token-200 step13 : Analyze graphs for spikes ________________________________________________________________________________ Analyze Gatling graphs for spikes checking parameters open overall stats JSON file checking simulation request restLoginInitiate checking simulation request restLoginUsernamePasswordCallback checking simulation request User Authorize PKCE stage checking simulation request User AccessToken PKCE stage checking simulation request Skip 2FA no spikes found ________________________________________________________________________________ [2025-03-19 21:17:41] Reporting-pkce-access-token-200 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 2864263, "ok": 2864253, "ko": 10 }, "minResponseTime": { "total": 35, "ok": 40, "ko": 35 }, "maxResponseTime": { "total": 1384, "ok": 1384, "ko": 245 }, "meanResponseTime": { "total": 53, "ok": 53, "ko": 59 }, "standardDeviation": { "total": 9, "ok": 9, "ko": 62 }, "percentiles1": { "total": 52, "ok": 52, "ko": 39 }, "percentiles2": { "total": 56, "ok": 56, "ko": 42 }, "percentiles3": { "total": 69, "ok": 69, "ko": 155 }, "percentiles4": { "total": 73, "ok": 73, "ko": 227 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 2864228, "percentage": 99.99877804517253 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 24, "percentage": 0.0008379118816952214 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 1, "percentage": 3.491299507063422e-05 }, "group4": { "name": "failed", "htmlName": "failed", "count": 10, "percentage": 0.00034912995070634226 }, "meanNumberOfRequestsPerSecond": { "total": 795.6286111111111, "ok": 795.6258333333334, "ko": 0.002777777777777778 } }, "details": [ { "name": "restLoginInitiate", "numberOfRequests": { "total": 716085, "ok": 716083, "ko": 2 }, "minResponseTime": { "total": 40, "ok": 40, "ko": 41 }, "maxResponseTime": { "total": 1384, "ok": 1384, "ko": 42 }, "meanResponseTime": { "total": 47, "ok": 47, "ko": 42 }, "standardDeviation": { "total": 8, "ok": 8, "ko": 1 }, "percentiles1": { "total": 47, "ok": 47, "ko": 42 }, "percentiles2": { "total": 49, "ok": 49, "ko": 42 }, "percentiles3": { "total": 52, "ok": 52, "ko": 42 }, "percentiles4": { "total": 58, "ok": 58, "ko": 42 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 716062, "percentage": 99.99678809079927 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 20, "percentage": 0.0027929645223681546 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 1, "percentage": 0.00013964822611840772 }, "group4": { "name": "failed", "htmlName": "failed", "count": 2, "percentage": 0.00027929645223681544 }, "meanNumberOfRequestsPerSecond": { "total": 198.9125, "ok": 198.91194444444446, "ko": 0.0005555555555555556 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 716074, "ok": 716072, "ko": 2 }, "minResponseTime": { "total": 36, "ok": 47, "ko": 36 }, "maxResponseTime": { "total": 1115, "ok": 1115, "ko": 44 }, "meanResponseTime": { "total": 61, "ok": 61, "ko": 40 }, "standardDeviation": { "total": 8, "ok": 8, "ko": 4 }, "percentiles1": { "total": 59, "ok": 59, "ko": 40 }, "percentiles2": { "total": 67, "ok": 67, "ko": 42 }, "percentiles3": { "total": 72, "ok": 72, "ko": 44 }, "percentiles4": { "total": 77, "ok": 77, "ko": 44 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 716070, "percentage": 99.99944139851468 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 2, "percentage": 0.0002793007426606747 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 2, "percentage": 0.0002793007426606747 }, "meanNumberOfRequestsPerSecond": { "total": 198.90944444444443, "ok": 198.9088888888889, "ko": 0.0005555555555555556 }, "spikes": [] }, { "name": "User Authorize PKCE stage", "numberOfRequests": { "total": 716060, "ok": 716056, "ko": 4 }, "minResponseTime": { "total": 35, "ok": 41, "ko": 35 }, "maxResponseTime": { "total": 1102, "ok": 1102, "ko": 245 }, "meanResponseTime": { "total": 52, "ok": 52, "ko": 89 }, "standardDeviation": { "total": 5, "ok": 5, "ko": 90 }, "percentiles1": { "total": 51, "ok": 51, "ko": 37 }, "percentiles2": { "total": 54, "ok": 54, "ko": 91 }, "percentiles3": { "total": 58, "ok": 58, "ko": 214 }, "percentiles4": { "total": 62, "ok": 62, "ko": 239 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 716054, "percentage": 99.99916208138983 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 2, "percentage": 0.0002793062033907773 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 4, "percentage": 0.0005586124067815546 }, "meanNumberOfRequestsPerSecond": { "total": 198.90555555555557, "ok": 198.90444444444444, "ko": 0.0011111111111111111 }, "spikes": [] }, { "name": "User AccessToken PKCE stage", "numberOfRequests": { "total": 716043, "ok": 716041, "ko": 2 }, "minResponseTime": { "total": 37, "ok": 40, "ko": 37 }, "maxResponseTime": { "total": 711, "ok": 711, "ko": 38 }, "meanResponseTime": { "total": 52, "ok": 52, "ko": 38 }, "standardDeviation": { "total": 6, "ok": 6, "ko": 1 }, "percentiles1": { "total": 52, "ok": 52, "ko": 38 }, "percentiles2": { "total": 55, "ok": 55, "ko": 38 }, "percentiles3": { "total": 61, "ok": 61, "ko": 38 }, "percentiles4": { "total": 65, "ok": 65, "ko": 38 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 716041, "percentage": 99.99972068716544 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0.0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 2, "percentage": 0.00027931283456440466 }, "meanNumberOfRequestsPerSecond": { "total": 198.90083333333334, "ok": 198.90027777777777, "ko": 0.0005555555555555556 }, "spikes": [] }, { "name": "Skip 2FA", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 55, "ok": 55, "ko": 0 }, "maxResponseTime": { "total": 55, "ok": 55, "ko": 0 }, "meanResponseTime": { "total": 55, "ok": 55, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 55, "ok": 55, "ko": 0 }, "percentiles2": { "total": 55, "ok": 55, "ko": 0 }, "percentiles3": { "total": 55, "ok": 55, "ko": 0 }, "percentiles4": { "total": 55, "ok": 55, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100.0 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0.0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0.0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0002777777777777778, "ok": 0.0002777777777777778, "ko": 0 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 796, "avg_response_time": 53, "max_response_time": 1384, "min_response_time": 40, "num_requests": 2864263, "num_requests_pass": 2864253, "num_requests_percent_pass": 100.0 }, "options": "; testCase:am.PKCEauthGrantFlow; testMode:open; throughput:200; duration:3600", "stats": { "details": [ { "group1": { "count": 716062, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.99678809079927 }, "group2": { "count": 20, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0027929645223681546 }, "group3": { "count": 1, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.00013964822611840772 }, "group4": { "count": 2, "htmlName": "failed", "name": "failed", "percentage": 0.00027929645223681544 }, "maxResponseTime": { "ko": 42, "ok": 1384, "total": 1384 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005555555555555556, "ok": 198.91194444444446, "total": 198.9125 }, "meanResponseTime": { "ko": 42, "ok": 47, "total": 47 }, "minResponseTime": { "ko": 41, "ok": 40, "total": 40 }, "name": "restLoginInitiate", "numberOfRequests": { "ko": 2, "ok": 716083, "total": 716085 }, "percentiles1": { "ko": 42, "ok": 47, "total": 47 }, "percentiles2": { "ko": 42, "ok": 49, "total": 49 }, "percentiles3": { "ko": 42, "ok": 52, "total": 52 }, "percentiles4": { "ko": 42, "ok": 58, "total": 58 }, "spikes": [], "standardDeviation": { "ko": 1, "ok": 8, "total": 8 } }, { "group1": { "count": 716070, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.99944139851468 }, "group2": { "count": 2, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0002793007426606747 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 2, "htmlName": "failed", "name": "failed", "percentage": 0.0002793007426606747 }, "maxResponseTime": { "ko": 44, "ok": 1115, "total": 1115 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005555555555555556, "ok": 198.9088888888889, "total": 198.90944444444443 }, "meanResponseTime": { "ko": 40, "ok": 61, "total": 61 }, "minResponseTime": { "ko": 36, "ok": 47, "total": 36 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 2, "ok": 716072, "total": 716074 }, "percentiles1": { "ko": 40, "ok": 59, "total": 59 }, "percentiles2": { "ko": 42, "ok": 67, "total": 67 }, "percentiles3": { "ko": 44, "ok": 72, "total": 72 }, "percentiles4": { "ko": 44, "ok": 77, "total": 77 }, "spikes": [], "standardDeviation": { "ko": 4, "ok": 8, "total": 8 } }, { "group1": { "count": 716054, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.99916208138983 }, "group2": { "count": 2, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0002793062033907773 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 4, "htmlName": "failed", "name": "failed", "percentage": 0.0005586124067815546 }, "maxResponseTime": { "ko": 245, "ok": 1102, "total": 1102 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0011111111111111111, "ok": 198.90444444444444, "total": 198.90555555555557 }, "meanResponseTime": { "ko": 89, "ok": 52, "total": 52 }, "minResponseTime": { "ko": 35, "ok": 41, "total": 35 }, "name": "User Authorize PKCE stage", "numberOfRequests": { "ko": 4, "ok": 716056, "total": 716060 }, "percentiles1": { "ko": 37, "ok": 51, "total": 51 }, "percentiles2": { "ko": 91, "ok": 54, "total": 54 }, "percentiles3": { "ko": 214, "ok": 58, "total": 58 }, "percentiles4": { "ko": 239, "ok": 62, "total": 62 }, "spikes": [], "standardDeviation": { "ko": 90, "ok": 5, "total": 5 } }, { "group1": { "count": 716041, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.99972068716544 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 2, "htmlName": "failed", "name": "failed", "percentage": 0.00027931283456440466 }, "maxResponseTime": { "ko": 38, "ok": 711, "total": 711 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005555555555555556, "ok": 198.90027777777777, "total": 198.90083333333334 }, "meanResponseTime": { "ko": 38, "ok": 52, "total": 52 }, "minResponseTime": { "ko": 37, "ok": 40, "total": 37 }, "name": "User AccessToken PKCE stage", "numberOfRequests": { "ko": 2, "ok": 716041, "total": 716043 }, "percentiles1": { "ko": 38, "ok": 52, "total": 52 }, "percentiles2": { "ko": 38, "ok": 55, "total": 55 }, "percentiles3": { "ko": 38, "ok": 61, "total": 61 }, "percentiles4": { "ko": 38, "ok": 65, "total": 65 }, "spikes": [], "standardDeviation": { "ko": 1, "ok": 6, "total": 6 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100.0 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0.0 }, "maxResponseTime": { "ko": 0, "ok": 55, "total": 55 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0002777777777777778, "total": 0.0002777777777777778 }, "meanResponseTime": { "ko": 0, "ok": 55, "total": 55 }, "minResponseTime": { "ko": 0, "ok": 55, "total": 55 }, "name": "Skip 2FA", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 55, "total": 55 }, "percentiles2": { "ko": 0, "ok": 55, "total": 55 }, "percentiles3": { "ko": 0, "ok": 55, "total": 55 }, "percentiles4": { "ko": 0, "ok": 55, "total": 55 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } } ], "global": { "group1": { "count": 2864228, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.99877804517253 }, "group2": { "count": 24, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0008379118816952214 }, "group3": { "count": 1, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 3.491299507063422e-05 }, "group4": { "count": 10, "htmlName": "failed", "name": "failed", "percentage": 0.00034912995070634226 }, "maxResponseTime": { "ko": 245, "ok": 1384, "total": 1384 }, "meanNumberOfRequestsPerSecond": { "ko": 0.002777777777777778, "ok": 795.6258333333334, "total": 795.6286111111111 }, "meanResponseTime": { "ko": 59, "ok": 53, "total": 53 }, "minResponseTime": { "ko": 35, "ok": 40, "total": 35 }, "name": "All Requests", "numberOfRequests": { "ko": 10, "ok": 2864253, "total": 2864263 }, "percentiles1": { "ko": 39, "ok": 52, "total": 52 }, "percentiles2": { "ko": 42, "ok": 56, "total": 56 }, "percentiles3": { "ko": 155, "ok": 69, "total": 69 }, "percentiles4": { "ko": 227, "ok": 73, "total": 73 }, "standardDeviation": { "ko": 62, "ok": 9, "total": 9 } } }, "target_hostname": "openam-perf-200m.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2025-03-19 21:17:41] Reporting-pkce-access-token-200 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2025-03-19 21:17:41] Reporting-pkce-access-token-200 step16 : Remove gatling task's stdout file ________________________________________________________________________________ Cleanup of Gatling stdout file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_access_token/08_Verification/09_Reporting-pkce-access-token-200/stdout.txt Gatling stdout.txt found, but is small - leave it intact. ________________________________________________________________________________ [2025-03-19 21:17:41] Reporting-pkce-access-token-200 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped