--Task-- name: Reporting-query-9 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-query-10', 'Logs-parse-query-9', 'Logs-parse-query-8', 'Logs-parse-query-7', 'Logs-parse-query-6', 'Logs-parse-query-5', 'Logs-parse-query-4', 'Reporting-query-10'] preceding_task: None options: {'task_name': 'query-9'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock source (overseer-0) is a component 2025-03-28 19:58:01 - INFO: Timeout for this Task has changed to 5h 30m (19800 seconds) 2025-03-28 19:58:01 - 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-query-9/stdout.txt Pod stderr file : /results/orders/Reporting-query-9/stderr.txt Pod log : /results/orders/Reporting-query-9 ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-9 step1 : Write order for overseer to generate the report ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/order.json { "name": "Reporting-query-9", "command": " /lodestar/lodestar.py perf run-gatling --reports-only=\"/results/gatling/query-9\" --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx8G\" --archive-name=\"query-9.tar.gz\"", "out-dir": "/results/orders/Reporting-query-9" } ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-9 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2025-03-28 19:58:01,289 INFO 2025-03-28 19:58:01,289 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 19:58:01,289 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2025-03-28 19:58:01,504 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:01,504 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:01,504 DEBUG --- stdout --- 2025-03-28 19:58:01,504 DEBUG WAITING 2025-03-28 19:58:01,504 DEBUG --- stderr --- 2025-03-28 19:58:01,504 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-9 step3 : Send order to overseer ________________________________________________________________________________ 2025-03-28 19:58:01,504 INFO 2025-03-28 19:58:01,504 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 19:58:01,504 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:01,783 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:01,783 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:01,783 DEBUG --- stdout --- 2025-03-28 19:58:01,783 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:01,783 DEBUG --- stderr --- 2025-03-28 19:58:01,783 DEBUG 2025-03-28 19:58:01,784 INFO 2025-03-28 19:58:01,784 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 19:58:01,784 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:03,143 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:03,143 DEBUG --- stdout --- 2025-03-28 19:58:03,143 DEBUG 2025-03-28 19:58:03,143 DEBUG --- stderr --- 2025-03-28 19:58:03,143 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2025-03-28 19:58:03] Reporting-query-9 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2025-03-28 19:58:08,144 INFO 2025-03-28 19:58:08,144 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 19:58:08,144 INFO [loop_until]: (max_time=19800, interval=5, expected_rc=[0] 2025-03-28 19:58:08,359 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 19:58:13,574 INFO [loop_until]: Function succeeded after 5s (rc=0) - expected pattern found 2025-03-28 19:58:13,574 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:13,574 DEBUG --- stdout --- 2025-03-28 19:58:13,574 DEBUG WAITING 2025-03-28 19:58:13,574 DEBUG --- stderr --- 2025-03-28 19:58:13,574 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2025-03-28 19:58:13] Reporting-query-9 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2025-03-28 19:58:13,574 INFO 2025-03-28 19:58:13,574 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 19:58:13,574 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:13,852 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:13,852 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:13,852 DEBUG --- stdout --- 2025-03-28 19:58:13,852 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:13,852 DEBUG --- stderr --- 2025-03-28 19:58:13,852 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:13,853 INFO 2025-03-28 19:58:13,853 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/query-9/query-9.tar.gz" ]; then echo "/results/gatling/query-9/query-9.tar.gz file found"; exit 0; else echo "/results/gatling/query-9/query-9.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/query-9/query-9.tar.gz file found" 2025-03-28 19:58:13,853 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:14,658 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:14,658 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:14,658 DEBUG --- stdout --- 2025-03-28 19:58:14,658 DEBUG /results/gatling/query-9/query-9.tar.gz file found 2025-03-28 19:58:14,658 DEBUG --- stderr --- 2025-03-28 19:58:14,658 DEBUG 2025-03-28 19:58:14,658 INFO 2025-03-28 19:58:14,659 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/gatling/query-9/query-9.tar.gz 2025-03-28 19:58:15,472 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:15,472 DEBUG --- stdout --- 2025-03-28 19:58:15,472 DEBUG 248 /results/gatling/query-9/query-9.tar.gz 2025-03-28 19:58:15,472 DEBUG --- stderr --- 2025-03-28 19:58:15,472 DEBUG 2025-03-28 19:58:15,472 INFO - Download file (size 248k) source : /results/gatling/query-9/query-9.tar.gz @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-9.tar.gz 2025-03-28 19:58:15,473 INFO 2025-03-28 19:58:15,473 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/gatling/query-9/query-9.tar.gz /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-9.tar.gz 2025-03-28 19:58:15,473 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:16,461 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:16,461 DEBUG --- stdout --- 2025-03-28 19:58:16,462 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:16,462 DEBUG --- stderr --- 2025-03-28 19:58:16,462 DEBUG ________________________________________________________________________________ [2025-03-28 19:58:16] Reporting-query-9 step6 : Unzip the result ________________________________________________________________________________ 2025-03-28 19:58:16,462 INFO 2025-03-28 19:58:16,462 INFO [run_command]: tar zxf /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-9.tar.gz -C /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/02_query-9/gatling 2025-03-28 19:58:16,475 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:16,475 DEBUG --- stdout --- 2025-03-28 19:58:16,475 DEBUG 2025-03-28 19:58:16,475 DEBUG --- stderr --- 2025-03-28 19:58:16,475 DEBUG 2025-03-28 19:58:16,475 INFO ________________________________________________________________________________ [2025-03-28 19:58:16] Reporting-query-9 step7 : Print rc order ________________________________________________________________________________ 2025-03-28 19:58:16,475 INFO 2025-03-28 19:58:16,475 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 19:58:16,475 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:16,755 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:16,756 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:16,756 DEBUG --- stdout --- 2025-03-28 19:58:16,756 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:16,756 DEBUG --- stderr --- 2025-03-28 19:58:16,756 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:16,757 INFO 2025-03-28 19:58:16,757 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-query-9/rc.txt" ]; then echo "/results/orders/Reporting-query-9/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-query-9/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-9/rc.txt file found" 2025-03-28 19:58:16,757 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:17,573 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:17,573 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:17,573 DEBUG --- stdout --- 2025-03-28 19:58:17,573 DEBUG /results/orders/Reporting-query-9/rc.txt file found 2025-03-28 19:58:17,573 DEBUG --- stderr --- 2025-03-28 19:58:17,573 DEBUG 2025-03-28 19:58:17,573 INFO 2025-03-28 19:58:17,574 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-query-9/rc.txt 2025-03-28 19:58:18,380 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:18,380 DEBUG --- stdout --- 2025-03-28 19:58:18,380 DEBUG 4 /results/orders/Reporting-query-9/rc.txt 2025-03-28 19:58:18,381 DEBUG --- stderr --- 2025-03-28 19:58:18,381 DEBUG 2025-03-28 19:58:18,381 INFO - Download file (size 4k) source : /results/orders/Reporting-query-9/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/rc.txt 2025-03-28 19:58:18,381 INFO 2025-03-28 19:58:18,382 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-query-9/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/rc.txt 2025-03-28 19:58:18,382 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:19,143 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:19,143 DEBUG --- stdout --- 2025-03-28 19:58:19,143 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:19,143 DEBUG --- stderr --- 2025-03-28 19:58:19,143 DEBUG 2025-03-28 19:58:19,143 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/rc.txt is small (1 lines), printing all lines: 2025-03-28 19:58:19,143 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 19:58:19] Reporting-query-9 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-28 19:58:19] Reporting-query-9 step9 : Print stdout order ________________________________________________________________________________ 2025-03-28 19:58:19,414 INFO 2025-03-28 19:58:19,414 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 19:58:19,414 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:19,693 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:19,693 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:19,693 DEBUG --- stdout --- 2025-03-28 19:58:19,693 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:19,693 DEBUG --- stderr --- 2025-03-28 19:58:19,693 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:19,694 INFO 2025-03-28 19:58:19,694 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-query-9/stdout.txt" ]; then echo "/results/orders/Reporting-query-9/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-query-9/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-9/stdout.txt file found" 2025-03-28 19:58:19,694 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:20,490 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:20,491 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:20,491 DEBUG --- stdout --- 2025-03-28 19:58:20,491 DEBUG /results/orders/Reporting-query-9/stdout.txt file found 2025-03-28 19:58:20,491 DEBUG --- stderr --- 2025-03-28 19:58:20,491 DEBUG 2025-03-28 19:58:20,491 INFO 2025-03-28 19:58:20,491 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-query-9/stdout.txt 2025-03-28 19:58:21,299 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:21,299 DEBUG --- stdout --- 2025-03-28 19:58:21,299 DEBUG 8 /results/orders/Reporting-query-9/stdout.txt 2025-03-28 19:58:21,299 DEBUG --- stderr --- 2025-03-28 19:58:21,299 DEBUG 2025-03-28 19:58:21,299 INFO - Download file (size 8k) source : /results/orders/Reporting-query-9/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/stdout.txt 2025-03-28 19:58:21,300 INFO 2025-03-28 19:58:21,300 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-query-9/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/stdout.txt 2025-03-28 19:58:21,300 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:22,021 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:22,021 DEBUG --- stdout --- 2025-03-28 19:58:22,022 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:22,022 DEBUG --- stderr --- 2025-03-28 19:58:22,022 DEBUG 2025-03-28 19:58:22,022 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/stdout.txt is small (87 lines), printing all lines: 2025-03-28 19:58:22,022 INFO ----- output ----- 2025-03-28 19:58:04,211 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpno5mgfwy 2025-03-28 19:58:04,213 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/query-9/loadtest-20250328185344938" -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/tmpno5mgfwy/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/tmpno5mgfwy/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 --- 19:58:06,054 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 19:58:06,056 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 19:58:06,056 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 19:58:06,057 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 19:58:06,062 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 19:58:06,062 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 19:58:06,069 |-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 19:58:06,069 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 19:58:06,070 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 19:58:06,070 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 19:58:06,073 |-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] 19:58:06,077 |-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 19:58:06,121 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 19:58:06,121 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 19:58:06,161 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 19:58:06,161 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 19:58:06,167 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 19:58:06,188 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 19:58:06,189 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 19:58:06,189 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 19:58:06,190 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 19:58:06,190 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 120 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY Parsing log file(s)... Parsing log file(s) done in 1s. Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 29247 (OK=29247 KO=0 ) > min response time 40 (OK=40 KO=- ) > max response time 1101 (OK=1101 KO=- ) > mean response time 47 (OK=47 KO=- ) > std deviation 11 (OK=11 KO=- ) > response time 50th percentile 47 (OK=47 KO=- ) > response time 75th percentile 49 (OK=49 KO=- ) > response time 95th percentile 52 (OK=52 KO=- ) > response time 99th percentile 58 (OK=58 KO=- ) > mean requests/sec 48.74 (OK=48.74 KO=- ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 29244 ( 99.99%) > 800 ms <= t < 1200 ms 3 ( 0.01%) > t >= 1200 ms 0 ( 0%) > failed 0 ( 0%) ================================================================================ Reports generated, please open the following file: file:///results/gatling/query-9/loadtest-20250328185344938/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 3.476 s [INFO] Finished at: 2025-03-28T19:58:08Z [INFO] ------------------------------------------------------------------------ 2025-03-28 19:58:08,562 INFO Gatling simulation run ended successfully 2025-03-28 19:58:08,562 INFO Creating archive query-9.tar.gz with report files 2025-03-28 19:58:08,627 INFO Archive /results/gatling/query-9/query-9.tar.gz successfully created ________________________________________________________________________________ [2025-03-28 19:58:22] Reporting-query-9 step10 : Check stdout log and parse its content ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2025-03-28 19:58:22] Reporting-query-9 step11 : Print stderr order ________________________________________________________________________________ 2025-03-28 19:58:22,023 INFO 2025-03-28 19:58:22,023 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 19:58:22,023 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:22,300 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:22,300 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:22,300 DEBUG --- stdout --- 2025-03-28 19:58:22,300 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:22,300 DEBUG --- stderr --- 2025-03-28 19:58:22,300 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:22,301 INFO 2025-03-28 19:58:22,301 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-query-9/stderr.txt" ]; then echo "/results/orders/Reporting-query-9/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-query-9/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-9/stderr.txt file found" 2025-03-28 19:58:22,301 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:23,102 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:23,102 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:23,102 DEBUG --- stdout --- 2025-03-28 19:58:23,102 DEBUG /results/orders/Reporting-query-9/stderr.txt file found 2025-03-28 19:58:23,102 DEBUG --- stderr --- 2025-03-28 19:58:23,102 DEBUG 2025-03-28 19:58:23,102 INFO 2025-03-28 19:58:23,102 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-query-9/stderr.txt 2025-03-28 19:58:23,914 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:23,914 DEBUG --- stdout --- 2025-03-28 19:58:23,914 DEBUG 0 /results/orders/Reporting-query-9/stderr.txt 2025-03-28 19:58:23,914 DEBUG --- stderr --- 2025-03-28 19:58:23,914 DEBUG 2025-03-28 19:58:23,914 INFO - Download file (size 0k) source : /results/orders/Reporting-query-9/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/stderr.txt 2025-03-28 19:58:23,915 INFO 2025-03-28 19:58:23,915 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-query-9/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/stderr.txt 2025-03-28 19:58:23,915 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:24,647 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:24,647 DEBUG --- stdout --- 2025-03-28 19:58:24,647 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:24,647 DEBUG --- stderr --- 2025-03-28 19:58:24,647 DEBUG 2025-03-28 19:58:24,647 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/stderr.txt is small (0 lines), printing all lines: 2025-03-28 19:58:24,647 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-9 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-9 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 Skip 2FA checking simulation request User Authorize PKCE stage checking simulation request User AccessToken PKCE stage checking simulation request queryPartial no spikes found ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-9 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 29247, "ok": 29247, "ko": 0 }, "minResponseTime": { "total": 40, "ok": 40, "ko": 0 }, "maxResponseTime": { "total": 1101, "ok": 1101, "ko": 0 }, "meanResponseTime": { "total": 47, "ok": 47, "ko": 0 }, "standardDeviation": { "total": 11, "ok": 11, "ko": 0 }, "percentiles1": { "total": 47, "ok": 47, "ko": 0 }, "percentiles2": { "total": 49, "ok": 49, "ko": 0 }, "percentiles3": { "total": 52, "ok": 52, "ko": 0 }, "percentiles4": { "total": 58, "ok": 58, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 29244, "percentage": 99.98974253769617 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 3, "percentage": 0.010257462303826032 }, "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": 48.745, "ok": 48.745, "ko": 0 } }, "details": [ { "name": "restLoginInitiate", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 68, "ok": 68, "ko": 0 }, "maxResponseTime": { "total": 68, "ok": 68, "ko": 0 }, "meanResponseTime": { "total": 68, "ok": 68, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 68, "ok": 68, "ko": 0 }, "percentiles2": { "total": 68, "ok": 68, "ko": 0 }, "percentiles3": { "total": 68, "ok": 68, "ko": 0 }, "percentiles4": { "total": 68, "ok": 68, "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.0016666666666666668, "ok": 0.0016666666666666668, "ko": 0 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 117, "ok": 117, "ko": 0 }, "maxResponseTime": { "total": 117, "ok": 117, "ko": 0 }, "meanResponseTime": { "total": 117, "ok": 117, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 117, "ok": 117, "ko": 0 }, "percentiles2": { "total": 117, "ok": 117, "ko": 0 }, "percentiles3": { "total": 117, "ok": 117, "ko": 0 }, "percentiles4": { "total": 117, "ok": 117, "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.0016666666666666668, "ok": 0.0016666666666666668, "ko": 0 }, "spikes": [] }, { "name": "Skip 2FA", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 71, "ok": 71, "ko": 0 }, "maxResponseTime": { "total": 71, "ok": 71, "ko": 0 }, "meanResponseTime": { "total": 71, "ok": 71, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 71, "ok": 71, "ko": 0 }, "percentiles2": { "total": 71, "ok": 71, "ko": 0 }, "percentiles3": { "total": 71, "ok": 71, "ko": 0 }, "percentiles4": { "total": 71, "ok": 71, "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.0016666666666666668, "ok": 0.0016666666666666668, "ko": 0 }, "spikes": [] }, { "name": "User Authorize PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 65, "ok": 65, "ko": 0 }, "maxResponseTime": { "total": 65, "ok": 65, "ko": 0 }, "meanResponseTime": { "total": 65, "ok": 65, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 65, "ok": 65, "ko": 0 }, "percentiles2": { "total": 65, "ok": 65, "ko": 0 }, "percentiles3": { "total": 65, "ok": 65, "ko": 0 }, "percentiles4": { "total": 65, "ok": 65, "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.0016666666666666668, "ok": 0.0016666666666666668, "ko": 0 }, "spikes": [] }, { "name": "User AccessToken PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 64, "ok": 64, "ko": 0 }, "maxResponseTime": { "total": 64, "ok": 64, "ko": 0 }, "meanResponseTime": { "total": 64, "ok": 64, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 64, "ok": 64, "ko": 0 }, "percentiles2": { "total": 64, "ok": 64, "ko": 0 }, "percentiles3": { "total": 64, "ok": 64, "ko": 0 }, "percentiles4": { "total": 64, "ok": 64, "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.0016666666666666668, "ok": 0.0016666666666666668, "ko": 0 }, "spikes": [] }, { "name": "queryPartial", "numberOfRequests": { "total": 29242, "ok": 29242, "ko": 0 }, "minResponseTime": { "total": 40, "ok": 40, "ko": 0 }, "maxResponseTime": { "total": 1101, "ok": 1101, "ko": 0 }, "meanResponseTime": { "total": 47, "ok": 47, "ko": 0 }, "standardDeviation": { "total": 11, "ok": 11, "ko": 0 }, "percentiles1": { "total": 47, "ok": 47, "ko": 0 }, "percentiles2": { "total": 49, "ok": 49, "ko": 0 }, "percentiles3": { "total": 52, "ok": 52, "ko": 0 }, "percentiles4": { "total": 57, "ok": 57, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 29239, "percentage": 99.98974078380411 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 3, "percentage": 0.010259216195882635 }, "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": 48.736666666666665, "ok": 48.736666666666665, "ko": 0 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 49, "avg_response_time": 47, "max_response_time": 1101, "min_response_time": 40, "num_requests": 29247, "num_requests_pass": 29247, "num_requests_percent_pass": 100.0 }, "options": "; testMode:open; testCase:idm.ManagedUsersQueryPartial; duration:600; throughput:50", "stats": { "details": [ { "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": 68, "total": 68 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 68, "total": 68 }, "minResponseTime": { "ko": 0, "ok": 68, "total": 68 }, "name": "restLoginInitiate", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 68, "total": 68 }, "percentiles2": { "ko": 0, "ok": 68, "total": 68 }, "percentiles3": { "ko": 0, "ok": 68, "total": 68 }, "percentiles4": { "ko": 0, "ok": 68, "total": 68 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "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": 117, "total": 117 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 117, "total": 117 }, "minResponseTime": { "ko": 0, "ok": 117, "total": 117 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 117, "total": 117 }, "percentiles2": { "ko": 0, "ok": 117, "total": 117 }, "percentiles3": { "ko": 0, "ok": 117, "total": 117 }, "percentiles4": { "ko": 0, "ok": 117, "total": 117 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "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": 71, "total": 71 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 71, "total": 71 }, "minResponseTime": { "ko": 0, "ok": 71, "total": 71 }, "name": "Skip 2FA", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 71, "total": 71 }, "percentiles2": { "ko": 0, "ok": 71, "total": 71 }, "percentiles3": { "ko": 0, "ok": 71, "total": 71 }, "percentiles4": { "ko": 0, "ok": 71, "total": 71 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "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": 65, "total": 65 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 65, "total": 65 }, "minResponseTime": { "ko": 0, "ok": 65, "total": 65 }, "name": "User Authorize PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 65, "total": 65 }, "percentiles2": { "ko": 0, "ok": 65, "total": 65 }, "percentiles3": { "ko": 0, "ok": 65, "total": 65 }, "percentiles4": { "ko": 0, "ok": 65, "total": 65 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "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": 64, "total": 64 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 64, "total": 64 }, "minResponseTime": { "ko": 0, "ok": 64, "total": 64 }, "name": "User AccessToken PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 64, "total": 64 }, "percentiles2": { "ko": 0, "ok": 64, "total": 64 }, "percentiles3": { "ko": 0, "ok": 64, "total": 64 }, "percentiles4": { "ko": 0, "ok": 64, "total": 64 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 29239, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.98974078380411 }, "group2": { "count": 3, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.010259216195882635 }, "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": 1101, "total": 1101 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 48.736666666666665, "total": 48.736666666666665 }, "meanResponseTime": { "ko": 0, "ok": 47, "total": 47 }, "minResponseTime": { "ko": 0, "ok": 40, "total": 40 }, "name": "queryPartial", "numberOfRequests": { "ko": 0, "ok": 29242, "total": 29242 }, "percentiles1": { "ko": 0, "ok": 47, "total": 47 }, "percentiles2": { "ko": 0, "ok": 49, "total": 49 }, "percentiles3": { "ko": 0, "ok": 52, "total": 52 }, "percentiles4": { "ko": 0, "ok": 57, "total": 57 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 11, "total": 11 } } ], "global": { "group1": { "count": 29244, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.98974253769617 }, "group2": { "count": 3, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.010257462303826032 }, "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": 1101, "total": 1101 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 48.745, "total": 48.745 }, "meanResponseTime": { "ko": 0, "ok": 47, "total": 47 }, "minResponseTime": { "ko": 0, "ok": 40, "total": 40 }, "name": "All Requests", "numberOfRequests": { "ko": 0, "ok": 29247, "total": 29247 }, "percentiles1": { "ko": 0, "ok": 47, "total": 47 }, "percentiles2": { "ko": 0, "ok": 49, "total": 49 }, "percentiles3": { "ko": 0, "ok": 52, "total": 52 }, "percentiles4": { "ko": 0, "ok": 58, "total": 58 }, "standardDeviation": { "ko": 0, "ok": 11, "total": 11 } } }, "target_hostname": "openam-perf-200m.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-9 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-9 step16 : Remove gatling task's stdout file ________________________________________________________________________________ Cleanup of Gatling stdout file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/10_Reporting-query-9/stdout.txt Gatling stdout.txt found, but is small - leave it intact. ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-9 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped