--Task-- name: Reporting-mixedquery-250 enabled: True class_name: GatlingResultTask source_name: overseer-0 source_namespace: >default< target_name: overseer-0 target_namespace: >default< start: 0 stop: None timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow loop: False interval: None dependencies: [] wait_for: ['Reporting-mixedquery-10', 'Reporting-mixedquery-50', 'Reporting-mixedquery-100', 'Reporting-mixedquery-150', 'Reporting-mixedquery-200'] preceding_task: None options: {'task_name': 'mixedquery-250'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-03-11 04:57:26] Reporting-mixedquery-250 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component [2024-03-11 04:57:26] - INFO: Timeout for this Task has changed to 1h 10m (4200 seconds) [2024-03-11 04:57:26] - 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-mixedquery-250/stdout.txt Pod stderr file : /results/orders/Reporting-mixedquery-250/stderr.txt Pod log : /results/orders/Reporting-mixedquery-250 ________________________________________________________________________________ [2024-03-11 04:57:26] Reporting-mixedquery-250 step1 : Write order for overseer to generate the report ________________________________________________________________________________ [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/order.json { "name": "Reporting-mixedquery-250", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh mixedquery-250 --extra-run-jvm-options \"-Xmx4G\"", "out-dir": "/results/orders/Reporting-mixedquery-250" } ________________________________________________________________________________ [2024-03-11 04:57:26] Reporting-mixedquery-250 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" [loop_until]: (max_time=120, interval=5, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found [loop_until]: OK (rc = 0) --- stdout --- WAITING --- stderr --- % 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 ________________________________________________________________________________ [2024-03-11 04:57:27] Reporting-mixedquery-250 step3 : Send order to overseer ________________________________________________________________________________ [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/order.json overseer-0-67d9575494-4zhsb:/results/orders/order.json [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- --- stderr --- Order has been successfully forwarded to overseer ________________________________________________________________________________ [2024-03-11 04:57:28] Reporting-mixedquery-250 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" [loop_until]: (max_time=4200, interval=5, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 15s (rc=0) - expected pattern found [loop_until]: OK (rc = 0) --- stdout --- WAITING --- stderr --- % 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 ________________________________________________________________________________ [2024-03-11 04:57:49] Reporting-mixedquery-250 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- Checking pod: overseer-0-67d9575494-4zhsb for file exists, if not wait. [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- bash -c 'if [ -f "/results/gatling/mixedquery-250.tar.gz" ]; then echo "/results/gatling/mixedquery-250.tar.gz file found"; exit 0; else echo "/results/gatling/mixedquery-250.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/mixedquery-250.tar.gz file found" [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found [loop_until]: OK (rc = 0) --- stdout --- /results/gatling/mixedquery-250.tar.gz file found --- stderr --- [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- du -k /results/gatling/mixedquery-250.tar.gz [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 448 /results/gatling/mixedquery-250.tar.gz --- stderr --- - Download file (size 448k) [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- source : /results/gatling/mixedquery-250.tar.gz @ overseer-0-67d9575494-4zhsb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/mixedquery-250.tar.gz [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-67d9575494-4zhsb:/results/gatling/mixedquery-250.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/mixedquery-250.tar.gz [loop_until]: (max_time=-1, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- tar: Removing leading `/' from member names --- stderr --- ________________________________________________________________________________ [2024-03-11 04:57:54] Reporting-mixedquery-250 step6 : Unzip the result ________________________________________________________________________________ [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/mixedquery-250.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/07_scenario/06_mixedquery-250/gatling [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- --- stderr --- ________________________________________________________________________________ [2024-03-11 04:57:54] Reporting-mixedquery-250 step7 : Print rc order ________________________________________________________________________________ [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- Checking pod: overseer-0-67d9575494-4zhsb for file exists, if not wait. [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- bash -c 'if [ -f "/results/orders/Reporting-mixedquery-250/rc.txt" ]; then echo "/results/orders/Reporting-mixedquery-250/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-mixedquery-250/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-mixedquery-250/rc.txt file found" [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found [loop_until]: OK (rc = 0) --- stdout --- /results/orders/Reporting-mixedquery-250/rc.txt file found --- stderr --- [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- du -k /results/orders/Reporting-mixedquery-250/rc.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting-mixedquery-250/rc.txt --- stderr --- - Download file (size 4k) [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- source : /results/orders/Reporting-mixedquery-250/rc.txt @ overseer-0-67d9575494-4zhsb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/rc.txt [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-67d9575494-4zhsb:/results/orders/Reporting-mixedquery-250/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/rc.txt [loop_until]: (max_time=-1, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- tar: Removing leading `/' from member names --- stderr --- [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/rc.txt is small (1 lines), printing all lines: ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2024-03-11 04:57:58] Reporting-mixedquery-250 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [2024-03-11 04:57:58] Reporting-mixedquery-250 step9 : Print stdout order ________________________________________________________________________________ [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- Checking pod: overseer-0-67d9575494-4zhsb for file exists, if not wait. [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- bash -c 'if [ -f "/results/orders/Reporting-mixedquery-250/stdout.txt" ]; then echo "/results/orders/Reporting-mixedquery-250/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-mixedquery-250/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-mixedquery-250/stdout.txt file found" [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found [loop_until]: OK (rc = 0) --- stdout --- /results/orders/Reporting-mixedquery-250/stdout.txt file found --- stderr --- [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- du -k /results/orders/Reporting-mixedquery-250/stdout.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting-mixedquery-250/stdout.txt --- stderr --- - Download file (size 4k) [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- source : /results/orders/Reporting-mixedquery-250/stdout.txt @ overseer-0-67d9575494-4zhsb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/stdout.txt [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-67d9575494-4zhsb:/results/orders/Reporting-mixedquery-250/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/stdout.txt [loop_until]: (max_time=-1, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- tar: Removing leading `/' from member names --- stderr --- [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/stdout.txt is small (89 lines), printing all lines: ----- output ----- [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/mixedquery-250/loadtest-20240311040645745 --extra-run-jvm-options -Xmx4G GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling Generating Gatling reports locally Parsing log file(s)... Parsing log file(s) done Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 294660 (OK=79777 KO=214883) > min response time 5 (OK=19 KO=5 ) > max response time 60129 (OK=59997 KO=60129 ) > mean response time 17640 (OK=20988 KO=16396 ) > std deviation 23549 (OK=21583 KO=24121 ) > response time 50th percentile 4269 (OK=4748 KO=9 ) > response time 75th percentile 39007 (OK=42685 KO=34455 ) > response time 95th percentile 60000 (OK=57402 KO=60000 ) > response time 99th percentile 60000 (OK=58632 KO=60000 ) > mean requests/sec 239.366 (OK=64.807 KO=174.56) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 1723 ( 1%) > 800 ms <= t < 1200 ms 466 ( 0%) > t >= 1200 ms 77588 ( 26%) > failed 214883 ( 73%) ---- Errors -------------------------------------------------------------------- > status.find.in(200,401), but actually found 503 102743 (47.81%) > status.find.in(200,401), but actually found 502 72986 (33.97%) > Request timeout to openam-ema-perf-iga.forgeblocks.com/34.144. 39128 (18.21%) 215.155:443 after 60000 ms > j.i.IOException: Premature close 26 ( 0.01%) ================================================================================ Reports generated in 0s. Please open the following file: file:///results/gatling/mixedquery-250/loadtest-20240311040645745/index.html ---------------------- [11/Mar/2024 04:57:48] Create tar file /results/gatling/mixedquery-250.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/mixedquery-250/loadtest-20240311040645745 RESULT_FOLDER=mixedquery-250 RESULT_PATH=/results/gatling/mixedquery-250 PWD=/results/gatling/mixedquery-250/loadtest-20240311040645745 [cmd] tar -czvf /results/gatling/mixedquery-250.tar.gz --exclude=simulation.log * group_retrievevariabl-5a49b.html group_storevariables-5102b.html index.html js/ js/global_stats.json js/highcharts-more.js js/highstock.js js/stats.json js/jquery-3.5.1.min.js js/assertions.xml js/gatling.js js/menu.js js/bootstrap.min.js js/ellipsis.js js/all_sessions.js js/stats.js js/theme.js js/assertions.json js/unpack.js req_querybysn-65c9b.html req_queryfull-e5d3d.html req_querypartial-f2acd.html req_querystartswith-1e9cd.html req_readmanageduser-f3f1e.html req_restlogininitia-e2b9b.html req_restloginuserna-d98ea.html req_skip-2fa-3cbda.html req_user-accesstoke-0d48d.html req_user-authorize--dd8b8.html style/ style/sortable.png style/stat-l-temps.png style/arrow_right_black.png style/stat-l-roue.png style/logo.svg style/stat-fleche-bas.png style/arrow_down_black.png style/favicon.ico style/logo-enterprise.svg style/arrow_down.png style/sorted-up.png style/bootstrap.min.css style/sorted-down.png style/style.css style/arrow_right.png style/little_arrow_right.png ________________________________________________________________________________ [2024-03-11 04:58:02] Reporting-mixedquery-250 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2024-03-11 04:58:02] Reporting-mixedquery-250 step11 : Print stderr order ________________________________________________________________________________ [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- Checking pod: overseer-0-67d9575494-4zhsb for file exists, if not wait. [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- bash -c 'if [ -f "/results/orders/Reporting-mixedquery-250/stderr.txt" ]; then echo "/results/orders/Reporting-mixedquery-250/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-mixedquery-250/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-mixedquery-250/stderr.txt file found" [loop_until]: (max_time=180, interval=5, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found [loop_until]: OK (rc = 0) --- stdout --- /results/orders/Reporting-mixedquery-250/stderr.txt file found --- stderr --- [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-67d9575494-4zhsb --stdin -- du -k /results/orders/Reporting-mixedquery-250/stderr.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 0 /results/orders/Reporting-mixedquery-250/stderr.txt --- stderr --- - Download file (size 0k) [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- source : /results/orders/Reporting-mixedquery-250/stderr.txt @ overseer-0-67d9575494-4zhsb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/stderr.txt [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 [loop_until]: (max_time=180, interval=10, expected_rc=[0] [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found [loop_until]: OK (rc = 0) --- stdout --- overseer-0-67d9575494-4zhsb --- stderr --- [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-67d9575494-4zhsb:/results/orders/Reporting-mixedquery-250/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/stderr.txt [loop_until]: (max_time=-1, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- tar: Removing leading `/' from member names --- stderr --- [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/14_Reporting-mixedquery-250/stderr.txt is small (0 lines), printing all lines: ----- output ----- ________________________________________________________________________________ [2024-03-11 04:58:06] Reporting-mixedquery-250 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2024-03-11 04:58:06] Reporting-mixedquery-250 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 ReadManagedUser [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/07_scenario/06_mixedquery-250/gatling/req_readmanageduser-f3f1e.html - cannot check for spikes checking simulation request queryStartsWith [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/07_scenario/06_mixedquery-250/gatling/req_querystartswith-1e9cd.html - cannot check for spikes checking simulation request queryFull [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/07_scenario/06_mixedquery-250/gatling/req_queryfull-e5d3d.html - cannot check for spikes checking simulation request queryBySn [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/07_scenario/06_mixedquery-250/gatling/req_querybysn-65c9b.html - cannot check for spikes checking simulation request queryPartial [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/07_scenario/06_mixedquery-250/gatling/req_querypartial-f2acd.html - cannot check for spikes no spikes found ________________________________________________________________________________ [2024-03-11 04:58:06] Reporting-mixedquery-250 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 294660, "ok": 79777, "ko": 214883 }, "minResponseTime": { "total": 5, "ok": 19, "ko": 5 }, "maxResponseTime": { "total": 60129, "ok": 59997, "ko": 60129 }, "meanResponseTime": { "total": 17640, "ok": 20988, "ko": 16396 }, "standardDeviation": { "total": 23549, "ok": 21583, "ko": 24121 }, "percentiles1": { "total": 4269, "ok": 4748, "ko": 9 }, "percentiles2": { "total": 39007, "ok": 42685, "ko": 34455 }, "percentiles3": { "total": 60000, "ok": 57402, "ko": 60000 }, "percentiles4": { "total": 60000, "ok": 58632, "ko": 60000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1723, "percentage": 1 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 466, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 77588, "percentage": 26 }, "group4": { "name": "failed", "htmlName": "failed", "count": 214883, "percentage": 73 }, "meanNumberOfRequestsPerSecond": { "total": 239.3663688058489, "ok": 64.80666125101544, "ko": 174.55970755483347 } }, "details": [ { "name": "restLoginInitiate", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 33, "ok": 33, "ko": 0 }, "maxResponseTime": { "total": 33, "ok": 33, "ko": 0 }, "meanResponseTime": { "total": 33, "ok": 33, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 33, "ok": 33, "ko": 0 }, "percentiles2": { "total": 33, "ok": 33, "ko": 0 }, "percentiles3": { "total": 33, "ok": 33, "ko": 0 }, "percentiles4": { "total": 33, "ok": 33, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0008123476848090983, "ok": 0.0008123476848090983, "ko": 0 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 238, "ok": 238, "ko": 0 }, "maxResponseTime": { "total": 238, "ok": 238, "ko": 0 }, "meanResponseTime": { "total": 238, "ok": 238, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 238, "ok": 238, "ko": 0 }, "percentiles2": { "total": 238, "ok": 238, "ko": 0 }, "percentiles3": { "total": 238, "ok": 238, "ko": 0 }, "percentiles4": { "total": 238, "ok": 238, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0008123476848090983, "ok": 0.0008123476848090983, "ko": 0 }, "spikes": [] }, { "name": "Skip 2FA", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 442, "ok": 442, "ko": 0 }, "maxResponseTime": { "total": 442, "ok": 442, "ko": 0 }, "meanResponseTime": { "total": 442, "ok": 442, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 442, "ok": 442, "ko": 0 }, "percentiles2": { "total": 442, "ok": 442, "ko": 0 }, "percentiles3": { "total": 442, "ok": 442, "ko": 0 }, "percentiles4": { "total": 442, "ok": 442, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0008123476848090983, "ok": 0.0008123476848090983, "ko": 0 }, "spikes": [] }, { "name": "User Authorize PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 953, "ok": 953, "ko": 0 }, "maxResponseTime": { "total": 953, "ok": 953, "ko": 0 }, "meanResponseTime": { "total": 953, "ok": 953, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 953, "ok": 953, "ko": 0 }, "percentiles2": { "total": 953, "ok": 953, "ko": 0 }, "percentiles3": { "total": 953, "ok": 953, "ko": 0 }, "percentiles4": { "total": 953, "ok": 953, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 0, "percentage": 0 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 1, "percentage": 100 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0008123476848090983, "ok": 0.0008123476848090983, "ko": 0 }, "spikes": [] }, { "name": "User AccessToken PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 56, "ok": 56, "ko": 0 }, "maxResponseTime": { "total": 56, "ok": 56, "ko": 0 }, "meanResponseTime": { "total": 56, "ok": 56, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 56, "ok": 56, "ko": 0 }, "percentiles2": { "total": 56, "ok": 56, "ko": 0 }, "percentiles3": { "total": 56, "ok": 56, "ko": 0 }, "percentiles4": { "total": 56, "ok": 56, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0008123476848090983, "ok": 0.0008123476848090983, "ko": 0 }, "spikes": [] }, { "name": "ReadManagedUser", "numberOfRequests": { "total": 58820, "ok": 15982, "ko": 42838 }, "minResponseTime": { "total": 5, "ok": 19, "ko": 5 }, "maxResponseTime": { "total": 60099, "ok": 59997, "ko": 60099 }, "meanResponseTime": { "total": 17639, "ok": 21266, "ko": 16286 }, "standardDeviation": { "total": 23562, "ok": 21722, "ko": 24073 }, "percentiles1": { "total": 4229, "ok": 4718, "ko": 9 }, "percentiles2": { "total": 39155, "ok": 43277, "ko": 33671 }, "percentiles3": { "total": 60000, "ok": 57407, "ko": 60000 }, "percentiles4": { "total": 60000, "ok": 58664, "ko": 60000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 370, "percentage": 1 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 83, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 15529, "percentage": 26 }, "group4": { "name": "failed", "htmlName": "failed", "count": 42838, "percentage": 73 }, "meanNumberOfRequestsPerSecond": { "total": 47.78229082047116, "ok": 12.982940698619009, "ko": 34.79935012185215 }, "spikes": [] }, { "name": "queryStartsWith", "numberOfRequests": { "total": 59146, "ok": 16083, "ko": 43063 }, "minResponseTime": { "total": 5, "ok": 34, "ko": 5 }, "maxResponseTime": { "total": 60120, "ok": 59978, "ko": 60120 }, "meanResponseTime": { "total": 17532, "ok": 20928, "ko": 16264 }, "standardDeviation": { "total": 23476, "ok": 21548, "ko": 24034 }, "percentiles1": { "total": 4255, "ok": 4732, "ko": 9 }, "percentiles2": { "total": 38403, "ok": 42524, "ko": 33691 }, "percentiles3": { "total": 60000, "ok": 57362, "ko": 60000 }, "percentiles4": { "total": 60000, "ok": 58657, "ko": 60000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 348, "percentage": 1 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 89, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 15646, "percentage": 26 }, "group4": { "name": "failed", "htmlName": "failed", "count": 43063, "percentage": 73 }, "meanNumberOfRequestsPerSecond": { "total": 48.047116165718926, "ok": 13.064987814784727, "ko": 34.9821283509342 }, "spikes": [] }, { "name": "queryFull", "numberOfRequests": { "total": 58639, "ok": 15720, "ko": 42919 }, "minResponseTime": { "total": 5, "ok": 19, "ko": 5 }, "maxResponseTime": { "total": 60129, "ok": 59973, "ko": 60129 }, "meanResponseTime": { "total": 17517, "ok": 20884, "ko": 16284 }, "standardDeviation": { "total": 23515, "ok": 21572, "ko": 24070 }, "percentiles1": { "total": 4211, "ok": 4695, "ko": 9 }, "percentiles2": { "total": 38453, "ok": 42814, "ko": 33691 }, "percentiles3": { "total": 60000, "ok": 57366, "ko": 60000 }, "percentiles4": { "total": 60000, "ok": 58544, "ko": 60000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 344, "percentage": 1 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 105, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 15271, "percentage": 26 }, "group4": { "name": "failed", "htmlName": "failed", "count": 42919, "percentage": 73 }, "meanNumberOfRequestsPerSecond": { "total": 47.635255889520714, "ok": 12.770105605199026, "ko": 34.86515028432169 }, "spikes": [] }, { "name": "queryBySn", "numberOfRequests": { "total": 59107, "ok": 15938, "ko": 43169 }, "minResponseTime": { "total": 5, "ok": 19, "ko": 5 }, "maxResponseTime": { "total": 60075, "ok": 59993, "ko": 60075 }, "meanResponseTime": { "total": 17689, "ok": 20879, "ko": 16512 }, "standardDeviation": { "total": 23574, "ok": 21497, "ko": 24190 }, "percentiles1": { "total": 4240, "ok": 4708, "ko": 9 }, "percentiles2": { "total": 39279, "ok": 42316, "ko": 35398 }, "percentiles3": { "total": 60000, "ok": 57342, "ko": 60000 }, "percentiles4": { "total": 60000, "ok": 58645, "ko": 60000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 347, "percentage": 1 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 86, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 15505, "percentage": 26 }, "group4": { "name": "failed", "htmlName": "failed", "count": 43169, "percentage": 73 }, "meanNumberOfRequestsPerSecond": { "total": 48.015434606011375, "ok": 12.947197400487408, "ko": 35.068237205523964 }, "spikes": [] }, { "name": "queryPartial", "numberOfRequests": { "total": 58943, "ok": 16049, "ko": 42894 }, "minResponseTime": { "total": 5, "ok": 177, "ko": 5 }, "maxResponseTime": { "total": 60068, "ok": 59979, "ko": 60068 }, "meanResponseTime": { "total": 17821, "ok": 20990, "ko": 16636 }, "standardDeviation": { "total": 23617, "ok": 21571, "ko": 24232 }, "percentiles1": { "total": 4425, "ok": 4861, "ko": 9 }, "percentiles2": { "total": 39829, "ok": 42507, "ko": 35653 }, "percentiles3": { "total": 60000, "ok": 57504, "ko": 60000 }, "percentiles4": { "total": 60000, "ok": 58648, "ko": 60000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 310, "percentage": 1 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 102, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 15637, "percentage": 27 }, "group4": { "name": "failed", "htmlName": "failed", "count": 42894, "percentage": 73 }, "meanNumberOfRequestsPerSecond": { "total": 47.88220958570268, "ok": 13.037367993501219, "ko": 34.84484159220146 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 239, "avg_response_time": 17640, "max_response_time": 59997, "min_response_time": 19, "num_requests": 294660, "num_requests_pass": 79777, "num_requests_percent_pass": 27.074 }, "options": "; duration:1200; testCase:idm.MixedQuery; testMode:open; throughput:250", "stats": { "details": [ { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 33, "total": 33 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0008123476848090983, "total": 0.0008123476848090983 }, "meanResponseTime": { "ko": 0, "ok": 33, "total": 33 }, "minResponseTime": { "ko": 0, "ok": 33, "total": 33 }, "name": "restLoginInitiate", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 33, "total": 33 }, "percentiles2": { "ko": 0, "ok": 33, "total": 33 }, "percentiles3": { "ko": 0, "ok": 33, "total": 33 }, "percentiles4": { "ko": 0, "ok": 33, "total": 33 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 238, "total": 238 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0008123476848090983, "total": 0.0008123476848090983 }, "meanResponseTime": { "ko": 0, "ok": 238, "total": 238 }, "minResponseTime": { "ko": 0, "ok": 238, "total": 238 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 238, "total": 238 }, "percentiles2": { "ko": 0, "ok": 238, "total": 238 }, "percentiles3": { "ko": 0, "ok": 238, "total": 238 }, "percentiles4": { "ko": 0, "ok": 238, "total": 238 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 442, "total": 442 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0008123476848090983, "total": 0.0008123476848090983 }, "meanResponseTime": { "ko": 0, "ok": 442, "total": 442 }, "minResponseTime": { "ko": 0, "ok": 442, "total": 442 }, "name": "Skip 2FA", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 442, "total": 442 }, "percentiles2": { "ko": 0, "ok": 442, "total": 442 }, "percentiles3": { "ko": 0, "ok": 442, "total": 442 }, "percentiles4": { "ko": 0, "ok": 442, "total": 442 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 0, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 0 }, "group2": { "count": 1, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 100 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 953, "total": 953 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0008123476848090983, "total": 0.0008123476848090983 }, "meanResponseTime": { "ko": 0, "ok": 953, "total": 953 }, "minResponseTime": { "ko": 0, "ok": 953, "total": 953 }, "name": "User Authorize PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 953, "total": 953 }, "percentiles2": { "ko": 0, "ok": 953, "total": 953 }, "percentiles3": { "ko": 0, "ok": 953, "total": 953 }, "percentiles4": { "ko": 0, "ok": 953, "total": 953 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 56, "total": 56 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0008123476848090983, "total": 0.0008123476848090983 }, "meanResponseTime": { "ko": 0, "ok": 56, "total": 56 }, "minResponseTime": { "ko": 0, "ok": 56, "total": 56 }, "name": "User AccessToken PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 56, "total": 56 }, "percentiles2": { "ko": 0, "ok": 56, "total": 56 }, "percentiles3": { "ko": 0, "ok": 56, "total": 56 }, "percentiles4": { "ko": 0, "ok": 56, "total": 56 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 370, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 1 }, "group2": { "count": 83, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 15529, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 26 }, "group4": { "count": 42838, "htmlName": "failed", "name": "failed", "percentage": 73 }, "maxResponseTime": { "ko": 60099, "ok": 59997, "total": 60099 }, "meanNumberOfRequestsPerSecond": { "ko": 34.79935012185215, "ok": 12.982940698619009, "total": 47.78229082047116 }, "meanResponseTime": { "ko": 16286, "ok": 21266, "total": 17639 }, "minResponseTime": { "ko": 5, "ok": 19, "total": 5 }, "name": "ReadManagedUser", "numberOfRequests": { "ko": 42838, "ok": 15982, "total": 58820 }, "percentiles1": { "ko": 9, "ok": 4718, "total": 4229 }, "percentiles2": { "ko": 33671, "ok": 43277, "total": 39155 }, "percentiles3": { "ko": 60000, "ok": 57407, "total": 60000 }, "percentiles4": { "ko": 60000, "ok": 58664, "total": 60000 }, "spikes": [], "standardDeviation": { "ko": 24073, "ok": 21722, "total": 23562 } }, { "group1": { "count": 348, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 1 }, "group2": { "count": 89, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 15646, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 26 }, "group4": { "count": 43063, "htmlName": "failed", "name": "failed", "percentage": 73 }, "maxResponseTime": { "ko": 60120, "ok": 59978, "total": 60120 }, "meanNumberOfRequestsPerSecond": { "ko": 34.9821283509342, "ok": 13.064987814784727, "total": 48.047116165718926 }, "meanResponseTime": { "ko": 16264, "ok": 20928, "total": 17532 }, "minResponseTime": { "ko": 5, "ok": 34, "total": 5 }, "name": "queryStartsWith", "numberOfRequests": { "ko": 43063, "ok": 16083, "total": 59146 }, "percentiles1": { "ko": 9, "ok": 4732, "total": 4255 }, "percentiles2": { "ko": 33691, "ok": 42524, "total": 38403 }, "percentiles3": { "ko": 60000, "ok": 57362, "total": 60000 }, "percentiles4": { "ko": 60000, "ok": 58657, "total": 60000 }, "spikes": [], "standardDeviation": { "ko": 24034, "ok": 21548, "total": 23476 } }, { "group1": { "count": 344, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 1 }, "group2": { "count": 105, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 15271, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 26 }, "group4": { "count": 42919, "htmlName": "failed", "name": "failed", "percentage": 73 }, "maxResponseTime": { "ko": 60129, "ok": 59973, "total": 60129 }, "meanNumberOfRequestsPerSecond": { "ko": 34.86515028432169, "ok": 12.770105605199026, "total": 47.635255889520714 }, "meanResponseTime": { "ko": 16284, "ok": 20884, "total": 17517 }, "minResponseTime": { "ko": 5, "ok": 19, "total": 5 }, "name": "queryFull", "numberOfRequests": { "ko": 42919, "ok": 15720, "total": 58639 }, "percentiles1": { "ko": 9, "ok": 4695, "total": 4211 }, "percentiles2": { "ko": 33691, "ok": 42814, "total": 38453 }, "percentiles3": { "ko": 60000, "ok": 57366, "total": 60000 }, "percentiles4": { "ko": 60000, "ok": 58544, "total": 60000 }, "spikes": [], "standardDeviation": { "ko": 24070, "ok": 21572, "total": 23515 } }, { "group1": { "count": 347, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 1 }, "group2": { "count": 86, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 15505, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 26 }, "group4": { "count": 43169, "htmlName": "failed", "name": "failed", "percentage": 73 }, "maxResponseTime": { "ko": 60075, "ok": 59993, "total": 60075 }, "meanNumberOfRequestsPerSecond": { "ko": 35.068237205523964, "ok": 12.947197400487408, "total": 48.015434606011375 }, "meanResponseTime": { "ko": 16512, "ok": 20879, "total": 17689 }, "minResponseTime": { "ko": 5, "ok": 19, "total": 5 }, "name": "queryBySn", "numberOfRequests": { "ko": 43169, "ok": 15938, "total": 59107 }, "percentiles1": { "ko": 9, "ok": 4708, "total": 4240 }, "percentiles2": { "ko": 35398, "ok": 42316, "total": 39279 }, "percentiles3": { "ko": 60000, "ok": 57342, "total": 60000 }, "percentiles4": { "ko": 60000, "ok": 58645, "total": 60000 }, "spikes": [], "standardDeviation": { "ko": 24190, "ok": 21497, "total": 23574 } }, { "group1": { "count": 310, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 1 }, "group2": { "count": 102, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 15637, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 27 }, "group4": { "count": 42894, "htmlName": "failed", "name": "failed", "percentage": 73 }, "maxResponseTime": { "ko": 60068, "ok": 59979, "total": 60068 }, "meanNumberOfRequestsPerSecond": { "ko": 34.84484159220146, "ok": 13.037367993501219, "total": 47.88220958570268 }, "meanResponseTime": { "ko": 16636, "ok": 20990, "total": 17821 }, "minResponseTime": { "ko": 5, "ok": 177, "total": 5 }, "name": "queryPartial", "numberOfRequests": { "ko": 42894, "ok": 16049, "total": 58943 }, "percentiles1": { "ko": 9, "ok": 4861, "total": 4425 }, "percentiles2": { "ko": 35653, "ok": 42507, "total": 39829 }, "percentiles3": { "ko": 60000, "ok": 57504, "total": 60000 }, "percentiles4": { "ko": 60000, "ok": 58648, "total": 60000 }, "spikes": [], "standardDeviation": { "ko": 24232, "ok": 21571, "total": 23617 } } ], "global": { "group1": { "count": 1723, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 1 }, "group2": { "count": 466, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 77588, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 26 }, "group4": { "count": 214883, "htmlName": "failed", "name": "failed", "percentage": 73 }, "maxResponseTime": { "ko": 60129, "ok": 59997, "total": 60129 }, "meanNumberOfRequestsPerSecond": { "ko": 174.55970755483347, "ok": 64.80666125101544, "total": 239.3663688058489 }, "meanResponseTime": { "ko": 16396, "ok": 20988, "total": 17640 }, "minResponseTime": { "ko": 5, "ok": 19, "total": 5 }, "name": "All Requests", "numberOfRequests": { "ko": 214883, "ok": 79777, "total": 294660 }, "percentiles1": { "ko": 9, "ok": 4748, "total": 4269 }, "percentiles2": { "ko": 34455, "ok": 42685, "total": 39007 }, "percentiles3": { "ko": 60000, "ok": 57402, "total": 60000 }, "percentiles4": { "ko": 60000, "ok": 58632, "total": 60000 }, "standardDeviation": { "ko": 24121, "ok": 21583, "total": 23549 } } }, "target_hostname": "openam-ema-perf-iga.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2024-03-11 04:58:06] Reporting-mixedquery-250 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2024-03-11 04:58:06] Reporting-mixedquery-250 step16 : Remove gatling task's stdout file ________________________________________________________________________________ Cleanup of Gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_simple_managed_users/07_scenario/06_mixedquery-250/stdout.txt Compressing Gatling stdout.txt file.. ________________________________________________________________________________ [2024-03-11 04:58:29] Reporting-mixedquery-250 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped