--Task-- name: Reporting_access-token-600 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_access-token-100', 'Reporting_access-token-200', 'Reporting_access-token-300', 'Reporting_access-token-400', 'Reporting_access-token-500'] options: {'task_name': 'access-token-600'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [04/Nov/2022 05:35:04] Reporting_access-token-600 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component [04/Nov/2022 05:35:04] - INFO: Timeout for this Task has changed to 1h (3600 seconds) Pod stdout file : /results/orders/Reporting_access-token-600/stdout.txt Pod stderr file : /results/orders/Reporting_access-token-600/stderr.txt Pod log : /results/orders/Reporting_access-token-600 ________________________________________________________________________________ [04/Nov/2022 05:35:04] Reporting_access-token-600 step1 : Write order for overseer to generate the report ________________________________________________________________________________ Order file : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/order.json { "name": "Reporting_access-token-600", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh access-token-600", "out-dir": "/results/orders/Reporting_access-token-600" } ________________________________________________________________________________ [04/Nov/2022 05:35:04] Reporting_access-token-600 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ [loop_until]: curl -k 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 30 0 --:--:-- --:--:-- --:--:-- 30 ________________________________________________________________________________ [04/Nov/2022 05:35:04] Reporting_access-token-600 step3 : Send order to overseer ________________________________________________________________________________ [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/order.json overseer-0-779957466d-hs7t7:/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 ________________________________________________________________________________ [04/Nov/2022 05:35:06] Reporting_access-token-600 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. [loop_until]: curl -k https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" [loop_until]: (max_time=3600, 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 16s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 37s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 42s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 58s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 1m 03s (rc=0) - failed to find expected output: WAITING - retry [loop_until]: Function succeeded after 1m 08s (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 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 23 0 --:--:-- --:--:-- --:--:-- 23 ________________________________________________________________________________ [04/Nov/2022 05:36:20] Reporting_access-token-600 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- Checking pod: overseer-0-779957466d-hs7t7 for file exists, if not wait. [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- bash -c 'if [ -f "/results/gatling/access-token-600.tar.gz" ]; then echo "/results/gatling/access-token-600.tar.gz file found"; exit 0; else echo "/results/gatling/access-token-600.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/access-token-600.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/access-token-600.tar.gz file found --- stderr --- [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- du -k /results/gatling/access-token-600.tar.gz [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 396 /results/gatling/access-token-600.tar.gz --- stderr --- - Download file (size 396k) [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- source : /results/gatling/access-token-600.tar.gz @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/access-token-600.tar.gz [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-779957466d-hs7t7:/results/gatling/access-token-600.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/access-token-600.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 --- ________________________________________________________________________________ [04/Nov/2022 05:36:24] Reporting_access-token-600 step6 : Unzip the result ________________________________________________________________________________ [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/access-token-600.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/05_AccessToken/06_access-token-600/gatling [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- --- stderr --- ________________________________________________________________________________ [04/Nov/2022 05:36:24] Reporting_access-token-600 step7 : Print rc order ________________________________________________________________________________ [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- Checking pod: overseer-0-779957466d-hs7t7 for file exists, if not wait. [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- bash -c 'if [ -f "/results/orders/Reporting_access-token-600/rc.txt" ]; then echo "/results/orders/Reporting_access-token-600/rc.txt file found"; exit 0; else echo "/results/orders/Reporting_access-token-600/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_access-token-600/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_access-token-600/rc.txt file found --- stderr --- [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- du -k /results/orders/Reporting_access-token-600/rc.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting_access-token-600/rc.txt --- stderr --- - Download file (size 4k) [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- source : /results/orders/Reporting_access-token-600/rc.txt @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/rc.txt [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-779957466d-hs7t7:/results/orders/Reporting_access-token-600/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/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/access_token/06_Verification/06_Reporting_access-token-600/rc.txt is small (1 lines), printing all lines: ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [04/Nov/2022 05:36:28] Reporting_access-token-600 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [04/Nov/2022 05:36:28] Reporting_access-token-600 step9 : Print stdout order ________________________________________________________________________________ [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- Checking pod: overseer-0-779957466d-hs7t7 for file exists, if not wait. [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- bash -c 'if [ -f "/results/orders/Reporting_access-token-600/stdout.txt" ]; then echo "/results/orders/Reporting_access-token-600/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting_access-token-600/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_access-token-600/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_access-token-600/stdout.txt file found --- stderr --- [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- du -k /results/orders/Reporting_access-token-600/stdout.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 8 /results/orders/Reporting_access-token-600/stdout.txt --- stderr --- - Download file (size 8k) [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- source : /results/orders/Reporting_access-token-600/stdout.txt @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/stdout.txt [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-779957466d-hs7t7:/results/orders/Reporting_access-token-600/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/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/access_token/06_Verification/06_Reporting_access-token-600/stdout.txt is small (102 lines), printing all lines: ----- output ----- [cmd] /lodestar/clients/gatling/bin/gatling.sh -ro /results/gatling/access-token-600/loadtest-20221104042307527 GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling Parsing log file(s)... Parsing log file(s) done Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 6498953 (OK=5481870 KO=1017083) > min response time 13 (OK=16 KO=13 ) > max response time 60680 (OK=59990 KO=60680 ) > mean response time 4385 (OK=3978 KO=6580 ) > std deviation 3881 (OK=3668 KO=4244 ) > response time 50th percentile 3725 (OK=3346 KO=9018 ) > response time 75th percentile 6771 (OK=5828 KO=9019 ) > response time 95th percentile 10555 (OK=10896 KO=9021 ) > response time 99th percentile 14572 (OK=14679 KO=13412 ) > mean requests/sec 1722.946 (OK=1453.306 KO=269.64) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 1232555 ( 19%) > 800 ms < t < 1200 ms 245509 ( 4%) > t > 1200 ms 4003806 ( 62%) > failed 1017083 ( 16%) ---- Errors -------------------------------------------------------------------- > getTokenInfo: Failed to build request: Failed to build request 948750 (27.00%) : j.u.NoSuchElementException: No attribute named 'access_token... > getAccessToken: Failed to build request: No attribute named 'a 840771 (23.93%) uthcode' is defined > userAuthorize: Failed to build request: No attribute named 'to 707589 (20.14%) kenId' is defined > status.find.in(200,201,202,203,204,205,206,207,208,209,304,401 666137 (18.96%) ), but actually found 502 > headerRegex((Location,(?<=code=)(.+?)(?=&))).find.exists, foun 132832 ( 3.78%) d nothing > jsonPath($.access_token).find.exists preparation crashed: Jack 113236 ( 3.22%) son failed to parse into a valid AST: c.f.j.c.JsonParseExcepti... > jsonPath($.access_token).find.exists preparation crashed: Jack 62732 ( 1.79%) son failed to parse into a valid AST: c.f.j.c.JsonParseExcepti... > status.find.in(200,201,202,203,204,205,206,207,208,209,304,401 41194 ( 1.17%) ), but actually found 503 > i.g.h.c.i.RequestTimeoutException: Request timeout to openam-p 938 ( 0.03%) erf-100m-test.forgeblocks.com/34.160.233.205:443 after 60000 m... > i.n.c.ConnectTimeoutException: connection timed out: openam-pe 11 ( 0.00%) rf-100m-test.forgeblocks.com/34.160.233.205:443 > jsonPath($.tokenId).find.noop preparation crashed: Jackson fai 2 ( 0.00%) led to parse into a valid AST: c.f.j.c.JsonParseException: Une... > j.n.s.SSLException: handshake timed out 1 ( 0.00%) ================================================================================ Reports generated in 0s. Please open the following file: /results/gatling/access-token-600/loadtest-20221104042307527/index.html ---------------------- [04/Nov/2022 05:36:15] Create tar file /results/gatling/access-token-600.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/access-token-600/loadtest-20221104042307527 RESULT_FOLDER=access-token-600 RESULT_PATH=/results/gatling/access-token-600 PWD=/results/gatling/access-token-600/loadtest-20221104042307527 [cmd] tar -czvf /results/gatling/access-token-600.tar.gz --exclude=simulation.log * index.html js/ js/assertions.json js/global_stats.json js/assertions.xml js/highstock.js js/stats.js js/unpack.js js/menu.js js/theme.js js/jquery.min.js js/bootstrap.min.js js/all_sessions.js js/gatling.js js/moment.min.js js/highcharts-more.js js/stats.json req_getaccesstoken-362c1.html req_gettokeninfo-e3de3.html req_userauthorize-f29d0.html req_user-ee11c.html req_userrestlogin-03b82.html style/ style/favicon.ico style/logo.png style/logo-gatling.jpg style/arrow_down_black.png style/stat-fond.png style/style.css style/sortable.png style/arrow_right.png style/cible.png style/stat-l-temps.png style/sorted-up.png style/stat-l-roue.png style/bootstrap.min.css style/arrow_right_black.png style/logo.svg style/little_arrow_right.png style/stat-fleche-bas.png style/arrow_down.png style/sorted-down.png ________________________________________________________________________________ [04/Nov/2022 05:36:32] Reporting_access-token-600 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [04/Nov/2022 05:36:32] Reporting_access-token-600 step11 : Print stderr order ________________________________________________________________________________ [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- Checking pod: overseer-0-779957466d-hs7t7 for file exists, if not wait. [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- bash -c 'if [ -f "/results/orders/Reporting_access-token-600/stderr.txt" ]; then echo "/results/orders/Reporting_access-token-600/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting_access-token-600/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_access-token-600/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_access-token-600/stderr.txt file found --- stderr --- [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-779957466d-hs7t7 -i -- du -k /results/orders/Reporting_access-token-600/stderr.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 0 /results/orders/Reporting_access-token-600/stderr.txt --- stderr --- - Download file (size 0k) [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- source : /results/orders/Reporting_access-token-600/stderr.txt @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/stderr.txt [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou get pods -l app=overseer-0 -o 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-779957466d-hs7t7 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-779957466d-hs7t7:/results/orders/Reporting_access-token-600/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/06_Reporting_access-token-600/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/access_token/06_Verification/06_Reporting_access-token-600/stderr.txt is small (0 lines), printing all lines: ----- output ----- ________________________________________________________________________________ [04/Nov/2022 05:36:36] Reporting_access-token-600 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [04/Nov/2022 05:36:36] Reporting_access-token-600 step13 : Analyze graphs for spikes ________________________________________________________________________________ Analyze Gatling graphs for spikes checking parameters open overall stats JSON file checking simulation request userRestLogin checking simulation request userAuthorize checking simulation request getAccessToken checking simulation request getTokenInfo checking simulation request user 64 spikes found - see "spikes" sections in js/stats.json ________________________________________________________________________________ [04/Nov/2022 05:36:36] Reporting_access-token-600 step14 : Collect gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "Global Information", "numberOfRequests": { "total": 6498953, "ok": 5481870, "ko": 1017083 }, "minResponseTime": { "total": 13, "ok": 16, "ko": 13 }, "maxResponseTime": { "total": 60680, "ok": 59990, "ko": 60680 }, "meanResponseTime": { "total": 4385, "ok": 3978, "ko": 6580 }, "standardDeviation": { "total": 3881, "ok": 3668, "ko": 4244 }, "percentiles1": { "total": 3725, "ok": 3346, "ko": 9018 }, "percentiles2": { "total": 6771, "ok": 5828, "ko": 9019 }, "percentiles3": { "total": 10555, "ok": 10896, "ko": 9021 }, "percentiles4": { "total": 14572, "ok": 14679, "ko": 13412 }, "group1": { "name": "t < 800 ms", "count": 1232555, "percentage": 19 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 245509, "percentage": 4 }, "group3": { "name": "t > 1200 ms", "count": 4003806, "percentage": 62 }, "group4": { "name": "failed", "count": 1017083, "percentage": 16 }, "meanNumberOfRequestsPerSecond": { "total": 1722.9461823966067, "ok": 1453.3059384941675, "ko": 269.640243902439 } }, "details": [ { "name": "userRestLogin", "numberOfRequests": { "total": 2249003, "ok": 1541415, "ko": 707588 }, "minResponseTime": { "total": 17, "ok": 63, "ko": 17 }, "maxResponseTime": { "total": 60675, "ok": 59914, "ko": 60675 }, "meanResponseTime": { "total": 5096, "ok": 3751, "ko": 8026 }, "standardDeviation": { "total": 4002, "ok": 3649, "ko": 3062 }, "percentiles1": { "total": 4633, "ok": 2995, "ko": 9019 }, "percentiles2": { "total": 9018, "ok": 5572, "ko": 9019 }, "percentiles3": { "total": 9824, "ok": 10607, "ko": 9021 }, "percentiles4": { "total": 13828, "ok": 14103, "ko": 10240 }, "group1": { "name": "t < 800 ms", "count": 389271, "percentage": 17 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 75873, "percentage": 3 }, "group3": { "name": "t > 1200 ms", "count": 1076271, "percentage": 48 }, "group4": { "name": "failed", "count": 707588, "percentage": 31 }, "meanNumberOfRequestsPerSecond": { "total": 596.2362142099682, "ok": 408.6466065747614, "ko": 187.5896076352068 }, "spikes": [ { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 59541 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 56122 }, { "datetime": "2022-11-04T04:29:50", "maxResponseTime": 26814 }, { "datetime": "2022-11-04T04:30:20", "maxResponseTime": 55893 }, { "datetime": "2022-11-04T04:35:37", "maxResponseTime": 39976 }, { "datetime": "2022-11-04T04:37:38", "maxResponseTime": 39735 }, { "datetime": "2022-11-04T04:38:04", "maxResponseTime": 43206 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 35566 }, { "datetime": "2022-11-04T04:39:31", "maxResponseTime": 57761 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 58479 }, { "datetime": "2022-11-04T04:42:32", "maxResponseTime": 56160 }, { "datetime": "2022-11-04T04:43:02", "maxResponseTime": 40727 }, { "datetime": "2022-11-04T04:43:32", "maxResponseTime": 36274 }, { "datetime": "2022-11-04T04:47:30", "maxResponseTime": 24801 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 56280 }, { "datetime": "2022-11-04T04:57:56", "maxResponseTime": 54033 } ] }, { "name": "userAuthorize", "numberOfRequests": { "total": 1541413, "ok": 1408231, "ko": 133182 }, "minResponseTime": { "total": 14, "ok": 19, "ko": 14 }, "maxResponseTime": { "total": 60655, "ok": 59990, "ko": 60655 }, "meanResponseTime": { "total": 4070, "ok": 4129, "ko": 3447 }, "standardDeviation": { "total": 3739, "ok": 3624, "ko": 4742 }, "percentiles1": { "total": 3441, "ok": 3486, "ko": 3086 }, "percentiles2": { "total": 5703, "ok": 5877, "ko": 4284 }, "percentiles3": { "total": 10931, "ok": 11030, "ko": 9188 }, "percentiles4": { "total": 15043, "ok": 14933, "ko": 18699 }, "group1": { "name": "t < 800 ms", "count": 263510, "percentage": 17 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 61762, "percentage": 4 }, "group3": { "name": "t > 1200 ms", "count": 1082959, "percentage": 70 }, "group4": { "name": "failed", "count": 133182, "percentage": 9 }, "meanNumberOfRequestsPerSecond": { "total": 408.6460763520679, "ok": 373.3380169671262, "ko": 35.30805938494168 }, "spikes": [ { "datetime": "2022-11-04T04:23:44", "maxResponseTime": 2617 }, { "datetime": "2022-11-04T04:23:48", "maxResponseTime": 5371 }, { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 59922 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 56124 }, { "datetime": "2022-11-04T04:30:20", "maxResponseTime": 55741 }, { "datetime": "2022-11-04T04:37:38", "maxResponseTime": 41773 }, { "datetime": "2022-11-04T04:38:04", "maxResponseTime": 45787 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 35818 }, { "datetime": "2022-11-04T04:39:31", "maxResponseTime": 59990 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 58126 }, { "datetime": "2022-11-04T04:41:24", "maxResponseTime": 34889 }, { "datetime": "2022-11-04T04:42:32", "maxResponseTime": 59501 }, { "datetime": "2022-11-04T04:45:59", "maxResponseTime": 28794 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 56185 }, { "datetime": "2022-11-04T04:56:07", "maxResponseTime": 27050 }, { "datetime": "2022-11-04T04:57:56", "maxResponseTime": 54148 }, { "datetime": "2022-11-04T05:09:53", "maxResponseTime": 29272 } ] }, { "name": "getAccessToken", "numberOfRequests": { "total": 1408231, "ok": 1300252, "ko": 107979 }, "minResponseTime": { "total": 13, "ok": 25, "ko": 13 }, "maxResponseTime": { "total": 60680, "ok": 59952, "ko": 60680 }, "meanResponseTime": { "total": 4718, "ok": 4806, "ko": 3651 }, "standardDeviation": { "total": 4025, "ok": 3905, "ko": 5139 }, "percentiles1": { "total": 4165, "ok": 4283, "ko": 2952 }, "percentiles2": { "total": 6605, "ok": 6739, "ko": 4777 }, "percentiles3": { "total": 12061, "ok": 12115, "ko": 10728 }, "percentiles4": { "total": 16159, "ok": 16045, "ko": 19903 }, "group1": { "name": "t < 800 ms", "count": 202578, "percentage": 14 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 43841, "percentage": 3 }, "group3": { "name": "t > 1200 ms", "count": 1053833, "percentage": 75 }, "group4": { "name": "failed", "count": 107979, "percentage": 8 }, "meanNumberOfRequestsPerSecond": { "total": 373.3380169671262, "ok": 344.711558854719, "ko": 28.62645811240721 }, "spikes": [ { "datetime": "2022-11-04T04:23:44", "maxResponseTime": 3875 }, { "datetime": "2022-11-04T04:23:48", "maxResponseTime": 6452 }, { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 58903 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 56161 }, { "datetime": "2022-11-04T04:30:20", "maxResponseTime": 55971 }, { "datetime": "2022-11-04T04:34:25", "maxResponseTime": 59260 }, { "datetime": "2022-11-04T04:38:04", "maxResponseTime": 46202 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 39762 }, { "datetime": "2022-11-04T04:39:31", "maxResponseTime": 59952 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 59619 }, { "datetime": "2022-11-04T04:41:24", "maxResponseTime": 35639 }, { "datetime": "2022-11-04T04:42:32", "maxResponseTime": 59818 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 58722 }, { "datetime": "2022-11-04T04:52:39", "maxResponseTime": 54518 }, { "datetime": "2022-11-04T04:56:14", "maxResponseTime": 59820 }, { "datetime": "2022-11-04T05:10:05", "maxResponseTime": 30505 } ] }, { "name": "getTokenInfo", "numberOfRequests": { "total": 1300252, "ok": 1231920, "ko": 68332 }, "minResponseTime": { "total": 14, "ok": 16, "ko": 14 }, "maxResponseTime": { "total": 60009, "ok": 59986, "ko": 60009 }, "meanResponseTime": { "total": 3168, "ok": 3214, "ko": 2342 }, "standardDeviation": { "total": 3297, "ok": 3272, "ko": 3623 }, "percentiles1": { "total": 2370, "ok": 2415, "ko": 1740 }, "percentiles2": { "total": 4802, "ok": 4897, "ko": 3440 }, "percentiles3": { "total": 9904, "ok": 9960, "ko": 7818 }, "percentiles4": { "total": 13358, "ok": 13325, "ko": 14444 }, "group1": { "name": "t < 800 ms", "count": 377196, "percentage": 29 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 64033, "percentage": 5 }, "group3": { "name": "t > 1200 ms", "count": 790691, "percentage": 61 }, "group4": { "name": "failed", "count": 68332, "percentage": 5 }, "meanNumberOfRequestsPerSecond": { "total": 344.711558854719, "ok": 326.59597030752917, "ko": 18.11558854718982 }, "spikes": [ { "datetime": "2022-11-04T04:23:48", "maxResponseTime": 3441 }, { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 59462 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 40878 }, { "datetime": "2022-11-04T04:30:24", "maxResponseTime": 56859 }, { "datetime": "2022-11-04T04:34:21", "maxResponseTime": 54632 }, { "datetime": "2022-11-04T04:35:37", "maxResponseTime": 40283 }, { "datetime": "2022-11-04T04:37:38", "maxResponseTime": 58240 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 36092 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 38237 }, { "datetime": "2022-11-04T04:41:24", "maxResponseTime": 34287 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 59986 }, { "datetime": "2022-11-04T04:51:54", "maxResponseTime": 26459 }, { "datetime": "2022-11-04T04:52:24", "maxResponseTime": 53758 }, { "datetime": "2022-11-04T04:54:29", "maxResponseTime": 58454 }, { "datetime": "2022-11-04T05:09:46", "maxResponseTime": 26835 } ] }, { "name": "user", "numberOfRequests": { "total": 54, "ok": 52, "ko": 2 }, "minResponseTime": { "total": 15, "ok": 1807, "ko": 15 }, "maxResponseTime": { "total": 7745, "ok": 7745, "ko": 28 }, "meanResponseTime": { "total": 4280, "ok": 4443, "ko": 22 }, "standardDeviation": { "total": 1335, "ok": 1061, "ko": 7 }, "percentiles1": { "total": 4134, "ok": 4162, "ko": 22 }, "percentiles2": { "total": 5041, "ok": 5053, "ko": 25 }, "percentiles3": { "total": 6173, "ok": 6399, "ko": 27 }, "percentiles4": { "total": 7703, "ok": 7704, "ko": 28 }, "group1": { "name": "t < 800 ms", "count": 0, "percentage": 0 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 52, "percentage": 96 }, "group4": { "name": "failed", "count": 2, "percentage": 4 }, "meanNumberOfRequestsPerSecond": { "total": 0.014316012725344645, "ok": 0.013785790031813362, "ko": 0.0005302226935312832 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 1723, "avg_response_time": 4385, "max_response_time": 59990, "min_response_time": 16, "num_requests": 6498953, "num_requests_pass": 5481870, "num_requests_percent_pass": 84.35 }, "options": "; testMode:open; simulation:com.forgerock.gatling.Loadtest; testCase:am.AMAccessToken; throughput:600; rampup-duration:30", "stats": { "details": [ { "group1": { "count": 389271, "name": "t < 800 ms", "percentage": 17 }, "group2": { "count": 75873, "name": "800 ms < t < 1200 ms", "percentage": 3 }, "group3": { "count": 1076271, "name": "t > 1200 ms", "percentage": 48 }, "group4": { "count": 707588, "name": "failed", "percentage": 31 }, "maxResponseTime": { "ko": 60675, "ok": 59914, "total": 60675 }, "meanNumberOfRequestsPerSecond": { "ko": 187.5896076352068, "ok": 408.6466065747614, "total": 596.2362142099682 }, "meanResponseTime": { "ko": 8026, "ok": 3751, "total": 5096 }, "minResponseTime": { "ko": 17, "ok": 63, "total": 17 }, "name": "userRestLogin", "numberOfRequests": { "ko": 707588, "ok": 1541415, "total": 2249003 }, "percentiles1": { "ko": 9019, "ok": 2995, "total": 4633 }, "percentiles2": { "ko": 9019, "ok": 5572, "total": 9018 }, "percentiles3": { "ko": 9021, "ok": 10607, "total": 9824 }, "percentiles4": { "ko": 10240, "ok": 14103, "total": 13828 }, "spikes": [ { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 59541 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 56122 }, { "datetime": "2022-11-04T04:29:50", "maxResponseTime": 26814 }, { "datetime": "2022-11-04T04:30:20", "maxResponseTime": 55893 }, { "datetime": "2022-11-04T04:35:37", "maxResponseTime": 39976 }, { "datetime": "2022-11-04T04:37:38", "maxResponseTime": 39735 }, { "datetime": "2022-11-04T04:38:04", "maxResponseTime": 43206 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 35566 }, { "datetime": "2022-11-04T04:39:31", "maxResponseTime": 57761 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 58479 }, { "datetime": "2022-11-04T04:42:32", "maxResponseTime": 56160 }, { "datetime": "2022-11-04T04:43:02", "maxResponseTime": 40727 }, { "datetime": "2022-11-04T04:43:32", "maxResponseTime": 36274 }, { "datetime": "2022-11-04T04:47:30", "maxResponseTime": 24801 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 56280 }, { "datetime": "2022-11-04T04:57:56", "maxResponseTime": 54033 } ], "standardDeviation": { "ko": 3062, "ok": 3649, "total": 4002 } }, { "group1": { "count": 263510, "name": "t < 800 ms", "percentage": 17 }, "group2": { "count": 61762, "name": "800 ms < t < 1200 ms", "percentage": 4 }, "group3": { "count": 1082959, "name": "t > 1200 ms", "percentage": 70 }, "group4": { "count": 133182, "name": "failed", "percentage": 9 }, "maxResponseTime": { "ko": 60655, "ok": 59990, "total": 60655 }, "meanNumberOfRequestsPerSecond": { "ko": 35.30805938494168, "ok": 373.3380169671262, "total": 408.6460763520679 }, "meanResponseTime": { "ko": 3447, "ok": 4129, "total": 4070 }, "minResponseTime": { "ko": 14, "ok": 19, "total": 14 }, "name": "userAuthorize", "numberOfRequests": { "ko": 133182, "ok": 1408231, "total": 1541413 }, "percentiles1": { "ko": 3086, "ok": 3486, "total": 3441 }, "percentiles2": { "ko": 4284, "ok": 5877, "total": 5703 }, "percentiles3": { "ko": 9188, "ok": 11030, "total": 10931 }, "percentiles4": { "ko": 18699, "ok": 14933, "total": 15043 }, "spikes": [ { "datetime": "2022-11-04T04:23:44", "maxResponseTime": 2617 }, { "datetime": "2022-11-04T04:23:48", "maxResponseTime": 5371 }, { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 59922 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 56124 }, { "datetime": "2022-11-04T04:30:20", "maxResponseTime": 55741 }, { "datetime": "2022-11-04T04:37:38", "maxResponseTime": 41773 }, { "datetime": "2022-11-04T04:38:04", "maxResponseTime": 45787 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 35818 }, { "datetime": "2022-11-04T04:39:31", "maxResponseTime": 59990 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 58126 }, { "datetime": "2022-11-04T04:41:24", "maxResponseTime": 34889 }, { "datetime": "2022-11-04T04:42:32", "maxResponseTime": 59501 }, { "datetime": "2022-11-04T04:45:59", "maxResponseTime": 28794 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 56185 }, { "datetime": "2022-11-04T04:56:07", "maxResponseTime": 27050 }, { "datetime": "2022-11-04T04:57:56", "maxResponseTime": 54148 }, { "datetime": "2022-11-04T05:09:53", "maxResponseTime": 29272 } ], "standardDeviation": { "ko": 4742, "ok": 3624, "total": 3739 } }, { "group1": { "count": 202578, "name": "t < 800 ms", "percentage": 14 }, "group2": { "count": 43841, "name": "800 ms < t < 1200 ms", "percentage": 3 }, "group3": { "count": 1053833, "name": "t > 1200 ms", "percentage": 75 }, "group4": { "count": 107979, "name": "failed", "percentage": 8 }, "maxResponseTime": { "ko": 60680, "ok": 59952, "total": 60680 }, "meanNumberOfRequestsPerSecond": { "ko": 28.62645811240721, "ok": 344.711558854719, "total": 373.3380169671262 }, "meanResponseTime": { "ko": 3651, "ok": 4806, "total": 4718 }, "minResponseTime": { "ko": 13, "ok": 25, "total": 13 }, "name": "getAccessToken", "numberOfRequests": { "ko": 107979, "ok": 1300252, "total": 1408231 }, "percentiles1": { "ko": 2952, "ok": 4283, "total": 4165 }, "percentiles2": { "ko": 4777, "ok": 6739, "total": 6605 }, "percentiles3": { "ko": 10728, "ok": 12115, "total": 12061 }, "percentiles4": { "ko": 19903, "ok": 16045, "total": 16159 }, "spikes": [ { "datetime": "2022-11-04T04:23:44", "maxResponseTime": 3875 }, { "datetime": "2022-11-04T04:23:48", "maxResponseTime": 6452 }, { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 58903 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 56161 }, { "datetime": "2022-11-04T04:30:20", "maxResponseTime": 55971 }, { "datetime": "2022-11-04T04:34:25", "maxResponseTime": 59260 }, { "datetime": "2022-11-04T04:38:04", "maxResponseTime": 46202 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 39762 }, { "datetime": "2022-11-04T04:39:31", "maxResponseTime": 59952 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 59619 }, { "datetime": "2022-11-04T04:41:24", "maxResponseTime": 35639 }, { "datetime": "2022-11-04T04:42:32", "maxResponseTime": 59818 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 58722 }, { "datetime": "2022-11-04T04:52:39", "maxResponseTime": 54518 }, { "datetime": "2022-11-04T04:56:14", "maxResponseTime": 59820 }, { "datetime": "2022-11-04T05:10:05", "maxResponseTime": 30505 } ], "standardDeviation": { "ko": 5139, "ok": 3905, "total": 4025 } }, { "group1": { "count": 377196, "name": "t < 800 ms", "percentage": 29 }, "group2": { "count": 64033, "name": "800 ms < t < 1200 ms", "percentage": 5 }, "group3": { "count": 790691, "name": "t > 1200 ms", "percentage": 61 }, "group4": { "count": 68332, "name": "failed", "percentage": 5 }, "maxResponseTime": { "ko": 60009, "ok": 59986, "total": 60009 }, "meanNumberOfRequestsPerSecond": { "ko": 18.11558854718982, "ok": 326.59597030752917, "total": 344.711558854719 }, "meanResponseTime": { "ko": 2342, "ok": 3214, "total": 3168 }, "minResponseTime": { "ko": 14, "ok": 16, "total": 14 }, "name": "getTokenInfo", "numberOfRequests": { "ko": 68332, "ok": 1231920, "total": 1300252 }, "percentiles1": { "ko": 1740, "ok": 2415, "total": 2370 }, "percentiles2": { "ko": 3440, "ok": 4897, "total": 4802 }, "percentiles3": { "ko": 7818, "ok": 9960, "total": 9904 }, "percentiles4": { "ko": 14444, "ok": 13325, "total": 13358 }, "spikes": [ { "datetime": "2022-11-04T04:23:48", "maxResponseTime": 3441 }, { "datetime": "2022-11-04T04:27:08", "maxResponseTime": 59462 }, { "datetime": "2022-11-04T04:27:34", "maxResponseTime": 40878 }, { "datetime": "2022-11-04T04:30:24", "maxResponseTime": 56859 }, { "datetime": "2022-11-04T04:34:21", "maxResponseTime": 54632 }, { "datetime": "2022-11-04T04:35:37", "maxResponseTime": 40283 }, { "datetime": "2022-11-04T04:37:38", "maxResponseTime": 58240 }, { "datetime": "2022-11-04T04:39:01", "maxResponseTime": 36092 }, { "datetime": "2022-11-04T04:40:31", "maxResponseTime": 38237 }, { "datetime": "2022-11-04T04:41:24", "maxResponseTime": 34287 }, { "datetime": "2022-11-04T04:49:01", "maxResponseTime": 59986 }, { "datetime": "2022-11-04T04:51:54", "maxResponseTime": 26459 }, { "datetime": "2022-11-04T04:52:24", "maxResponseTime": 53758 }, { "datetime": "2022-11-04T04:54:29", "maxResponseTime": 58454 }, { "datetime": "2022-11-04T05:09:46", "maxResponseTime": 26835 } ], "standardDeviation": { "ko": 3623, "ok": 3272, "total": 3297 } }, { "group1": { "count": 0, "name": "t < 800 ms", "percentage": 0 }, "group2": { "count": 0, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 52, "name": "t > 1200 ms", "percentage": 96 }, "group4": { "count": 2, "name": "failed", "percentage": 4 }, "maxResponseTime": { "ko": 28, "ok": 7745, "total": 7745 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005302226935312832, "ok": 0.013785790031813362, "total": 0.014316012725344645 }, "meanResponseTime": { "ko": 22, "ok": 4443, "total": 4280 }, "minResponseTime": { "ko": 15, "ok": 1807, "total": 15 }, "name": "user", "numberOfRequests": { "ko": 2, "ok": 52, "total": 54 }, "percentiles1": { "ko": 22, "ok": 4162, "total": 4134 }, "percentiles2": { "ko": 25, "ok": 5053, "total": 5041 }, "percentiles3": { "ko": 27, "ok": 6399, "total": 6173 }, "percentiles4": { "ko": 28, "ok": 7704, "total": 7703 }, "spikes": [], "standardDeviation": { "ko": 7, "ok": 1061, "total": 1335 } } ], "global": { "group1": { "count": 1232555, "name": "t < 800 ms", "percentage": 19 }, "group2": { "count": 245509, "name": "800 ms < t < 1200 ms", "percentage": 4 }, "group3": { "count": 4003806, "name": "t > 1200 ms", "percentage": 62 }, "group4": { "count": 1017083, "name": "failed", "percentage": 16 }, "maxResponseTime": { "ko": 60680, "ok": 59990, "total": 60680 }, "meanNumberOfRequestsPerSecond": { "ko": 269.640243902439, "ok": 1453.3059384941675, "total": 1722.9461823966067 }, "meanResponseTime": { "ko": 6580, "ok": 3978, "total": 4385 }, "minResponseTime": { "ko": 13, "ok": 16, "total": 13 }, "name": "Global Information", "numberOfRequests": { "ko": 1017083, "ok": 5481870, "total": 6498953 }, "percentiles1": { "ko": 9018, "ok": 3346, "total": 3725 }, "percentiles2": { "ko": 9019, "ok": 5828, "total": 6771 }, "percentiles3": { "ko": 9021, "ok": 10896, "total": 10555 }, "percentiles4": { "ko": 13412, "ok": 14679, "total": 14572 }, "standardDeviation": { "ko": 4244, "ok": 3668, "total": 3881 } } }, "target_hostname": "openam-perf-100m-test.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [04/Nov/2022 05:36:36] Reporting_access-token-600 step15 : Remove gatling task's stdout file ________________________________________________________________________________ Deleting gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/05_AccessToken/06_access-token-600/stdout.txt Gatling stdout.txt has been deleted ________________________________________________________________________________ [04/Nov/2022 05:36:37] Reporting_access-token-600 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped