--Task--
name: Reporting-login-tree-300
enabled: True
class_name: GatlingResultTask
source_name: overseer-0
source_namespace: >default<
target_name: overseer-0
target_namespace: >default<
start: 0.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-100', 'Reporting-login-tree-150', 'Reporting-login-tree-200', 'Reporting-login-tree-250']
preceding_task: None
options: {'task_name': 'login-tree-300'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-06-23 11:06:48] Reporting-login-tree-300 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
2024-06-23 11:06:48 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds)
2024-06-23 11:06:48 - INFO: timeout was set to GatlingResultTask default (half of global_duration or 3600 seconds (whatever is higher)), because it was unset
Pod stdout file : /results/orders/Reporting-login-tree-300/stdout.txt
Pod stderr file : /results/orders/Reporting-login-tree-300/stderr.txt
Pod log : /results/orders/Reporting-login-tree-300
________________________________________________________________________________
[2024-06-23 11:06:48] Reporting-login-tree-300 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-06-23 11:06:48,808 INFO
2024-06-23 11:06:48,808 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-23 11:06:48,808 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:06:49,131 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:06:49,131 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:06:49,131 DEBUG --- stdout ---
2024-06-23 11:06:49,131 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:06:49,131 DEBUG --- stderr ---
2024-06-23 11:06:49,131 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/order.json
{
"name": "Reporting-login-tree-300",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-300 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-login-tree-300"
}
________________________________________________________________________________
[2024-06-23 11:06:49] Reporting-login-tree-300 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-06-23 11:06:49,133 INFO
2024-06-23 11:06:49,133 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-23 11:06:49,133 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-06-23 11:06:49,377 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:06:49,377 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:06:49,377 DEBUG --- stdout ---
2024-06-23 11:06:49,377 DEBUG WAITING
2024-06-23 11:06:49,377 DEBUG --- stderr ---
2024-06-23 11:06:49,377 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 32 0 --:--:-- --:--:-- --:--:-- 32
________________________________________________________________________________
[2024-06-23 11:06:49] Reporting-login-tree-300 step3 : Send order to overseer
________________________________________________________________________________
2024-06-23 11:06:49,378 INFO
2024-06-23 11:06:49,378 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-23 11:06:49,379 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:06:49,710 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:06:49,710 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:06:49,710 DEBUG --- stdout ---
2024-06-23 11:06:49,710 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:06:49,710 DEBUG --- stderr ---
2024-06-23 11:06:49,710 DEBUG
2024-06-23 11:06:49,711 INFO
2024-06-23 11:06:49,711 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/order.json overseer-0-5b6f9464fd-slbm8:/results/orders/order.json
2024-06-23 11:06:49,711 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:06:51,088 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:06:51,088 DEBUG --- stdout ---
2024-06-23 11:06:51,088 DEBUG
2024-06-23 11:06:51,088 DEBUG --- stderr ---
2024-06-23 11:06:51,088 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-06-23 11:06:51] Reporting-login-tree-300 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-06-23 11:06:56,095 INFO
2024-06-23 11:06:56,095 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-23 11:06:56,097 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0]
2024-06-23 11:06:56,401 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-06-23 11:07:01,650 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-06-23 11:07:06,890 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
2024-06-23 11:07:12,142 INFO [loop_until]: Function succeeded after 16s (rc=0) - failed to find expected output: WAITING - retry
2024-06-23 11:07:17,385 INFO [loop_until]: Function succeeded after 21s (rc=0) - expected pattern found
2024-06-23 11:07:17,386 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:17,386 DEBUG --- stdout ---
2024-06-23 11:07:17,386 DEBUG WAITING
2024-06-23 11:07:17,386 DEBUG --- stderr ---
2024-06-23 11:07:17,386 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33
________________________________________________________________________________
[2024-06-23 11:07:17] Reporting-login-tree-300 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-06-23 11:07:17,387 INFO
2024-06-23 11:07:17,387 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-06-23 11:07:17,387 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:17,695 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:17,695 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:17,695 DEBUG --- stdout ---
2024-06-23 11:07:17,695 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:17,695 DEBUG --- stderr ---
2024-06-23 11:07:17,695 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:07:17,695 INFO
2024-06-23 11:07:17,695 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-06-23 11:07:17,695 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:17,997 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:17,997 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:17,997 DEBUG --- stdout ---
2024-06-23 11:07:17,997 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:17,997 DEBUG --- stderr ---
2024-06-23 11:07:17,997 DEBUG
2024-06-23 11:07:17,998 INFO
2024-06-23 11:07:17,998 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/gatling/login-tree-300.tar.gz" ]; then echo "/results/gatling/login-tree-300.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-300.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-300.tar.gz file found"
2024-06-23 11:07:17,998 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:07:18,843 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:07:18,843 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:18,844 DEBUG --- stdout ---
2024-06-23 11:07:18,844 DEBUG /results/gatling/login-tree-300.tar.gz file found
2024-06-23 11:07:18,844 DEBUG --- stderr ---
2024-06-23 11:07:18,844 DEBUG
2024-06-23 11:07:18,844 INFO
2024-06-23 11:07:18,844 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-23 11:07:18,844 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:19,179 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:19,179 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:19,179 DEBUG --- stdout ---
2024-06-23 11:07:19,179 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:19,179 DEBUG --- stderr ---
2024-06-23 11:07:19,179 DEBUG
2024-06-23 11:07:19,179 INFO
2024-06-23 11:07:19,180 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/gatling/login-tree-300.tar.gz
2024-06-23 11:07:20,004 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:07:20,005 DEBUG --- stdout ---
2024-06-23 11:07:20,005 DEBUG 452 /results/gatling/login-tree-300.tar.gz
2024-06-23 11:07:20,005 DEBUG --- stderr ---
2024-06-23 11:07:20,005 DEBUG
2024-06-23 11:07:20,005 INFO
- Download file (size 452k)
2024-06-23 11:07:20,005 INFO
2024-06-23 11:07:20,005 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-23 11:07:20,005 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:20,327 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:20,327 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:20,329 DEBUG --- stdout ---
2024-06-23 11:07:20,329 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:20,329 DEBUG --- stderr ---
2024-06-23 11:07:20,329 DEBUG
source : /results/gatling/login-tree-300.tar.gz @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz
2024-06-23 11:07:20,330 INFO
2024-06-23 11:07:20,330 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-23 11:07:20,330 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:20,649 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:20,650 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:20,650 DEBUG --- stdout ---
2024-06-23 11:07:20,650 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:20,650 DEBUG --- stderr ---
2024-06-23 11:07:20,650 DEBUG
2024-06-23 11:07:20,650 INFO
2024-06-23 11:07:20,651 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/gatling/login-tree-300.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz
2024-06-23 11:07:20,651 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:07:21,711 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:21,711 DEBUG --- stdout ---
2024-06-23 11:07:21,711 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:07:21,711 DEBUG --- stderr ---
2024-06-23 11:07:21,711 DEBUG
________________________________________________________________________________
[2024-06-23 11:07:21] Reporting-login-tree-300 step6 : Unzip the result
________________________________________________________________________________
2024-06-23 11:07:21,712 INFO
2024-06-23 11:07:21,712 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/gatling
2024-06-23 11:07:21,747 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:07:21,748 DEBUG --- stdout ---
2024-06-23 11:07:21,748 DEBUG
2024-06-23 11:07:21,748 DEBUG --- stderr ---
2024-06-23 11:07:21,748 DEBUG
2024-06-23 11:07:21,748 INFO
________________________________________________________________________________
[2024-06-23 11:07:21] Reporting-login-tree-300 step7 : Print rc order
________________________________________________________________________________
2024-06-23 11:07:21,749 INFO
2024-06-23 11:07:21,749 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-23 11:07:21,749 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:22,076 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:22,076 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:22,076 DEBUG --- stdout ---
2024-06-23 11:07:22,076 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:22,076 DEBUG --- stderr ---
2024-06-23 11:07:22,076 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:07:22,077 INFO
2024-06-23 11:07:22,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-23 11:07:22,077 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:22,396 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:22,397 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:22,397 DEBUG --- stdout ---
2024-06-23 11:07:22,397 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:22,397 DEBUG --- stderr ---
2024-06-23 11:07:22,397 DEBUG
2024-06-23 11:07:22,398 INFO
2024-06-23 11:07:22,398 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-300/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/rc.txt file found"
2024-06-23 11:07:22,398 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:07:23,260 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:07:23,261 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:23,261 DEBUG --- stdout ---
2024-06-23 11:07:23,261 DEBUG /results/orders/Reporting-login-tree-300/rc.txt file found
2024-06-23 11:07:23,261 DEBUG --- stderr ---
2024-06-23 11:07:23,261 DEBUG
2024-06-23 11:07:23,261 INFO
2024-06-23 11:07:23,261 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-23 11:07:23,261 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:23,583 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:23,584 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:23,584 DEBUG --- stdout ---
2024-06-23 11:07:23,584 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:23,584 DEBUG --- stderr ---
2024-06-23 11:07:23,584 DEBUG
2024-06-23 11:07:23,584 INFO
2024-06-23 11:07:23,584 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/Reporting-login-tree-300/rc.txt
2024-06-23 11:07:24,405 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:07:24,405 DEBUG --- stdout ---
2024-06-23 11:07:24,405 DEBUG 4 /results/orders/Reporting-login-tree-300/rc.txt
2024-06-23 11:07:24,406 DEBUG --- stderr ---
2024-06-23 11:07:24,406 DEBUG
2024-06-23 11:07:24,406 INFO
- Download file (size 4k)
2024-06-23 11:07:24,406 INFO
2024-06-23 11:07:24,406 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-23 11:07:24,406 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:24,732 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:24,732 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:24,732 DEBUG --- stdout ---
2024-06-23 11:07:24,732 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:24,732 DEBUG --- stderr ---
2024-06-23 11:07:24,732 DEBUG
source : /results/orders/Reporting-login-tree-300/rc.txt @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/rc.txt
2024-06-23 11:07:24,733 INFO
2024-06-23 11:07:24,733 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-23 11:07:24,733 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:25,049 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:25,049 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:25,049 DEBUG --- stdout ---
2024-06-23 11:07:25,050 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:25,050 DEBUG --- stderr ---
2024-06-23 11:07:25,050 DEBUG
2024-06-23 11:07:25,050 INFO
2024-06-23 11:07:25,050 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/Reporting-login-tree-300/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/rc.txt
2024-06-23 11:07:25,050 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:07:25,838 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:25,839 DEBUG --- stdout ---
2024-06-23 11:07:25,839 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:07:25,839 DEBUG --- stderr ---
2024-06-23 11:07:25,839 DEBUG
2024-06-23 11:07:25,839 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/rc.txt is small (1 lines), printing all lines:
2024-06-23 11:07:25,839 DEBUG ----- output -----
2024-06-23 11:07:25,839 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-06-23 11:07:25,839 INFO
________________________________________________________________________________
[2024-06-23 11:07:25] Reporting-login-tree-300 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-06-23 11:07:25] Reporting-login-tree-300 step9 : Print stdout order
________________________________________________________________________________
2024-06-23 11:07:25,840 INFO
2024-06-23 11:07:25,840 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-23 11:07:25,840 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:26,148 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:26,148 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:26,148 DEBUG --- stdout ---
2024-06-23 11:07:26,148 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:26,148 DEBUG --- stderr ---
2024-06-23 11:07:26,148 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:07:26,149 INFO
2024-06-23 11:07:26,149 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-23 11:07:26,149 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:26,455 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:26,455 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:26,455 DEBUG --- stdout ---
2024-06-23 11:07:26,455 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:26,455 DEBUG --- stderr ---
2024-06-23 11:07:26,455 DEBUG
2024-06-23 11:07:26,456 INFO
2024-06-23 11:07:26,456 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-300/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/stdout.txt file found"
2024-06-23 11:07:26,456 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:07:27,261 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:07:27,262 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:27,262 DEBUG --- stdout ---
2024-06-23 11:07:27,262 DEBUG /results/orders/Reporting-login-tree-300/stdout.txt file found
2024-06-23 11:07:27,262 DEBUG --- stderr ---
2024-06-23 11:07:27,262 DEBUG
2024-06-23 11:07:27,262 INFO
2024-06-23 11:07:27,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-23 11:07:27,262 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:27,578 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:27,578 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:27,578 DEBUG --- stdout ---
2024-06-23 11:07:27,579 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:27,579 DEBUG --- stderr ---
2024-06-23 11:07:27,579 DEBUG
2024-06-23 11:07:27,579 INFO
2024-06-23 11:07:27,579 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/Reporting-login-tree-300/stdout.txt
2024-06-23 11:07:28,378 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:07:28,379 DEBUG --- stdout ---
2024-06-23 11:07:28,379 DEBUG 8 /results/orders/Reporting-login-tree-300/stdout.txt
2024-06-23 11:07:28,379 DEBUG --- stderr ---
2024-06-23 11:07:28,379 DEBUG
2024-06-23 11:07:28,379 INFO
- Download file (size 8k)
2024-06-23 11:07:28,379 INFO
2024-06-23 11:07:28,379 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-23 11:07:28,380 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:28,691 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:28,691 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:28,691 DEBUG --- stdout ---
2024-06-23 11:07:28,691 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:28,691 DEBUG --- stderr ---
2024-06-23 11:07:28,691 DEBUG
source : /results/orders/Reporting-login-tree-300/stdout.txt @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/stdout.txt
2024-06-23 11:07:28,691 INFO
2024-06-23 11:07: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-23 11:07:28,691 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:28,999 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:29,000 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:29,000 DEBUG --- stdout ---
2024-06-23 11:07:29,000 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:29,000 DEBUG --- stderr ---
2024-06-23 11:07:29,000 DEBUG
2024-06-23 11:07:29,000 INFO
2024-06-23 11:07:29,000 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/Reporting-login-tree-300/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/stdout.txt
2024-06-23 11:07:29,000 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:07:29,726 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:29,726 DEBUG --- stdout ---
2024-06-23 11:07:29,726 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:07:29,726 DEBUG --- stderr ---
2024-06-23 11:07:29,726 DEBUG
2024-06-23 11:07:29,727 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/stdout.txt is small (94 lines), printing all lines:
2024-06-23 11:07:29,727 DEBUG ----- output -----
2024-06-23 11:07:29,727 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-300/loadtest-20240623085635868 --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 4567088 (OK=4535973 KO=31115 )
> min response time 4 (OK=40 KO=4 )
> max response time 76857 (OK=76857 KO=60020 )
> mean response time 3732 (OK=3747 KO=1545 )
> std deviation 3909 (OK=3898 KO=4798 )
> response time 50th percentile 2555 (OK=2576 KO=38 )
> response time 75th percentile 5997 (OK=6016 KO=41 )
> response time 95th percentile 11545 (OK=11547 KO=9259 )
> response time 99th percentile 15391 (OK=15393 KO=14279 )
> mean requests/sec 1255.039 (OK=1246.489 KO=8.55 )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 1479907 ( 32%)
> 800 ms <= t < 1200 ms 154972 ( 3%)
> t >= 1200 ms 2901094 ( 64%)
> failed 31115 ( 1%)
---- Errors --------------------------------------------------------------------
> status.find.is(200), but actually found 503 25631 (53.39%)
> PingOneProtectEvaluationCallback: Failed to build request: No 4223 ( 8.80%)
attribute named 'callbacks' is defined
> restLoginUsernamePasswordCallback: Failed to build request: No 4223 ( 8.80%)
attribute named 'callbacks' is defined
> restloginProgressiveProfileCallback: Failed to build request: 4223 ( 8.80%)
No attribute named 'callbacks' is defined
> PingOneProtectInitializeCallback: Failed to build request: No 4223 ( 8.80%)
attribute named 'callbacks' is defined
> status.find.is(200), but actually found 502 3260 ( 6.79%)
> status.find.is(200), but actually found 401 1259 ( 2.62%)
> jsonPath($.tokenId).find.exists, found nothing 788 ( 1.64%)
> Request timeout to openam-ema-perf-p1.forgeblocks.com/35.241.5 114 ( 0.24%)
9.5:443 after 60000 ms
> status.find.is(200), but actually found 400 50 ( 0.10%)
> j.i.IOException: Premature close 10 ( 0.02%)
> status.find.is(200), but actually found 500 3 ( 0.01%)
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/login-tree-300/loadtest-20240623085635868/index.html
----------------------
[23/Jun/2024 12:07:12] Create tar file /results/gatling/login-tree-300.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/login-tree-300/loadtest-20240623085635868
RESULT_FOLDER=login-tree-300
RESULT_PATH=/results/gatling/login-tree-300
PWD=/results/gatling/login-tree-300/loadtest-20240623085635868
[cmd] tar -czvf /results/gatling/login-tree-300.tar.gz --exclude=simulation.log *
index.html
js/
js/gatling.js
js/highcharts-more.js
js/highstock.js
js/ellipsis.js
js/bootstrap.min.js
js/stats.json
js/stats.js
js/global_stats.json
js/all_sessions.js
js/assertions.xml
js/menu.js
js/theme.js
js/unpack.js
js/jquery-3.5.1.min.js
js/assertions.json
req_pingoneprotecte-ee094.html
req_pingoneprotecti-dd6e3.html
req_protectloginini-66072.html
req_restloginprogre-9fc93.html
req_restloginuserna-d98ea.html
style/
style/bootstrap.min.css
style/stat-l-temps.png
style/favicon.ico
style/style.css
style/arrow_down_black.png
style/sorted-down.png
style/arrow_right.png
style/stat-l-roue.png
style/stat-fleche-bas.png
style/sorted-up.png
style/logo-enterprise.svg
style/little_arrow_right.png
style/logo.svg
style/sortable.png
style/arrow_down.png
style/arrow_right_black.png
2024-06-23 11:07:29,727 INFO
________________________________________________________________________________
[2024-06-23 11:07:29] Reporting-login-tree-300 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-06-23 11:07:29] Reporting-login-tree-300 step11 : Print stderr order
________________________________________________________________________________
2024-06-23 11:07:29,728 INFO
2024-06-23 11:07:29,728 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-23 11:07:29,728 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:30,036 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:30,036 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:30,036 DEBUG --- stdout ---
2024-06-23 11:07:30,036 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:30,036 DEBUG --- stderr ---
2024-06-23 11:07:30,036 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:07:30,037 INFO
2024-06-23 11:07:30,037 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-23 11:07:30,037 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:30,343 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:30,343 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:30,343 DEBUG --- stdout ---
2024-06-23 11:07:30,343 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:30,343 DEBUG --- stderr ---
2024-06-23 11:07:30,343 DEBUG
2024-06-23 11:07:30,344 INFO
2024-06-23 11:07:30,344 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-300/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/stderr.txt file found"
2024-06-23 11:07:30,344 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:07:31,148 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:07:31,149 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:31,150 DEBUG --- stdout ---
2024-06-23 11:07:31,150 DEBUG /results/orders/Reporting-login-tree-300/stderr.txt file found
2024-06-23 11:07:31,150 DEBUG --- stderr ---
2024-06-23 11:07:31,150 DEBUG
2024-06-23 11:07:31,151 INFO
2024-06-23 11:07:31,151 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-23 11:07:31,151 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:31,470 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:31,470 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:31,470 DEBUG --- stdout ---
2024-06-23 11:07:31,470 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:31,470 DEBUG --- stderr ---
2024-06-23 11:07:31,470 DEBUG
2024-06-23 11:07:31,470 INFO
2024-06-23 11:07:31,471 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/Reporting-login-tree-300/stderr.txt
2024-06-23 11:07:32,296 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:07:32,296 DEBUG --- stdout ---
2024-06-23 11:07:32,296 DEBUG 0 /results/orders/Reporting-login-tree-300/stderr.txt
2024-06-23 11:07:32,296 DEBUG --- stderr ---
2024-06-23 11:07:32,296 DEBUG
2024-06-23 11:07:32,296 INFO
- Download file (size 0k)
2024-06-23 11:07:32,297 INFO
2024-06-23 11:07:32,297 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-23 11:07:32,297 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:32,614 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:32,615 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:32,615 DEBUG --- stdout ---
2024-06-23 11:07:32,615 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:32,615 DEBUG --- stderr ---
2024-06-23 11:07:32,615 DEBUG
source : /results/orders/Reporting-login-tree-300/stderr.txt @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/stderr.txt
2024-06-23 11:07:32,615 INFO
2024-06-23 11:07:32,615 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-23 11:07:32,615 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:07:32,934 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:07:32,934 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:32,934 DEBUG --- stdout ---
2024-06-23 11:07:32,934 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:07:32,934 DEBUG --- stderr ---
2024-06-23 11:07:32,934 DEBUG
2024-06-23 11:07:32,935 INFO
2024-06-23 11:07:32,935 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/Reporting-login-tree-300/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/stderr.txt
2024-06-23 11:07:32,935 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:07:33,729 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:07:33,729 DEBUG --- stdout ---
2024-06-23 11:07:33,729 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:07:33,729 DEBUG --- stderr ---
2024-06-23 11:07:33,729 DEBUG
2024-06-23 11:07:33,730 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/14_Reporting-login-tree-300/stderr.txt is small (0 lines), printing all lines:
2024-06-23 11:07:33,730 DEBUG ----- output -----
2024-06-23 11:07:33,730 DEBUG
2024-06-23 11:07:33,730 INFO
________________________________________________________________________________
[2024-06-23 11:07:33] Reporting-login-tree-300 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-06-23 11:07:33] Reporting-login-tree-300 step13 : Analyze graphs for spikes
________________________________________________________________________________
Analyze Gatling graphs for spikes
checking parameters
open overall stats JSON file
checking simulation request protectLoginInitiate
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/gatling/req_protectloginini-66072.html - cannot check for spikes
checking simulation request PingOneProtectInitializeCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/gatling/req_pingoneprotecti-dd6e3.html - cannot check for spikes
checking simulation request restLoginUsernamePasswordCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/gatling/req_restloginuserna-d98ea.html - cannot check for spikes
checking simulation request PingOneProtectEvaluationCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/gatling/req_pingoneprotecte-ee094.html - cannot check for spikes
checking simulation request restloginProgressiveProfileCallback
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/gatling/req_restloginprogre-9fc93.html - cannot check for spikes
no spikes found
________________________________________________________________________________
[2024-06-23 11:07:33] Reporting-login-tree-300 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 4567088,
"ok": 4535973,
"ko": 31115
},
"minResponseTime": {
"total": 4,
"ok": 40,
"ko": 4
},
"maxResponseTime": {
"total": 76857,
"ok": 76857,
"ko": 60020
},
"meanResponseTime": {
"total": 3732,
"ok": 3747,
"ko": 1545
},
"standardDeviation": {
"total": 3909,
"ok": 3898,
"ko": 4798
},
"percentiles1": {
"total": 2555,
"ok": 2576,
"ko": 38
},
"percentiles2": {
"total": 5997,
"ok": 6016,
"ko": 41
},
"percentiles3": {
"total": 11545,
"ok": 11547,
"ko": 9259
},
"percentiles4": {
"total": 15391,
"ok": 15393,
"ko": 14279
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 1479907,
"percentage": 32
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 154972,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 2901094,
"percentage": 64
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 31115,
"percentage": 1
},
"meanNumberOfRequestsPerSecond": {
"total": 1255.0392965100302,
"ok": 1246.4888705688377,
"ko": 8.550425941192636
}
},
"details": [
{
"name": "protectLoginInitiate",
"numberOfRequests": {
"total": 1084997,
"ok": 1080774,
"ko": 4223
},
"minResponseTime": {
"total": 4,
"ok": 44,
"ko": 4
},
"maxResponseTime": {
"total": 29678,
"ok": 29678,
"ko": 18291
},
"meanResponseTime": {
"total": 2464,
"ok": 2467,
"ko": 1894
},
"standardDeviation": {
"total": 2899,
"ok": 2896,
"ko": 3644
},
"percentiles1": {
"total": 1501,
"ok": 1509,
"ko": 41
},
"percentiles2": {
"total": 3849,
"ok": 3849,
"ko": 4037
},
"percentiles3": {
"total": 8326,
"ok": 8325,
"ko": 12042
},
"percentiles4": {
"total": 11402,
"ok": 11368,
"ko": 12048
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 456491,
"percentage": 42
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 45304,
"percentage": 4
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 578979,
"percentage": 53
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 4223,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 298.15801044242926,
"ok": 296.997526793075,
"ko": 1.160483649354218
},
"spikes": []
},
{
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"total": 1080774,
"ok": 1077636,
"ko": 3138
},
"minResponseTime": {
"total": 32,
"ok": 40,
"ko": 32
},
"maxResponseTime": {
"total": 60001,
"ok": 59177,
"ko": 60001
},
"meanResponseTime": {
"total": 2490,
"ok": 2490,
"ko": 2539
},
"standardDeviation": {
"total": 2902,
"ok": 2885,
"ko": 6563
},
"percentiles1": {
"total": 1552,
"ok": 1557,
"ko": 38
},
"percentiles2": {
"total": 3928,
"ok": 3928,
"ko": 3344
},
"percentiles3": {
"total": 8289,
"ok": 8285,
"ko": 12041
},
"percentiles4": {
"total": 11455,
"ok": 11408,
"ko": 17233
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 455970,
"percentage": 42
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 41769,
"percentage": 4
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 579897,
"percentage": 54
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 3138,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 296.997526793075,
"ok": 296.13520197856553,
"ko": 0.8623248145094806
},
"spikes": []
},
{
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"total": 1080774,
"ok": 1074927,
"ko": 5847
},
"minResponseTime": {
"total": 32,
"ok": 49,
"ko": 32
},
"maxResponseTime": {
"total": 60001,
"ok": 56737,
"ko": 60001
},
"meanResponseTime": {
"total": 3619,
"ok": 3626,
"ko": 2191
},
"standardDeviation": {
"total": 3336,
"ok": 3315,
"ko": 5982
},
"percentiles1": {
"total": 2932,
"ok": 2948,
"ko": 38
},
"percentiles2": {
"total": 5376,
"ok": 5384,
"ko": 40
},
"percentiles3": {
"total": 10145,
"ok": 10140,
"ko": 12041
},
"percentiles4": {
"total": 12832,
"ok": 12808,
"ko": 20239
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 279610,
"percentage": 26
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 37179,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 758138,
"percentage": 70
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 5847,
"percentage": 1
},
"meanNumberOfRequestsPerSecond": {
"total": 296.997526793075,
"ok": 295.39076669414675,
"ko": 1.606760098928277
},
"spikes": []
},
{
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"total": 1080774,
"ok": 1072173,
"ko": 8601
},
"minResponseTime": {
"total": 32,
"ok": 50,
"ko": 32
},
"maxResponseTime": {
"total": 76857,
"ok": 76857,
"ko": 60020
},
"meanResponseTime": {
"total": 5856,
"ok": 5890,
"ko": 1664
},
"standardDeviation": {
"total": 4757,
"ok": 4737,
"ko": 5311
},
"percentiles1": {
"total": 5234,
"ok": 5296,
"ko": 38
},
"percentiles2": {
"total": 9180,
"ok": 9204,
"ko": 40
},
"percentiles3": {
"total": 14554,
"ok": 14567,
"ko": 8897
},
"percentiles4": {
"total": 17058,
"ok": 17061,
"ko": 14017
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 237196,
"percentage": 22
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 27253,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 807724,
"percentage": 75
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 8601,
"percentage": 1
},
"meanNumberOfRequestsPerSecond": {
"total": 296.997526793075,
"ok": 294.63396537510306,
"ko": 2.36356141797197
},
"spikes": []
},
{
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"total": 239769,
"ok": 230463,
"ko": 9306
},
"minResponseTime": {
"total": 32,
"ok": 127,
"ko": 32
},
"maxResponseTime": {
"total": 60001,
"ok": 53895,
"ko": 60001
},
"meanResponseTime": {
"total": 5997,
"ok": 6218,
"ko": 536
},
"standardDeviation": {
"total": 4810,
"ok": 4750,
"ko": 2484
},
"percentiles1": {
"total": 5934,
"ok": 6240,
"ko": 37
},
"percentiles2": {
"total": 9344,
"ok": 9494,
"ko": 39
},
"percentiles3": {
"total": 14374,
"ok": 14438,
"ko": 3875
},
"percentiles4": {
"total": 16924,
"ok": 16993,
"ko": 10763
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 50640,
"percentage": 21
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 3467,
"percentage": 1
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 176356,
"percentage": 74
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 9306,
"percentage": 4
},
"meanNumberOfRequestsPerSecond": {
"total": 65.88870568837592,
"ok": 63.33140972794724,
"ko": 2.5572959604286893
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 1255,
"avg_response_time": 3732,
"max_response_time": 76857,
"min_response_time": 40,
"num_requests": 4567088,
"num_requests_pass": 4535973,
"num_requests_percent_pass": 99.319
},
"options": "; testCase:idc.loginProtect; testMode:open; throughput:300; rampup-duration:30; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 456491,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 42
},
"group2": {
"count": 45304,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 4
},
"group3": {
"count": 578979,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 53
},
"group4": {
"count": 4223,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 18291,
"ok": 29678,
"total": 29678
},
"meanNumberOfRequestsPerSecond": {
"ko": 1.160483649354218,
"ok": 296.997526793075,
"total": 298.15801044242926
},
"meanResponseTime": {
"ko": 1894,
"ok": 2467,
"total": 2464
},
"minResponseTime": {
"ko": 4,
"ok": 44,
"total": 4
},
"name": "protectLoginInitiate",
"numberOfRequests": {
"ko": 4223,
"ok": 1080774,
"total": 1084997
},
"percentiles1": {
"ko": 41,
"ok": 1509,
"total": 1501
},
"percentiles2": {
"ko": 4037,
"ok": 3849,
"total": 3849
},
"percentiles3": {
"ko": 12042,
"ok": 8325,
"total": 8326
},
"percentiles4": {
"ko": 12048,
"ok": 11368,
"total": 11402
},
"spikes": [],
"standardDeviation": {
"ko": 3644,
"ok": 2896,
"total": 2899
}
},
{
"group1": {
"count": 455970,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 42
},
"group2": {
"count": 41769,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 4
},
"group3": {
"count": 579897,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 54
},
"group4": {
"count": 3138,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 60001,
"ok": 59177,
"total": 60001
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.8623248145094806,
"ok": 296.13520197856553,
"total": 296.997526793075
},
"meanResponseTime": {
"ko": 2539,
"ok": 2490,
"total": 2490
},
"minResponseTime": {
"ko": 32,
"ok": 40,
"total": 32
},
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"ko": 3138,
"ok": 1077636,
"total": 1080774
},
"percentiles1": {
"ko": 38,
"ok": 1557,
"total": 1552
},
"percentiles2": {
"ko": 3344,
"ok": 3928,
"total": 3928
},
"percentiles3": {
"ko": 12041,
"ok": 8285,
"total": 8289
},
"percentiles4": {
"ko": 17233,
"ok": 11408,
"total": 11455
},
"spikes": [],
"standardDeviation": {
"ko": 6563,
"ok": 2885,
"total": 2902
}
},
{
"group1": {
"count": 279610,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 26
},
"group2": {
"count": 37179,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 758138,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 70
},
"group4": {
"count": 5847,
"htmlName": "failed",
"name": "failed",
"percentage": 1
},
"maxResponseTime": {
"ko": 60001,
"ok": 56737,
"total": 60001
},
"meanNumberOfRequestsPerSecond": {
"ko": 1.606760098928277,
"ok": 295.39076669414675,
"total": 296.997526793075
},
"meanResponseTime": {
"ko": 2191,
"ok": 3626,
"total": 3619
},
"minResponseTime": {
"ko": 32,
"ok": 49,
"total": 32
},
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"ko": 5847,
"ok": 1074927,
"total": 1080774
},
"percentiles1": {
"ko": 38,
"ok": 2948,
"total": 2932
},
"percentiles2": {
"ko": 40,
"ok": 5384,
"total": 5376
},
"percentiles3": {
"ko": 12041,
"ok": 10140,
"total": 10145
},
"percentiles4": {
"ko": 20239,
"ok": 12808,
"total": 12832
},
"spikes": [],
"standardDeviation": {
"ko": 5982,
"ok": 3315,
"total": 3336
}
},
{
"group1": {
"count": 237196,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 22
},
"group2": {
"count": 27253,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 807724,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 75
},
"group4": {
"count": 8601,
"htmlName": "failed",
"name": "failed",
"percentage": 1
},
"maxResponseTime": {
"ko": 60020,
"ok": 76857,
"total": 76857
},
"meanNumberOfRequestsPerSecond": {
"ko": 2.36356141797197,
"ok": 294.63396537510306,
"total": 296.997526793075
},
"meanResponseTime": {
"ko": 1664,
"ok": 5890,
"total": 5856
},
"minResponseTime": {
"ko": 32,
"ok": 50,
"total": 32
},
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"ko": 8601,
"ok": 1072173,
"total": 1080774
},
"percentiles1": {
"ko": 38,
"ok": 5296,
"total": 5234
},
"percentiles2": {
"ko": 40,
"ok": 9204,
"total": 9180
},
"percentiles3": {
"ko": 8897,
"ok": 14567,
"total": 14554
},
"percentiles4": {
"ko": 14017,
"ok": 17061,
"total": 17058
},
"spikes": [],
"standardDeviation": {
"ko": 5311,
"ok": 4737,
"total": 4757
}
},
{
"group1": {
"count": 50640,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 21
},
"group2": {
"count": 3467,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 1
},
"group3": {
"count": 176356,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 74
},
"group4": {
"count": 9306,
"htmlName": "failed",
"name": "failed",
"percentage": 4
},
"maxResponseTime": {
"ko": 60001,
"ok": 53895,
"total": 60001
},
"meanNumberOfRequestsPerSecond": {
"ko": 2.5572959604286893,
"ok": 63.33140972794724,
"total": 65.88870568837592
},
"meanResponseTime": {
"ko": 536,
"ok": 6218,
"total": 5997
},
"minResponseTime": {
"ko": 32,
"ok": 127,
"total": 32
},
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"ko": 9306,
"ok": 230463,
"total": 239769
},
"percentiles1": {
"ko": 37,
"ok": 6240,
"total": 5934
},
"percentiles2": {
"ko": 39,
"ok": 9494,
"total": 9344
},
"percentiles3": {
"ko": 3875,
"ok": 14438,
"total": 14374
},
"percentiles4": {
"ko": 10763,
"ok": 16993,
"total": 16924
},
"spikes": [],
"standardDeviation": {
"ko": 2484,
"ok": 4750,
"total": 4810
}
}
],
"global": {
"group1": {
"count": 1479907,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 32
},
"group2": {
"count": 154972,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 2901094,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 64
},
"group4": {
"count": 31115,
"htmlName": "failed",
"name": "failed",
"percentage": 1
},
"maxResponseTime": {
"ko": 60020,
"ok": 76857,
"total": 76857
},
"meanNumberOfRequestsPerSecond": {
"ko": 8.550425941192636,
"ok": 1246.4888705688377,
"total": 1255.0392965100302
},
"meanResponseTime": {
"ko": 1545,
"ok": 3747,
"total": 3732
},
"minResponseTime": {
"ko": 4,
"ok": 40,
"total": 4
},
"name": "All Requests",
"numberOfRequests": {
"ko": 31115,
"ok": 4535973,
"total": 4567088
},
"percentiles1": {
"ko": 38,
"ok": 2576,
"total": 2555
},
"percentiles2": {
"ko": 41,
"ok": 6016,
"total": 5997
},
"percentiles3": {
"ko": 9259,
"ok": 11547,
"total": 11545
},
"percentiles4": {
"ko": 14279,
"ok": 15393,
"total": 15391
},
"standardDeviation": {
"ko": 4798,
"ok": 3898,
"total": 3909
}
}
},
"target_hostname": "openam-ema-perf-p1.forgeblocks.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-06-23 11:07:33] Reporting-login-tree-300 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-06-23 11:07:33] Reporting-login-tree-300 step16 : Remove gatling task's stdout file
________________________________________________________________________________
Cleanup of Gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/stdout.txt
Compressing Gatling stdout.txt file..
________________________________________________________________________________
[2024-06-23 11:07:40] Reporting-login-tree-300 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped