--Task--
name: Reporting-login-tree-180
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']
preceding_task: None
options: {'task_name': 'login-tree-180'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-180 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
2024-06-13 06:11:44 - INFO: Timeout for this Task has changed to 3h (10800 seconds)
2024-06-13 06:11:44 - 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-180/stdout.txt
Pod stderr file : /results/orders/Reporting-login-tree-180/stderr.txt
Pod log : /results/orders/Reporting-login-tree-180
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-180 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-06-13 06:11:44,537 INFO
2024-06-13 06:11:44,537 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:11:44,538 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:44,835 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:44,835 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:44,835 DEBUG --- stdout ---
2024-06-13 06:11:44,835 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:44,835 DEBUG --- stderr ---
2024-06-13 06:11:44,835 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/order.json
{
"name": "Reporting-login-tree-180",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-180 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-login-tree-180"
}
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-180 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-06-13 06:11:44,836 INFO
2024-06-13 06:11:44,836 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-13 06:11:44,836 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-06-13 06:11:45,072 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:11:45,072 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:45,072 DEBUG --- stdout ---
2024-06-13 06:11:45,072 DEBUG WAITING
2024-06-13 06:11:45,072 DEBUG --- stderr ---
2024-06-13 06:11:45,073 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:11:45] Reporting-login-tree-180 step3 : Send order to overseer
________________________________________________________________________________
2024-06-13 06:11:45,073 INFO
2024-06-13 06:11:45,073 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:11:45,073 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:45,377 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:45,377 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:45,377 DEBUG --- stdout ---
2024-06-13 06:11:45,377 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:45,378 DEBUG --- stderr ---
2024-06-13 06:11:45,378 DEBUG
2024-06-13 06:11:45,378 INFO
2024-06-13 06:11:45,378 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/13_Reporting-login-tree-180/order.json overseer-0-6c7d65494f-sln6z:/results/orders/order.json
2024-06-13 06:11:45,378 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:11:46,730 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:46,730 DEBUG --- stdout ---
2024-06-13 06:11:46,730 DEBUG
2024-06-13 06:11:46,730 DEBUG --- stderr ---
2024-06-13 06:11:46,730 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-06-13 06:11:46] Reporting-login-tree-180 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-06-13 06:11:51,736 INFO
2024-06-13 06:11:51,737 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-13 06:11:51,738 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0]
2024-06-13 06:11:51,980 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-06-13 06:11:57,222 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-06-13 06:12:02,525 INFO [loop_until]: Function succeeded after 10s (rc=0) - expected pattern found
2024-06-13 06:12:02,525 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:02,525 DEBUG --- stdout ---
2024-06-13 06:12:02,525 DEBUG WAITING
2024-06-13 06:12:02,525 DEBUG --- stderr ---
2024-06-13 06:12:02,526 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 25 0 --:--:-- --:--:-- --:--:-- 25
________________________________________________________________________________
[2024-06-13 06:12:02] Reporting-login-tree-180 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-06-13 06:12:02,527 INFO
2024-06-13 06:12:02,527 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:12:02,527 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:02,829 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:02,829 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:02,829 DEBUG --- stdout ---
2024-06-13 06:12:02,829 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:02,829 DEBUG --- stderr ---
2024-06-13 06:12:02,829 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:12:02,829 INFO
2024-06-13 06:12:02,829 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:12:02,829 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:03,126 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:03,126 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:03,126 DEBUG --- stdout ---
2024-06-13 06:12:03,126 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:03,127 DEBUG --- stderr ---
2024-06-13 06:12:03,127 DEBUG
2024-06-13 06:12:03,127 INFO
2024-06-13 06:12:03,127 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-180.tar.gz" ]; then echo "/results/gatling/login-tree-180.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-180.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-180.tar.gz file found"
2024-06-13 06:12:03,127 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:12:03,925 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:12:03,925 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:03,925 DEBUG --- stdout ---
2024-06-13 06:12:03,925 DEBUG /results/gatling/login-tree-180.tar.gz file found
2024-06-13 06:12:03,925 DEBUG --- stderr ---
2024-06-13 06:12:03,925 DEBUG
2024-06-13 06:12:03,926 INFO
2024-06-13 06:12:03,926 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:12:03,926 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:04,233 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:04,233 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:04,233 DEBUG --- stdout ---
2024-06-13 06:12:04,233 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:04,233 DEBUG --- stderr ---
2024-06-13 06:12:04,233 DEBUG
2024-06-13 06:12:04,233 INFO
2024-06-13 06:12:04,234 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-180.tar.gz
2024-06-13 06:12:05,035 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:12:05,035 DEBUG --- stdout ---
2024-06-13 06:12:05,035 DEBUG 436 /results/gatling/login-tree-180.tar.gz
2024-06-13 06:12:05,035 DEBUG --- stderr ---
2024-06-13 06:12:05,035 DEBUG
2024-06-13 06:12:05,035 INFO
- Download file (size 436k)
2024-06-13 06:12:05,036 INFO
2024-06-13 06:12:05,036 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:12:05,036 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:05,384 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:05,384 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:05,384 DEBUG --- stdout ---
2024-06-13 06:12:05,384 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:05,384 DEBUG --- stderr ---
2024-06-13 06:12:05,384 DEBUG
source : /results/gatling/login-tree-180.tar.gz @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-180.tar.gz
2024-06-13 06:12:05,385 INFO
2024-06-13 06:12:05,385 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:12:05,385 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:05,698 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:05,699 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:05,699 DEBUG --- stdout ---
2024-06-13 06:12:05,699 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:05,699 DEBUG --- stderr ---
2024-06-13 06:12:05,699 DEBUG
2024-06-13 06:12:05,699 INFO
2024-06-13 06:12:05,699 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-180.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-180.tar.gz
2024-06-13 06:12:05,699 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:12:06,744 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:06,744 DEBUG --- stdout ---
2024-06-13 06:12:06,744 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:12:06,744 DEBUG --- stderr ---
2024-06-13 06:12:06,744 DEBUG
________________________________________________________________________________
[2024-06-13 06:12:06] Reporting-login-tree-180 step6 : Unzip the result
________________________________________________________________________________
2024-06-13 06:12:06,745 INFO
2024-06-13 06:12:06,745 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-180.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-180/gatling
2024-06-13 06:12:06,773 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:12:06,774 DEBUG --- stdout ---
2024-06-13 06:12:06,774 DEBUG
2024-06-13 06:12:06,774 DEBUG --- stderr ---
2024-06-13 06:12:06,774 DEBUG
2024-06-13 06:12:06,774 INFO
________________________________________________________________________________
[2024-06-13 06:12:06] Reporting-login-tree-180 step7 : Print rc order
________________________________________________________________________________
2024-06-13 06:12:06,775 INFO
2024-06-13 06:12:06,775 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:12:06,775 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:07,076 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:07,076 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:07,076 DEBUG --- stdout ---
2024-06-13 06:12:07,076 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:07,076 DEBUG --- stderr ---
2024-06-13 06:12:07,076 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:12:07,077 INFO
2024-06-13 06:12:07,077 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:12:07,077 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:07,410 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:07,410 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:07,410 DEBUG --- stdout ---
2024-06-13 06:12:07,410 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:07,410 DEBUG --- stderr ---
2024-06-13 06:12:07,410 DEBUG
2024-06-13 06:12:07,411 INFO
2024-06-13 06:12:07,411 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-180/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-180/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-180/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-180/rc.txt file found"
2024-06-13 06:12:07,411 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:12:08,220 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:12:08,220 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:08,220 DEBUG --- stdout ---
2024-06-13 06:12:08,220 DEBUG /results/orders/Reporting-login-tree-180/rc.txt file found
2024-06-13 06:12:08,220 DEBUG --- stderr ---
2024-06-13 06:12:08,220 DEBUG
2024-06-13 06:12:08,221 INFO
2024-06-13 06:12:08,221 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:12:08,221 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:08,533 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:08,533 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:08,533 DEBUG --- stdout ---
2024-06-13 06:12:08,533 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:08,534 DEBUG --- stderr ---
2024-06-13 06:12:08,534 DEBUG
2024-06-13 06:12:08,534 INFO
2024-06-13 06:12:08,534 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-180/rc.txt
2024-06-13 06:12:09,355 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:12:09,355 DEBUG --- stdout ---
2024-06-13 06:12:09,357 DEBUG 4 /results/orders/Reporting-login-tree-180/rc.txt
2024-06-13 06:12:09,357 DEBUG --- stderr ---
2024-06-13 06:12:09,357 DEBUG
2024-06-13 06:12:09,357 INFO
- Download file (size 4k)
2024-06-13 06:12:09,357 INFO
2024-06-13 06:12:09,357 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:12:09,357 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:09,653 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:09,654 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:09,654 DEBUG --- stdout ---
2024-06-13 06:12:09,654 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:09,654 DEBUG --- stderr ---
2024-06-13 06:12:09,654 DEBUG
source : /results/orders/Reporting-login-tree-180/rc.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/rc.txt
2024-06-13 06:12:09,654 INFO
2024-06-13 06:12:09,654 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:12:09,654 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:09,959 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:09,959 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:09,959 DEBUG --- stdout ---
2024-06-13 06:12:09,959 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:09,959 DEBUG --- stderr ---
2024-06-13 06:12:09,959 DEBUG
2024-06-13 06:12:09,960 INFO
2024-06-13 06:12:09,960 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-180/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/rc.txt
2024-06-13 06:12:09,960 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:12:10,754 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:10,754 DEBUG --- stdout ---
2024-06-13 06:12:10,754 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:12:10,754 DEBUG --- stderr ---
2024-06-13 06:12:10,754 DEBUG
2024-06-13 06:12:10,755 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/rc.txt is small (1 lines), printing all lines:
2024-06-13 06:12:10,755 DEBUG ----- output -----
2024-06-13 06:12:10,755 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-06-13 06:12:10,755 INFO
________________________________________________________________________________
[2024-06-13 06:12:10] Reporting-login-tree-180 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-06-13 06:12:10] Reporting-login-tree-180 step9 : Print stdout order
________________________________________________________________________________
2024-06-13 06:12:10,756 INFO
2024-06-13 06:12:10,757 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:12:10,757 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:11,067 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:11,067 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:11,067 DEBUG --- stdout ---
2024-06-13 06:12:11,068 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:11,068 DEBUG --- stderr ---
2024-06-13 06:12:11,068 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:12:11,068 INFO
2024-06-13 06:12:11,068 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:12:11,068 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:11,380 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:11,381 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:11,381 DEBUG --- stdout ---
2024-06-13 06:12:11,381 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:11,381 DEBUG --- stderr ---
2024-06-13 06:12:11,381 DEBUG
2024-06-13 06:12:11,382 INFO
2024-06-13 06:12:11,382 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-180/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-180/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-180/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-180/stdout.txt file found"
2024-06-13 06:12:11,382 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:12:12,187 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:12:12,188 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:12,188 DEBUG --- stdout ---
2024-06-13 06:12:12,188 DEBUG /results/orders/Reporting-login-tree-180/stdout.txt file found
2024-06-13 06:12:12,188 DEBUG --- stderr ---
2024-06-13 06:12:12,188 DEBUG
2024-06-13 06:12:12,188 INFO
2024-06-13 06:12:12,188 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:12:12,188 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:12,485 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:12,485 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:12,485 DEBUG --- stdout ---
2024-06-13 06:12:12,485 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:12,485 DEBUG --- stderr ---
2024-06-13 06:12:12,485 DEBUG
2024-06-13 06:12:12,485 INFO
2024-06-13 06:12:12,486 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-180/stdout.txt
2024-06-13 06:12:13,279 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:12:13,279 DEBUG --- stdout ---
2024-06-13 06:12:13,279 DEBUG 8 /results/orders/Reporting-login-tree-180/stdout.txt
2024-06-13 06:12:13,279 DEBUG --- stderr ---
2024-06-13 06:12:13,279 DEBUG
2024-06-13 06:12:13,279 INFO
- Download file (size 8k)
2024-06-13 06:12:13,280 INFO
2024-06-13 06:12:13,280 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:12:13,280 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:13,600 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:13,600 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:13,600 DEBUG --- stdout ---
2024-06-13 06:12:13,600 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:13,600 DEBUG --- stderr ---
2024-06-13 06:12:13,600 DEBUG
source : /results/orders/Reporting-login-tree-180/stdout.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/stdout.txt
2024-06-13 06:12:13,600 INFO
2024-06-13 06:12:13,600 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:12:13,601 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:13,913 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:13,913 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:13,913 DEBUG --- stdout ---
2024-06-13 06:12:13,913 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:13,913 DEBUG --- stderr ---
2024-06-13 06:12:13,913 DEBUG
2024-06-13 06:12:13,914 INFO
2024-06-13 06:12:13,914 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-180/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/stdout.txt
2024-06-13 06:12:13,914 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:12:14,654 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:14,655 DEBUG --- stdout ---
2024-06-13 06:12:14,655 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:12:14,655 DEBUG --- stderr ---
2024-06-13 06:12:14,655 DEBUG
2024-06-13 06:12:14,655 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/stdout.txt is small (93 lines), printing all lines:
2024-06-13 06:12:14,655 DEBUG ----- output -----
2024-06-13 06:12:14,655 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-180/loadtest-20240613040038343 --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 2675445 (OK=2434023 KO=241422)
> min response time 88 (OK=97 KO=88 )
> max response time 60001 (OK=51881 KO=60001 )
> mean response time 3465 (OK=3648 KO=1612 )
> std deviation 3935 (OK=3621 KO=5967 )
> response time 50th percentile 2443 (OK=2808 KO=99 )
> response time 75th percentile 5704 (OK=5934 KO=100 )
> response time 95th percentile 8823 (OK=8811 KO=12098 )
> response time 99th percentile 17238 (OK=14228 KO=35971 )
> mean requests/sec 736.631 (OK=670.161 KO=66.471)
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 646040 ( 24%)
> 800 ms <= t < 1200 ms 129274 ( 5%)
> t >= 1200 ms 1658709 ( 62%)
> failed 241422 ( 9%)
---- Errors --------------------------------------------------------------------
> status.find.is(200), but actually found 503 220921 (54.90%)
> PingOneProtectEvaluationCallback: Failed to build request: No 40242 (10.00%)
attribute named 'callbacks' is defined
> restLoginUsernamePasswordCallback: Failed to build request: No 40242 (10.00%)
attribute named 'callbacks' is defined
> restloginProgressiveProfileCallback: Failed to build request: 40242 (10.00%)
No attribute named 'callbacks' is defined
> PingOneProtectInitializeCallback: Failed to build request: No 40242 (10.00%)
attribute named 'callbacks' is defined
> status.find.is(200), but actually found 401 8149 ( 2.03%)
> status.find.is(200), but actually found 502 7761 ( 1.93%)
> jsonPath($.tokenId).find.exists, found nothing 4001 ( 0.99%)
> status.find.is(200), but actually found 400 587 ( 0.15%)
> Request timeout to openam-ema-perf-p1protect.forgeblocks.com/3 2 ( 0.00%)
4.49.48.52:443 after 60000 ms
> j.i.IOException: Premature close 1 ( 0.00%)
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/login-tree-180/loadtest-20240613040038343/index.html
----------------------
[13/Jun/2024 07:11:59] Create tar file /results/gatling/login-tree-180.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/login-tree-180/loadtest-20240613040038343
RESULT_FOLDER=login-tree-180
RESULT_PATH=/results/gatling/login-tree-180
PWD=/results/gatling/login-tree-180/loadtest-20240613040038343
[cmd] tar -czvf /results/gatling/login-tree-180.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:12:14,655 INFO
________________________________________________________________________________
[2024-06-13 06:12:14] Reporting-login-tree-180 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-06-13 06:12:14] Reporting-login-tree-180 step11 : Print stderr order
________________________________________________________________________________
2024-06-13 06:12:14,657 INFO
2024-06-13 06:12:14,657 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:12:14,657 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:14,969 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:14,969 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:14,969 DEBUG --- stdout ---
2024-06-13 06:12:14,969 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:14,969 DEBUG --- stderr ---
2024-06-13 06:12:14,969 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:12:14,970 INFO
2024-06-13 06:12:14,970 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:12:14,970 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:15,281 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:15,281 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:15,282 DEBUG --- stdout ---
2024-06-13 06:12:15,282 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:15,282 DEBUG --- stderr ---
2024-06-13 06:12:15,282 DEBUG
2024-06-13 06:12:15,283 INFO
2024-06-13 06:12:15,283 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-180/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-180/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-180/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-180/stderr.txt file found"
2024-06-13 06:12:15,283 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:12:16,118 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:12:16,118 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:16,118 DEBUG --- stdout ---
2024-06-13 06:12:16,118 DEBUG /results/orders/Reporting-login-tree-180/stderr.txt file found
2024-06-13 06:12:16,118 DEBUG --- stderr ---
2024-06-13 06:12:16,118 DEBUG
2024-06-13 06:12:16,119 INFO
2024-06-13 06:12:16,119 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:12:16,119 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:16,430 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:16,431 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:16,431 DEBUG --- stdout ---
2024-06-13 06:12:16,431 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:16,431 DEBUG --- stderr ---
2024-06-13 06:12:16,431 DEBUG
2024-06-13 06:12:16,431 INFO
2024-06-13 06:12:16,431 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-180/stderr.txt
2024-06-13 06:12:17,240 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:12:17,240 DEBUG --- stdout ---
2024-06-13 06:12:17,240 DEBUG 0 /results/orders/Reporting-login-tree-180/stderr.txt
2024-06-13 06:12:17,240 DEBUG --- stderr ---
2024-06-13 06:12:17,240 DEBUG
2024-06-13 06:12:17,240 INFO
- Download file (size 0k)
2024-06-13 06:12:17,241 INFO
2024-06-13 06:12:17,241 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:12:17,241 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:17,545 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:17,546 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:17,546 DEBUG --- stdout ---
2024-06-13 06:12:17,546 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:17,546 DEBUG --- stderr ---
2024-06-13 06:12:17,546 DEBUG
source : /results/orders/Reporting-login-tree-180/stderr.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/stderr.txt
2024-06-13 06:12:17,546 INFO
2024-06-13 06:12:17,546 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:12:17,546 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:12:17,855 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:12:17,856 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:17,856 DEBUG --- stdout ---
2024-06-13 06:12:17,856 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:12:17,856 DEBUG --- stderr ---
2024-06-13 06:12:17,856 DEBUG
2024-06-13 06:12:17,856 INFO
2024-06-13 06:12:17,856 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-180/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/stderr.txt
2024-06-13 06:12:17,856 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:12:18,638 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:12:18,639 DEBUG --- stdout ---
2024-06-13 06:12:18,639 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:12:18,639 DEBUG --- stderr ---
2024-06-13 06:12:18,639 DEBUG
2024-06-13 06:12:18,639 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/13_Reporting-login-tree-180/stderr.txt is small (0 lines), printing all lines:
2024-06-13 06:12:18,639 DEBUG ----- output -----
2024-06-13 06:12:18,639 DEBUG
2024-06-13 06:12:18,639 INFO
________________________________________________________________________________
[2024-06-13 06:12:18] Reporting-login-tree-180 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-06-13 06:12:18] Reporting-login-tree-180 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/05_login-tree-180/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/05_login-tree-180/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/05_login-tree-180/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/05_login-tree-180/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/05_login-tree-180/gatling/req_restloginprogre-9fc93.html - cannot check for spikes
no spikes found
________________________________________________________________________________
[2024-06-13 06:12:18] Reporting-login-tree-180 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 2675445,
"ok": 2434023,
"ko": 241422
},
"minResponseTime": {
"total": 88,
"ok": 97,
"ko": 88
},
"maxResponseTime": {
"total": 60001,
"ok": 51881,
"ko": 60001
},
"meanResponseTime": {
"total": 3465,
"ok": 3648,
"ko": 1612
},
"standardDeviation": {
"total": 3935,
"ok": 3621,
"ko": 5967
},
"percentiles1": {
"total": 2443,
"ok": 2808,
"ko": 99
},
"percentiles2": {
"total": 5704,
"ok": 5934,
"ko": 100
},
"percentiles3": {
"total": 8823,
"ok": 8811,
"ko": 12098
},
"percentiles4": {
"total": 17238,
"ok": 14228,
"ko": 35971
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 646040,
"percentage": 24
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 129274,
"percentage": 5
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 1658709,
"percentage": 62
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 241422,
"percentage": 9
},
"meanNumberOfRequestsPerSecond": {
"total": 736.631332599119,
"ok": 670.1605176211453,
"ko": 66.47081497797357
}
},
"details": [
{
"name": "protectLoginInitiate",
"numberOfRequests": {
"total": 650014,
"ok": 609772,
"ko": 40242
},
"minResponseTime": {
"total": 91,
"ok": 99,
"ko": 91
},
"maxResponseTime": {
"total": 42123,
"ok": 42123,
"ko": 31580
},
"meanResponseTime": {
"total": 3309,
"ok": 3444,
"ko": 1260
},
"standardDeviation": {
"total": 3954,
"ok": 3974,
"ko": 2967
},
"percentiles1": {
"total": 2211,
"ok": 2398,
"ko": 97
},
"percentiles2": {
"total": 5426,
"ok": 5565,
"ko": 99
},
"percentiles3": {
"total": 8344,
"ok": 8364,
"ko": 8100
},
"percentiles4": {
"total": 19908,
"ok": 20278,
"ko": 12101
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 187583,
"percentage": 29
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 29235,
"percentage": 4
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 392954,
"percentage": 60
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 40242,
"percentage": 6
},
"meanNumberOfRequestsPerSecond": {
"total": 178.96861233480178,
"ok": 167.88876651982378,
"ko": 11.079845814977974
},
"spikes": []
},
{
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"total": 609772,
"ok": 586811,
"ko": 22961
},
"minResponseTime": {
"total": 88,
"ok": 97,
"ko": 88
},
"maxResponseTime": {
"total": 60000,
"ok": 42260,
"ko": 60000
},
"meanResponseTime": {
"total": 3406,
"ok": 3521,
"ko": 486
},
"standardDeviation": {
"total": 3376,
"ok": 3367,
"ko": 2002
},
"percentiles1": {
"total": 2566,
"ok": 2734,
"ko": 99
},
"percentiles2": {
"total": 5730,
"ok": 5843,
"ko": 100
},
"percentiles3": {
"total": 8611,
"ok": 8644,
"ko": 120
},
"percentiles4": {
"total": 12766,
"ok": 12965,
"ko": 12101
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 163552,
"percentage": 27
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 27140,
"percentage": 4
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 396119,
"percentage": 65
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 22961,
"percentage": 4
},
"meanNumberOfRequestsPerSecond": {
"total": 167.88876651982378,
"ok": 161.56690528634363,
"ko": 6.321861233480176
},
"spikes": []
},
{
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"total": 609772,
"ok": 568548,
"ko": 41224
},
"minResponseTime": {
"total": 88,
"ok": 105,
"ko": 88
},
"maxResponseTime": {
"total": 60001,
"ok": 42380,
"ko": 60001
},
"meanResponseTime": {
"total": 3438,
"ok": 3667,
"ko": 278
},
"standardDeviation": {
"total": 3421,
"ok": 3413,
"ko": 1334
},
"percentiles1": {
"total": 2592,
"ok": 2907,
"ko": 99
},
"percentiles2": {
"total": 5815,
"ok": 6039,
"ko": 100
},
"percentiles3": {
"total": 8829,
"ok": 8897,
"ko": 102
},
"percentiles4": {
"total": 12131,
"ok": 13034,
"ko": 8095
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 151534,
"percentage": 25
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 25814,
"percentage": 4
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 391200,
"percentage": 64
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 41224,
"percentage": 7
},
"meanNumberOfRequestsPerSecond": {
"total": 167.88876651982378,
"ok": 156.53854625550662,
"ko": 11.35022026431718
},
"spikes": []
},
{
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"total": 609772,
"ok": 543737,
"ko": 66035
},
"minResponseTime": {
"total": 88,
"ok": 106,
"ko": 88
},
"maxResponseTime": {
"total": 51881,
"ok": 51881,
"ko": 49533
},
"meanResponseTime": {
"total": 4021,
"ok": 4093,
"ko": 3424
},
"standardDeviation": {
"total": 4807,
"ok": 3782,
"ko": 9757
},
"percentiles1": {
"total": 2901,
"ok": 3334,
"ko": 99
},
"percentiles2": {
"total": 6261,
"ok": 6473,
"ko": 100
},
"percentiles3": {
"total": 9451,
"ok": 9274,
"ko": 29027
},
"percentiles4": {
"total": 26223,
"ok": 10972,
"ko": 43485
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 105472,
"percentage": 17
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 40387,
"percentage": 7
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 397878,
"percentage": 65
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 66035,
"percentage": 11
},
"meanNumberOfRequestsPerSecond": {
"total": 167.88876651982378,
"ok": 149.70732378854626,
"ko": 18.18144273127753
},
"spikes": []
},
{
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"total": 196115,
"ok": 125155,
"ko": 70960
},
"minResponseTime": {
"total": 88,
"ok": 174,
"ko": 88
},
"maxResponseTime": {
"total": 39775,
"ok": 35685,
"ko": 39775
},
"meanResponseTime": {
"total": 2517,
"ok": 3226,
"ko": 1266
},
"standardDeviation": {
"total": 3709,
"ok": 2919,
"ko": 4531
},
"percentiles1": {
"total": 607,
"ok": 2381,
"ko": 99
},
"percentiles2": {
"total": 4038,
"ok": 5536,
"ko": 100
},
"percentiles3": {
"total": 8478,
"ok": 8401,
"ko": 10927
},
"percentiles4": {
"total": 17011,
"ok": 9590,
"ko": 22792
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 37899,
"percentage": 19
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 6698,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 80558,
"percentage": 41
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 70960,
"percentage": 36
},
"meanNumberOfRequestsPerSecond": {
"total": 53.99642070484582,
"ok": 34.45897577092511,
"ko": 19.537444933920703
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 737,
"avg_response_time": 3465,
"max_response_time": 51881,
"min_response_time": 97,
"num_requests": 2675445,
"num_requests_pass": 2434023,
"num_requests_percent_pass": 90.976
},
"options": "; testCase:idc.loginProtect; testMode:open; throughput:180; rampup-duration:30; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 187583,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 29
},
"group2": {
"count": 29235,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 4
},
"group3": {
"count": 392954,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 60
},
"group4": {
"count": 40242,
"htmlName": "failed",
"name": "failed",
"percentage": 6
},
"maxResponseTime": {
"ko": 31580,
"ok": 42123,
"total": 42123
},
"meanNumberOfRequestsPerSecond": {
"ko": 11.079845814977974,
"ok": 167.88876651982378,
"total": 178.96861233480178
},
"meanResponseTime": {
"ko": 1260,
"ok": 3444,
"total": 3309
},
"minResponseTime": {
"ko": 91,
"ok": 99,
"total": 91
},
"name": "protectLoginInitiate",
"numberOfRequests": {
"ko": 40242,
"ok": 609772,
"total": 650014
},
"percentiles1": {
"ko": 97,
"ok": 2398,
"total": 2211
},
"percentiles2": {
"ko": 99,
"ok": 5565,
"total": 5426
},
"percentiles3": {
"ko": 8100,
"ok": 8364,
"total": 8344
},
"percentiles4": {
"ko": 12101,
"ok": 20278,
"total": 19908
},
"spikes": [],
"standardDeviation": {
"ko": 2967,
"ok": 3974,
"total": 3954
}
},
{
"group1": {
"count": 163552,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 27
},
"group2": {
"count": 27140,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 4
},
"group3": {
"count": 396119,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 65
},
"group4": {
"count": 22961,
"htmlName": "failed",
"name": "failed",
"percentage": 4
},
"maxResponseTime": {
"ko": 60000,
"ok": 42260,
"total": 60000
},
"meanNumberOfRequestsPerSecond": {
"ko": 6.321861233480176,
"ok": 161.56690528634363,
"total": 167.88876651982378
},
"meanResponseTime": {
"ko": 486,
"ok": 3521,
"total": 3406
},
"minResponseTime": {
"ko": 88,
"ok": 97,
"total": 88
},
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"ko": 22961,
"ok": 586811,
"total": 609772
},
"percentiles1": {
"ko": 99,
"ok": 2734,
"total": 2566
},
"percentiles2": {
"ko": 100,
"ok": 5843,
"total": 5730
},
"percentiles3": {
"ko": 120,
"ok": 8644,
"total": 8611
},
"percentiles4": {
"ko": 12101,
"ok": 12965,
"total": 12766
},
"spikes": [],
"standardDeviation": {
"ko": 2002,
"ok": 3367,
"total": 3376
}
},
{
"group1": {
"count": 151534,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 25
},
"group2": {
"count": 25814,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 4
},
"group3": {
"count": 391200,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 64
},
"group4": {
"count": 41224,
"htmlName": "failed",
"name": "failed",
"percentage": 7
},
"maxResponseTime": {
"ko": 60001,
"ok": 42380,
"total": 60001
},
"meanNumberOfRequestsPerSecond": {
"ko": 11.35022026431718,
"ok": 156.53854625550662,
"total": 167.88876651982378
},
"meanResponseTime": {
"ko": 278,
"ok": 3667,
"total": 3438
},
"minResponseTime": {
"ko": 88,
"ok": 105,
"total": 88
},
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"ko": 41224,
"ok": 568548,
"total": 609772
},
"percentiles1": {
"ko": 99,
"ok": 2907,
"total": 2592
},
"percentiles2": {
"ko": 100,
"ok": 6039,
"total": 5815
},
"percentiles3": {
"ko": 102,
"ok": 8897,
"total": 8829
},
"percentiles4": {
"ko": 8095,
"ok": 13034,
"total": 12131
},
"spikes": [],
"standardDeviation": {
"ko": 1334,
"ok": 3413,
"total": 3421
}
},
{
"group1": {
"count": 105472,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 17
},
"group2": {
"count": 40387,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 7
},
"group3": {
"count": 397878,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 65
},
"group4": {
"count": 66035,
"htmlName": "failed",
"name": "failed",
"percentage": 11
},
"maxResponseTime": {
"ko": 49533,
"ok": 51881,
"total": 51881
},
"meanNumberOfRequestsPerSecond": {
"ko": 18.18144273127753,
"ok": 149.70732378854626,
"total": 167.88876651982378
},
"meanResponseTime": {
"ko": 3424,
"ok": 4093,
"total": 4021
},
"minResponseTime": {
"ko": 88,
"ok": 106,
"total": 88
},
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"ko": 66035,
"ok": 543737,
"total": 609772
},
"percentiles1": {
"ko": 99,
"ok": 3334,
"total": 2901
},
"percentiles2": {
"ko": 100,
"ok": 6473,
"total": 6261
},
"percentiles3": {
"ko": 29027,
"ok": 9274,
"total": 9451
},
"percentiles4": {
"ko": 43485,
"ok": 10972,
"total": 26223
},
"spikes": [],
"standardDeviation": {
"ko": 9757,
"ok": 3782,
"total": 4807
}
},
{
"group1": {
"count": 37899,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 19
},
"group2": {
"count": 6698,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 80558,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 41
},
"group4": {
"count": 70960,
"htmlName": "failed",
"name": "failed",
"percentage": 36
},
"maxResponseTime": {
"ko": 39775,
"ok": 35685,
"total": 39775
},
"meanNumberOfRequestsPerSecond": {
"ko": 19.537444933920703,
"ok": 34.45897577092511,
"total": 53.99642070484582
},
"meanResponseTime": {
"ko": 1266,
"ok": 3226,
"total": 2517
},
"minResponseTime": {
"ko": 88,
"ok": 174,
"total": 88
},
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"ko": 70960,
"ok": 125155,
"total": 196115
},
"percentiles1": {
"ko": 99,
"ok": 2381,
"total": 607
},
"percentiles2": {
"ko": 100,
"ok": 5536,
"total": 4038
},
"percentiles3": {
"ko": 10927,
"ok": 8401,
"total": 8478
},
"percentiles4": {
"ko": 22792,
"ok": 9590,
"total": 17011
},
"spikes": [],
"standardDeviation": {
"ko": 4531,
"ok": 2919,
"total": 3709
}
}
],
"global": {
"group1": {
"count": 646040,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 24
},
"group2": {
"count": 129274,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 5
},
"group3": {
"count": 1658709,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 62
},
"group4": {
"count": 241422,
"htmlName": "failed",
"name": "failed",
"percentage": 9
},
"maxResponseTime": {
"ko": 60001,
"ok": 51881,
"total": 60001
},
"meanNumberOfRequestsPerSecond": {
"ko": 66.47081497797357,
"ok": 670.1605176211453,
"total": 736.631332599119
},
"meanResponseTime": {
"ko": 1612,
"ok": 3648,
"total": 3465
},
"minResponseTime": {
"ko": 88,
"ok": 97,
"total": 88
},
"name": "All Requests",
"numberOfRequests": {
"ko": 241422,
"ok": 2434023,
"total": 2675445
},
"percentiles1": {
"ko": 99,
"ok": 2808,
"total": 2443
},
"percentiles2": {
"ko": 100,
"ok": 5934,
"total": 5704
},
"percentiles3": {
"ko": 12098,
"ok": 8811,
"total": 8823
},
"percentiles4": {
"ko": 35971,
"ok": 14228,
"total": 17238
},
"standardDeviation": {
"ko": 5967,
"ok": 3621,
"total": 3935
}
}
},
"target_hostname": "openam-ema-perf-p1protect.forgeblocks.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-06-13 06:12:18] Reporting-login-tree-180 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-06-13 06:12:18] Reporting-login-tree-180 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/05_login-tree-180/stdout.txt
Compressing Gatling stdout.txt file..
________________________________________________________________________________
[2024-06-13 06:13:03] Reporting-login-tree-180 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped