--Task--
name: Reporting-login-tree-150
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']
preceding_task: None
options: {'task_name': 'login-tree-150'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-06-13 06:11:10] Reporting-login-tree-150 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
2024-06-13 06:11:10 - INFO: Timeout for this Task has changed to 3h (10800 seconds)
2024-06-13 06:11:10 - 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-150/stdout.txt
Pod stderr file : /results/orders/Reporting-login-tree-150/stderr.txt
Pod log : /results/orders/Reporting-login-tree-150
________________________________________________________________________________
[2024-06-13 06:11:10] Reporting-login-tree-150 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-06-13 06:11:10,725 INFO
2024-06-13 06:11:10,725 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:10,725 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:11,041 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:11,041 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:11,043 DEBUG --- stdout ---
2024-06-13 06:11:11,043 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:11,043 DEBUG --- stderr ---
2024-06-13 06:11:11,043 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/order.json
{
"name": "Reporting-login-tree-150",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-150 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-login-tree-150"
}
________________________________________________________________________________
[2024-06-13 06:11:11] Reporting-login-tree-150 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-06-13 06:11:11,044 INFO
2024-06-13 06:11:11,044 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-13 06:11:11,044 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-06-13 06:11:11,281 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:11:11,281 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:11,281 DEBUG --- stdout ---
2024-06-13 06:11:11,281 DEBUG WAITING
2024-06-13 06:11:11,281 DEBUG --- stderr ---
2024-06-13 06:11:11,281 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 33 0 --:--:-- --:--:-- --:--:-- 33
________________________________________________________________________________
[2024-06-13 06:11:11] Reporting-login-tree-150 step3 : Send order to overseer
________________________________________________________________________________
2024-06-13 06:11:11,282 INFO
2024-06-13 06:11:11,282 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:11,282 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:11,588 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:11,589 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:11,589 DEBUG --- stdout ---
2024-06-13 06:11:11,589 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:11,589 DEBUG --- stderr ---
2024-06-13 06:11:11,589 DEBUG
2024-06-13 06:11:11,589 INFO
2024-06-13 06:11:11,589 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/12_Reporting-login-tree-150/order.json overseer-0-6c7d65494f-sln6z:/results/orders/order.json
2024-06-13 06:11:11,589 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:11:12,932 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:12,932 DEBUG --- stdout ---
2024-06-13 06:11:12,933 DEBUG
2024-06-13 06:11:12,933 DEBUG --- stderr ---
2024-06-13 06:11:12,933 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-06-13 06:11:12] Reporting-login-tree-150 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-06-13 06:11:17,938 INFO
2024-06-13 06:11:17,939 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-13 06:11:17,939 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0]
2024-06-13 06:11:18,173 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-06-13 06:11:23,409 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-06-13 06:11:28,690 INFO [loop_until]: Function succeeded after 10s (rc=0) - expected pattern found
2024-06-13 06:11:28,690 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:28,690 DEBUG --- stdout ---
2024-06-13 06:11:28,690 DEBUG WAITING
2024-06-13 06:11:28,690 DEBUG --- stderr ---
2024-06-13 06:11:28,690 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 27 0 --:--:-- --:--:-- --:--:-- 27
________________________________________________________________________________
[2024-06-13 06:11:28] Reporting-login-tree-150 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-06-13 06:11:28,691 INFO
2024-06-13 06:11:28,691 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:28,691 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:28,988 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:28,988 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:28,988 DEBUG --- stdout ---
2024-06-13 06:11:28,988 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:28,988 DEBUG --- stderr ---
2024-06-13 06:11:28,988 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:11:28,989 INFO
2024-06-13 06:11:28,989 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:28,989 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:29,284 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:29,284 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:29,284 DEBUG --- stdout ---
2024-06-13 06:11:29,284 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:29,284 DEBUG --- stderr ---
2024-06-13 06:11:29,284 DEBUG
2024-06-13 06:11:29,284 INFO
2024-06-13 06:11:29,285 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-150.tar.gz" ]; then echo "/results/gatling/login-tree-150.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-150.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-150.tar.gz file found"
2024-06-13 06:11:29,285 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:11:30,078 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:11:30,078 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:30,078 DEBUG --- stdout ---
2024-06-13 06:11:30,079 DEBUG /results/gatling/login-tree-150.tar.gz file found
2024-06-13 06:11:30,079 DEBUG --- stderr ---
2024-06-13 06:11:30,079 DEBUG
2024-06-13 06:11:30,079 INFO
2024-06-13 06:11:30,079 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:30,079 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:30,387 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:30,387 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:30,389 DEBUG --- stdout ---
2024-06-13 06:11:30,389 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:30,389 DEBUG --- stderr ---
2024-06-13 06:11:30,389 DEBUG
2024-06-13 06:11:30,389 INFO
2024-06-13 06:11:30,390 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-150.tar.gz
2024-06-13 06:11:31,195 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:11:31,195 DEBUG --- stdout ---
2024-06-13 06:11:31,195 DEBUG 352 /results/gatling/login-tree-150.tar.gz
2024-06-13 06:11:31,195 DEBUG --- stderr ---
2024-06-13 06:11:31,195 DEBUG
2024-06-13 06:11:31,195 INFO
- Download file (size 352k)
2024-06-13 06:11:31,196 INFO
2024-06-13 06:11:31,196 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:31,196 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:31,505 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:31,505 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:31,505 DEBUG --- stdout ---
2024-06-13 06:11:31,505 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:31,505 DEBUG --- stderr ---
2024-06-13 06:11:31,505 DEBUG
source : /results/gatling/login-tree-150.tar.gz @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-150.tar.gz
2024-06-13 06:11:31,506 INFO
2024-06-13 06:11:31,506 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:31,506 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:31,813 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:31,813 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:31,813 DEBUG --- stdout ---
2024-06-13 06:11:31,813 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:31,813 DEBUG --- stderr ---
2024-06-13 06:11:31,813 DEBUG
2024-06-13 06:11:31,814 INFO
2024-06-13 06:11:31,814 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-150.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-150.tar.gz
2024-06-13 06:11:31,814 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:11:32,808 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:32,808 DEBUG --- stdout ---
2024-06-13 06:11:32,808 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:11:32,808 DEBUG --- stderr ---
2024-06-13 06:11:32,808 DEBUG
________________________________________________________________________________
[2024-06-13 06:11:32] Reporting-login-tree-150 step6 : Unzip the result
________________________________________________________________________________
2024-06-13 06:11:32,809 INFO
2024-06-13 06:11:32,809 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-150.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-150/gatling
2024-06-13 06:11:32,834 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:11:32,835 DEBUG --- stdout ---
2024-06-13 06:11:32,835 DEBUG
2024-06-13 06:11:32,835 DEBUG --- stderr ---
2024-06-13 06:11:32,835 DEBUG
2024-06-13 06:11:32,835 INFO
________________________________________________________________________________
[2024-06-13 06:11:32] Reporting-login-tree-150 step7 : Print rc order
________________________________________________________________________________
2024-06-13 06:11:32,836 INFO
2024-06-13 06:11:32,836 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:32,836 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:33,144 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:33,144 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:33,144 DEBUG --- stdout ---
2024-06-13 06:11:33,144 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:33,144 DEBUG --- stderr ---
2024-06-13 06:11:33,144 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:11:33,145 INFO
2024-06-13 06:11:33,145 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:33,145 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:33,456 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:33,456 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:33,456 DEBUG --- stdout ---
2024-06-13 06:11:33,456 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:33,456 DEBUG --- stderr ---
2024-06-13 06:11:33,456 DEBUG
2024-06-13 06:11:33,457 INFO
2024-06-13 06:11:33,457 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-150/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-150/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-150/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-150/rc.txt file found"
2024-06-13 06:11:33,457 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:11:34,261 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:11:34,261 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:34,261 DEBUG --- stdout ---
2024-06-13 06:11:34,261 DEBUG /results/orders/Reporting-login-tree-150/rc.txt file found
2024-06-13 06:11:34,261 DEBUG --- stderr ---
2024-06-13 06:11:34,261 DEBUG
2024-06-13 06:11:34,262 INFO
2024-06-13 06:11:34,262 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:34,262 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:34,557 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:34,557 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:34,557 DEBUG --- stdout ---
2024-06-13 06:11:34,557 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:34,557 DEBUG --- stderr ---
2024-06-13 06:11:34,557 DEBUG
2024-06-13 06:11:34,557 INFO
2024-06-13 06:11:34,557 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-150/rc.txt
2024-06-13 06:11:35,384 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:11:35,384 DEBUG --- stdout ---
2024-06-13 06:11:35,384 DEBUG 4 /results/orders/Reporting-login-tree-150/rc.txt
2024-06-13 06:11:35,384 DEBUG --- stderr ---
2024-06-13 06:11:35,384 DEBUG
2024-06-13 06:11:35,384 INFO
- Download file (size 4k)
2024-06-13 06:11:35,384 INFO
2024-06-13 06:11:35,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:11:35,385 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:35,693 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:35,693 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:35,695 DEBUG --- stdout ---
2024-06-13 06:11:35,695 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:35,695 DEBUG --- stderr ---
2024-06-13 06:11:35,695 DEBUG
source : /results/orders/Reporting-login-tree-150/rc.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/rc.txt
2024-06-13 06:11:35,696 INFO
2024-06-13 06:11:35,696 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:35,696 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:36,005 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:36,005 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:36,005 DEBUG --- stdout ---
2024-06-13 06:11:36,006 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:36,006 DEBUG --- stderr ---
2024-06-13 06:11:36,006 DEBUG
2024-06-13 06:11:36,006 INFO
2024-06-13 06:11:36,006 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-150/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/rc.txt
2024-06-13 06:11:36,006 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:11:36,723 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:36,724 DEBUG --- stdout ---
2024-06-13 06:11:36,724 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:11:36,724 DEBUG --- stderr ---
2024-06-13 06:11:36,724 DEBUG
2024-06-13 06:11:36,724 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/rc.txt is small (1 lines), printing all lines:
2024-06-13 06:11:36,724 DEBUG ----- output -----
2024-06-13 06:11:36,724 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-06-13 06:11:36,724 INFO
________________________________________________________________________________
[2024-06-13 06:11:36] Reporting-login-tree-150 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-06-13 06:11:36] Reporting-login-tree-150 step9 : Print stdout order
________________________________________________________________________________
2024-06-13 06:11:36,725 INFO
2024-06-13 06:11:36,725 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:36,726 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:37,026 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:37,026 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:37,026 DEBUG --- stdout ---
2024-06-13 06:11:37,026 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:37,027 DEBUG --- stderr ---
2024-06-13 06:11:37,027 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:11:37,027 INFO
2024-06-13 06:11:37,027 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:37,027 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:37,331 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:37,331 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:37,331 DEBUG --- stdout ---
2024-06-13 06:11:37,331 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:37,331 DEBUG --- stderr ---
2024-06-13 06:11:37,331 DEBUG
2024-06-13 06:11:37,332 INFO
2024-06-13 06:11:37,332 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-150/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-150/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-150/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-150/stdout.txt file found"
2024-06-13 06:11:37,332 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:11:38,160 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:11:38,160 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:38,160 DEBUG --- stdout ---
2024-06-13 06:11:38,160 DEBUG /results/orders/Reporting-login-tree-150/stdout.txt file found
2024-06-13 06:11:38,160 DEBUG --- stderr ---
2024-06-13 06:11:38,160 DEBUG
2024-06-13 06:11:38,161 INFO
2024-06-13 06:11:38,161 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:38,161 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:38,470 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:38,471 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:38,471 DEBUG --- stdout ---
2024-06-13 06:11:38,471 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:38,471 DEBUG --- stderr ---
2024-06-13 06:11:38,471 DEBUG
2024-06-13 06:11:38,471 INFO
2024-06-13 06:11:38,471 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-150/stdout.txt
2024-06-13 06:11:39,287 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:11:39,287 DEBUG --- stdout ---
2024-06-13 06:11:39,287 DEBUG 4 /results/orders/Reporting-login-tree-150/stdout.txt
2024-06-13 06:11:39,287 DEBUG --- stderr ---
2024-06-13 06:11:39,287 DEBUG
2024-06-13 06:11:39,287 INFO
- Download file (size 4k)
2024-06-13 06:11:39,288 INFO
2024-06-13 06:11:39,288 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:39,288 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:39,597 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:39,597 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:39,597 DEBUG --- stdout ---
2024-06-13 06:11:39,597 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:39,597 DEBUG --- stderr ---
2024-06-13 06:11:39,597 DEBUG
source : /results/orders/Reporting-login-tree-150/stdout.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/stdout.txt
2024-06-13 06:11:39,598 INFO
2024-06-13 06:11:39,598 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:39,598 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:39,904 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:39,904 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:39,904 DEBUG --- stdout ---
2024-06-13 06:11:39,904 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:39,904 DEBUG --- stderr ---
2024-06-13 06:11:39,904 DEBUG
2024-06-13 06:11:39,905 INFO
2024-06-13 06:11:39,905 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-150/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/stdout.txt
2024-06-13 06:11:39,905 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:11:40,637 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:40,637 DEBUG --- stdout ---
2024-06-13 06:11:40,637 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:11:40,637 DEBUG --- stderr ---
2024-06-13 06:11:40,637 DEBUG
2024-06-13 06:11:40,637 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/stdout.txt is small (89 lines), printing all lines:
2024-06-13 06:11:40,637 DEBUG ----- output -----
2024-06-13 06:11:40,637 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-150/loadtest-20240613025800991 --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 2249662 (OK=2249623 KO=39 )
> min response time 93 (OK=96 KO=93 )
> max response time 3827 (OK=3827 KO=610 )
> mean response time 226 (OK=226 KO=191 )
> std deviation 180 (OK=180 KO=92 )
> response time 50th percentile 130 (OK=130 KO=170 )
> response time 75th percentile 288 (OK=288 KO=241 )
> response time 95th percentile 535 (OK=535 KO=309 )
> response time 99th percentile 686 (OK=686 KO=503 )
> mean requests/sec 619.4 (OK=619.39 KO=0.011 )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 2238475 (100%)
> 800 ms <= t < 1200 ms 7907 ( 0%)
> t >= 1200 ms 3241 ( 0%)
> failed 39 ( 0%)
---- Errors --------------------------------------------------------------------
> status.find.is(200), but actually found 401 19 (44.19%)
> jsonPath($.tokenId).find.exists, found nothing 15 (34.88%)
> status.find.is(200), but actually found 502 4 ( 9.30%)
> restLoginUsernamePasswordCallback: Failed to build request: No 1 ( 2.33%)
attribute named 'callbacks' is defined
> restloginProgressiveProfileCallback: Failed to build request: 1 ( 2.33%)
No attribute named 'callbacks' is defined
> PingOneProtectEvaluationCallback: Failed to build request: No 1 ( 2.33%)
attribute named 'callbacks' is defined
> status.find.is(200), but actually found 400 1 ( 2.33%)
> PingOneProtectInitializeCallback: Failed to build request: No 1 ( 2.33%)
attribute named 'callbacks' is defined
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/login-tree-150/loadtest-20240613025800991/index.html
----------------------
[13/Jun/2024 07:11:27] Create tar file /results/gatling/login-tree-150.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/login-tree-150/loadtest-20240613025800991
RESULT_FOLDER=login-tree-150
RESULT_PATH=/results/gatling/login-tree-150
PWD=/results/gatling/login-tree-150/loadtest-20240613025800991
[cmd] tar -czvf /results/gatling/login-tree-150.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:11:40,637 INFO
________________________________________________________________________________
[2024-06-13 06:11:40] Reporting-login-tree-150 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-06-13 06:11:40] Reporting-login-tree-150 step11 : Print stderr order
________________________________________________________________________________
2024-06-13 06:11:40,639 INFO
2024-06-13 06:11:40,639 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:40,639 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:40,948 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:40,949 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:40,950 DEBUG --- stdout ---
2024-06-13 06:11:40,950 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:40,950 DEBUG --- stderr ---
2024-06-13 06:11:40,950 DEBUG
Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait.
2024-06-13 06:11:40,951 INFO
2024-06-13 06:11:40,951 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:40,951 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:41,260 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:41,261 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:41,261 DEBUG --- stdout ---
2024-06-13 06:11:41,261 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:41,261 DEBUG --- stderr ---
2024-06-13 06:11:41,261 DEBUG
2024-06-13 06:11:41,262 INFO
2024-06-13 06:11:41,262 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-150/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-150/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-150/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-150/stderr.txt file found"
2024-06-13 06:11:41,262 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-13 06:11:42,056 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-13 06:11:42,056 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:42,056 DEBUG --- stdout ---
2024-06-13 06:11:42,056 DEBUG /results/orders/Reporting-login-tree-150/stderr.txt file found
2024-06-13 06:11:42,056 DEBUG --- stderr ---
2024-06-13 06:11:42,056 DEBUG
2024-06-13 06:11:42,056 INFO
2024-06-13 06:11:42,056 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:42,057 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:42,353 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:42,353 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:42,353 DEBUG --- stdout ---
2024-06-13 06:11:42,353 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:42,354 DEBUG --- stderr ---
2024-06-13 06:11:42,354 DEBUG
2024-06-13 06:11:42,354 INFO
2024-06-13 06:11:42,354 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-150/stderr.txt
2024-06-13 06:11:43,154 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-13 06:11:43,154 DEBUG --- stdout ---
2024-06-13 06:11:43,154 DEBUG 0 /results/orders/Reporting-login-tree-150/stderr.txt
2024-06-13 06:11:43,154 DEBUG --- stderr ---
2024-06-13 06:11:43,154 DEBUG
2024-06-13 06:11:43,154 INFO
- Download file (size 0k)
2024-06-13 06:11:43,155 INFO
2024-06-13 06:11:43,155 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:43,155 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:43,460 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:43,460 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:43,460 DEBUG --- stdout ---
2024-06-13 06:11:43,460 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:43,461 DEBUG --- stderr ---
2024-06-13 06:11:43,461 DEBUG
source : /results/orders/Reporting-login-tree-150/stderr.txt @ overseer-0-6c7d65494f-sln6z
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/stderr.txt
2024-06-13 06:11:43,461 INFO
2024-06-13 06:11:43,461 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:43,461 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-13 06:11:43,768 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-13 06:11:43,768 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:43,768 DEBUG --- stdout ---
2024-06-13 06:11:43,768 DEBUG overseer-0-6c7d65494f-sln6z
2024-06-13 06:11:43,768 DEBUG --- stderr ---
2024-06-13 06:11:43,768 DEBUG
2024-06-13 06:11:43,769 INFO
2024-06-13 06:11:43,769 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-150/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/stderr.txt
2024-06-13 06:11:43,769 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-13 06:11:44,495 INFO [loop_until]: OK (rc = 0)
2024-06-13 06:11:44,496 DEBUG --- stdout ---
2024-06-13 06:11:44,496 DEBUG tar: Removing leading `/' from member names
2024-06-13 06:11:44,496 DEBUG --- stderr ---
2024-06-13 06:11:44,496 DEBUG
2024-06-13 06:11:44,496 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/12_Reporting-login-tree-150/stderr.txt is small (0 lines), printing all lines:
2024-06-13 06:11:44,496 DEBUG ----- output -----
2024-06-13 06:11:44,496 DEBUG
2024-06-13 06:11:44,496 INFO
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-150 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-150 step13 : Analyze graphs for spikes
________________________________________________________________________________
Analyze Gatling graphs for spikes
checking parameters
open overall stats JSON file
checking simulation request protectLoginInitiate
checking simulation request PingOneProtectInitializeCallback
checking simulation request restLoginUsernamePasswordCallback
checking simulation request PingOneProtectEvaluationCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-150/gatling/req_pingoneprotecte-ee094.html - cannot check for spikes
checking simulation request restloginProgressiveProfileCallback
no spikes found
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-150 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 2249662,
"ok": 2249623,
"ko": 39
},
"minResponseTime": {
"total": 93,
"ok": 96,
"ko": 93
},
"maxResponseTime": {
"total": 3827,
"ok": 3827,
"ko": 610
},
"meanResponseTime": {
"total": 226,
"ok": 226,
"ko": 191
},
"standardDeviation": {
"total": 180,
"ok": 180,
"ko": 92
},
"percentiles1": {
"total": 130,
"ok": 130,
"ko": 170
},
"percentiles2": {
"total": 288,
"ok": 288,
"ko": 241
},
"percentiles3": {
"total": 535,
"ok": 535,
"ko": 309
},
"percentiles4": {
"total": 686,
"ok": 686,
"ko": 503
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 2238475,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 7907,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 3241,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 39,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 619.4003303964757,
"ok": 619.3895925110132,
"ko": 0.010737885462555066
}
},
"details": [
{
"name": "protectLoginInitiate",
"numberOfRequests": {
"total": 541726,
"ok": 541725,
"ko": 1
},
"minResponseTime": {
"total": 93,
"ok": 98,
"ko": 93
},
"maxResponseTime": {
"total": 1175,
"ok": 1175,
"ko": 93
},
"meanResponseTime": {
"total": 116,
"ok": 116,
"ko": 93
},
"standardDeviation": {
"total": 15,
"ok": 15,
"ko": 0
},
"percentiles1": {
"total": 113,
"ok": 113,
"ko": 93
},
"percentiles2": {
"total": 118,
"ok": 118,
"ko": 93
},
"percentiles3": {
"total": 139,
"ok": 139,
"ko": 93
},
"percentiles4": {
"total": 170,
"ok": 170,
"ko": 93
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 541723,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 2,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 1,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 149.1536343612335,
"ok": 149.153359030837,
"ko": 0.00027533039647577095
},
"spikes": []
},
{
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"total": 541725,
"ok": 541724,
"ko": 1
},
"minResponseTime": {
"total": 96,
"ok": 96,
"ko": 106
},
"maxResponseTime": {
"total": 765,
"ok": 765,
"ko": 106
},
"meanResponseTime": {
"total": 120,
"ok": 120,
"ko": 106
},
"standardDeviation": {
"total": 24,
"ok": 24,
"ko": 0
},
"percentiles1": {
"total": 115,
"ok": 115,
"ko": 106
},
"percentiles2": {
"total": 122,
"ok": 122,
"ko": 106
},
"percentiles3": {
"total": 152,
"ok": 152,
"ko": 106
},
"percentiles4": {
"total": 200,
"ok": 200,
"ko": 106
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 541724,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 0,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 1,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 149.153359030837,
"ok": 149.15308370044053,
"ko": 0.00027533039647577095
},
"spikes": []
},
{
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"total": 541725,
"ok": 541722,
"ko": 3
},
"minResponseTime": {
"total": 99,
"ok": 105,
"ko": 99
},
"maxResponseTime": {
"total": 715,
"ok": 715,
"ko": 329
},
"meanResponseTime": {
"total": 143,
"ok": 143,
"ko": 222
},
"standardDeviation": {
"total": 28,
"ok": 28,
"ko": 95
},
"percentiles1": {
"total": 136,
"ok": 136,
"ko": 237
},
"percentiles2": {
"total": 148,
"ok": 148,
"ko": 283
},
"percentiles3": {
"total": 186,
"ok": 186,
"ko": 320
},
"percentiles4": {
"total": 244,
"ok": 244,
"ko": 327
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 541722,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 0,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 3,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 149.153359030837,
"ok": 149.15253303964758,
"ko": 0.0008259911894273128
},
"spikes": []
},
{
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"total": 541725,
"ok": 541708,
"ko": 17
},
"minResponseTime": {
"total": 99,
"ok": 148,
"ko": 99
},
"maxResponseTime": {
"total": 3827,
"ok": 3827,
"ko": 610
},
"meanResponseTime": {
"total": 521,
"ok": 521,
"ko": 243
},
"standardDeviation": {
"total": 128,
"ok": 128,
"ko": 107
},
"percentiles1": {
"total": 495,
"ok": 495,
"ko": 241
},
"percentiles2": {
"total": 527,
"ok": 527,
"ko": 247
},
"percentiles3": {
"total": 661,
"ok": 661,
"ko": 368
},
"percentiles4": {
"total": 959,
"ok": 959,
"ko": 562
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 530563,
"percentage": 98
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 7904,
"percentage": 1
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 3241,
"percentage": 1
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 17,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 149.153359030837,
"ok": 149.1486784140969,
"ko": 0.004680616740088106
},
"spikes": []
},
{
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"total": 82761,
"ok": 82744,
"ko": 17
},
"minResponseTime": {
"total": 106,
"ok": 181,
"ko": 106
},
"maxResponseTime": {
"total": 885,
"ok": 885,
"ko": 212
},
"meanResponseTime": {
"total": 261,
"ok": 261,
"ko": 146
},
"standardDeviation": {
"total": 36,
"ok": 36,
"ko": 27
},
"percentiles1": {
"total": 257,
"ok": 257,
"ko": 145
},
"percentiles2": {
"total": 279,
"ok": 279,
"ko": 159
},
"percentiles3": {
"total": 322,
"ok": 322,
"ko": 182
},
"percentiles4": {
"total": 370,
"ok": 370,
"ko": 206
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 82743,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 1,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 17,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 22.786618942731277,
"ok": 22.781938325991188,
"ko": 0.004680616740088106
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 619,
"avg_response_time": 226,
"max_response_time": 3827,
"min_response_time": 96,
"num_requests": 2249662,
"num_requests_pass": 2249623,
"num_requests_percent_pass": 99.998
},
"options": "; testCase:idc.loginProtect; testMode:open; throughput:150; rampup-duration:30; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 541723,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 2,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 0,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 1,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 93,
"ok": 1175,
"total": 1175
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.00027533039647577095,
"ok": 149.153359030837,
"total": 149.1536343612335
},
"meanResponseTime": {
"ko": 93,
"ok": 116,
"total": 116
},
"minResponseTime": {
"ko": 93,
"ok": 98,
"total": 93
},
"name": "protectLoginInitiate",
"numberOfRequests": {
"ko": 1,
"ok": 541725,
"total": 541726
},
"percentiles1": {
"ko": 93,
"ok": 113,
"total": 113
},
"percentiles2": {
"ko": 93,
"ok": 118,
"total": 118
},
"percentiles3": {
"ko": 93,
"ok": 139,
"total": 139
},
"percentiles4": {
"ko": 93,
"ok": 170,
"total": 170
},
"spikes": [],
"standardDeviation": {
"ko": 0,
"ok": 15,
"total": 15
}
},
{
"group1": {
"count": 541724,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 0,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 0,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 1,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 106,
"ok": 765,
"total": 765
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.00027533039647577095,
"ok": 149.15308370044053,
"total": 149.153359030837
},
"meanResponseTime": {
"ko": 106,
"ok": 120,
"total": 120
},
"minResponseTime": {
"ko": 106,
"ok": 96,
"total": 96
},
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"ko": 1,
"ok": 541724,
"total": 541725
},
"percentiles1": {
"ko": 106,
"ok": 115,
"total": 115
},
"percentiles2": {
"ko": 106,
"ok": 122,
"total": 122
},
"percentiles3": {
"ko": 106,
"ok": 152,
"total": 152
},
"percentiles4": {
"ko": 106,
"ok": 200,
"total": 200
},
"spikes": [],
"standardDeviation": {
"ko": 0,
"ok": 24,
"total": 24
}
},
{
"group1": {
"count": 541722,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 0,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 0,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 3,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 329,
"ok": 715,
"total": 715
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.0008259911894273128,
"ok": 149.15253303964758,
"total": 149.153359030837
},
"meanResponseTime": {
"ko": 222,
"ok": 143,
"total": 143
},
"minResponseTime": {
"ko": 99,
"ok": 105,
"total": 99
},
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"ko": 3,
"ok": 541722,
"total": 541725
},
"percentiles1": {
"ko": 237,
"ok": 136,
"total": 136
},
"percentiles2": {
"ko": 283,
"ok": 148,
"total": 148
},
"percentiles3": {
"ko": 320,
"ok": 186,
"total": 186
},
"percentiles4": {
"ko": 327,
"ok": 244,
"total": 244
},
"spikes": [],
"standardDeviation": {
"ko": 95,
"ok": 28,
"total": 28
}
},
{
"group1": {
"count": 530563,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 98
},
"group2": {
"count": 7904,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 1
},
"group3": {
"count": 3241,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 1
},
"group4": {
"count": 17,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 610,
"ok": 3827,
"total": 3827
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.004680616740088106,
"ok": 149.1486784140969,
"total": 149.153359030837
},
"meanResponseTime": {
"ko": 243,
"ok": 521,
"total": 521
},
"minResponseTime": {
"ko": 99,
"ok": 148,
"total": 99
},
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"ko": 17,
"ok": 541708,
"total": 541725
},
"percentiles1": {
"ko": 241,
"ok": 495,
"total": 495
},
"percentiles2": {
"ko": 247,
"ok": 527,
"total": 527
},
"percentiles3": {
"ko": 368,
"ok": 661,
"total": 661
},
"percentiles4": {
"ko": 562,
"ok": 959,
"total": 959
},
"spikes": [],
"standardDeviation": {
"ko": 107,
"ok": 128,
"total": 128
}
},
{
"group1": {
"count": 82743,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 1,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 0,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 17,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 212,
"ok": 885,
"total": 885
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.004680616740088106,
"ok": 22.781938325991188,
"total": 22.786618942731277
},
"meanResponseTime": {
"ko": 146,
"ok": 261,
"total": 261
},
"minResponseTime": {
"ko": 106,
"ok": 181,
"total": 106
},
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"ko": 17,
"ok": 82744,
"total": 82761
},
"percentiles1": {
"ko": 145,
"ok": 257,
"total": 257
},
"percentiles2": {
"ko": 159,
"ok": 279,
"total": 279
},
"percentiles3": {
"ko": 182,
"ok": 322,
"total": 322
},
"percentiles4": {
"ko": 206,
"ok": 370,
"total": 370
},
"spikes": [],
"standardDeviation": {
"ko": 27,
"ok": 36,
"total": 36
}
}
],
"global": {
"group1": {
"count": 2238475,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 7907,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 3241,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 39,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 610,
"ok": 3827,
"total": 3827
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.010737885462555066,
"ok": 619.3895925110132,
"total": 619.4003303964757
},
"meanResponseTime": {
"ko": 191,
"ok": 226,
"total": 226
},
"minResponseTime": {
"ko": 93,
"ok": 96,
"total": 93
},
"name": "All Requests",
"numberOfRequests": {
"ko": 39,
"ok": 2249623,
"total": 2249662
},
"percentiles1": {
"ko": 170,
"ok": 130,
"total": 130
},
"percentiles2": {
"ko": 241,
"ok": 288,
"total": 288
},
"percentiles3": {
"ko": 309,
"ok": 535,
"total": 535
},
"percentiles4": {
"ko": 503,
"ok": 686,
"total": 686
},
"standardDeviation": {
"ko": 92,
"ok": 180,
"total": 180
}
}
},
"target_hostname": "openam-ema-perf-p1protect.forgeblocks.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-150 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-150 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/04_login-tree-150/stdout.txt
Compressing Gatling stdout.txt file..
________________________________________________________________________________
[2024-06-13 06:11:44] Reporting-login-tree-150 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped