--Task-- name: Reporting_authn-users 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: [] options: {'task_name': 'authn-users'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [30/Aug/2022 22:12:25] Reporting_authn-users pre : N/A ________________________________________________________________________________ source (overseer-0) is a component [30/Aug/2022 22:12:25] - INFO: Timeout for this Task has changed to 1h (3600 seconds) Pod stdout file : /results/orders/Reporting_authn-users/stdout.txt Pod stderr file : /results/orders/Reporting_authn-users/stderr.txt Pod log : /results/orders/Reporting_authn-users ________________________________________________________________________________ [30/Aug/2022 22:12:25] Reporting_authn-users step1 : Write order for overseer to generate the report ________________________________________________________________________________ Order file : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/order.json { "name": "Reporting_authn-users", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh authn-users", "out-dir": "/results/orders/Reporting_authn-users" } ________________________________________________________________________________ [30/Aug/2022 22:12:25] Reporting_authn-users 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 ________________________________________________________________________________ [30/Aug/2022 22:12:26] Reporting_authn-users 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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/order.json overseer-0-758cf6894f-b87q8:/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 ________________________________________________________________________________ [30/Aug/2022 22:12:28] Reporting_authn-users 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) - 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 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [30/Aug/2022 22:13:25] Reporting_authn-users 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-758cf6894f-b87q8 --- stderr --- Checking pod: overseer-0-758cf6894f-b87q8 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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- bash -c 'if [ -f "/results/gatling/authn-users.tar.gz" ]; then echo "/results/gatling/authn-users.tar.gz file found"; exit 0; else echo "/results/gatling/authn-users.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/authn-users.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/authn-users.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-758cf6894f-b87q8 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- du -k /results/gatling/authn-users.tar.gz [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 256 /results/gatling/authn-users.tar.gz --- stderr --- - Download file (size 256k) [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-758cf6894f-b87q8 --- stderr --- source : /results/gatling/authn-users.tar.gz @ overseer-0-758cf6894f-b87q8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/shared/authn-users.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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-758cf6894f-b87q8:/results/gatling/authn-users.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/shared/authn-users.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 --- ________________________________________________________________________________ [30/Aug/2022 22:13:29] Reporting_authn-users step6 : Unzip the result ________________________________________________________________________________ [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/shared/authn-users.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/05_scenario/01_authn-users/gatling [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- --- stderr --- ________________________________________________________________________________ [30/Aug/2022 22:13:29] Reporting_authn-users 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-758cf6894f-b87q8 --- stderr --- Checking pod: overseer-0-758cf6894f-b87q8 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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- bash -c 'if [ -f "/results/orders/Reporting_authn-users/rc.txt" ]; then echo "/results/orders/Reporting_authn-users/rc.txt file found"; exit 0; else echo "/results/orders/Reporting_authn-users/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_authn-users/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_authn-users/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-758cf6894f-b87q8 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- du -k /results/orders/Reporting_authn-users/rc.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting_authn-users/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-758cf6894f-b87q8 --- stderr --- source : /results/orders/Reporting_authn-users/rc.txt @ overseer-0-758cf6894f-b87q8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-758cf6894f-b87q8:/results/orders/Reporting_authn-users/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/rc.txt [loop_until]: (max_time=-1, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- tar: Removing leading `/' from member names --- stderr --- [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/rc.txt is small (1 lines), printing all lines: ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [30/Aug/2022 22:13:33] Reporting_authn-users step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [30/Aug/2022 22:13:33] Reporting_authn-users 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-758cf6894f-b87q8 --- stderr --- Checking pod: overseer-0-758cf6894f-b87q8 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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- bash -c 'if [ -f "/results/orders/Reporting_authn-users/stdout.txt" ]; then echo "/results/orders/Reporting_authn-users/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting_authn-users/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_authn-users/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_authn-users/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-758cf6894f-b87q8 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- du -k /results/orders/Reporting_authn-users/stdout.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 4 /results/orders/Reporting_authn-users/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-758cf6894f-b87q8 --- stderr --- source : /results/orders/Reporting_authn-users/stdout.txt @ overseer-0-758cf6894f-b87q8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-758cf6894f-b87q8:/results/orders/Reporting_authn-users/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/stdout.txt [loop_until]: (max_time=-1, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- tar: Removing leading `/' from member names --- stderr --- [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/stdout.txt is small (84 lines), printing all lines: ----- output ----- [cmd] /lodestar/clients/gatling/bin/gatling.sh -ro /results/gatling/authn-users/loadtest-20220830211221868 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 2863054 (OK=2863048 KO=6 ) > min response time 2 (OK=19 KO=2 ) > max response time 7142 (OK=7142 KO=128 ) > mean response time 45 (OK=45 KO=54 ) > std deviation 22 (OK=22 KO=49 ) > response time 50th percentile 52 (OK=52 KO=34 ) > response time 75th percentile 64 (OK=64 KO=97 ) > response time 95th percentile 68 (OK=68 KO=124 ) > response time 99th percentile 74 (OK=74 KO=127 ) > mean requests/sec 796.62 (OK=796.619 KO=0.002 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 2863028 (100%) > 800 ms < t < 1200 ms 17 ( 0%) > t > 1200 ms 3 ( 0%) > failed 6 ( 0%) ---- Errors -------------------------------------------------------------------- > restloginProgressiveProfileCallback: Failed to build request: 2 (20.00%) No attribute named 'callbacks' is defined > j.n.c.ClosedChannelException 2 (20.00%) > status.find.is(200), but actually found 400 2 (20.00%) > status.find.is(200), but actually found 502 2 (20.00%) > restLoginUsernamePasswordCallback: Failed to build request: No 2 (20.00%) attribute named 'callbacks' is defined ================================================================================ Reports generated in 0s. Please open the following file: /results/gatling/authn-users/loadtest-20220830211221868/index.html ---------------------- [30/Aug/2022 23:13:21] Create tar file /results/gatling/authn-users.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/authn-users/loadtest-20220830211221868 RESULT_FOLDER=authn-users RESULT_PATH=/results/gatling/authn-users PWD=/results/gatling/authn-users/loadtest-20220830211221868 [cmd] tar -czvf /results/gatling/authn-users.tar.gz --exclude=simulation.log * index.html js/ js/gatling.js js/theme.js js/unpack.js js/menu.js js/assertions.xml js/jquery.min.js js/stats.json js/bootstrap.min.js js/stats.js js/highcharts-more.js js/global_stats.json js/moment.min.js js/all_sessions.js js/assertions.json js/highstock.js req_restlogininitia-e2b9b.html req_restloginprogre-9fc93.html req_restloginuserna-d98ea.html style/ style/arrow_down.png style/logo.png style/stat-fond.png style/stat-fleche-bas.png style/stat-l-roue.png style/cible.png style/sortable.png style/arrow_down_black.png style/style.css style/little_arrow_right.png style/stat-l-temps.png style/logo-gatling.jpg style/arrow_right.png style/sorted-up.png style/logo.svg style/bootstrap.min.css style/arrow_right_black.png style/sorted-down.png style/favicon.ico ________________________________________________________________________________ [30/Aug/2022 22:13:37] Reporting_authn-users step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [30/Aug/2022 22:13:37] Reporting_authn-users 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-758cf6894f-b87q8 --- stderr --- Checking pod: overseer-0-758cf6894f-b87q8 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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- bash -c 'if [ -f "/results/orders/Reporting_authn-users/stderr.txt" ]; then echo "/results/orders/Reporting_authn-users/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting_authn-users/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting_authn-users/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_authn-users/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-758cf6894f-b87q8 --- stderr --- [run_command]: kubectl --namespace=xlou exec overseer-0-758cf6894f-b87q8 -i -- du -k /results/orders/Reporting_authn-users/stderr.txt [run_command]: OK (rc = 0 - expected to be in [0]) --- stdout --- 0 /results/orders/Reporting_authn-users/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-758cf6894f-b87q8 --- stderr --- source : /results/orders/Reporting_authn-users/stderr.txt @ overseer-0-758cf6894f-b87q8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/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-758cf6894f-b87q8 --- stderr --- [loop_until]: kubectl --namespace=xlou cp overseer-0-758cf6894f-b87q8:/results/orders/Reporting_authn-users/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/stderr.txt [loop_until]: (max_time=-1, interval=5, expected_rc=[0] [loop_until]: OK (rc = 0) --- stdout --- tar: Removing leading `/' from member names --- stderr --- [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/06_Verification/04_Reporting_authn-users/stderr.txt is small (0 lines), printing all lines: ----- output ----- ________________________________________________________________________________ [30/Aug/2022 22:13:40] Reporting_authn-users step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [30/Aug/2022 22:13:40] Reporting_authn-users step13 : Analyze graphs for spikes ________________________________________________________________________________ Analyze Gatling graphs for spikes checking parameters open overall stats JSON file checking simulation request restLoginInitiate checking simulation request restLoginUsernamePasswordCallback checking simulation request restloginProgressiveProfileCallback 3 spikes found - see "spikes" sections in js/stats.json ________________________________________________________________________________ [30/Aug/2022 22:13:40] Reporting_authn-users step14 : Collect gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "Global Information", "numberOfRequests": { "total": 2863054, "ok": 2863048, "ko": 6 }, "minResponseTime": { "total": 2, "ok": 19, "ko": 2 }, "maxResponseTime": { "total": 7142, "ok": 7142, "ko": 128 }, "meanResponseTime": { "total": 45, "ok": 45, "ko": 54 }, "standardDeviation": { "total": 22, "ok": 22, "ko": 49 }, "percentiles1": { "total": 52, "ok": 52, "ko": 34 }, "percentiles2": { "total": 64, "ok": 64, "ko": 97 }, "percentiles3": { "total": 68, "ok": 68, "ko": 124 }, "percentiles4": { "total": 74, "ok": 74, "ko": 127 }, "group1": { "name": "t < 800 ms", "count": 2863028, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 17, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 3, "percentage": 0 }, "group4": { "name": "failed", "count": 6, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 796.6204785754035, "ok": 796.6188091263216, "ko": 0.001669449081803005 } }, "details": [ { "name": "restLoginInitiate", "numberOfRequests": { "total": 1431543, "ok": 1431541, "ko": 2 }, "minResponseTime": { "total": 14, "ok": 19, "ko": 2 }, "maxResponseTime": { "total": 7142, "ok": 7142, "ko": 50 }, "meanResponseTime": { "total": 24, "ok": 24, "ko": 26 }, "standardDeviation": { "total": 9, "ok": 9, "ko": 24 }, "percentiles1": { "total": 23, "ok": 23, "ko": 26 }, "percentiles2": { "total": 27, "ok": 27, "ko": 38 }, "percentiles3": { "total": 29, "ok": 29, "ko": 48 }, "percentiles4": { "total": 30, "ok": 30, "ko": 50 }, "group1": { "name": "t < 800 ms", "count": 1431533, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 6, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 2, "percentage": 0 }, "group4": { "name": "failed", "count": 2, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 398.3146911519199, "ok": 398.3141346688926, "ko": 0.0005564830272676684 }, "spikes": [ { "datetime": "2022-08-30T21:30:33", "maxResponseTime": 7142 }, { "datetime": "2022-08-30T22:09:09", "maxResponseTime": 7123 } ] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 1431509, "ok": 1431507, "ko": 2 }, "minResponseTime": { "total": 17, "ok": 54, "ko": 17 }, "maxResponseTime": { "total": 3149, "ok": 3149, "ko": 17 }, "meanResponseTime": { "total": 65, "ok": 65, "ko": 17 }, "standardDeviation": { "total": 9, "ok": 9, "ko": 0 }, "percentiles1": { "total": 64, "ok": 64, "ko": 17 }, "percentiles2": { "total": 66, "ok": 66, "ko": 17 }, "percentiles3": { "total": 70, "ok": 70, "ko": 17 }, "percentiles4": { "total": 78, "ok": 78, "ko": 17 }, "group1": { "name": "t < 800 ms", "count": 1431495, "percentage": 100 }, "group2": { "name": "800 ms < t < 1200 ms", "count": 11, "percentage": 0 }, "group3": { "name": "t > 1200 ms", "count": 1, "percentage": 0 }, "group4": { "name": "failed", "count": 2, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 398.30523094045634, "ok": 398.30467445742903, "ko": 0.0005564830272676684 }, "spikes": [ { "datetime": "2022-08-30T22:09:09", "maxResponseTime": 3149 } ] }, { "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "total": 2, "ok": 0, "ko": 2 }, "minResponseTime": { "total": 112, "ok": 0, "ko": 112 }, "maxResponseTime": { "total": 128, "ok": 0, "ko": 128 }, "meanResponseTime": { "total": 120, "ok": 0, "ko": 120 }, "standardDeviation": { "total": 8, "ok": 0, "ko": 8 }, "percentiles1": { "total": 120, "ok": 0, "ko": 120 }, "percentiles2": { "total": 124, "ok": 0, "ko": 124 }, "percentiles3": { "total": 127, "ok": 0, "ko": 127 }, "percentiles4": { "total": 128, "ok": 0, "ko": 128 }, "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": 0, "percentage": 0 }, "group4": { "name": "failed", "count": 2, "percentage": 100 }, "meanNumberOfRequestsPerSecond": { "total": 0.0005564830272676684, "ok": 0, "ko": 0.0005564830272676684 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 797, "avg_response_time": 45, "max_response_time": 7142, "min_response_time": 19, "num_requests": 2863054, "num_requests_pass": 2863048, "num_requests_percent_pass": 100.0 }, "options": "; simulation:com.forgerock.gatling.Loadtest; testCase:idc.login; testMode:open; throughput:400; rampup-duration:30", "stats": { "details": [ { "group1": { "count": 1431533, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 6, "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": 50, "ok": 7142, "total": 7142 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005564830272676684, "ok": 398.3141346688926, "total": 398.3146911519199 }, "meanResponseTime": { "ko": 26, "ok": 24, "total": 24 }, "minResponseTime": { "ko": 2, "ok": 19, "total": 14 }, "name": "restLoginInitiate", "numberOfRequests": { "ko": 2, "ok": 1431541, "total": 1431543 }, "percentiles1": { "ko": 26, "ok": 23, "total": 23 }, "percentiles2": { "ko": 38, "ok": 27, "total": 27 }, "percentiles3": { "ko": 48, "ok": 29, "total": 29 }, "percentiles4": { "ko": 50, "ok": 30, "total": 30 }, "spikes": [ { "datetime": "2022-08-30T21:30:33", "maxResponseTime": 7142 }, { "datetime": "2022-08-30T22:09:09", "maxResponseTime": 7123 } ], "standardDeviation": { "ko": 24, "ok": 9, "total": 9 } }, { "group1": { "count": 1431495, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 11, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 1, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 2, "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 17, "ok": 3149, "total": 3149 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005564830272676684, "ok": 398.30467445742903, "total": 398.30523094045634 }, "meanResponseTime": { "ko": 17, "ok": 65, "total": 65 }, "minResponseTime": { "ko": 17, "ok": 54, "total": 17 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 2, "ok": 1431507, "total": 1431509 }, "percentiles1": { "ko": 17, "ok": 64, "total": 64 }, "percentiles2": { "ko": 17, "ok": 66, "total": 66 }, "percentiles3": { "ko": 17, "ok": 70, "total": 70 }, "percentiles4": { "ko": 17, "ok": 78, "total": 78 }, "spikes": [ { "datetime": "2022-08-30T22:09:09", "maxResponseTime": 3149 } ], "standardDeviation": { "ko": 0, "ok": 9, "total": 9 } }, { "group1": { "count": 0, "name": "t < 800 ms", "percentage": 0 }, "group2": { "count": 0, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 2, "name": "failed", "percentage": 100 }, "maxResponseTime": { "ko": 128, "ok": 0, "total": 128 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005564830272676684, "ok": 0, "total": 0.0005564830272676684 }, "meanResponseTime": { "ko": 120, "ok": 0, "total": 120 }, "minResponseTime": { "ko": 112, "ok": 0, "total": 112 }, "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "ko": 2, "ok": 0, "total": 2 }, "percentiles1": { "ko": 120, "ok": 0, "total": 120 }, "percentiles2": { "ko": 124, "ok": 0, "total": 124 }, "percentiles3": { "ko": 127, "ok": 0, "total": 127 }, "percentiles4": { "ko": 128, "ok": 0, "total": 128 }, "spikes": [], "standardDeviation": { "ko": 8, "ok": 0, "total": 8 } } ], "global": { "group1": { "count": 2863028, "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 17, "name": "800 ms < t < 1200 ms", "percentage": 0 }, "group3": { "count": 3, "name": "t > 1200 ms", "percentage": 0 }, "group4": { "count": 6, "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 128, "ok": 7142, "total": 7142 }, "meanNumberOfRequestsPerSecond": { "ko": 0.001669449081803005, "ok": 796.6188091263216, "total": 796.6204785754035 }, "meanResponseTime": { "ko": 54, "ok": 45, "total": 45 }, "minResponseTime": { "ko": 2, "ok": 19, "total": 2 }, "name": "Global Information", "numberOfRequests": { "ko": 6, "ok": 2863048, "total": 2863054 }, "percentiles1": { "ko": 34, "ok": 52, "total": 52 }, "percentiles2": { "ko": 97, "ok": 64, "total": 64 }, "percentiles3": { "ko": 124, "ok": 68, "total": 68 }, "percentiles4": { "ko": 127, "ok": 74, "total": 74 }, "standardDeviation": { "ko": 49, "ok": 22, "total": 22 } } }, "target_hostname": "openam-perf-100m-testing.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [30/Aug/2022 22:13:40] Reporting_authn-users step15 : Remove gatling task's stdout file ________________________________________________________________________________ Deleting gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_am_authn/05_scenario/01_authn-users/stdout.txt Gatling stdout.txt has been deleted ________________________________________________________________________________ [30/Aug/2022 22:13:40] Reporting_authn-users post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped