--Task-- name: Reporting_access-token-400 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'] options: {'task_name': 'access-token-400'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [04/Nov/2022 05:31:54] Reporting_access-token-400 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component [04/Nov/2022 05:31:54] - INFO: Timeout for this Task has changed to 1h (3600 seconds) Pod stdout file : /results/orders/Reporting_access-token-400/stdout.txt Pod stderr file : /results/orders/Reporting_access-token-400/stderr.txt Pod log : /results/orders/Reporting_access-token-400 ________________________________________________________________________________ [04/Nov/2022 05:31:54] Reporting_access-token-400 step1 : Write order for overseer to generate the report ________________________________________________________________________________ Order file : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/04_Reporting_access-token-400/order.json { "name": "Reporting_access-token-400", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh access-token-400", "out-dir": "/results/orders/Reporting_access-token-400" } ________________________________________________________________________________ [04/Nov/2022 05:31:54] Reporting_access-token-400 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:31:54] Reporting_access-token-400 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/04_Reporting_access-token-400/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:31:56] Reporting_access-token-400 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 100 7 100 7 0 0 31 0 --:--:-- --:--:-- --:--:-- 31 ________________________________________________________________________________ [04/Nov/2022 05:33:10] Reporting_access-token-400 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-400.tar.gz" ]; then echo "/results/gatling/access-token-400.tar.gz file found"; exit 0; else echo "/results/gatling/access-token-400.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/access-token-400.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-400.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-400.tar.gz [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 300 /results/gatling/access-token-400.tar.gz --- stderr --- - Download file (size 300k) [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-400.tar.gz @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/access-token-400.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-400.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/access-token-400.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:33:14] Reporting_access-token-400 step6 : Unzip the result ________________________________________________________________________________ [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/access-token-400.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/05_AccessToken/04_access-token-400/gatling [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- --- stderr --- ________________________________________________________________________________ [04/Nov/2022 05:33:14] Reporting_access-token-400 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-400/rc.txt" ]; then echo "/results/orders/Reporting_access-token-400/rc.txt file found"; exit 0; else echo "/results/orders/Reporting_access-token-400/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_access-token-400/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-400/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-400/rc.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting_access-token-400/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-400/rc.txt @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/04_Reporting_access-token-400/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-400/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/04_Reporting_access-token-400/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/04_Reporting_access-token-400/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:33:18] Reporting_access-token-400 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [04/Nov/2022 05:33:18] Reporting_access-token-400 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-400/stdout.txt" ]; then echo "/results/orders/Reporting_access-token-400/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting_access-token-400/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_access-token-400/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-400/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-400/stdout.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting_access-token-400/stdout.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-400/stdout.txt @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/04_Reporting_access-token-400/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-400/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/04_Reporting_access-token-400/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/04_Reporting_access-token-400/stdout.txt is small (82 lines), printing all lines: ----- output ----- [cmd] /lodestar/clients/gatling/bin/gatling.sh -ro /results/gatling/access-token-400/loadtest-20221104022042220 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 5511123 (OK=5511121 KO=2 ) > min response time 15 (OK=15 KO=15 ) > max response time 7163 (OK=7163 KO=15 ) > mean response time 42 (OK=42 KO=15 ) > std deviation 26 (OK=26 KO=0 ) > response time 50th percentile 31 (OK=31 KO=15 ) > response time 75th percentile 71 (OK=71 KO=15 ) > response time 95th percentile 82 (OK=82 KO=15 ) > response time 99th percentile 96 (OK=96 KO=15 ) > mean requests/sec 1593.731 (OK=1593.731 KO=0.001 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 5511034 (100%) > 800 ms < t < 1200 ms 85 ( 0%) > t > 1200 ms 2 ( 0%) > failed 2 ( 0%) ---- Errors -------------------------------------------------------------------- > getTokenInfo: Failed to build request: Failed to build request 2 (50.00%) : j.u.NoSuchElementException: No attribute named 'access_token... > jsonPath($.access_token).find.exists preparation crashed: Jack 2 (50.00%) son failed to parse into a valid AST: c.f.j.c.JsonParseExcepti... ================================================================================ Reports generated in 0s. Please open the following file: /results/gatling/access-token-400/loadtest-20221104022042220/index.html ---------------------- [04/Nov/2022 05:33:09] Create tar file /results/gatling/access-token-400.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/access-token-400/loadtest-20221104022042220 RESULT_FOLDER=access-token-400 RESULT_PATH=/results/gatling/access-token-400 PWD=/results/gatling/access-token-400/loadtest-20221104022042220 [cmd] tar -czvf /results/gatling/access-token-400.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_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:33:22] Reporting_access-token-400 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [04/Nov/2022 05:33:22] Reporting_access-token-400 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-400/stderr.txt" ]; then echo "/results/orders/Reporting_access-token-400/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting_access-token-400/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_access-token-400/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-400/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-400/stderr.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 0 /results/orders/Reporting_access-token-400/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-400/stderr.txt @ overseer-0-779957466d-hs7t7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/04_Reporting_access-token-400/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-400/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/06_Verification/04_Reporting_access-token-400/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/04_Reporting_access-token-400/stderr.txt is small (0 lines), printing all lines: ----- output ----- ________________________________________________________________________________ [04/Nov/2022 05:33:26] Reporting_access-token-400 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [04/Nov/2022 05:33:26] Reporting_access-token-400 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 1 spikes found - see "spikes" sections in js/stats.json ________________________________________________________________________________ [04/Nov/2022 05:33:26] Reporting_access-token-400 step14 : Collect gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "Global Information", "numberOfRequests": { "total": 5511123, "ok": 5511121, "ko": 2 }, "minResponseTime": { "total": 15, "ok": 15, "ko": 15 }, "maxResponseTime": { "total": 7163, "ok": 7163, "ko": 15 }, "meanResponseTime": { "total": 42, "ok": 42, "ko": 15 }, "standardDeviation": { "total": 26, "ok": 26, "ko": 0 }, "percentiles1": { "total": 31, "ok": 31, "ko": 15 }, "percentiles2": { "total": 71, "ok": 71, "ko": 15 }, "percentiles3": { "total": 82, "ok": 82, "ko": 15 }, "percentiles4": { "total": 96, "ok": 96, "ko": 15 }, "group1": { "name": "t < 800 ms", "count": 5511034, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 85, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 2, "percentage": 0 }, "group4": { "name": "failed", "count": 2, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 1593.7313475997687, "ok": 1593.7307692307693, "ko": 0.000578368999421631 } }, "details": [ { "name": "userRestLogin", "numberOfRequests": { "total": 1377799, "ok": 1377799, "ko": 0 }, "minResponseTime": { "total": 61, "ok": 61, "ko": 0 }, "maxResponseTime": { "total": 7163, "ok": 7163, "ko": 0 }, "meanResponseTime": { "total": 79, "ok": 79, "ko": 0 }, "standardDeviation": { "total": 15, "ok": 15, "ko": 0 }, "percentiles1": { "total": 77, "ok": 77, "ko": 0 }, "percentiles2": { "total": 81, "ok": 81, "ko": 0 }, "percentiles3": { "total": 90, "ok": 90, "ko": 0 }, "percentiles4": { "total": 110, "ok": 110, "ko": 0 }, "group1": { "name": "t < 800 ms", "count": 1377719, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 78, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 2, "percentage": 0 }, "group4": { "name": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 398.4381145170619, "ok": 398.4381145170619, "ko": 0 }, "spikes": [ { "datetime": "2022-11-04T02:46:47", "maxResponseTime": 7163 } ] }, { "name": "userAuthorize", "numberOfRequests": { "total": 1377789, "ok": 1377789, "ko": 0 }, "minResponseTime": { "total": 18, "ok": 18, "ko": 0 }, "maxResponseTime": { "total": 997, "ok": 997, "ko": 0 }, "meanResponseTime": { "total": 28, "ok": 28, "ko": 0 }, "standardDeviation": { "total": 12, "ok": 12, "ko": 0 }, "percentiles1": { "total": 26, "ok": 26, "ko": 0 }, "percentiles2": { "total": 30, "ok": 30, "ko": 0 }, "percentiles3": { "total": 41, "ok": 41, "ko": 0 }, "percentiles4": { "total": 70, "ok": 70, "ko": 0 }, "group1": { "name": "t < 800 ms", "count": 1377787, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 2, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 398.43522267206475, "ok": 398.43522267206475, "ko": 0 }, "spikes": [] }, { "name": "getAccessToken", "numberOfRequests": { "total": 1377773, "ok": 1377771, "ko": 2 }, "minResponseTime": { "total": 15, "ok": 23, "ko": 15 }, "maxResponseTime": { "total": 832, "ok": 832, "ko": 15 }, "meanResponseTime": { "total": 37, "ok": 37, "ko": 15 }, "standardDeviation": { "total": 15, "ok": 15, "ko": 0 }, "percentiles1": { "total": 34, "ok": 34, "ko": 15 }, "percentiles2": { "total": 39, "ok": 39, "ko": 15 }, "percentiles3": { "total": 53, "ok": 53, "ko": 15 }, "percentiles4": { "total": 89, "ok": 89, "ko": 15 }, "group1": { "name": "t < 800 ms", "count": 1377769, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 2, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "count": 2, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 398.4305957200694, "ok": 398.43001735107, "ko": 0.000578368999421631 }, "spikes": [] }, { "name": "getTokenInfo", "numberOfRequests": { "total": 1377762, "ok": 1377762, "ko": 0 }, "minResponseTime": { "total": 15, "ok": 15, "ko": 0 }, "maxResponseTime": { "total": 1111, "ok": 1111, "ko": 0 }, "meanResponseTime": { "total": 22, "ok": 22, "ko": 0 }, "standardDeviation": { "total": 7, "ok": 7, "ko": 0 }, "percentiles1": { "total": 20, "ok": 20, "ko": 0 }, "percentiles2": { "total": 23, "ok": 23, "ko": 0 }, "percentiles3": { "total": 29, "ok": 29, "ko": 0 }, "percentiles4": { "total": 45, "ok": 45, "ko": 0 }, "group1": { "name": "t < 800 ms", "count": 1377759, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 3, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 398.42741469057256, "ok": 398.42741469057256, "ko": 0 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 1594, "avg_response_time": 42, "max_response_time": 7163, "min_response_time": 15, "num_requests": 5511123, "num_requests_pass": 5511121, "num_requests_percent_pass": 100.0 }, "options": "; testMode:open; simulation:com.forgerock.gatling.Loadtest; testCase:am.AMAccessToken; throughput:400; rampup-duration:30", "stats": { "details": [ { "group1": { "count": 1377719, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 78, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 2, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 0, "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 7163, "total": 7163 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 398.4381145170619, "total": 398.4381145170619 }, "meanResponseTime": { "ko": 0, "ok": 79, "total": 79 }, "minResponseTime": { "ko": 0, "ok": 61, "total": 61 }, "name": "userRestLogin", "numberOfRequests": { "ko": 0, "ok": 1377799, "total": 1377799 }, "percentiles1": { "ko": 0, "ok": 77, "total": 77 }, "percentiles2": { "ko": 0, "ok": 81, "total": 81 }, "percentiles3": { "ko": 0, "ok": 90, "total": 90 }, "percentiles4": { "ko": 0, "ok": 110, "total": 110 }, "spikes": [ { "datetime": "2022-11-04T02:46:47", "maxResponseTime": 7163 } ], "standardDeviation": { "ko": 0, "ok": 15, "total": 15 } }, { "group1": { "count": 1377787, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 2, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 0, "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 997, "total": 997 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 398.43522267206475, "total": 398.43522267206475 }, "meanResponseTime": { "ko": 0, "ok": 28, "total": 28 }, "minResponseTime": { "ko": 0, "ok": 18, "total": 18 }, "name": "userAuthorize", "numberOfRequests": { "ko": 0, "ok": 1377789, "total": 1377789 }, "percentiles1": { "ko": 0, "ok": 26, "total": 26 }, "percentiles2": { "ko": 0, "ok": 30, "total": 30 }, "percentiles3": { "ko": 0, "ok": 41, "total": 41 }, "percentiles4": { "ko": 0, "ok": 70, "total": 70 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 12, "total": 12 } }, { "group1": { "count": 1377769, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 2, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 2, "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 15, "ok": 832, "total": 832 }, "meanNumberOfRequestsPerSecond": { "ko": 0.000578368999421631, "ok": 398.43001735107, "total": 398.4305957200694 }, "meanResponseTime": { "ko": 15, "ok": 37, "total": 37 }, "minResponseTime": { "ko": 15, "ok": 23, "total": 15 }, "name": "getAccessToken", "numberOfRequests": { "ko": 2, "ok": 1377771, "total": 1377773 }, "percentiles1": { "ko": 15, "ok": 34, "total": 34 }, "percentiles2": { "ko": 15, "ok": 39, "total": 39 }, "percentiles3": { "ko": 15, "ok": 53, "total": 53 }, "percentiles4": { "ko": 15, "ok": 89, "total": 89 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 15, "total": 15 } }, { "group1": { "count": 1377759, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 3, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 0, "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 1111, "total": 1111 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 398.42741469057256, "total": 398.42741469057256 }, "meanResponseTime": { "ko": 0, "ok": 22, "total": 22 }, "minResponseTime": { "ko": 0, "ok": 15, "total": 15 }, "name": "getTokenInfo", "numberOfRequests": { "ko": 0, "ok": 1377762, "total": 1377762 }, "percentiles1": { "ko": 0, "ok": 20, "total": 20 }, "percentiles2": { "ko": 0, "ok": 23, "total": 23 }, "percentiles3": { "ko": 0, "ok": 29, "total": 29 }, "percentiles4": { "ko": 0, "ok": 45, "total": 45 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 7, "total": 7 } } ], "global": { "group1": { "count": 5511034, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 85, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 2, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 2, "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 15, "ok": 7163, "total": 7163 }, "meanNumberOfRequestsPerSecond": { "ko": 0.000578368999421631, "ok": 1593.7307692307693, "total": 1593.7313475997687 }, "meanResponseTime": { "ko": 15, "ok": 42, "total": 42 }, "minResponseTime": { "ko": 15, "ok": 15, "total": 15 }, "name": "Global Information", "numberOfRequests": { "ko": 2, "ok": 5511121, "total": 5511123 }, "percentiles1": { "ko": 15, "ok": 31, "total": 31 }, "percentiles2": { "ko": 15, "ok": 71, "total": 71 }, "percentiles3": { "ko": 15, "ok": 82, "total": 82 }, "percentiles4": { "ko": 15, "ok": 96, "total": 96 }, "standardDeviation": { "ko": 0, "ok": 26, "total": 26 } } }, "target_hostname": "openam-perf-100m-test.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [04/Nov/2022 05:33:26] Reporting_access-token-400 step15 : Remove gatling task's stdout file ________________________________________________________________________________ Deleting gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/05_AccessToken/04_access-token-400/stdout.txt Gatling stdout.txt has been deleted ________________________________________________________________________________ [04/Nov/2022 05:33:26] Reporting_access-token-400 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped