--Task--
name: Reporting-login-tree-300
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-login-tree-10', 'Reporting-login-tree-50', 'Reporting-login-tree-100', 'Reporting-login-tree-150', 'Reporting-login-tree-200', 'Reporting-login-tree-250']
options: {'task_name': 'login-tree-300'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-02-13 14:55:47] Reporting-login-tree-300 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
[2024-02-13 14:55:47] - INFO: Timeout for this Task has changed to 4h (14400 seconds)
[2024-02-13 14:55:47] - INFO: timeout was set to GatlingResultTask default (half of global_duration or 3600 seconds (whatever is higher)), because it was unset
Pod stdout file : /results/orders/Reporting-login-tree-300/stdout.txt
Pod stderr file : /results/orders/Reporting-login-tree-300/stderr.txt
Pod log : /results/orders/Reporting-login-tree-300
________________________________________________________________________________
[2024-02-13 14:55:47] Reporting-login-tree-300 step1 : Write order for overseer to generate the report
________________________________________________________________________________
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/order.json
{
"name": "Reporting-login-tree-300",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-300 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-login-tree-300"
}
________________________________________________________________________________
[2024-02-13 14:55:47] Reporting-login-tree-300 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
[loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
[loop_until]: (max_time=120, interval=5, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
[loop_until]: OK (rc = 0)
--- stdout ---
WAITING
--- stderr ---
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
100 7 100 7 0 0 26 0 --:--:-- --:--:-- --:--:-- 26
________________________________________________________________________________
[2024-02-13 14:55:47] Reporting-login-tree-300 step3 : Send order to overseer
________________________________________________________________________________
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/order.json overseer-0-58754774cf-xhms5:/results/orders/order.json
[loop_until]: (max_time=180, interval=5, expected_rc=[0]
[loop_until]: OK (rc = 0)
--- stdout ---
--- stderr ---
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-02-13 14:55:49] Reporting-login-tree-300 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
[loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
[loop_until]: (max_time=14400, interval=5, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
[loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
[loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
[loop_until]: Function succeeded after 15s (rc=0) - expected pattern found
[loop_until]: OK (rc = 0)
--- stdout ---
WAITING
--- stderr ---
% Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33
________________________________________________________________________________
[2024-02-13 14:56:10] Reporting-login-tree-300 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
Checking pod: overseer-0-58754774cf-xhms5 for file exists, if not wait.
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- bash -c 'if [ -f "/results/gatling/login-tree-300.tar.gz" ]; then echo "/results/gatling/login-tree-300.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-300.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-300.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/login-tree-300.tar.gz file found
--- stderr ---
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- du -k /results/gatling/login-tree-300.tar.gz
[run_command]: OK (rc = 0 - expected to be in [0])
--- stdout ---
344 /results/gatling/login-tree-300.tar.gz
--- stderr ---
- Download file (size 344k)
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
source : /results/gatling/login-tree-300.tar.gz @ overseer-0-58754774cf-xhms5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-58754774cf-xhms5:/results/gatling/login-tree-300.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz
[loop_until]: (max_time=-1, interval=5, expected_rc=[0]
[loop_until]: OK (rc = 0)
--- stdout ---
tar: Removing leading `/' from member names
--- stderr ---
________________________________________________________________________________
[2024-02-13 14:56:14] Reporting-login-tree-300 step6 : Unzip the result
________________________________________________________________________________
[run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_scenario/07_login-tree-300/gatling
[run_command]: OK (rc = 0 - expected to be in [0])
--- stdout ---
--- stderr ---
________________________________________________________________________________
[2024-02-13 14:56:14] Reporting-login-tree-300 step7 : Print rc order
________________________________________________________________________________
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
Checking pod: overseer-0-58754774cf-xhms5 for file exists, if not wait.
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-300/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/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-login-tree-300/rc.txt file found
--- stderr ---
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- du -k /results/orders/Reporting-login-tree-300/rc.txt
[run_command]: OK (rc = 0 - expected to be in [0])
--- stdout ---
4 /results/orders/Reporting-login-tree-300/rc.txt
--- stderr ---
- Download file (size 4k)
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
source : /results/orders/Reporting-login-tree-300/rc.txt @ overseer-0-58754774cf-xhms5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/rc.txt
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-58754774cf-xhms5:/results/orders/Reporting-login-tree-300/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/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_login_tree/08_Verification/15_Reporting-login-tree-300/rc.txt is small (1 lines), printing all lines:
----- output -----
CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
________________________________________________________________________________
[2024-02-13 14:56:18] Reporting-login-tree-300 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-02-13 14:56:18] Reporting-login-tree-300 step9 : Print stdout order
________________________________________________________________________________
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
Checking pod: overseer-0-58754774cf-xhms5 for file exists, if not wait.
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-300/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/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-login-tree-300/stdout.txt file found
--- stderr ---
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- du -k /results/orders/Reporting-login-tree-300/stdout.txt
[run_command]: OK (rc = 0 - expected to be in [0])
--- stdout ---
4 /results/orders/Reporting-login-tree-300/stdout.txt
--- stderr ---
- Download file (size 4k)
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
source : /results/orders/Reporting-login-tree-300/stdout.txt @ overseer-0-58754774cf-xhms5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stdout.txt
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-58754774cf-xhms5:/results/orders/Reporting-login-tree-300/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/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_login_tree/08_Verification/15_Reporting-login-tree-300/stdout.txt is small (83 lines), printing all lines:
----- output -----
[cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-300/loadtest-20240213124036275 --extra-run-jvm-options -Xmx4G
GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling
Generating Gatling reports locally
Parsing log file(s)...
Parsing log file(s) done
Generating reports...
================================================================================
---- Global Information --------------------------------------------------------
> request count 1773259 (OK=1071493 KO=701766)
> min response time 32 (OK=38 KO=32 )
> max response time 65357 (OK=60000 KO=65357 )
> mean response time 12170 (OK=16579 KO=5438 )
> std deviation 13466 (OK=13158 KO=10901 )
> response time 50th percentile 8044 (OK=13435 KO=40 )
> response time 75th percentile 17804 (OK=23687 KO=7122 )
> response time 95th percentile 41396 (OK=44259 KO=26037 )
> response time 99th percentile 58414 (OK=54930 KO=60000 )
> mean requests/sec 479.648 (OK=289.828 KO=189.82)
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 71594 ( 4%)
> 800 ms <= t < 1200 ms 14504 ( 1%)
> t >= 1200 ms 985395 ( 56%)
> failed 701766 ( 40%)
---- Errors --------------------------------------------------------------------
> restLoginUsernamePasswordCallback: Failed to build request: No 480686 (40.65%)
attribute named 'callbacks' is defined
> status.find.is(200), but actually found 503 467466 (39.53%)
> status.find.is(200), but actually found 502 200500 (16.96%)
> Request timeout to openam-ema-perf-benchmark.forgeblocks.com/3 13669 ( 1.16%)
4.102.200.114:443 after 60000 ms
> status.find.is(200), but actually found 401 10921 ( 0.92%)
> status.find.is(200), but actually found 500 9210 ( 0.78%)
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/login-tree-300/loadtest-20240213124036275/index.html
----------------------
[13/Feb/2024 14:56:09] Create tar file /results/gatling/login-tree-300.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/login-tree-300/loadtest-20240213124036275
RESULT_FOLDER=login-tree-300
RESULT_PATH=/results/gatling/login-tree-300
PWD=/results/gatling/login-tree-300/loadtest-20240213124036275
[cmd] tar -czvf /results/gatling/login-tree-300.tar.gz --exclude=simulation.log *
index.html
js/
js/assertions.json
js/stats.js
js/all_sessions.js
js/highstock.js
js/theme.js
js/menu.js
js/highcharts-more.js
js/assertions.xml
js/gatling.js
js/ellipsis.js
js/jquery-3.5.1.min.js
js/stats.json
js/global_stats.json
js/bootstrap.min.js
js/unpack.js
req_restlogininitia-e2b9b.html
req_restloginprogre-9fc93.html
req_restloginuserna-d98ea.html
style/
style/stat-fleche-bas.png
style/bootstrap.min.css
style/arrow_right_black.png
style/sorted-up.png
style/style.css
style/arrow_down.png
style/stat-l-roue.png
style/sortable.png
style/logo.svg
style/sorted-down.png
style/arrow_right.png
style/logo-enterprise.svg
style/arrow_down_black.png
style/stat-l-temps.png
style/favicon.ico
style/little_arrow_right.png
________________________________________________________________________________
[2024-02-13 14:56:22] Reporting-login-tree-300 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-02-13 14:56:22] Reporting-login-tree-300 step11 : Print stderr order
________________________________________________________________________________
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
Checking pod: overseer-0-58754774cf-xhms5 for file exists, if not wait.
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-300/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/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-login-tree-300/stderr.txt file found
--- stderr ---
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-58754774cf-xhms5 --stdin -- du -k /results/orders/Reporting-login-tree-300/stderr.txt
[run_command]: OK (rc = 0 - expected to be in [0])
--- stdout ---
0 /results/orders/Reporting-login-tree-300/stderr.txt
--- stderr ---
- Download file (size 0k)
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
source : /results/orders/Reporting-login-tree-300/stderr.txt @ overseer-0-58754774cf-xhms5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stderr.txt
[loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
[loop_until]: (max_time=180, interval=10, expected_rc=[0]
[loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
[loop_until]: OK (rc = 0)
--- stdout ---
overseer-0-58754774cf-xhms5
--- stderr ---
[loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-58754774cf-xhms5:/results/orders/Reporting-login-tree-300/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/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_login_tree/08_Verification/15_Reporting-login-tree-300/stderr.txt is small (0 lines), printing all lines:
----- output -----
________________________________________________________________________________
[2024-02-13 14:56:25] Reporting-login-tree-300 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-02-13 14:56:25] Reporting-login-tree-300 step13 : Analyze graphs for spikes
________________________________________________________________________________
Analyze Gatling graphs for spikes
checking parameters
open overall stats JSON file
checking simulation request restLoginInitiate
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_scenario/07_login-tree-300/gatling/req_restlogininitia-e2b9b.html - cannot check for spikes
checking simulation request restLoginUsernamePasswordCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_scenario/07_login-tree-300/gatling/req_restloginuserna-d98ea.html - cannot check for spikes
checking simulation request restloginProgressiveProfileCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_scenario/07_login-tree-300/gatling/req_restloginprogre-9fc93.html - cannot check for spikes
no spikes found
________________________________________________________________________________
[2024-02-13 14:56:25] Reporting-login-tree-300 step14 : Collect gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 1773259,
"ok": 1071493,
"ko": 701766
},
"minResponseTime": {
"total": 32,
"ok": 38,
"ko": 32
},
"maxResponseTime": {
"total": 65357,
"ok": 60000,
"ko": 65357
},
"meanResponseTime": {
"total": 12170,
"ok": 16579,
"ko": 5438
},
"standardDeviation": {
"total": 13466,
"ok": 13158,
"ko": 10901
},
"percentiles1": {
"total": 8044,
"ok": 13435,
"ko": 40
},
"percentiles2": {
"total": 17804,
"ok": 23687,
"ko": 7122
},
"percentiles3": {
"total": 41396,
"ok": 44259,
"ko": 26037
},
"percentiles4": {
"total": 58414,
"ok": 54930,
"ko": 60000
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 71594,
"percentage": 4
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 14504,
"percentage": 1
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 985395,
"percentage": 56
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 701766,
"percentage": 40
},
"meanNumberOfRequestsPerSecond": {
"total": 479.64809304841765,
"ok": 289.8276981336219,
"ko": 189.82039491479577
}
},
"details": [
{
"name": "restLoginInitiate",
"numberOfRequests": {
"total": 1081985,
"ok": 601299,
"ko": 480686
},
"minResponseTime": {
"total": 35,
"ok": 38,
"ko": 35
},
"maxResponseTime": {
"total": 60015,
"ok": 59999,
"ko": 60015
},
"meanResponseTime": {
"total": 9371,
"ok": 14117,
"ko": 3435
},
"standardDeviation": {
"total": 11710,
"ok": 12446,
"ko": 7175
},
"percentiles1": {
"total": 5111,
"ok": 10985,
"ko": 40
},
"percentiles2": {
"total": 13670,
"ok": 21067,
"ko": 4042
},
"percentiles3": {
"total": 34851,
"ok": 40049,
"ko": 14705
},
"percentiles4": {
"total": 48855,
"ok": 51078,
"ko": 33751
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 60865,
"percentage": 6
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 11660,
"percentage": 1
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 528774,
"percentage": 49
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 480686,
"percentage": 44
},
"meanNumberOfRequestsPerSecond": {
"total": 292.66567487151747,
"ok": 162.64511766296997,
"ko": 130.02055720854747
},
"spikes": []
},
{
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"total": 601299,
"ok": 406629,
"ko": 194670
},
"minResponseTime": {
"total": 32,
"ok": 105,
"ko": 32
},
"maxResponseTime": {
"total": 65357,
"ok": 60000,
"ko": 65357
},
"meanResponseTime": {
"total": 16587,
"ok": 19646,
"ko": 10196
},
"standardDeviation": {
"total": 14955,
"ok": 13421,
"ko": 15945
},
"percentiles1": {
"total": 12655,
"ok": 16317,
"ko": 4036
},
"percentiles2": {
"total": 23978,
"ok": 27573,
"ko": 12040
},
"percentiles3": {
"total": 48695,
"ok": 47558,
"ko": 60000
},
"percentiles4": {
"total": 60000,
"ok": 56380,
"ko": 60000
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 9771,
"percentage": 2
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 2735,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 394123,
"percentage": 66
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 194670,
"percentage": 32
},
"meanNumberOfRequestsPerSecond": {
"total": 162.64511766296997,
"ok": 109.9889099269678,
"ko": 52.656207736002166
},
"spikes": []
},
{
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"total": 89975,
"ok": 63565,
"ko": 26410
},
"minResponseTime": {
"total": 32,
"ok": 153,
"ko": 32
},
"maxResponseTime": {
"total": 60033,
"ok": 59972,
"ko": 60033
},
"meanResponseTime": {
"total": 16309,
"ok": 20248,
"ko": 6828
},
"standardDeviation": {
"total": 13720,
"ok": 13040,
"ko": 10237
},
"percentiles1": {
"total": 13269,
"ok": 16834,
"ko": 4035
},
"percentiles2": {
"total": 22995,
"ok": 27850,
"ko": 8886
},
"percentiles3": {
"total": 45451,
"ok": 48010,
"ko": 27926
},
"percentiles4": {
"total": 57728,
"ok": 57694,
"ko": 60000
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 958,
"percentage": 1
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 109,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 62498,
"percentage": 69
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 26410,
"percentage": 29
},
"meanNumberOfRequestsPerSecond": {
"total": 24.337300513930213,
"ok": 17.193670543684068,
"ko": 7.143629970246145
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 480,
"avg_response_time": 12170,
"max_response_time": 60000,
"min_response_time": 38,
"num_requests": 1773259,
"num_requests_pass": 1071493,
"num_requests_percent_pass": 60.425
},
"options": "; testCase:idc.login; testMode:open; throughput:300; rampup-duration:30; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 60865,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 6
},
"group2": {
"count": 11660,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 1
},
"group3": {
"count": 528774,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 49
},
"group4": {
"count": 480686,
"htmlName": "failed",
"name": "failed",
"percentage": 44
},
"maxResponseTime": {
"ko": 60015,
"ok": 59999,
"total": 60015
},
"meanNumberOfRequestsPerSecond": {
"ko": 130.02055720854747,
"ok": 162.64511766296997,
"total": 292.66567487151747
},
"meanResponseTime": {
"ko": 3435,
"ok": 14117,
"total": 9371
},
"minResponseTime": {
"ko": 35,
"ok": 38,
"total": 35
},
"name": "restLoginInitiate",
"numberOfRequests": {
"ko": 480686,
"ok": 601299,
"total": 1081985
},
"percentiles1": {
"ko": 40,
"ok": 10985,
"total": 5111
},
"percentiles2": {
"ko": 4042,
"ok": 21067,
"total": 13670
},
"percentiles3": {
"ko": 14705,
"ok": 40049,
"total": 34851
},
"percentiles4": {
"ko": 33751,
"ok": 51078,
"total": 48855
},
"spikes": [],
"standardDeviation": {
"ko": 7175,
"ok": 12446,
"total": 11710
}
},
{
"group1": {
"count": 9771,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 2
},
"group2": {
"count": 2735,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 394123,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 66
},
"group4": {
"count": 194670,
"htmlName": "failed",
"name": "failed",
"percentage": 32
},
"maxResponseTime": {
"ko": 65357,
"ok": 60000,
"total": 65357
},
"meanNumberOfRequestsPerSecond": {
"ko": 52.656207736002166,
"ok": 109.9889099269678,
"total": 162.64511766296997
},
"meanResponseTime": {
"ko": 10196,
"ok": 19646,
"total": 16587
},
"minResponseTime": {
"ko": 32,
"ok": 105,
"total": 32
},
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"ko": 194670,
"ok": 406629,
"total": 601299
},
"percentiles1": {
"ko": 4036,
"ok": 16317,
"total": 12655
},
"percentiles2": {
"ko": 12040,
"ok": 27573,
"total": 23978
},
"percentiles3": {
"ko": 60000,
"ok": 47558,
"total": 48695
},
"percentiles4": {
"ko": 60000,
"ok": 56380,
"total": 60000
},
"spikes": [],
"standardDeviation": {
"ko": 15945,
"ok": 13421,
"total": 14955
}
},
{
"group1": {
"count": 958,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 1
},
"group2": {
"count": 109,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 62498,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 69
},
"group4": {
"count": 26410,
"htmlName": "failed",
"name": "failed",
"percentage": 29
},
"maxResponseTime": {
"ko": 60033,
"ok": 59972,
"total": 60033
},
"meanNumberOfRequestsPerSecond": {
"ko": 7.143629970246145,
"ok": 17.193670543684068,
"total": 24.337300513930213
},
"meanResponseTime": {
"ko": 6828,
"ok": 20248,
"total": 16309
},
"minResponseTime": {
"ko": 32,
"ok": 153,
"total": 32
},
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"ko": 26410,
"ok": 63565,
"total": 89975
},
"percentiles1": {
"ko": 4035,
"ok": 16834,
"total": 13269
},
"percentiles2": {
"ko": 8886,
"ok": 27850,
"total": 22995
},
"percentiles3": {
"ko": 27926,
"ok": 48010,
"total": 45451
},
"percentiles4": {
"ko": 60000,
"ok": 57694,
"total": 57728
},
"spikes": [],
"standardDeviation": {
"ko": 10237,
"ok": 13040,
"total": 13720
}
}
],
"global": {
"group1": {
"count": 71594,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 4
},
"group2": {
"count": 14504,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 1
},
"group3": {
"count": 985395,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 56
},
"group4": {
"count": 701766,
"htmlName": "failed",
"name": "failed",
"percentage": 40
},
"maxResponseTime": {
"ko": 65357,
"ok": 60000,
"total": 65357
},
"meanNumberOfRequestsPerSecond": {
"ko": 189.82039491479577,
"ok": 289.8276981336219,
"total": 479.64809304841765
},
"meanResponseTime": {
"ko": 5438,
"ok": 16579,
"total": 12170
},
"minResponseTime": {
"ko": 32,
"ok": 38,
"total": 32
},
"name": "All Requests",
"numberOfRequests": {
"ko": 701766,
"ok": 1071493,
"total": 1773259
},
"percentiles1": {
"ko": 40,
"ok": 13435,
"total": 8044
},
"percentiles2": {
"ko": 7122,
"ok": 23687,
"total": 17804
},
"percentiles3": {
"ko": 26037,
"ok": 44259,
"total": 41396
},
"percentiles4": {
"ko": 60000,
"ok": 54930,
"total": 58414
},
"standardDeviation": {
"ko": 10901,
"ok": 13158,
"total": 13466
}
}
},
"target_hostname": "openam-ema-perf-benchmark.forgeblocks.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-02-13 14:56:25] Reporting-login-tree-300 step15 : Remove gatling task's stdout file
________________________________________________________________________________
Cleanup of Gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_scenario/07_login-tree-300/stdout.txt
Compressing Gatling stdout.txt file..
________________________________________________________________________________
[2024-02-13 14:57:30] Reporting-login-tree-300 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped