--Task--
name: Reporting-login-tree-200
enabled: True
class_name: GatlingResultTask
source_name: overseer-0
source_namespace: >default<
target_name: overseer-0
target_namespace: >default<
start: 0.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-180']
preceding_task: None
options: {'task_name': 'login-tree-200'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-06-13 06:13:03] Reporting-login-tree-200 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
2024-06-13 06:13:03 - INFO: Timeout for this Task has changed to 3h (10800 seconds)
2024-06-13 06:13:03 - 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-200/stdout.txt
Pod stderr file : /results/orders/Reporting-login-tree-200/stderr.txt
Pod log : /results/orders/Reporting-login-tree-200
________________________________________________________________________________
[2024-06-13 06:13:03] Reporting-login-tree-200 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-06-13 06:13:03,177 INFO
2024-06-13 06:13:03,177 INFO [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
2024-06-13 06:13:03,177 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:03,496 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:03,496 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:03,496 DEBUG --- stdout ---
2024-06-13 06:13:03,497 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:03,497 DEBUG --- stderr ---
2024-06-13 06:13:03,497 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/order.json
{
"name": "Reporting-login-tree-200",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-200 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-login-tree-200"
}
________________________________________________________________________________
[2024-06-13 06:13:03] Reporting-login-tree-200 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-06-13 06:13:03,498 INFO
2024-06-13 06:13:03,498 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-13 06:13:03,498 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-06-13 06:13:03,736 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:13:03,736 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:03,736 DEBUG --- stdout ---
2024-06-13 06:13:03,736 DEBUG WAITING
2024-06-13 06:13:03,736 DEBUG --- stderr ---
2024-06-13 06:13:03,736 DEBUG % 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 32 0 --:--:-- --:--:-- --:--:-- 32
________________________________________________________________________________
[2024-06-13 06:13:03] Reporting-login-tree-200 step3 : Send order to overseer
________________________________________________________________________________
2024-06-13 06:13:03,737 INFO
2024-06-13 06:13:03,737 INFO [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
2024-06-13 06:13:03,737 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:04,036 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:04,037 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:04,037 DEBUG --- stdout ---
2024-06-13 06:13:04,037 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:04,037 DEBUG --- stderr ---
2024-06-13 06:13:04,037 DEBUG
2024-06-13 06:13:04,037 INFO
2024-06-13 06:13:04,037 INFO [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/14_Reporting-login-tree-200/order.json overseer-0-6c7d65494f-sln6z:/results/orders/order.json
2024-06-13 06:13:04,037 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:13:05,418 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:05,418 DEBUG --- stdout ---
2024-06-13 06:13:05,418 DEBUG
2024-06-13 06:13:05,418 DEBUG --- stderr ---
2024-06-13 06:13:05,418 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-06-13 06:13:05] Reporting-login-tree-200 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-06-13 06:13:10,424 INFO
2024-06-13 06:13:10,424 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-13 06:13:10,426 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0]
2024-06-13 06:13:10,666 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-06-13 06:13:15,905 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-06-13 06:13:21,141 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
2024-06-13 06:13:26,383 INFO [loop_until]: Function succeeded after 15s (rc=0) - expected pattern found
2024-06-13 06:13:26,383 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:26,385 DEBUG --- stdout ---
2024-06-13 06:13:26,385 DEBUG WAITING
2024-06-13 06:13:26,385 DEBUG --- stderr ---
2024-06-13 06:13:26,385 DEBUG % 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
________________________________________________________________________________
[2024-06-13 06:13:26] Reporting-login-tree-200 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-06-13 06:13:26,387 INFO
2024-06-13 06:13:26,387 INFO [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
2024-06-13 06:13:26,387 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:26,695 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:26,695 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:26,695 DEBUG --- stdout ---
2024-06-13 06:13:26,695 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:26,695 DEBUG --- stderr ---
2024-06-13 06:13:26,695 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:13:26,695 INFO
2024-06-13 06:13:26,695 INFO [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
2024-06-13 06:13:26,695 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:26,994 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:26,994 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:26,994 DEBUG --- stdout ---
2024-06-13 06:13:26,994 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:26,994 DEBUG --- stderr ---
2024-06-13 06:13:26,995 DEBUG
2024-06-13 06:13:26,995 INFO
2024-06-13 06:13:26,995 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/gatling/login-tree-200.tar.gz" ]; then echo "/results/gatling/login-tree-200.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-200.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-200.tar.gz file found"
2024-06-13 06:13:26,995 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:13:27,793 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:13:27,793 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:27,793 DEBUG --- stdout ---
2024-06-13 06:13:27,793 DEBUG /results/gatling/login-tree-200.tar.gz file found
2024-06-13 06:13:27,793 DEBUG --- stderr ---
2024-06-13 06:13:27,793 DEBUG
2024-06-13 06:13:27,794 INFO
2024-06-13 06:13:27,794 INFO [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
2024-06-13 06:13:27,794 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:28,092 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:28,092 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:28,092 DEBUG --- stdout ---
2024-06-13 06:13:28,092 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:28,092 DEBUG --- stderr ---
2024-06-13 06:13:28,092 DEBUG
2024-06-13 06:13:28,092 INFO
2024-06-13 06:13:28,093 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/gatling/login-tree-200.tar.gz
2024-06-13 06:13:28,892 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:13:28,892 DEBUG --- stdout ---
2024-06-13 06:13:28,892 DEBUG 452 /results/gatling/login-tree-200.tar.gz
2024-06-13 06:13:28,892 DEBUG --- stderr ---
2024-06-13 06:13:28,892 DEBUG
2024-06-13 06:13:28,893 INFO
- Download file (size 452k)
2024-06-13 06:13:28,893 INFO
2024-06-13 06:13:28,893 INFO [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
2024-06-13 06:13:28,893 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:29,197 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:29,197 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:29,197 DEBUG --- stdout ---
2024-06-13 06:13:29,197 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:29,197 DEBUG --- stderr ---
2024-06-13 06:13:29,197 DEBUG
source : /results/gatling/login-tree-200.tar.gz @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-200.tar.gz
2024-06-13 06:13:29,198 INFO
2024-06-13 06:13:29,198 INFO [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
2024-06-13 06:13:29,198 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:29,511 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:29,511 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:29,511 DEBUG --- stdout ---
2024-06-13 06:13:29,512 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:29,512 DEBUG --- stderr ---
2024-06-13 06:13:29,512 DEBUG
2024-06-13 06:13:29,512 INFO
2024-06-13 06:13:29,512 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/gatling/login-tree-200.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-200.tar.gz
2024-06-13 06:13:29,512 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:13:30,652 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:30,653 DEBUG --- stdout ---
2024-06-13 06:13:30,653 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:13:30,653 DEBUG --- stderr ---
2024-06-13 06:13:30,653 DEBUG
________________________________________________________________________________
[2024-06-13 06:13:30] Reporting-login-tree-200 step6 : Unzip the result
________________________________________________________________________________
2024-06-13 06:13:30,654 INFO
2024-06-13 06:13:30,654 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-200.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-200/gatling
2024-06-13 06:13:30,681 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:13:30,682 DEBUG --- stdout ---
2024-06-13 06:13:30,682 DEBUG
2024-06-13 06:13:30,682 DEBUG --- stderr ---
2024-06-13 06:13:30,682 DEBUG
2024-06-13 06:13:30,682 INFO
________________________________________________________________________________
[2024-06-13 06:13:30] Reporting-login-tree-200 step7 : Print rc order
________________________________________________________________________________
2024-06-13 06:13:30,684 INFO
2024-06-13 06:13:30,684 INFO [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
2024-06-13 06:13:30,684 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:30,983 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:30,983 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:30,983 DEBUG --- stdout ---
2024-06-13 06:13:30,983 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:30,983 DEBUG --- stderr ---
2024-06-13 06:13:30,983 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:13:30,984 INFO
2024-06-13 06:13:30,984 INFO [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
2024-06-13 06:13:30,984 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:31,277 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:31,277 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:31,277 DEBUG --- stdout ---
2024-06-13 06:13:31,277 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:31,277 DEBUG --- stderr ---
2024-06-13 06:13:31,277 DEBUG
2024-06-13 06:13:31,278 INFO
2024-06-13 06:13:31,278 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-200/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-200/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-200/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-200/rc.txt file found"
2024-06-13 06:13:31,278 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:13:32,075 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:13:32,075 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:32,077 DEBUG --- stdout ---
2024-06-13 06:13:32,077 DEBUG /results/orders/Reporting-login-tree-200/rc.txt file found
2024-06-13 06:13:32,077 DEBUG --- stderr ---
2024-06-13 06:13:32,077 DEBUG
2024-06-13 06:13:32,078 INFO
2024-06-13 06:13:32,078 INFO [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
2024-06-13 06:13:32,078 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:32,387 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:32,387 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:32,387 DEBUG --- stdout ---
2024-06-13 06:13:32,387 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:32,387 DEBUG --- stderr ---
2024-06-13 06:13:32,387 DEBUG
2024-06-13 06:13:32,388 INFO
2024-06-13 06:13:32,388 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/orders/Reporting-login-tree-200/rc.txt
2024-06-13 06:13:33,197 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:13:33,198 DEBUG --- stdout ---
2024-06-13 06:13:33,198 DEBUG 4 /results/orders/Reporting-login-tree-200/rc.txt
2024-06-13 06:13:33,198 DEBUG --- stderr ---
2024-06-13 06:13:33,198 DEBUG
2024-06-13 06:13:33,198 INFO
- Download file (size 4k)
2024-06-13 06:13:33,198 INFO
2024-06-13 06:13:33,198 INFO [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
2024-06-13 06:13:33,198 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:33,496 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:33,496 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:33,496 DEBUG --- stdout ---
2024-06-13 06:13:33,496 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:33,496 DEBUG --- stderr ---
2024-06-13 06:13:33,496 DEBUG
source : /results/orders/Reporting-login-tree-200/rc.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/rc.txt
2024-06-13 06:13:33,496 INFO
2024-06-13 06:13:33,497 INFO [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
2024-06-13 06:13:33,497 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:33,792 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:33,792 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:33,792 DEBUG --- stdout ---
2024-06-13 06:13:33,792 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:33,792 DEBUG --- stderr ---
2024-06-13 06:13:33,792 DEBUG
2024-06-13 06:13:33,793 INFO
2024-06-13 06:13:33,793 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/orders/Reporting-login-tree-200/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/rc.txt
2024-06-13 06:13:33,793 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:13:34,513 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:34,514 DEBUG --- stdout ---
2024-06-13 06:13:34,514 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:13:34,514 DEBUG --- stderr ---
2024-06-13 06:13:34,514 DEBUG
2024-06-13 06:13:34,514 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/rc.txt is small (1 lines), printing all lines:
2024-06-13 06:13:34,514 DEBUG ----- output -----
2024-06-13 06:13:34,514 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-06-13 06:13:34,514 INFO
________________________________________________________________________________
[2024-06-13 06:13:34] Reporting-login-tree-200 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-06-13 06:13:34] Reporting-login-tree-200 step9 : Print stdout order
________________________________________________________________________________
2024-06-13 06:13:34,516 INFO
2024-06-13 06:13:34,516 INFO [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
2024-06-13 06:13:34,516 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:34,812 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:34,812 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:34,812 DEBUG --- stdout ---
2024-06-13 06:13:34,812 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:34,812 DEBUG --- stderr ---
2024-06-13 06:13:34,812 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:13:34,812 INFO
2024-06-13 06:13:34,812 INFO [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
2024-06-13 06:13:34,812 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:35,108 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:35,109 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:35,109 DEBUG --- stdout ---
2024-06-13 06:13:35,109 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:35,109 DEBUG --- stderr ---
2024-06-13 06:13:35,109 DEBUG
2024-06-13 06:13:35,109 INFO
2024-06-13 06:13:35,110 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-200/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-200/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-200/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-200/stdout.txt file found"
2024-06-13 06:13:35,110 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:13:35,905 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:13:35,905 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:35,905 DEBUG --- stdout ---
2024-06-13 06:13:35,905 DEBUG /results/orders/Reporting-login-tree-200/stdout.txt file found
2024-06-13 06:13:35,905 DEBUG --- stderr ---
2024-06-13 06:13:35,905 DEBUG
2024-06-13 06:13:35,906 INFO
2024-06-13 06:13:35,906 INFO [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
2024-06-13 06:13:35,906 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:36,211 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:36,212 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:36,212 DEBUG --- stdout ---
2024-06-13 06:13:36,212 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:36,212 DEBUG --- stderr ---
2024-06-13 06:13:36,212 DEBUG
2024-06-13 06:13:36,212 INFO
2024-06-13 06:13:36,212 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/orders/Reporting-login-tree-200/stdout.txt
2024-06-13 06:13:37,013 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:13:37,013 DEBUG --- stdout ---
2024-06-13 06:13:37,013 DEBUG 8 /results/orders/Reporting-login-tree-200/stdout.txt
2024-06-13 06:13:37,014 DEBUG --- stderr ---
2024-06-13 06:13:37,014 DEBUG
2024-06-13 06:13:37,014 INFO
- Download file (size 8k)
2024-06-13 06:13:37,014 INFO
2024-06-13 06:13:37,014 INFO [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
2024-06-13 06:13:37,014 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:37,347 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:37,348 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:37,349 DEBUG --- stdout ---
2024-06-13 06:13:37,349 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:37,349 DEBUG --- stderr ---
2024-06-13 06:13:37,349 DEBUG
source : /results/orders/Reporting-login-tree-200/stdout.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/stdout.txt
2024-06-13 06:13:37,350 INFO
2024-06-13 06:13:37,350 INFO [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
2024-06-13 06:13:37,350 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:37,648 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:37,649 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:37,649 DEBUG --- stdout ---
2024-06-13 06:13:37,649 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:37,649 DEBUG --- stderr ---
2024-06-13 06:13:37,649 DEBUG
2024-06-13 06:13:37,649 INFO
2024-06-13 06:13:37,649 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/orders/Reporting-login-tree-200/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/stdout.txt
2024-06-13 06:13:37,649 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:13:38,418 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:38,418 DEBUG --- stdout ---
2024-06-13 06:13:38,418 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:13:38,418 DEBUG --- stderr ---
2024-06-13 06:13:38,418 DEBUG
2024-06-13 06:13:38,418 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/stdout.txt is small (91 lines), printing all lines:
2024-06-13 06:13:38,418 DEBUG ----- output -----
2024-06-13 06:13:38,418 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-200/loadtest-20240613050439256 --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 2974179 (OK=2538314 KO=435865)
> min response time 88 (OK=97 KO=88 )
> max response time 49253 (OK=49253 KO=46011 )
> mean response time 4680 (OK=5335 KO=861 )
> std deviation 3765 (OK=3454 KO=3188 )
> response time 50th percentile 4322 (OK=5087 KO=98 )
> response time 75th percentile 7412 (OK=7749 KO=100 )
> response time 95th percentile 10292 (OK=10400 KO=7918 )
> response time 99th percentile 13443 (OK=13564 KO=12119 )
> mean requests/sec 815.514 (OK=696.001 KO=119.513)
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 193152 ( 6%)
> 800 ms <= t < 1200 ms 89050 ( 3%)
> t >= 1200 ms 2256112 ( 76%)
> failed 435865 ( 15%)
---- Errors --------------------------------------------------------------------
> status.find.is(200), but actually found 503 399083 (58.75%)
> restLoginUsernamePasswordCallback: Failed to build request: No 60860 ( 8.96%)
attribute named 'callbacks' is defined
> restloginProgressiveProfileCallback: Failed to build request: 60860 ( 8.96%)
No attribute named 'callbacks' is defined
> PingOneProtectEvaluationCallback: Failed to build request: No 60860 ( 8.96%)
attribute named 'callbacks' is defined
> PingOneProtectInitializeCallback: Failed to build request: No 60860 ( 8.96%)
attribute named 'callbacks' is defined
> status.find.is(200), but actually found 401 14892 ( 2.19%)
> status.find.is(200), but actually found 502 13637 ( 2.01%)
> jsonPath($.tokenId).find.exists, found nothing 7035 ( 1.04%)
> status.find.is(200), but actually found 400 1213 ( 0.18%)
> j.i.IOException: Premature close 5 ( 0.00%)
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/login-tree-200/loadtest-20240613050439256/index.html
----------------------
[13/Jun/2024 07:13:21] Create tar file /results/gatling/login-tree-200.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/login-tree-200/loadtest-20240613050439256
RESULT_FOLDER=login-tree-200
RESULT_PATH=/results/gatling/login-tree-200
PWD=/results/gatling/login-tree-200/loadtest-20240613050439256
[cmd] tar -czvf /results/gatling/login-tree-200.tar.gz --exclude=simulation.log *
index.html
js/
js/bootstrap.min.js
js/ellipsis.js
js/assertions.xml
js/menu.js
js/jquery-3.5.1.min.js
js/global_stats.json
js/stats.js
js/gatling.js
js/all_sessions.js
js/highstock.js
js/stats.json
js/highcharts-more.js
js/unpack.js
js/assertions.json
js/theme.js
req_pingoneprotecte-ee094.html
req_pingoneprotecti-dd6e3.html
req_protectloginini-66072.html
req_restloginprogre-9fc93.html
req_restloginuserna-d98ea.html
style/
style/arrow_right_black.png
style/style.css
style/arrow_down_black.png
style/bootstrap.min.css
style/sortable.png
style/arrow_down.png
style/favicon.ico
style/little_arrow_right.png
style/sorted-down.png
style/stat-fleche-bas.png
style/logo-enterprise.svg
style/stat-l-temps.png
style/logo.svg
style/arrow_right.png
style/stat-l-roue.png
style/sorted-up.png
2024-06-13 06:13:38,418 INFO
________________________________________________________________________________
[2024-06-13 06:13:38] Reporting-login-tree-200 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-06-13 06:13:38] Reporting-login-tree-200 step11 : Print stderr order
________________________________________________________________________________
2024-06-13 06:13:38,420 INFO
2024-06-13 06:13:38,420 INFO [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
2024-06-13 06:13:38,420 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:38,716 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:38,716 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:38,716 DEBUG --- stdout ---
2024-06-13 06:13:38,716 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:38,716 DEBUG --- stderr ---
2024-06-13 06:13:38,716 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:13:38,716 INFO
2024-06-13 06:13:38,717 INFO [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
2024-06-13 06:13:38,717 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:39,015 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:39,015 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:39,015 DEBUG --- stdout ---
2024-06-13 06:13:39,015 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:39,015 DEBUG --- stderr ---
2024-06-13 06:13:39,015 DEBUG
2024-06-13 06:13:39,016 INFO
2024-06-13 06:13:39,016 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-200/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-200/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-200/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-200/stderr.txt file found"
2024-06-13 06:13:39,016 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:13:39,819 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:13:39,819 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:39,819 DEBUG --- stdout ---
2024-06-13 06:13:39,819 DEBUG /results/orders/Reporting-login-tree-200/stderr.txt file found
2024-06-13 06:13:39,819 DEBUG --- stderr ---
2024-06-13 06:13:39,819 DEBUG
2024-06-13 06:13:39,819 INFO
2024-06-13 06:13:39,820 INFO [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
2024-06-13 06:13:39,820 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:40,128 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:40,129 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:40,129 DEBUG --- stdout ---
2024-06-13 06:13:40,129 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:40,129 DEBUG --- stderr ---
2024-06-13 06:13:40,129 DEBUG
2024-06-13 06:13:40,129 INFO
2024-06-13 06:13:40,129 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/orders/Reporting-login-tree-200/stderr.txt
2024-06-13 06:13:40,935 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:13:40,935 DEBUG --- stdout ---
2024-06-13 06:13:40,935 DEBUG 0 /results/orders/Reporting-login-tree-200/stderr.txt
2024-06-13 06:13:40,935 DEBUG --- stderr ---
2024-06-13 06:13:40,935 DEBUG
2024-06-13 06:13:40,935 INFO
- Download file (size 0k)
2024-06-13 06:13:40,936 INFO
2024-06-13 06:13:40,936 INFO [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
2024-06-13 06:13:40,936 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:41,234 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:41,234 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:41,234 DEBUG --- stdout ---
2024-06-13 06:13:41,234 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:41,234 DEBUG --- stderr ---
2024-06-13 06:13:41,234 DEBUG
source : /results/orders/Reporting-login-tree-200/stderr.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/stderr.txt
2024-06-13 06:13:41,235 INFO
2024-06-13 06:13:41,235 INFO [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
2024-06-13 06:13:41,235 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:13:41,530 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:13:41,530 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:41,530 DEBUG --- stdout ---
2024-06-13 06:13:41,531 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:13:41,531 DEBUG --- stderr ---
2024-06-13 06:13:41,531 DEBUG
2024-06-13 06:13:41,531 INFO
2024-06-13 06:13:41,531 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/orders/Reporting-login-tree-200/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/stderr.txt
2024-06-13 06:13:41,531 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:13:42,252 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:13:42,253 DEBUG --- stdout ---
2024-06-13 06:13:42,253 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:13:42,253 DEBUG --- stderr ---
2024-06-13 06:13:42,253 DEBUG
2024-06-13 06:13:42,253 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-200/stderr.txt is small (0 lines), printing all lines:
2024-06-13 06:13:42,253 DEBUG ----- output -----
2024-06-13 06:13:42,253 DEBUG
2024-06-13 06:13:42,253 INFO
________________________________________________________________________________
[2024-06-13 06:13:42] Reporting-login-tree-200 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-06-13 06:13:42] Reporting-login-tree-200 step13 : Analyze graphs for spikes
________________________________________________________________________________
Analyze Gatling graphs for spikes
checking parameters
open overall stats JSON file
checking simulation request protectLoginInitiate
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-200/gatling/req_protectloginini-66072.html - cannot check for spikes
checking simulation request PingOneProtectInitializeCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-200/gatling/req_pingoneprotecti-dd6e3.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_scenario/06_login-tree-200/gatling/req_restloginuserna-d98ea.html - cannot check for spikes
checking simulation request PingOneProtectEvaluationCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-200/gatling/req_pingoneprotecte-ee094.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_scenario/06_login-tree-200/gatling/req_restloginprogre-9fc93.html - cannot check for spikes
no spikes found
________________________________________________________________________________
[2024-06-13 06:13:42] Reporting-login-tree-200 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 2974179,
"ok": 2538314,
"ko": 435865
},
"minResponseTime": {
"total": 88,
"ok": 97,
"ko": 88
},
"maxResponseTime": {
"total": 49253,
"ok": 49253,
"ko": 46011
},
"meanResponseTime": {
"total": 4680,
"ok": 5335,
"ko": 861
},
"standardDeviation": {
"total": 3765,
"ok": 3454,
"ko": 3188
},
"percentiles1": {
"total": 4322,
"ok": 5087,
"ko": 98
},
"percentiles2": {
"total": 7412,
"ok": 7749,
"ko": 100
},
"percentiles3": {
"total": 10292,
"ok": 10400,
"ko": 7918
},
"percentiles4": {
"total": 13443,
"ok": 13564,
"ko": 12119
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 193152,
"percentage": 6
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 89050,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 2256112,
"percentage": 76
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 435865,
"percentage": 15
},
"meanNumberOfRequestsPerSecond": {
"total": 815.5138469975323,
"ok": 696.0005483959419,
"ko": 119.51329860159035
}
},
"details": [
{
"name": "protectLoginInitiate",
"numberOfRequests": {
"total": 722902,
"ok": 662042,
"ko": 60860
},
"minResponseTime": {
"total": 91,
"ok": 100,
"ko": 91
},
"maxResponseTime": {
"total": 42961,
"ok": 42961,
"ko": 33688
},
"meanResponseTime": {
"total": 4564,
"ok": 4913,
"ko": 760
},
"standardDeviation": {
"total": 3529,
"ok": 3415,
"ko": 2280
},
"percentiles1": {
"total": 4195,
"ok": 4634,
"ko": 97
},
"percentiles2": {
"total": 7160,
"ok": 7352,
"ko": 98
},
"percentiles3": {
"total": 9781,
"ok": 9845,
"ko": 4142
},
"percentiles4": {
"total": 12786,
"ok": 13100,
"ko": 12100
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 71188,
"percentage": 10
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 25867,
"percentage": 4
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 564987,
"percentage": 78
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 60860,
"percentage": 8
},
"meanNumberOfRequestsPerSecond": {
"total": 198.21826158486428,
"ok": 181.53057307375926,
"ko": 16.68768851110502
},
"spikes": []
},
{
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"total": 662042,
"ok": 622117,
"ko": 39925
},
"minResponseTime": {
"total": 88,
"ok": 97,
"ko": 88
},
"maxResponseTime": {
"total": 43873,
"ok": 43873,
"ko": 29981
},
"meanResponseTime": {
"total": 4949,
"ok": 5244,
"ko": 348
},
"standardDeviation": {
"total": 3440,
"ok": 3316,
"ko": 1551
},
"percentiles1": {
"total": 4726,
"ok": 5061,
"ko": 99
},
"percentiles2": {
"total": 7542,
"ok": 7688,
"ko": 100
},
"percentiles3": {
"total": 10093,
"ok": 10152,
"ko": 105
},
"percentiles4": {
"total": 11987,
"ok": 12018,
"ko": 8101
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 50341,
"percentage": 8
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 20616,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 551160,
"percentage": 83
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 39925,
"percentage": 6
},
"meanNumberOfRequestsPerSecond": {
"total": 181.53057307375926,
"ok": 170.58321908417878,
"ko": 10.947353989580478
},
"spikes": []
},
{
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"total": 662042,
"ok": 585551,
"ko": 76491
},
"minResponseTime": {
"total": 88,
"ok": 105,
"ko": 88
},
"maxResponseTime": {
"total": 43605,
"ok": 43605,
"ko": 33698
},
"meanResponseTime": {
"total": 4825,
"ok": 5421,
"ko": 265
},
"standardDeviation": {
"total": 3566,
"ok": 3332,
"ko": 1234
},
"percentiles1": {
"total": 4571,
"ok": 5240,
"ko": 99
},
"percentiles2": {
"total": 7597,
"ok": 7894,
"ko": 100
},
"percentiles3": {
"total": 10206,
"ok": 10333,
"ko": 102
},
"percentiles4": {
"total": 12099,
"ok": 12247,
"ko": 6180
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 41032,
"percentage": 6
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 18510,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 526009,
"percentage": 79
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 76491,
"percentage": 12
},
"meanNumberOfRequestsPerSecond": {
"total": 181.53057307375926,
"ok": 160.556896078969,
"ko": 20.97367699479024
},
"spikes": []
},
{
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"total": 662042,
"ok": 539833,
"ko": 122209
},
"minResponseTime": {
"total": 88,
"ok": 106,
"ko": 88
},
"maxResponseTime": {
"total": 49253,
"ok": 49253,
"ko": 46011
},
"meanResponseTime": {
"total": 5132,
"ok": 5983,
"ko": 1375
},
"standardDeviation": {
"total": 4351,
"ok": 3773,
"ko": 4726
},
"percentiles1": {
"total": 4700,
"ok": 5583,
"ko": 99
},
"percentiles2": {
"total": 7949,
"ok": 8388,
"ko": 100
},
"percentiles3": {
"total": 11230,
"ok": 11326,
"ko": 10490
},
"percentiles4": {
"total": 16538,
"ok": 15996,
"ko": 27807
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 19871,
"percentage": 3
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 18666,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 501296,
"percentage": 76
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 122209,
"percentage": 18
},
"meanNumberOfRequestsPerSecond": {
"total": 181.53057307375926,
"ok": 148.021113243762,
"ko": 33.509459829997255
},
"spikes": []
},
{
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"total": 265151,
"ok": 128771,
"ko": 136380
},
"minResponseTime": {
"total": 88,
"ok": 171,
"ko": 88
},
"maxResponseTime": {
"total": 48394,
"ok": 48394,
"ko": 40305
},
"meanResponseTime": {
"total": 2828,
"ok": 4839,
"ko": 929
},
"standardDeviation": {
"total": 3511,
"ok": 2995,
"ko": 2842
},
"percentiles1": {
"total": 714,
"ok": 4538,
"ko": 99
},
"percentiles2": {
"total": 5302,
"ok": 7133,
"ko": 100
},
"percentiles3": {
"total": 9344,
"ok": 9826,
"ko": 8118
},
"percentiles4": {
"total": 11302,
"ok": 11428,
"ko": 11021
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 10720,
"percentage": 4
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 5391,
"percentage": 2
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 112660,
"percentage": 42
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 136380,
"percentage": 51
},
"meanNumberOfRequestsPerSecond": {
"total": 72.70386619139019,
"ok": 35.30874691527283,
"ko": 37.395119276117356
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 816,
"avg_response_time": 4680,
"max_response_time": 49253,
"min_response_time": 97,
"num_requests": 2974179,
"num_requests_pass": 2538314,
"num_requests_percent_pass": 85.345
},
"options": "; testCase:idc.loginProtect; testMode:open; throughput:200; rampup-duration:30; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 71188,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 10
},
"group2": {
"count": 25867,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 4
},
"group3": {
"count": 564987,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 78
},
"group4": {
"count": 60860,
"htmlName": "failed",
"name": "failed",
"percentage": 8
},
"maxResponseTime": {
"ko": 33688,
"ok": 42961,
"total": 42961
},
"meanNumberOfRequestsPerSecond": {
"ko": 16.68768851110502,
"ok": 181.53057307375926,
"total": 198.21826158486428
},
"meanResponseTime": {
"ko": 760,
"ok": 4913,
"total": 4564
},
"minResponseTime": {
"ko": 91,
"ok": 100,
"total": 91
},
"name": "protectLoginInitiate",
"numberOfRequests": {
"ko": 60860,
"ok": 662042,
"total": 722902
},
"percentiles1": {
"ko": 97,
"ok": 4634,
"total": 4195
},
"percentiles2": {
"ko": 98,
"ok": 7352,
"total": 7160
},
"percentiles3": {
"ko": 4142,
"ok": 9845,
"total": 9781
},
"percentiles4": {
"ko": 12100,
"ok": 13100,
"total": 12786
},
"spikes": [],
"standardDeviation": {
"ko": 2280,
"ok": 3415,
"total": 3529
}
},
{
"group1": {
"count": 50341,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 8
},
"group2": {
"count": 20616,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 551160,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 83
},
"group4": {
"count": 39925,
"htmlName": "failed",
"name": "failed",
"percentage": 6
},
"maxResponseTime": {
"ko": 29981,
"ok": 43873,
"total": 43873
},
"meanNumberOfRequestsPerSecond": {
"ko": 10.947353989580478,
"ok": 170.58321908417878,
"total": 181.53057307375926
},
"meanResponseTime": {
"ko": 348,
"ok": 5244,
"total": 4949
},
"minResponseTime": {
"ko": 88,
"ok": 97,
"total": 88
},
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"ko": 39925,
"ok": 622117,
"total": 662042
},
"percentiles1": {
"ko": 99,
"ok": 5061,
"total": 4726
},
"percentiles2": {
"ko": 100,
"ok": 7688,
"total": 7542
},
"percentiles3": {
"ko": 105,
"ok": 10152,
"total": 10093
},
"percentiles4": {
"ko": 8101,
"ok": 12018,
"total": 11987
},
"spikes": [],
"standardDeviation": {
"ko": 1551,
"ok": 3316,
"total": 3440
}
},
{
"group1": {
"count": 41032,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 6
},
"group2": {
"count": 18510,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 526009,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 79
},
"group4": {
"count": 76491,
"htmlName": "failed",
"name": "failed",
"percentage": 12
},
"maxResponseTime": {
"ko": 33698,
"ok": 43605,
"total": 43605
},
"meanNumberOfRequestsPerSecond": {
"ko": 20.97367699479024,
"ok": 160.556896078969,
"total": 181.53057307375926
},
"meanResponseTime": {
"ko": 265,
"ok": 5421,
"total": 4825
},
"minResponseTime": {
"ko": 88,
"ok": 105,
"total": 88
},
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"ko": 76491,
"ok": 585551,
"total": 662042
},
"percentiles1": {
"ko": 99,
"ok": 5240,
"total": 4571
},
"percentiles2": {
"ko": 100,
"ok": 7894,
"total": 7597
},
"percentiles3": {
"ko": 102,
"ok": 10333,
"total": 10206
},
"percentiles4": {
"ko": 6180,
"ok": 12247,
"total": 12099
},
"spikes": [],
"standardDeviation": {
"ko": 1234,
"ok": 3332,
"total": 3566
}
},
{
"group1": {
"count": 19871,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 3
},
"group2": {
"count": 18666,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 501296,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 76
},
"group4": {
"count": 122209,
"htmlName": "failed",
"name": "failed",
"percentage": 18
},
"maxResponseTime": {
"ko": 46011,
"ok": 49253,
"total": 49253
},
"meanNumberOfRequestsPerSecond": {
"ko": 33.509459829997255,
"ok": 148.021113243762,
"total": 181.53057307375926
},
"meanResponseTime": {
"ko": 1375,
"ok": 5983,
"total": 5132
},
"minResponseTime": {
"ko": 88,
"ok": 106,
"total": 88
},
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"ko": 122209,
"ok": 539833,
"total": 662042
},
"percentiles1": {
"ko": 99,
"ok": 5583,
"total": 4700
},
"percentiles2": {
"ko": 100,
"ok": 8388,
"total": 7949
},
"percentiles3": {
"ko": 10490,
"ok": 11326,
"total": 11230
},
"percentiles4": {
"ko": 27807,
"ok": 15996,
"total": 16538
},
"spikes": [],
"standardDeviation": {
"ko": 4726,
"ok": 3773,
"total": 4351
}
},
{
"group1": {
"count": 10720,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 4
},
"group2": {
"count": 5391,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 2
},
"group3": {
"count": 112660,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 42
},
"group4": {
"count": 136380,
"htmlName": "failed",
"name": "failed",
"percentage": 51
},
"maxResponseTime": {
"ko": 40305,
"ok": 48394,
"total": 48394
},
"meanNumberOfRequestsPerSecond": {
"ko": 37.395119276117356,
"ok": 35.30874691527283,
"total": 72.70386619139019
},
"meanResponseTime": {
"ko": 929,
"ok": 4839,
"total": 2828
},
"minResponseTime": {
"ko": 88,
"ok": 171,
"total": 88
},
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"ko": 136380,
"ok": 128771,
"total": 265151
},
"percentiles1": {
"ko": 99,
"ok": 4538,
"total": 714
},
"percentiles2": {
"ko": 100,
"ok": 7133,
"total": 5302
},
"percentiles3": {
"ko": 8118,
"ok": 9826,
"total": 9344
},
"percentiles4": {
"ko": 11021,
"ok": 11428,
"total": 11302
},
"spikes": [],
"standardDeviation": {
"ko": 2842,
"ok": 2995,
"total": 3511
}
}
],
"global": {
"group1": {
"count": 193152,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 6
},
"group2": {
"count": 89050,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 2256112,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 76
},
"group4": {
"count": 435865,
"htmlName": "failed",
"name": "failed",
"percentage": 15
},
"maxResponseTime": {
"ko": 46011,
"ok": 49253,
"total": 49253
},
"meanNumberOfRequestsPerSecond": {
"ko": 119.51329860159035,
"ok": 696.0005483959419,
"total": 815.5138469975323
},
"meanResponseTime": {
"ko": 861,
"ok": 5335,
"total": 4680
},
"minResponseTime": {
"ko": 88,
"ok": 97,
"total": 88
},
"name": "All Requests",
"numberOfRequests": {
"ko": 435865,
"ok": 2538314,
"total": 2974179
},
"percentiles1": {
"ko": 98,
"ok": 5087,
"total": 4322
},
"percentiles2": {
"ko": 100,
"ok": 7749,
"total": 7412
},
"percentiles3": {
"ko": 7918,
"ok": 10400,
"total": 10292
},
"percentiles4": {
"ko": 12119,
"ok": 13564,
"total": 13443
},
"standardDeviation": {
"ko": 3188,
"ok": 3454,
"total": 3765
}
}
},
"target_hostname": "openam-ema-perf-p1protect.forgeblocks.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-06-13 06:13:42] Reporting-login-tree-200 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-06-13 06:13:42] Reporting-login-tree-200 step16 : Remove gatling task's stdout file
________________________________________________________________________________
Cleanup of Gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-200/stdout.txt
Compressing Gatling stdout.txt file..
________________________________________________________________________________
[2024-06-13 06:14:57] Reporting-login-tree-200 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped