--Task-- name: Reporting_revoke-access-token-1000 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-700', 'Reporting_revoke-access-token-700', 'Reporting_access-token-800', 'Reporting_revoke-access-token-800', 'Reporting_access-token-900', 'Reporting_revoke-access-token-900', 'Reporting_access-token-1000'] options: {'task_name': 'revoke-access-token-1000'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [19/May/2023 03:53:25] Reporting_revoke-access-token-1000 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component [19/May/2023 03:53:25] - INFO: Timeout for this Task has changed to 1h (3600 seconds) [19/May/2023 03:53:25] - INFO: timeout was set to GatlingResultTask default, because it was unset Pod stdout file : /results/orders/Reporting_revoke-access-token-1000/stdout.txt Pod stderr file : /results/orders/Reporting_revoke-access-token-1000/stderr.txt Pod log : /results/orders/Reporting_revoke-access-token-1000 ________________________________________________________________________________ [19/May/2023 03:53:25] Reporting_revoke-access-token-1000 step1 : Write order for overseer to generate the report ________________________________________________________________________________ Order file : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/order.json { "name": "Reporting_revoke-access-token-1000", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh revoke-access-token-1000", "out-dir": "/results/orders/Reporting_revoke-access-token-1000" } ________________________________________________________________________________ [19/May/2023 03:53:25] Reporting_revoke-access-token-1000 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 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [19/May/2023 03:53:26] Reporting_revoke-access-token-1000 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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/order.json overseer-0-6d59df6649-vlgh6:/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 ________________________________________________________________________________ [19/May/2023 03:53:27] Reporting_revoke-access-token-1000 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) - 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 27 0 --:--:-- --:--:-- --:--:-- 27 ________________________________________________________________________________ [19/May/2023 03:54:04] Reporting_revoke-access-token-1000 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-6d59df6649-vlgh6 --- stderr --- Checking pod: overseer-0-6d59df6649-vlgh6 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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- bash -c 'if [ -f "/results/gatling/revoke-access-token-1000.tar.gz" ]; then echo "/results/gatling/revoke-access-token-1000.tar.gz file found"; exit 0; else echo "/results/gatling/revoke-access-token-1000.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/revoke-access-token-1000.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/revoke-access-token-1000.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-6d59df6649-vlgh6 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- du -k /results/gatling/revoke-access-token-1000.tar.gz [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 336 /results/gatling/revoke-access-token-1000.tar.gz --- stderr --- - Download file (size 336k) [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-6d59df6649-vlgh6 --- stderr --- source : /results/gatling/revoke-access-token-1000.tar.gz @ overseer-0-6d59df6649-vlgh6 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/revoke-access-token-1000.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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-6d59df6649-vlgh6:/results/gatling/revoke-access-token-1000.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/revoke-access-token-1000.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 --- ________________________________________________________________________________ [19/May/2023 03:54:09] Reporting_revoke-access-token-1000 step6 : Unzip the result ________________________________________________________________________________ [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/shared/revoke-access-token-1000.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/07_AccessToken/08_revoke-access-token-1000/gatling [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- --- stderr --- ________________________________________________________________________________ [19/May/2023 03:54:09] Reporting_revoke-access-token-1000 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-6d59df6649-vlgh6 --- stderr --- Checking pod: overseer-0-6d59df6649-vlgh6 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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- bash -c 'if [ -f "/results/orders/Reporting_revoke-access-token-1000/rc.txt" ]; then echo "/results/orders/Reporting_revoke-access-token-1000/rc.txt file found"; exit 0; else echo "/results/orders/Reporting_revoke-access-token-1000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_revoke-access-token-1000/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_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- du -k /results/orders/Reporting_revoke-access-token-1000/rc.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- source : /results/orders/Reporting_revoke-access-token-1000/rc.txt @ overseer-0-6d59df6649-vlgh6 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-6d59df6649-vlgh6:/results/orders/Reporting_revoke-access-token-1000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/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/08_Verification/16_Reporting_revoke-access-token-1000/rc.txt is small (1 lines), printing all lines: ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [19/May/2023 03:54:13] Reporting_revoke-access-token-1000 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [19/May/2023 03:54:13] Reporting_revoke-access-token-1000 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-6d59df6649-vlgh6 --- stderr --- Checking pod: overseer-0-6d59df6649-vlgh6 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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- bash -c 'if [ -f "/results/orders/Reporting_revoke-access-token-1000/stdout.txt" ]; then echo "/results/orders/Reporting_revoke-access-token-1000/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting_revoke-access-token-1000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_revoke-access-token-1000/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_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- du -k /results/orders/Reporting_revoke-access-token-1000/stdout.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- source : /results/orders/Reporting_revoke-access-token-1000/stdout.txt @ overseer-0-6d59df6649-vlgh6 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-6d59df6649-vlgh6:/results/orders/Reporting_revoke-access-token-1000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/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/08_Verification/16_Reporting_revoke-access-token-1000/stdout.txt is small (77 lines), printing all lines: ----- output ----- [cmd] /lodestar/clients/gatling/bin/gatling.sh -ro /results/gatling/revoke-access-token-1000/loadtest-20230519032911033 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 3657728 (OK=3657727 KO=1 ) > min response time 3 (OK=3 KO=11 ) > max response time 2741 (OK=2741 KO=11 ) > mean response time 99 (OK=99 KO=11 ) > std deviation 175 (OK=175 KO=0 ) > response time 50th percentile 36 (OK=36 KO=11 ) > response time 75th percentile 95 (OK=95 KO=11 ) > response time 95th percentile 416 (OK=416 KO=11 ) > response time 99th percentile 918 (OK=918 KO=11 ) > mean requests/sec 3928.816 (OK=3928.815 KO=0.001 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 3606209 ( 99%) > 800 ms <= t < 1200 ms 36030 ( 1%) > t ≥ 1200 ms 15488 ( 0%) > failed 1 ( 0%) ---- Errors -------------------------------------------------------------------- > status.find.is(200), but actually found 502 1 (100.0%) ================================================================================ Reports generated in 0s. Please open the following file: file:///results/gatling/revoke-access-token-1000/loadtest-20230519032911033/index.html ---------------------- [19/May/2023 04:54:02] Create tar file /results/gatling/revoke-access-token-1000.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/revoke-access-token-1000/loadtest-20230519032911033 RESULT_FOLDER=revoke-access-token-1000 RESULT_PATH=/results/gatling/revoke-access-token-1000 PWD=/results/gatling/revoke-access-token-1000/loadtest-20230519032911033 [cmd] tar -czvf /results/gatling/revoke-access-token-1000.tar.gz --exclude=simulation.log * index.html js/ js/jquery-3.5.1.min.js js/stats.json js/menu.js js/unpack.js js/ellipsis.js js/gatling.js js/stats.js js/all_sessions.js js/highcharts-more.js js/theme.js js/assertions.json js/bootstrap.min.js js/global_stats.json js/assertions.xml js/highstock.js req_getaccesstoken-362c1.html req_revoketoken-0966a.html req_userauthorize-f29d0.html req_userrestlogin-03b82.html style/ style/arrow_down.png style/stat-l-roue.png style/sorted-down.png style/sortable.png style/little_arrow_right.png style/bootstrap.min.css style/arrow_right_black.png style/arrow_right.png style/sorted-up.png style/stat-l-temps.png style/stat-fleche-bas.png style/logo-enterprise.svg style/logo.svg style/style.css style/arrow_down_black.png style/favicon.ico ________________________________________________________________________________ [19/May/2023 03:54:17] Reporting_revoke-access-token-1000 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [19/May/2023 03:54:17] Reporting_revoke-access-token-1000 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-6d59df6649-vlgh6 --- stderr --- Checking pod: overseer-0-6d59df6649-vlgh6 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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- bash -c 'if [ -f "/results/orders/Reporting_revoke-access-token-1000/stderr.txt" ]; then echo "/results/orders/Reporting_revoke-access-token-1000/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting_revoke-access-token-1000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_revoke-access-token-1000/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_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-6d59df6649-vlgh6 -i -- du -k /results/orders/Reporting_revoke-access-token-1000/stderr.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 0 /results/orders/Reporting_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- source : /results/orders/Reporting_revoke-access-token-1000/stderr.txt @ overseer-0-6d59df6649-vlgh6 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/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-6d59df6649-vlgh6 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-6d59df6649-vlgh6:/results/orders/Reporting_revoke-access-token-1000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/08_Verification/16_Reporting_revoke-access-token-1000/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/08_Verification/16_Reporting_revoke-access-token-1000/stderr.txt is small (0 lines), printing all lines: ----- output ----- ________________________________________________________________________________ [19/May/2023 03:54:21] Reporting_revoke-access-token-1000 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [19/May/2023 03:54:21] Reporting_revoke-access-token-1000 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 [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/07_AccessToken/08_revoke-access-token-1000/gatling/req_getaccesstoken-362c1.html - cannot check for spikes checking simulation request RevokeToken [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/07_AccessToken/08_revoke-access-token-1000/gatling/req_revoketoken-0966a.html - cannot check for spikes no spikes found ________________________________________________________________________________ [19/May/2023 03:54:21] Reporting_revoke-access-token-1000 step14 : Collect gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 3657728, "ok": 3657727, "ko": 1 }, "minResponseTime": { "total": 3, "ok": 3, "ko": 11 }, "maxResponseTime": { "total": 2741, "ok": 2741, "ko": 11 }, "meanResponseTime": { "total": 99, "ok": 99, "ko": 11 }, "standardDeviation": { "total": 175, "ok": 175, "ko": 0 }, "percentiles1": { "total": 36, "ok": 36, "ko": 11 }, "percentiles2": { "total": 95, "ok": 95, "ko": 11 }, "percentiles3": { "total": 416, "ok": 416, "ko": 11 }, "percentiles4": { "total": 918, "ok": 918, "ko": 11 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 3606209, "percentage": 99 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t \u2265 800 ms
t < 1200 ms", "count": 36030, "percentage": 1 }, "group3": { "name": "t \u2265 1200 ms", "htmlName": "t \u2265 1200 ms", "count": 15488, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 1, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 3928.816326530612, "ok": 3928.8152524167563, "ko": 0.0010741138560687433 } }, "details": [ { "name": "userRestLogin", "numberOfRequests": { "total": 914432, "ok": 914432, "ko": 0 }, "minResponseTime": { "total": 10, "ok": 10, "ko": 0 }, "maxResponseTime": { "total": 975, "ok": 975, "ko": 0 }, "meanResponseTime": { "total": 63, "ok": 63, "ko": 0 }, "standardDeviation": { "total": 75, "ok": 75, "ko": 0 }, "percentiles1": { "total": 35, "ok": 35, "ko": 0 }, "percentiles2": { "total": 68, "ok": 68, "ko": 0 }, "percentiles3": { "total": 217, "ok": 217, "ko": 0 }, "percentiles4": { "total": 400, "ok": 400, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 914395, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t \u2265 800 ms
t < 1200 ms", "count": 37, "percentage": 0 }, "group3": { "name": "t \u2265 1200 ms", "htmlName": "t \u2265 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 982.204081632653, "ok": 982.204081632653, "ko": 0 }, "spikes": [] }, { "name": "userAuthorize", "numberOfRequests": { "total": 914432, "ok": 914432, "ko": 0 }, "minResponseTime": { "total": 3, "ok": 3, "ko": 0 }, "maxResponseTime": { "total": 697, "ok": 697, "ko": 0 }, "meanResponseTime": { "total": 45, "ok": 45, "ko": 0 }, "standardDeviation": { "total": 71, "ok": 71, "ko": 0 }, "percentiles1": { "total": 18, "ok": 18, "ko": 0 }, "percentiles2": { "total": 47, "ok": 47, "ko": 0 }, "percentiles3": { "total": 190, "ok": 190, "ko": 0 }, "percentiles4": { "total": 373, "ok": 373, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 914432, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t \u2265 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t \u2265 1200 ms", "htmlName": "t \u2265 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 982.204081632653, "ok": 982.204081632653, "ko": 0 }, "spikes": [] }, { "name": "getAccessToken", "numberOfRequests": { "total": 914432, "ok": 914432, "ko": 0 }, "minResponseTime": { "total": 6, "ok": 6, "ko": 0 }, "maxResponseTime": { "total": 2741, "ok": 2741, "ko": 0 }, "meanResponseTime": { "total": 182, "ok": 182, "ko": 0 }, "standardDeviation": { "total": 261, "ok": 261, "ko": 0 }, "percentiles1": { "total": 75, "ok": 75, "ko": 0 }, "percentiles2": { "total": 221, "ok": 221, "ko": 0 }, "percentiles3": { "total": 714, "ok": 714, "ko": 0 }, "percentiles4": { "total": 1305, "ok": 1305, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 877841, "percentage": 96 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t \u2265 800 ms
t < 1200 ms", "count": 23919, "percentage": 3 }, "group3": { "name": "t \u2265 1200 ms", "htmlName": "t \u2265 1200 ms", "count": 12672, "percentage": 1 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 982.204081632653, "ok": 982.204081632653, "ko": 0 }, "spikes": [] }, { "name": "RevokeToken", "numberOfRequests": { "total": 914432, "ok": 914431, "ko": 1 }, "minResponseTime": { "total": 3, "ok": 3, "ko": 11 }, "maxResponseTime": { "total": 2339, "ok": 2339, "ko": 11 }, "meanResponseTime": { "total": 108, "ok": 108, "ko": 11 }, "standardDeviation": { "total": 183, "ok": 183, "ko": 0 }, "percentiles1": { "total": 34, "ok": 34, "ko": 11 }, "percentiles2": { "total": 111, "ok": 111, "ko": 11 }, "percentiles3": { "total": 479, "ok": 479, "ko": 11 }, "percentiles4": { "total": 927, "ok": 927, "ko": 11 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 899541, "percentage": 98 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t \u2265 800 ms
t < 1200 ms", "count": 12074, "percentage": 1 }, "group3": { "name": "t \u2265 1200 ms", "htmlName": "t \u2265 1200 ms", "count": 2816, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 1, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 982.204081632653, "ok": 982.203007518797, "ko": 0.0010741138560687433 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 3929, "avg_response_time": 99, "max_response_time": 2741, "min_response_time": 3, "num_requests": 3657728, "num_requests_pass": 3657727, "num_requests_percent_pass": 100.0 }, "options": "; simulation:com.forgerock.gatling.Loadtest; testCase:am.AMAccessToken; testMode:open; throughput:1000; duration:900", "stats": { "details": [ { "group1": { "count": 914395, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 37, "htmlName": "t \u2265 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t \u2265 1200 ms", "name": "t \u2265 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 975, "total": 975 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 982.204081632653, "total": 982.204081632653 }, "meanResponseTime": { "ko": 0, "ok": 63, "total": 63 }, "minResponseTime": { "ko": 0, "ok": 10, "total": 10 }, "name": "userRestLogin", "numberOfRequests": { "ko": 0, "ok": 914432, "total": 914432 }, "percentiles1": { "ko": 0, "ok": 35, "total": 35 }, "percentiles2": { "ko": 0, "ok": 68, "total": 68 }, "percentiles3": { "ko": 0, "ok": 217, "total": 217 }, "percentiles4": { "ko": 0, "ok": 400, "total": 400 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 75, "total": 75 } }, { "group1": { "count": 914432, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 0, "htmlName": "t \u2265 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t \u2265 1200 ms", "name": "t \u2265 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 697, "total": 697 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 982.204081632653, "total": 982.204081632653 }, "meanResponseTime": { "ko": 0, "ok": 45, "total": 45 }, "minResponseTime": { "ko": 0, "ok": 3, "total": 3 }, "name": "userAuthorize", "numberOfRequests": { "ko": 0, "ok": 914432, "total": 914432 }, "percentiles1": { "ko": 0, "ok": 18, "total": 18 }, "percentiles2": { "ko": 0, "ok": 47, "total": 47 }, "percentiles3": { "ko": 0, "ok": 190, "total": 190 }, "percentiles4": { "ko": 0, "ok": 373, "total": 373 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 71, "total": 71 } }, { "group1": { "count": 877841, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 96 }, "group2": { "count": 23919, "htmlName": "t \u2265 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 3 }, "group3": { "count": 12672, "htmlName": "t \u2265 1200 ms", "name": "t \u2265 1200 ms", "percentage": 1 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 2741, "total": 2741 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 982.204081632653, "total": 982.204081632653 }, "meanResponseTime": { "ko": 0, "ok": 182, "total": 182 }, "minResponseTime": { "ko": 0, "ok": 6, "total": 6 }, "name": "getAccessToken", "numberOfRequests": { "ko": 0, "ok": 914432, "total": 914432 }, "percentiles1": { "ko": 0, "ok": 75, "total": 75 }, "percentiles2": { "ko": 0, "ok": 221, "total": 221 }, "percentiles3": { "ko": 0, "ok": 714, "total": 714 }, "percentiles4": { "ko": 0, "ok": 1305, "total": 1305 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 261, "total": 261 } }, { "group1": { "count": 899541, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 98 }, "group2": { "count": 12074, "htmlName": "t \u2265 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 1 }, "group3": { "count": 2816, "htmlName": "t \u2265 1200 ms", "name": "t \u2265 1200 ms", "percentage": 0 }, "group4": { "count": 1, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 11, "ok": 2339, "total": 2339 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0010741138560687433, "ok": 982.203007518797, "total": 982.204081632653 }, "meanResponseTime": { "ko": 11, "ok": 108, "total": 108 }, "minResponseTime": { "ko": 11, "ok": 3, "total": 3 }, "name": "RevokeToken", "numberOfRequests": { "ko": 1, "ok": 914431, "total": 914432 }, "percentiles1": { "ko": 11, "ok": 34, "total": 34 }, "percentiles2": { "ko": 11, "ok": 111, "total": 111 }, "percentiles3": { "ko": 11, "ok": 479, "total": 479 }, "percentiles4": { "ko": 11, "ok": 927, "total": 927 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 183, "total": 183 } } ], "global": { "group1": { "count": 3606209, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99 }, "group2": { "count": 36030, "htmlName": "t \u2265 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 1 }, "group3": { "count": 15488, "htmlName": "t \u2265 1200 ms", "name": "t \u2265 1200 ms", "percentage": 0 }, "group4": { "count": 1, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 11, "ok": 2741, "total": 2741 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0010741138560687433, "ok": 3928.8152524167563, "total": 3928.816326530612 }, "meanResponseTime": { "ko": 11, "ok": 99, "total": 99 }, "minResponseTime": { "ko": 11, "ok": 3, "total": 3 }, "name": "All Requests", "numberOfRequests": { "ko": 1, "ok": 3657727, "total": 3657728 }, "percentiles1": { "ko": 11, "ok": 36, "total": 36 }, "percentiles2": { "ko": 11, "ok": 95, "total": 95 }, "percentiles3": { "ko": 11, "ok": 416, "total": 416 }, "percentiles4": { "ko": 11, "ok": 918, "total": 918 }, "standardDeviation": { "ko": 0, "ok": 175, "total": 175 } } }, "target_hostname": "xlou.iam.xlou-cdm.engineeringpit.com", "tool_name": "gatling" } ________________________________________________________________________________ [19/May/2023 03:54:21] Reporting_revoke-access-token-1000 step15 : Remove gatling task's stdout file ________________________________________________________________________________ Deleting gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/access_token/07_AccessToken/08_revoke-access-token-1000/stdout.txt Gatling stdout.txt has been deleted ________________________________________________________________________________ [19/May/2023 03:54:21] Reporting_revoke-access-token-1000 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped