--Task-- name: Reporting-query-8 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', 'Reporting-query-9'] preceding_task: None options: {'task_name': 'query-8'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock source (overseer-0) is a component 2025-03-28 19:58:24 - INFO: Timeout for this Task has changed to 5h 30m (19800 seconds) 2025-03-28 19:58:24 - 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-8/stdout.txt Pod stderr file : /results/orders/Reporting-query-8/stderr.txt Pod log : /results/orders/Reporting-query-8 ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-8 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/11_Reporting-query-8/order.json { "name": "Reporting-query-8", "command": " /lodestar/lodestar.py perf run-gatling --reports-only=\"/results/gatling/query-8\" --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx8G\" --archive-name=\"query-8.tar.gz\"", "out-dir": "/results/orders/Reporting-query-8" } ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-8 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2025-03-28 19:58:24,655 INFO 2025-03-28 19:58:24,655 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 19:58:24,655 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2025-03-28 19:58:24,940 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:24,940 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:24,940 DEBUG --- stdout --- 2025-03-28 19:58:24,940 DEBUG WAITING 2025-03-28 19:58:24,940 DEBUG --- stderr --- 2025-03-28 19:58:24,940 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 25 0 --:--:-- --:--:-- --:--:-- 25 ________________________________________________________________________________ [2025-03-28 19:58:24] Reporting-query-8 step3 : Send order to overseer ________________________________________________________________________________ 2025-03-28 19:58:24,941 INFO 2025-03-28 19:58:24,941 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:24,941 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:25,238 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:25,238 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:25,238 DEBUG --- stdout --- 2025-03-28 19:58:25,238 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:25,239 DEBUG --- stderr --- 2025-03-28 19:58:25,239 DEBUG 2025-03-28 19:58:25,239 INFO 2025-03-28 19:58:25,239 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/11_Reporting-query-8/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 19:58:25,239 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:26,618 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:26,618 DEBUG --- stdout --- 2025-03-28 19:58:26,618 DEBUG 2025-03-28 19:58:26,618 DEBUG --- stderr --- 2025-03-28 19:58:26,618 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2025-03-28 19:58:26] Reporting-query-8 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2025-03-28 19:58:31,618 INFO 2025-03-28 19:58:31,618 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 19:58:31,618 INFO [loop_until]: (max_time=19800, interval=5, expected_rc=[0] 2025-03-28 19:58:31,833 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 19:58:37,048 INFO [loop_until]: Function succeeded after 5s (rc=0) - expected pattern found 2025-03-28 19:58:37,048 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:37,048 DEBUG --- stdout --- 2025-03-28 19:58:37,048 DEBUG WAITING 2025-03-28 19:58:37,049 DEBUG --- stderr --- 2025-03-28 19:58:37,049 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:37] Reporting-query-8 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2025-03-28 19:58:37,049 INFO 2025-03-28 19:58:37,049 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:37,049 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:37,327 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:37,327 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:37,327 DEBUG --- stdout --- 2025-03-28 19:58:37,327 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:37,327 DEBUG --- stderr --- 2025-03-28 19:58:37,327 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:37,328 INFO 2025-03-28 19:58:37,328 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-8/query-8.tar.gz" ]; then echo "/results/gatling/query-8/query-8.tar.gz file found"; exit 0; else echo "/results/gatling/query-8/query-8.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/query-8/query-8.tar.gz file found" 2025-03-28 19:58:37,328 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:38,125 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:38,125 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:38,125 DEBUG --- stdout --- 2025-03-28 19:58:38,125 DEBUG /results/gatling/query-8/query-8.tar.gz file found 2025-03-28 19:58:38,125 DEBUG --- stderr --- 2025-03-28 19:58:38,125 DEBUG 2025-03-28 19:58:38,125 INFO 2025-03-28 19:58:38,126 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-8/query-8.tar.gz 2025-03-28 19:58:38,936 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:38,936 DEBUG --- stdout --- 2025-03-28 19:58:38,937 DEBUG 248 /results/gatling/query-8/query-8.tar.gz 2025-03-28 19:58:38,937 DEBUG --- stderr --- 2025-03-28 19:58:38,937 DEBUG 2025-03-28 19:58:38,937 INFO - Download file (size 248k) source : /results/gatling/query-8/query-8.tar.gz @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-8.tar.gz 2025-03-28 19:58:38,938 INFO 2025-03-28 19:58:38,938 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/gatling/query-8/query-8.tar.gz /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-8.tar.gz 2025-03-28 19:58:38,938 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:39,960 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:39,960 DEBUG --- stdout --- 2025-03-28 19:58:39,960 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:39,960 DEBUG --- stderr --- 2025-03-28 19:58:39,960 DEBUG ________________________________________________________________________________ [2025-03-28 19:58:39] Reporting-query-8 step6 : Unzip the result ________________________________________________________________________________ 2025-03-28 19:58:39,961 INFO 2025-03-28 19:58:39,961 INFO [run_command]: tar zxf /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-8.tar.gz -C /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/03_query-8/gatling 2025-03-28 19:58:39,973 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:39,973 DEBUG --- stdout --- 2025-03-28 19:58:39,973 DEBUG 2025-03-28 19:58:39,973 DEBUG --- stderr --- 2025-03-28 19:58:39,973 DEBUG 2025-03-28 19:58:39,973 INFO ________________________________________________________________________________ [2025-03-28 19:58:39] Reporting-query-8 step7 : Print rc order ________________________________________________________________________________ 2025-03-28 19:58:39,974 INFO 2025-03-28 19:58:39,974 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:39,974 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:40,308 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:40,308 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:40,308 DEBUG --- stdout --- 2025-03-28 19:58:40,308 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:40,308 DEBUG --- stderr --- 2025-03-28 19:58:40,308 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:40,309 INFO 2025-03-28 19:58:40,309 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-8/rc.txt" ]; then echo "/results/orders/Reporting-query-8/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-query-8/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-8/rc.txt file found" 2025-03-28 19:58:40,309 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:41,110 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:41,110 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:41,110 DEBUG --- stdout --- 2025-03-28 19:58:41,111 DEBUG /results/orders/Reporting-query-8/rc.txt file found 2025-03-28 19:58:41,111 DEBUG --- stderr --- 2025-03-28 19:58:41,111 DEBUG 2025-03-28 19:58:41,111 INFO 2025-03-28 19:58:41,111 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-8/rc.txt 2025-03-28 19:58:41,911 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:41,911 DEBUG --- stdout --- 2025-03-28 19:58:41,911 DEBUG 4 /results/orders/Reporting-query-8/rc.txt 2025-03-28 19:58:41,911 DEBUG --- stderr --- 2025-03-28 19:58:41,912 DEBUG 2025-03-28 19:58:41,912 INFO - Download file (size 4k) source : /results/orders/Reporting-query-8/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/rc.txt 2025-03-28 19:58:41,912 INFO 2025-03-28 19:58:41,912 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-8/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/rc.txt 2025-03-28 19:58:41,912 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:42,632 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:42,633 DEBUG --- stdout --- 2025-03-28 19:58:42,633 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:42,633 DEBUG --- stderr --- 2025-03-28 19:58:42,633 DEBUG 2025-03-28 19:58:42,633 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/rc.txt is small (1 lines), printing all lines: 2025-03-28 19:58:42,633 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 19:58:42] Reporting-query-8 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:42] Reporting-query-8 step9 : Print stdout order ________________________________________________________________________________ 2025-03-28 19:58:42,871 INFO 2025-03-28 19:58:42,871 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:42,871 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:43,150 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:43,150 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:43,150 DEBUG --- stdout --- 2025-03-28 19:58:43,150 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:43,150 DEBUG --- stderr --- 2025-03-28 19:58:43,150 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:43,151 INFO 2025-03-28 19:58:43,151 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-8/stdout.txt" ]; then echo "/results/orders/Reporting-query-8/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-query-8/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-8/stdout.txt file found" 2025-03-28 19:58:43,151 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:43,951 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:43,951 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:43,951 DEBUG --- stdout --- 2025-03-28 19:58:43,951 DEBUG /results/orders/Reporting-query-8/stdout.txt file found 2025-03-28 19:58:43,951 DEBUG --- stderr --- 2025-03-28 19:58:43,951 DEBUG 2025-03-28 19:58:43,951 INFO 2025-03-28 19:58:43,952 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-8/stdout.txt 2025-03-28 19:58:44,750 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:44,750 DEBUG --- stdout --- 2025-03-28 19:58:44,750 DEBUG 8 /results/orders/Reporting-query-8/stdout.txt 2025-03-28 19:58:44,750 DEBUG --- stderr --- 2025-03-28 19:58:44,750 DEBUG 2025-03-28 19:58:44,750 INFO - Download file (size 8k) source : /results/orders/Reporting-query-8/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/stdout.txt 2025-03-28 19:58:44,750 INFO 2025-03-28 19:58:44,751 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-8/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/stdout.txt 2025-03-28 19:58:44,751 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:45,474 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:45,474 DEBUG --- stdout --- 2025-03-28 19:58:45,474 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:45,474 DEBUG --- stderr --- 2025-03-28 19:58:45,474 DEBUG 2025-03-28 19:58:45,474 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/stdout.txt is small (87 lines), printing all lines: 2025-03-28 19:58:45,474 INFO ----- output ----- 2025-03-28 19:58:27,219 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp6m7n37ec 2025-03-28 19:58:27,220 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/query-8/loadtest-20250328190415996" -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/tmp6m7n37ec/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/tmp6m7n37ec/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:29,041 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 19:58:29,042 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 19:58:29,042 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 19:58:29,043 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 19:58:29,049 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 19:58:29,049 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 19:58:29,056 |-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:29,056 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 19:58:29,056 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 19:58:29,057 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 19:58:29,060 |-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:29,064 |-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:29,107 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 19:58:29,107 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 19:58:29,146 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 19:58:29,146 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 19:58:29,152 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 19:58:29,173 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 19:58:29,174 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 19:58:29,174 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 19:58:29,174 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 19:58:29,174 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 118 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 29425 (OK=29425 KO=0 ) > min response time 39 (OK=39 KO=- ) > max response time 1186 (OK=1186 KO=- ) > mean response time 47 (OK=47 KO=- ) > std deviation 8 (OK=8 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 57 (OK=57 KO=- ) > mean requests/sec 49.04 (OK=49.04 KO=- ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 29424 ( 100%) > 800 ms <= t < 1200 ms 1 ( 0%) > t >= 1200 ms 0 ( 0%) > failed 0 ( 0%) ================================================================================ Reports generated, please open the following file: file:///results/gatling/query-8/loadtest-20250328190415996/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 3.405 s [INFO] Finished at: 2025-03-28T19:58:31Z [INFO] ------------------------------------------------------------------------ 2025-03-28 19:58:31,479 INFO Gatling simulation run ended successfully 2025-03-28 19:58:31,480 INFO Creating archive query-8.tar.gz with report files 2025-03-28 19:58:31,545 INFO Archive /results/gatling/query-8/query-8.tar.gz successfully created ________________________________________________________________________________ [2025-03-28 19:58:45] Reporting-query-8 step10 : Check stdout log and parse its content ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2025-03-28 19:58:45] Reporting-query-8 step11 : Print stderr order ________________________________________________________________________________ 2025-03-28 19:58:45,475 INFO 2025-03-28 19:58:45,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:45,475 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:58:45,777 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:58:45,777 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:45,777 DEBUG --- stdout --- 2025-03-28 19:58:45,777 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:58:45,777 DEBUG --- stderr --- 2025-03-28 19:58:45,777 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:58:45,778 INFO 2025-03-28 19:58:45,778 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-8/stderr.txt" ]; then echo "/results/orders/Reporting-query-8/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-query-8/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-8/stderr.txt file found" 2025-03-28 19:58:45,778 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:58:46,593 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:58:46,593 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:46,594 DEBUG --- stdout --- 2025-03-28 19:58:46,594 DEBUG /results/orders/Reporting-query-8/stderr.txt file found 2025-03-28 19:58:46,594 DEBUG --- stderr --- 2025-03-28 19:58:46,594 DEBUG 2025-03-28 19:58:46,594 INFO 2025-03-28 19:58:46,594 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-8/stderr.txt 2025-03-28 19:58:47,393 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:47,393 DEBUG --- stdout --- 2025-03-28 19:58:47,393 DEBUG 0 /results/orders/Reporting-query-8/stderr.txt 2025-03-28 19:58:47,393 DEBUG --- stderr --- 2025-03-28 19:58:47,393 DEBUG 2025-03-28 19:58:47,393 INFO - Download file (size 0k) source : /results/orders/Reporting-query-8/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/stderr.txt 2025-03-28 19:58:47,394 INFO 2025-03-28 19:58:47,394 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-8/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/stderr.txt 2025-03-28 19:58:47,394 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:48,155 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:48,155 DEBUG --- stdout --- 2025-03-28 19:58:48,155 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:48,155 DEBUG --- stderr --- 2025-03-28 19:58:48,155 DEBUG 2025-03-28 19:58:48,156 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/11_Reporting-query-8/stderr.txt is small (0 lines), printing all lines: 2025-03-28 19:58:48,156 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 19:58:48] Reporting-query-8 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2025-03-28 19:58:48] Reporting-query-8 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:48] Reporting-query-8 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 29425, "ok": 29425, "ko": 0 }, "minResponseTime": { "total": 39, "ok": 39, "ko": 0 }, "maxResponseTime": { "total": 1186, "ok": 1186, "ko": 0 }, "meanResponseTime": { "total": 47, "ok": 47, "ko": 0 }, "standardDeviation": { "total": 8, "ok": 8, "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": 29424, "percentage": 99.99660152931182 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 1, "percentage": 0.0033984706881903144 }, "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": 49.041666666666664, "ok": 49.041666666666664, "ko": 0 } }, "details": [ { "name": "restLoginInitiate", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 67, "ok": 67, "ko": 0 }, "maxResponseTime": { "total": 67, "ok": 67, "ko": 0 }, "meanResponseTime": { "total": 67, "ok": 67, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 67, "ok": 67, "ko": 0 }, "percentiles2": { "total": 67, "ok": 67, "ko": 0 }, "percentiles3": { "total": 67, "ok": 67, "ko": 0 }, "percentiles4": { "total": 67, "ok": 67, "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": 109, "ok": 109, "ko": 0 }, "maxResponseTime": { "total": 109, "ok": 109, "ko": 0 }, "meanResponseTime": { "total": 109, "ok": 109, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 109, "ok": 109, "ko": 0 }, "percentiles2": { "total": 109, "ok": 109, "ko": 0 }, "percentiles3": { "total": 109, "ok": 109, "ko": 0 }, "percentiles4": { "total": 109, "ok": 109, "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": 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": "User Authorize PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 59, "ok": 59, "ko": 0 }, "maxResponseTime": { "total": 59, "ok": 59, "ko": 0 }, "meanResponseTime": { "total": 59, "ok": 59, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 59, "ok": 59, "ko": 0 }, "percentiles2": { "total": 59, "ok": 59, "ko": 0 }, "percentiles3": { "total": 59, "ok": 59, "ko": 0 }, "percentiles4": { "total": 59, "ok": 59, "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": 58, "ok": 58, "ko": 0 }, "maxResponseTime": { "total": 58, "ok": 58, "ko": 0 }, "meanResponseTime": { "total": 58, "ok": 58, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 58, "ok": 58, "ko": 0 }, "percentiles2": { "total": 58, "ok": 58, "ko": 0 }, "percentiles3": { "total": 58, "ok": 58, "ko": 0 }, "percentiles4": { "total": 58, "ok": 58, "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": 29420, "ok": 29420, "ko": 0 }, "minResponseTime": { "total": 39, "ok": 39, "ko": 0 }, "maxResponseTime": { "total": 1186, "ok": 1186, "ko": 0 }, "meanResponseTime": { "total": 47, "ok": 47, "ko": 0 }, "standardDeviation": { "total": 8, "ok": 8, "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": 56, "ok": 56, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 29419, "percentage": 99.99660095173351 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 1, "percentage": 0.003399048266485384 }, "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": 49.03333333333333, "ok": 49.03333333333333, "ko": 0 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 49, "avg_response_time": 47, "max_response_time": 1186, "min_response_time": 39, "num_requests": 29425, "num_requests_pass": 29425, "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": 67, "total": 67 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 67, "total": 67 }, "minResponseTime": { "ko": 0, "ok": 67, "total": 67 }, "name": "restLoginInitiate", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 67, "total": 67 }, "percentiles2": { "ko": 0, "ok": 67, "total": 67 }, "percentiles3": { "ko": 0, "ok": 67, "total": 67 }, "percentiles4": { "ko": 0, "ok": 67, "total": 67 }, "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": 109, "total": 109 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 109, "total": 109 }, "minResponseTime": { "ko": 0, "ok": 109, "total": 109 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 109, "total": 109 }, "percentiles2": { "ko": 0, "ok": 109, "total": 109 }, "percentiles3": { "ko": 0, "ok": 109, "total": 109 }, "percentiles4": { "ko": 0, "ok": 109, "total": 109 }, "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": 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": "Skip 2FA", "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": 59, "total": 59 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 59, "total": 59 }, "minResponseTime": { "ko": 0, "ok": 59, "total": 59 }, "name": "User Authorize PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 59, "total": 59 }, "percentiles2": { "ko": 0, "ok": 59, "total": 59 }, "percentiles3": { "ko": 0, "ok": 59, "total": 59 }, "percentiles4": { "ko": 0, "ok": 59, "total": 59 }, "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": 58, "total": 58 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 58, "total": 58 }, "minResponseTime": { "ko": 0, "ok": 58, "total": 58 }, "name": "User AccessToken PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 58, "total": 58 }, "percentiles2": { "ko": 0, "ok": 58, "total": 58 }, "percentiles3": { "ko": 0, "ok": 58, "total": 58 }, "percentiles4": { "ko": 0, "ok": 58, "total": 58 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 29419, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.99660095173351 }, "group2": { "count": 1, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.003399048266485384 }, "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": 1186, "total": 1186 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 49.03333333333333, "total": 49.03333333333333 }, "meanResponseTime": { "ko": 0, "ok": 47, "total": 47 }, "minResponseTime": { "ko": 0, "ok": 39, "total": 39 }, "name": "queryPartial", "numberOfRequests": { "ko": 0, "ok": 29420, "total": 29420 }, "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": 56, "total": 56 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 8, "total": 8 } } ], "global": { "group1": { "count": 29424, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.99660152931182 }, "group2": { "count": 1, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0033984706881903144 }, "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": 1186, "total": 1186 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 49.041666666666664, "total": 49.041666666666664 }, "meanResponseTime": { "ko": 0, "ok": 47, "total": 47 }, "minResponseTime": { "ko": 0, "ok": 39, "total": 39 }, "name": "All Requests", "numberOfRequests": { "ko": 0, "ok": 29425, "total": 29425 }, "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 }, "standardDeviation": { "ko": 0, "ok": 8, "total": 8 } } }, "target_hostname": "openam-perf-200m.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2025-03-28 19:58:48] Reporting-query-8 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2025-03-28 19:58:48] Reporting-query-8 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/11_Reporting-query-8/stdout.txt Gatling stdout.txt found, but is small - leave it intact. ________________________________________________________________________________ [2025-03-28 19:58:48] Reporting-query-8 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped