--Task-- name: Reporting-query-10 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'] preceding_task: None options: {'task_name': 'query-10'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock source (overseer-0) is a component 2025-03-28 19:57:37 - INFO: Timeout for this Task has changed to 5h 30m (19800 seconds) 2025-03-28 19:57:37 - 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-10/stdout.txt Pod stderr file : /results/orders/Reporting-query-10/stderr.txt Pod log : /results/orders/Reporting-query-10 ________________________________________________________________________________ [2025-03-28 19:57:37] Reporting-query-10 step1 : Write order for overseer to generate the report ________________________________________________________________________________ 2025-03-28 19:57:37 - INFO: Get overseer pod resources requests memory 2025-03-28 19:57:37,535 INFO 2025-03-28 19:57:37,535 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods overseer-0-59c948f569-rgrkv --output jsonpath={.spec.containers[].resources.requests.memory} 2025-03-28 19:57:37,535 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:57:37,811 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:37,812 DEBUG --- stdout --- 2025-03-28 19:57:37,812 DEBUG 8Gi 2025-03-28 19:57:37,812 DEBUG --- stderr --- 2025-03-28 19:57:37,812 DEBUG Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/order.json { "name": "Reporting-query-10", "command": " /lodestar/lodestar.py perf run-gatling --reports-only=\"/results/gatling/query-10\" --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx8G\" --archive-name=\"query-10.tar.gz\"", "out-dir": "/results/orders/Reporting-query-10" } ________________________________________________________________________________ [2025-03-28 19:57:37] Reporting-query-10 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2025-03-28 19:57:37,813 INFO 2025-03-28 19:57:37,813 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 19:57:37,813 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2025-03-28 19:57:38,027 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:57:38,027 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:38,027 DEBUG --- stdout --- 2025-03-28 19:57:38,027 DEBUG WAITING 2025-03-28 19:57:38,027 DEBUG --- stderr --- 2025-03-28 19:57:38,027 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:57:38] Reporting-query-10 step3 : Send order to overseer ________________________________________________________________________________ 2025-03-28 19:57:38,028 INFO 2025-03-28 19:57:38,028 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:57:38,028 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:57:38,309 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:57:38,309 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:38,309 DEBUG --- stdout --- 2025-03-28 19:57:38,309 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:57:38,309 DEBUG --- stderr --- 2025-03-28 19:57:38,309 DEBUG 2025-03-28 19:57:38,309 INFO 2025-03-28 19:57:38,309 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/09_Reporting-query-10/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 19:57:38,309 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:57:39,680 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:39,680 DEBUG --- stdout --- 2025-03-28 19:57:39,680 DEBUG 2025-03-28 19:57:39,680 DEBUG --- stderr --- 2025-03-28 19:57:39,680 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2025-03-28 19:57:39] Reporting-query-10 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2025-03-28 19:57:44,681 INFO 2025-03-28 19:57:44,681 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 19:57:44,681 INFO [loop_until]: (max_time=19800, interval=5, expected_rc=[0] 2025-03-28 19:57:44,897 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 19:57:50,154 INFO [loop_until]: Function succeeded after 5s (rc=0) - expected pattern found 2025-03-28 19:57:50,154 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:50,154 DEBUG --- stdout --- 2025-03-28 19:57:50,154 DEBUG WAITING 2025-03-28 19:57:50,154 DEBUG --- stderr --- 2025-03-28 19:57:50,154 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 28 0 --:--:-- --:--:-- --:--:-- 28 ________________________________________________________________________________ [2025-03-28 19:57:50] Reporting-query-10 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2025-03-28 19:57:50,155 INFO 2025-03-28 19:57:50,155 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:57:50,155 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:57:50,434 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:57:50,434 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:50,434 DEBUG --- stdout --- 2025-03-28 19:57:50,434 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:57:50,434 DEBUG --- stderr --- 2025-03-28 19:57:50,434 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:57:50,435 INFO 2025-03-28 19:57:50,435 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-10/query-10.tar.gz" ]; then echo "/results/gatling/query-10/query-10.tar.gz file found"; exit 0; else echo "/results/gatling/query-10/query-10.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/query-10/query-10.tar.gz file found" 2025-03-28 19:57:50,435 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:57:51,242 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:57:51,242 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:51,242 DEBUG --- stdout --- 2025-03-28 19:57:51,242 DEBUG /results/gatling/query-10/query-10.tar.gz file found 2025-03-28 19:57:51,242 DEBUG --- stderr --- 2025-03-28 19:57:51,242 DEBUG 2025-03-28 19:57:51,242 INFO 2025-03-28 19:57:51,242 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-10/query-10.tar.gz 2025-03-28 19:57:52,054 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:57:52,054 DEBUG --- stdout --- 2025-03-28 19:57:52,054 DEBUG 248 /results/gatling/query-10/query-10.tar.gz 2025-03-28 19:57:52,054 DEBUG --- stderr --- 2025-03-28 19:57:52,054 DEBUG 2025-03-28 19:57:52,054 INFO - Download file (size 248k) source : /results/gatling/query-10/query-10.tar.gz @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-10.tar.gz 2025-03-28 19:57:52,055 INFO 2025-03-28 19:57:52,055 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/gatling/query-10/query-10.tar.gz /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-10.tar.gz 2025-03-28 19:57:52,055 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:57:53,051 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:53,051 DEBUG --- stdout --- 2025-03-28 19:57:53,051 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:57:53,051 DEBUG --- stderr --- 2025-03-28 19:57:53,051 DEBUG ________________________________________________________________________________ [2025-03-28 19:57:53] Reporting-query-10 step6 : Unzip the result ________________________________________________________________________________ 2025-03-28 19:57:53,051 INFO 2025-03-28 19:57:53,051 INFO [run_command]: tar zxf /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/query-10.tar.gz -C /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/01_query-10/gatling 2025-03-28 19:57:53,064 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:57:53,064 DEBUG --- stdout --- 2025-03-28 19:57:53,064 DEBUG 2025-03-28 19:57:53,064 DEBUG --- stderr --- 2025-03-28 19:57:53,064 DEBUG 2025-03-28 19:57:53,064 INFO ________________________________________________________________________________ [2025-03-28 19:57:53] Reporting-query-10 step7 : Print rc order ________________________________________________________________________________ 2025-03-28 19:57:53,065 INFO 2025-03-28 19:57:53,065 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:57:53,065 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:57:53,342 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:57:53,342 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:53,342 DEBUG --- stdout --- 2025-03-28 19:57:53,342 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:57:53,342 DEBUG --- stderr --- 2025-03-28 19:57:53,342 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:57:53,343 INFO 2025-03-28 19:57:53,343 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-10/rc.txt" ]; then echo "/results/orders/Reporting-query-10/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-query-10/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-10/rc.txt file found" 2025-03-28 19:57:53,343 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:57:54,148 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:57:54,148 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:54,148 DEBUG --- stdout --- 2025-03-28 19:57:54,148 DEBUG /results/orders/Reporting-query-10/rc.txt file found 2025-03-28 19:57:54,148 DEBUG --- stderr --- 2025-03-28 19:57:54,148 DEBUG 2025-03-28 19:57:54,148 INFO 2025-03-28 19:57:54,148 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-10/rc.txt 2025-03-28 19:57:54,954 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:57:54,954 DEBUG --- stdout --- 2025-03-28 19:57:54,954 DEBUG 4 /results/orders/Reporting-query-10/rc.txt 2025-03-28 19:57:54,954 DEBUG --- stderr --- 2025-03-28 19:57:54,954 DEBUG 2025-03-28 19:57:54,954 INFO - Download file (size 4k) source : /results/orders/Reporting-query-10/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/rc.txt 2025-03-28 19:57:54,955 INFO 2025-03-28 19:57:54,955 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-10/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/rc.txt 2025-03-28 19:57:54,955 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:57:55,782 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:55,782 DEBUG --- stdout --- 2025-03-28 19:57:55,782 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:57:55,782 DEBUG --- stderr --- 2025-03-28 19:57:55,782 DEBUG 2025-03-28 19:57:55,782 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/rc.txt is small (1 lines), printing all lines: 2025-03-28 19:57:55,782 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 19:57:55] Reporting-query-10 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:57:56] Reporting-query-10 step9 : Print stdout order ________________________________________________________________________________ 2025-03-28 19:57:56,021 INFO 2025-03-28 19:57:56,021 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:57:56,021 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:57:56,298 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:57:56,299 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:56,299 DEBUG --- stdout --- 2025-03-28 19:57:56,299 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:57:56,299 DEBUG --- stderr --- 2025-03-28 19:57:56,299 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:57:56,300 INFO 2025-03-28 19:57:56,300 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-10/stdout.txt" ]; then echo "/results/orders/Reporting-query-10/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-query-10/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-10/stdout.txt file found" 2025-03-28 19:57:56,300 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:57:57,096 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:57:57,096 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:57,096 DEBUG --- stdout --- 2025-03-28 19:57:57,096 DEBUG /results/orders/Reporting-query-10/stdout.txt file found 2025-03-28 19:57:57,096 DEBUG --- stderr --- 2025-03-28 19:57:57,096 DEBUG 2025-03-28 19:57:57,096 INFO 2025-03-28 19:57:57,097 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-10/stdout.txt 2025-03-28 19:57:57,902 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:57:57,902 DEBUG --- stdout --- 2025-03-28 19:57:57,902 DEBUG 8 /results/orders/Reporting-query-10/stdout.txt 2025-03-28 19:57:57,902 DEBUG --- stderr --- 2025-03-28 19:57:57,902 DEBUG 2025-03-28 19:57:57,902 INFO - Download file (size 8k) source : /results/orders/Reporting-query-10/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/stdout.txt 2025-03-28 19:57:57,903 INFO 2025-03-28 19:57:57,903 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-10/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/stdout.txt 2025-03-28 19:57:57,903 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:57:58,627 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:58,627 DEBUG --- stdout --- 2025-03-28 19:57:58,627 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:57:58,627 DEBUG --- stderr --- 2025-03-28 19:57:58,627 DEBUG 2025-03-28 19:57:58,627 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/stdout.txt is small (87 lines), printing all lines: 2025-03-28 19:57:58,627 INFO ----- output ----- 2025-03-28 19:57:40,705 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpoqeyyb5j 2025-03-28 19:57:40,707 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/query-10/loadtest-20250328184313494" -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/tmpoqeyyb5j/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/tmpoqeyyb5j/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:57:42,514 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 19:57:42,515 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 19:57:42,516 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 19:57:42,516 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 19:57:42,522 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 19:57:42,522 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 19:57:42,529 |-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:57:42,529 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 19:57:42,530 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 19:57:42,530 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 19:57:42,533 |-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:57:42,537 |-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:57:42,581 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 19:57:42,581 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 19:57:42,620 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 19:57:42,620 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 19:57:42,626 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 19:57:42,647 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 19:57:42,648 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 19:57:42,648 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 19:57:42,648 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 19:57:42,648 |-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 29351 (OK=29351 KO=0 ) > min response time 40 (OK=40 KO=- ) > max response time 548 (OK=548 KO=- ) > mean response time 48 (OK=48 KO=- ) > std deviation 5 (OK=5 KO=- ) > response time 50th percentile 48 (OK=48 KO=- ) > response time 75th percentile 50 (OK=50 KO=- ) > response time 95th percentile 53 (OK=53 KO=- ) > response time 99th percentile 59 (OK=59 KO=- ) > mean requests/sec 48.92 (OK=48.92 KO=- ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 29351 ( 100%) > 800 ms <= t < 1200 ms 0 ( 0%) > t >= 1200 ms 0 ( 0%) > failed 0 ( 0%) ================================================================================ Reports generated, please open the following file: file:///results/gatling/query-10/loadtest-20250328184313494/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 3.503 s [INFO] Finished at: 2025-03-28T19:57:45Z [INFO] ------------------------------------------------------------------------ 2025-03-28 19:57:45,082 INFO Gatling simulation run ended successfully 2025-03-28 19:57:45,082 INFO Creating archive query-10.tar.gz with report files 2025-03-28 19:57:45,147 INFO Archive /results/gatling/query-10/query-10.tar.gz successfully created ________________________________________________________________________________ [2025-03-28 19:57:58] Reporting-query-10 step10 : Check stdout log and parse its content ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2025-03-28 19:57:58] Reporting-query-10 step11 : Print stderr order ________________________________________________________________________________ 2025-03-28 19:57:58,628 INFO 2025-03-28 19:57:58,628 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:57:58,628 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:57:58,905 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:57:58,905 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:58,905 DEBUG --- stdout --- 2025-03-28 19:57:58,905 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:57:58,905 DEBUG --- stderr --- 2025-03-28 19:57:58,905 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:57:58,906 INFO 2025-03-28 19:57:58,906 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-10/stderr.txt" ]; then echo "/results/orders/Reporting-query-10/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-query-10/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-query-10/stderr.txt file found" 2025-03-28 19:57:58,906 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:57:59,703 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:57:59,703 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:57:59,703 DEBUG --- stdout --- 2025-03-28 19:57:59,703 DEBUG /results/orders/Reporting-query-10/stderr.txt file found 2025-03-28 19:57:59,703 DEBUG --- stderr --- 2025-03-28 19:57:59,703 DEBUG 2025-03-28 19:57:59,703 INFO 2025-03-28 19:57:59,703 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-10/stderr.txt 2025-03-28 19:58:00,511 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:58:00,512 DEBUG --- stdout --- 2025-03-28 19:58:00,512 DEBUG 0 /results/orders/Reporting-query-10/stderr.txt 2025-03-28 19:58:00,512 DEBUG --- stderr --- 2025-03-28 19:58:00,512 DEBUG 2025-03-28 19:58:00,512 INFO - Download file (size 0k) source : /results/orders/Reporting-query-10/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/stderr.txt 2025-03-28 19:58:00,512 INFO 2025-03-28 19:58:00,512 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-10/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/stderr.txt 2025-03-28 19:58:00,512 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:58:01,279 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:58:01,279 DEBUG --- stdout --- 2025-03-28 19:58:01,279 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:58:01,279 DEBUG --- stderr --- 2025-03-28 19:58:01,279 DEBUG 2025-03-28 19:58:01,279 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/09_Reporting-query-10/stderr.txt is small (0 lines), printing all lines: 2025-03-28 19:58:01,279 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-10 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-10 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:01] Reporting-query-10 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 29351, "ok": 29351, "ko": 0 }, "minResponseTime": { "total": 40, "ok": 40, "ko": 0 }, "maxResponseTime": { "total": 548, "ok": 548, "ko": 0 }, "meanResponseTime": { "total": 48, "ok": 48, "ko": 0 }, "standardDeviation": { "total": 5, "ok": 5, "ko": 0 }, "percentiles1": { "total": 48, "ok": 48, "ko": 0 }, "percentiles2": { "total": 50, "ok": 50, "ko": 0 }, "percentiles3": { "total": 53, "ok": 53, "ko": 0 }, "percentiles4": { "total": 59, "ok": 59, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 29351, "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": 48.91833333333334, "ok": 48.91833333333334, "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": 139, "ok": 139, "ko": 0 }, "maxResponseTime": { "total": 139, "ok": 139, "ko": 0 }, "meanResponseTime": { "total": 139, "ok": 139, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 139, "ok": 139, "ko": 0 }, "percentiles2": { "total": 139, "ok": 139, "ko": 0 }, "percentiles3": { "total": 139, "ok": 139, "ko": 0 }, "percentiles4": { "total": 139, "ok": 139, "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": 72, "ok": 72, "ko": 0 }, "maxResponseTime": { "total": 72, "ok": 72, "ko": 0 }, "meanResponseTime": { "total": 72, "ok": 72, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 72, "ok": 72, "ko": 0 }, "percentiles2": { "total": 72, "ok": 72, "ko": 0 }, "percentiles3": { "total": 72, "ok": 72, "ko": 0 }, "percentiles4": { "total": 72, "ok": 72, "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": 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": "User AccessToken PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 61, "ok": 61, "ko": 0 }, "maxResponseTime": { "total": 61, "ok": 61, "ko": 0 }, "meanResponseTime": { "total": 61, "ok": 61, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 61, "ok": 61, "ko": 0 }, "percentiles2": { "total": 61, "ok": 61, "ko": 0 }, "percentiles3": { "total": 61, "ok": 61, "ko": 0 }, "percentiles4": { "total": 61, "ok": 61, "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": 29346, "ok": 29346, "ko": 0 }, "minResponseTime": { "total": 40, "ok": 40, "ko": 0 }, "maxResponseTime": { "total": 548, "ok": 548, "ko": 0 }, "meanResponseTime": { "total": 48, "ok": 48, "ko": 0 }, "standardDeviation": { "total": 5, "ok": 5, "ko": 0 }, "percentiles1": { "total": 48, "ok": 48, "ko": 0 }, "percentiles2": { "total": 50, "ok": 50, "ko": 0 }, "percentiles3": { "total": 53, "ok": 53, "ko": 0 }, "percentiles4": { "total": 59, "ok": 59, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 29346, "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": 48.91, "ok": 48.91, "ko": 0 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 49, "avg_response_time": 48, "max_response_time": 548, "min_response_time": 40, "num_requests": 29351, "num_requests_pass": 29351, "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": 139, "total": 139 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 139, "total": 139 }, "minResponseTime": { "ko": 0, "ok": 139, "total": 139 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 139, "total": 139 }, "percentiles2": { "ko": 0, "ok": 139, "total": 139 }, "percentiles3": { "ko": 0, "ok": 139, "total": 139 }, "percentiles4": { "ko": 0, "ok": 139, "total": 139 }, "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": 72, "total": 72 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 72, "total": 72 }, "minResponseTime": { "ko": 0, "ok": 72, "total": 72 }, "name": "Skip 2FA", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 72, "total": 72 }, "percentiles2": { "ko": 0, "ok": 72, "total": 72 }, "percentiles3": { "ko": 0, "ok": 72, "total": 72 }, "percentiles4": { "ko": 0, "ok": 72, "total": 72 }, "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 Authorize 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": 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": 61, "total": 61 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0016666666666666668, "total": 0.0016666666666666668 }, "meanResponseTime": { "ko": 0, "ok": 61, "total": 61 }, "minResponseTime": { "ko": 0, "ok": 61, "total": 61 }, "name": "User AccessToken PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 61, "total": 61 }, "percentiles2": { "ko": 0, "ok": 61, "total": 61 }, "percentiles3": { "ko": 0, "ok": 61, "total": 61 }, "percentiles4": { "ko": 0, "ok": 61, "total": 61 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 29346, "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": 548, "total": 548 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 48.91, "total": 48.91 }, "meanResponseTime": { "ko": 0, "ok": 48, "total": 48 }, "minResponseTime": { "ko": 0, "ok": 40, "total": 40 }, "name": "queryPartial", "numberOfRequests": { "ko": 0, "ok": 29346, "total": 29346 }, "percentiles1": { "ko": 0, "ok": 48, "total": 48 }, "percentiles2": { "ko": 0, "ok": 50, "total": 50 }, "percentiles3": { "ko": 0, "ok": 53, "total": 53 }, "percentiles4": { "ko": 0, "ok": 59, "total": 59 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 5, "total": 5 } } ], "global": { "group1": { "count": 29351, "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": 548, "total": 548 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 48.91833333333334, "total": 48.91833333333334 }, "meanResponseTime": { "ko": 0, "ok": 48, "total": 48 }, "minResponseTime": { "ko": 0, "ok": 40, "total": 40 }, "name": "All Requests", "numberOfRequests": { "ko": 0, "ok": 29351, "total": 29351 }, "percentiles1": { "ko": 0, "ok": 48, "total": 48 }, "percentiles2": { "ko": 0, "ok": 50, "total": 50 }, "percentiles3": { "ko": 0, "ok": 53, "total": 53 }, "percentiles4": { "ko": 0, "ok": 59, "total": 59 }, "standardDeviation": { "ko": 0, "ok": 5, "total": 5 } } }, "target_hostname": "openam-perf-200m.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-10 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-10 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/09_Reporting-query-10/stdout.txt Gatling stdout.txt found, but is small - leave it intact. Removing parsed Gatling stdout_parsed.txt file.. ________________________________________________________________________________ [2025-03-28 19:58:01] Reporting-query-10 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped