--Task--
name: Reporting-login-tree-100
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']
preceding_task: None
options: {'task_name': 'login-tree-100'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-06-23 11:04:04] Reporting-login-tree-100 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
2024-06-23 11:04:04 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds)
2024-06-23 11:04:04 - 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-100/stdout.txt
Pod stderr file : /results/orders/Reporting-login-tree-100/stderr.txt
Pod log : /results/orders/Reporting-login-tree-100
________________________________________________________________________________
[2024-06-23 11:04:04] Reporting-login-tree-100 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-06-23 11:04:04,951 INFO
2024-06-23 11:04:04,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-23 11:04:04,951 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:05,290 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:05,290 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:05,290 DEBUG --- stdout ---
2024-06-23 11:04:05,290 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:05,290 DEBUG --- stderr ---
2024-06-23 11:04:05,290 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/order.json
{
"name": "Reporting-login-tree-100",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-100 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-login-tree-100"
}
________________________________________________________________________________
[2024-06-23 11:04:05] Reporting-login-tree-100 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-06-23 11:04:05,292 INFO
2024-06-23 11:04:05,292 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-23 11:04:05,292 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-06-23 11:04:05,528 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:04:05,528 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:05,528 DEBUG --- stdout ---
2024-06-23 11:04:05,529 DEBUG WAITING
2024-06-23 11:04:05,529 DEBUG --- stderr ---
2024-06-23 11:04:05,529 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:04:05] Reporting-login-tree-100 step3 : Send order to overseer
________________________________________________________________________________
2024-06-23 11:04:05,529 INFO
2024-06-23 11:04:05,529 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:04:05,529 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:05,842 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:05,843 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:05,843 DEBUG --- stdout ---
2024-06-23 11:04:05,843 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:05,843 DEBUG --- stderr ---
2024-06-23 11:04:05,843 DEBUG
2024-06-23 11:04:05,843 INFO
2024-06-23 11:04:05,843 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/10_Reporting-login-tree-100/order.json overseer-0-5b6f9464fd-slbm8:/results/orders/order.json
2024-06-23 11:04:05,843 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:04:07,224 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:07,224 DEBUG --- stdout ---
2024-06-23 11:04:07,225 DEBUG
2024-06-23 11:04:07,225 DEBUG --- stderr ---
2024-06-23 11:04:07,225 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-06-23 11:04:07] Reporting-login-tree-100 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-06-23 11:04:12,231 INFO
2024-06-23 11:04:12,231 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-23 11:04:12,231 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0]
2024-06-23 11:04:12,523 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-06-23 11:04:17,762 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-06-23 11:04:23,007 INFO [loop_until]: Function succeeded after 10s (rc=0) - expected pattern found
2024-06-23 11:04:23,007 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:23,008 DEBUG --- stdout ---
2024-06-23 11:04:23,009 DEBUG WAITING
2024-06-23 11:04:23,009 DEBUG --- stderr ---
2024-06-23 11:04:23,009 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-23 11:04:23] Reporting-login-tree-100 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-06-23 11:04:23,010 INFO
2024-06-23 11:04:23,010 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:04:23,010 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:23,348 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:23,348 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:23,348 DEBUG --- stdout ---
2024-06-23 11:04:23,348 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:23,348 DEBUG --- stderr ---
2024-06-23 11:04:23,348 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:04:23,349 INFO
2024-06-23 11:04:23,349 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:04:23,349 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:23,667 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:23,667 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:23,667 DEBUG --- stdout ---
2024-06-23 11:04:23,667 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:23,667 DEBUG --- stderr ---
2024-06-23 11:04:23,667 DEBUG
2024-06-23 11:04:23,668 INFO
2024-06-23 11:04:23,668 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-100.tar.gz" ]; then echo "/results/gatling/login-tree-100.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-100.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-100.tar.gz file found"
2024-06-23 11:04:23,668 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:04:24,474 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:04:24,474 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:24,474 DEBUG --- stdout ---
2024-06-23 11:04:24,474 DEBUG /results/gatling/login-tree-100.tar.gz file found
2024-06-23 11:04:24,475 DEBUG --- stderr ---
2024-06-23 11:04:24,475 DEBUG
2024-06-23 11:04:24,475 INFO
2024-06-23 11:04:24,475 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:04:24,475 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:24,799 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:24,799 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:24,799 DEBUG --- stdout ---
2024-06-23 11:04:24,799 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:24,799 DEBUG --- stderr ---
2024-06-23 11:04:24,800 DEBUG
2024-06-23 11:04:24,800 INFO
2024-06-23 11:04:24,800 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-100.tar.gz
2024-06-23 11:04:25,623 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:04:25,624 DEBUG --- stdout ---
2024-06-23 11:04:25,624 DEBUG 316 /results/gatling/login-tree-100.tar.gz
2024-06-23 11:04:25,624 DEBUG --- stderr ---
2024-06-23 11:04:25,624 DEBUG
2024-06-23 11:04:25,624 INFO
- Download file (size 316k)
2024-06-23 11:04:25,624 INFO
2024-06-23 11:04:25,624 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:04:25,624 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:25,944 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:25,944 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:25,944 DEBUG --- stdout ---
2024-06-23 11:04:25,944 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:25,945 DEBUG --- stderr ---
2024-06-23 11:04:25,945 DEBUG
source : /results/gatling/login-tree-100.tar.gz @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-100.tar.gz
2024-06-23 11:04:25,945 INFO
2024-06-23 11:04:25,945 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:04:25,945 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:26,252 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:26,252 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:26,252 DEBUG --- stdout ---
2024-06-23 11:04:26,252 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:26,252 DEBUG --- stderr ---
2024-06-23 11:04:26,252 DEBUG
2024-06-23 11:04:26,252 INFO
2024-06-23 11:04:26,252 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-100.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-100.tar.gz
2024-06-23 11:04:26,253 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:04:27,266 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:27,266 DEBUG --- stdout ---
2024-06-23 11:04:27,266 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:04:27,267 DEBUG --- stderr ---
2024-06-23 11:04:27,267 DEBUG
________________________________________________________________________________
[2024-06-23 11:04:27] Reporting-login-tree-100 step6 : Unzip the result
________________________________________________________________________________
2024-06-23 11:04:27,268 INFO
2024-06-23 11:04:27,268 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-100.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/02_login-tree-100/gatling
2024-06-23 11:04:27,299 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:04:27,299 DEBUG --- stdout ---
2024-06-23 11:04:27,299 DEBUG
2024-06-23 11:04:27,299 DEBUG --- stderr ---
2024-06-23 11:04:27,299 DEBUG
2024-06-23 11:04:27,299 INFO
________________________________________________________________________________
[2024-06-23 11:04:27] Reporting-login-tree-100 step7 : Print rc order
________________________________________________________________________________
2024-06-23 11:04:27,300 INFO
2024-06-23 11:04:27,301 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:04:27,301 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:27,619 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:27,619 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:27,620 DEBUG --- stdout ---
2024-06-23 11:04:27,620 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:27,620 DEBUG --- stderr ---
2024-06-23 11:04:27,620 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:04:27,620 INFO
2024-06-23 11:04:27,620 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:04:27,620 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:27,940 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:27,941 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:27,941 DEBUG --- stdout ---
2024-06-23 11:04:27,941 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:27,941 DEBUG --- stderr ---
2024-06-23 11:04:27,941 DEBUG
2024-06-23 11:04:27,942 INFO
2024-06-23 11:04:27,942 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-100/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-100/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-100/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-100/rc.txt file found"
2024-06-23 11:04:27,942 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:04:28,761 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:04:28,761 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:28,762 DEBUG --- stdout ---
2024-06-23 11:04:28,762 DEBUG /results/orders/Reporting-login-tree-100/rc.txt file found
2024-06-23 11:04:28,762 DEBUG --- stderr ---
2024-06-23 11:04:28,762 DEBUG
2024-06-23 11:04:28,762 INFO
2024-06-23 11:04:28,762 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:04:28,762 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:29,085 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:29,085 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:29,085 DEBUG --- stdout ---
2024-06-23 11:04:29,085 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:29,085 DEBUG --- stderr ---
2024-06-23 11:04:29,085 DEBUG
2024-06-23 11:04:29,085 INFO
2024-06-23 11:04:29,086 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-100/rc.txt
2024-06-23 11:04:29,903 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:04:29,904 DEBUG --- stdout ---
2024-06-23 11:04:29,904 DEBUG 4 /results/orders/Reporting-login-tree-100/rc.txt
2024-06-23 11:04:29,904 DEBUG --- stderr ---
2024-06-23 11:04:29,904 DEBUG
2024-06-23 11:04:29,904 INFO
- Download file (size 4k)
2024-06-23 11:04:29,904 INFO
2024-06-23 11:04:29,904 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:04:29,904 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:30,226 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:30,226 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:30,226 DEBUG --- stdout ---
2024-06-23 11:04:30,226 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:30,226 DEBUG --- stderr ---
2024-06-23 11:04:30,226 DEBUG
source : /results/orders/Reporting-login-tree-100/rc.txt @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/rc.txt
2024-06-23 11:04:30,227 INFO
2024-06-23 11:04:30,227 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:04:30,227 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:30,550 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:30,550 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:30,550 DEBUG --- stdout ---
2024-06-23 11:04:30,550 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:30,550 DEBUG --- stderr ---
2024-06-23 11:04:30,550 DEBUG
2024-06-23 11:04:30,551 INFO
2024-06-23 11:04:30,551 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-100/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/rc.txt
2024-06-23 11:04:30,551 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:04:31,292 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:31,292 DEBUG --- stdout ---
2024-06-23 11:04:31,292 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:04:31,292 DEBUG --- stderr ---
2024-06-23 11:04:31,292 DEBUG
2024-06-23 11:04:31,293 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/rc.txt is small (1 lines), printing all lines:
2024-06-23 11:04:31,293 DEBUG ----- output -----
2024-06-23 11:04:31,293 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-06-23 11:04:31,293 INFO
________________________________________________________________________________
[2024-06-23 11:04:31] Reporting-login-tree-100 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-06-23 11:04:31] Reporting-login-tree-100 step9 : Print stdout order
________________________________________________________________________________
2024-06-23 11:04:31,294 INFO
2024-06-23 11:04:31,294 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:04:31,295 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:31,618 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:31,619 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:31,619 DEBUG --- stdout ---
2024-06-23 11:04:31,619 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:31,619 DEBUG --- stderr ---
2024-06-23 11:04:31,619 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:04:31,619 INFO
2024-06-23 11:04:31,619 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:04:31,619 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:31,955 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:31,955 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:31,955 DEBUG --- stdout ---
2024-06-23 11:04:31,955 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:31,955 DEBUG --- stderr ---
2024-06-23 11:04:31,955 DEBUG
2024-06-23 11:04:31,956 INFO
2024-06-23 11:04:31,956 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-100/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-100/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-100/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-100/stdout.txt file found"
2024-06-23 11:04:31,956 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:04:32,794 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:04:32,795 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:32,795 DEBUG --- stdout ---
2024-06-23 11:04:32,795 DEBUG /results/orders/Reporting-login-tree-100/stdout.txt file found
2024-06-23 11:04:32,795 DEBUG --- stderr ---
2024-06-23 11:04:32,795 DEBUG
2024-06-23 11:04:32,795 INFO
2024-06-23 11:04:32,795 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:04:32,795 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:33,114 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:33,114 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:33,114 DEBUG --- stdout ---
2024-06-23 11:04:33,114 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:33,114 DEBUG --- stderr ---
2024-06-23 11:04:33,114 DEBUG
2024-06-23 11:04:33,114 INFO
2024-06-23 11:04:33,115 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-100/stdout.txt
2024-06-23 11:04:33,931 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:04:33,931 DEBUG --- stdout ---
2024-06-23 11:04:33,932 DEBUG 4 /results/orders/Reporting-login-tree-100/stdout.txt
2024-06-23 11:04:33,932 DEBUG --- stderr ---
2024-06-23 11:04:33,932 DEBUG
2024-06-23 11:04:33,932 INFO
- Download file (size 4k)
2024-06-23 11:04:33,933 INFO
2024-06-23 11:04:33,933 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:04:33,933 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:34,237 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:34,237 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:34,237 DEBUG --- stdout ---
2024-06-23 11:04:34,237 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:34,237 DEBUG --- stderr ---
2024-06-23 11:04:34,237 DEBUG
source : /results/orders/Reporting-login-tree-100/stdout.txt @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/stdout.txt
2024-06-23 11:04:34,238 INFO
2024-06-23 11:04:34,238 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:04:34,238 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:34,543 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:34,543 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:34,544 DEBUG --- stdout ---
2024-06-23 11:04:34,544 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:34,544 DEBUG --- stderr ---
2024-06-23 11:04:34,544 DEBUG
2024-06-23 11:04:34,544 INFO
2024-06-23 11:04:34,544 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-100/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/stdout.txt
2024-06-23 11:04:34,544 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:04:35,305 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:35,306 DEBUG --- stdout ---
2024-06-23 11:04:35,306 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:04:35,306 DEBUG --- stderr ---
2024-06-23 11:04:35,306 DEBUG
2024-06-23 11:04:35,306 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/stdout.txt is small (88 lines), printing all lines:
2024-06-23 11:04:35,306 DEBUG ----- output -----
2024-06-23 11:04:35,306 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-100/loadtest-20240623044605369 --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 1454413 (OK=1454087 KO=326 )
> min response time 34 (OK=39 KO=34 )
> max response time 15647 (OK=15647 KO=12877 )
> mean response time 141 (OK=140 KO=4600 )
> std deviation 365 (OK=350 KO=5323 )
> response time 50th percentile 54 (OK=54 KO=51 )
> response time 75th percentile 179 (OK=178 KO=10495 )
> response time 95th percentile 326 (OK=326 KO=11565 )
> response time 99th percentile 1210 (OK=1204 KO=12119 )
> mean requests/sec 400.554 (OK=400.465 KO=0.09 )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 1430576 ( 98%)
> 800 ms <= t < 1200 ms 8904 ( 1%)
> t >= 1200 ms 14607 ( 1%)
> failed 326 ( 0%)
---- Errors --------------------------------------------------------------------
> jsonPath($.tokenId).find.exists, found nothing 156 (46.71%)
> status.find.is(200), but actually found 401 155 (46.41%)
> status.find.is(200), but actually found 502 15 ( 4.49%)
> restLoginUsernamePasswordCallback: Failed to build request: No 2 ( 0.60%)
attribute named 'callbacks' is defined
> restloginProgressiveProfileCallback: Failed to build request: 2 ( 0.60%)
No attribute named 'callbacks' is defined
> PingOneProtectEvaluationCallback: Failed to build request: No 2 ( 0.60%)
attribute named 'callbacks' is defined
> PingOneProtectInitializeCallback: Failed to build request: No 2 ( 0.60%)
attribute named 'callbacks' is defined
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/login-tree-100/loadtest-20240623044605369/index.html
----------------------
[23/Jun/2024 12:04:19] Create tar file /results/gatling/login-tree-100.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/login-tree-100/loadtest-20240623044605369
RESULT_FOLDER=login-tree-100
RESULT_PATH=/results/gatling/login-tree-100
PWD=/results/gatling/login-tree-100/loadtest-20240623044605369
[cmd] tar -czvf /results/gatling/login-tree-100.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:04:35,306 INFO
________________________________________________________________________________
[2024-06-23 11:04:35] Reporting-login-tree-100 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-06-23 11:04:35] Reporting-login-tree-100 step11 : Print stderr order
________________________________________________________________________________
2024-06-23 11:04:35,308 INFO
2024-06-23 11:04:35,308 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:04:35,309 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:35,640 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:35,640 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:35,640 DEBUG --- stdout ---
2024-06-23 11:04:35,640 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:35,640 DEBUG --- stderr ---
2024-06-23 11:04:35,640 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-23 11:04:35,641 INFO
2024-06-23 11:04:35,641 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:04:35,641 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:35,962 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:35,962 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:35,962 DEBUG --- stdout ---
2024-06-23 11:04:35,962 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:35,962 DEBUG --- stderr ---
2024-06-23 11:04:35,962 DEBUG
2024-06-23 11:04:35,963 INFO
2024-06-23 11:04:35,963 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-100/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-100/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-100/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-100/stderr.txt file found"
2024-06-23 11:04:35,963 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-23 11:04:36,777 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-23 11:04:36,777 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:36,777 DEBUG --- stdout ---
2024-06-23 11:04:36,777 DEBUG /results/orders/Reporting-login-tree-100/stderr.txt file found
2024-06-23 11:04:36,777 DEBUG --- stderr ---
2024-06-23 11:04:36,777 DEBUG
2024-06-23 11:04:36,778 INFO
2024-06-23 11:04:36,778 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:04:36,778 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:37,083 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:37,083 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:37,083 DEBUG --- stdout ---
2024-06-23 11:04:37,083 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:37,083 DEBUG --- stderr ---
2024-06-23 11:04:37,083 DEBUG
2024-06-23 11:04:37,083 INFO
2024-06-23 11:04:37,084 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-100/stderr.txt
2024-06-23 11:04:37,973 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-23 11:04:37,974 DEBUG --- stdout ---
2024-06-23 11:04:37,974 DEBUG 0 /results/orders/Reporting-login-tree-100/stderr.txt
2024-06-23 11:04:37,974 DEBUG --- stderr ---
2024-06-23 11:04:37,974 DEBUG
2024-06-23 11:04:37,974 INFO
- Download file (size 0k)
2024-06-23 11:04:37,974 INFO
2024-06-23 11:04:37,974 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:04:37,974 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:38,276 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:38,277 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:38,277 DEBUG --- stdout ---
2024-06-23 11:04:38,277 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:38,277 DEBUG --- stderr ---
2024-06-23 11:04:38,277 DEBUG
source : /results/orders/Reporting-login-tree-100/stderr.txt @ overseer-0-5b6f9464fd-slbm8
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/stderr.txt
2024-06-23 11:04:38,277 INFO
2024-06-23 11:04:38,277 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:04:38,277 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-23 11:04:38,579 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-23 11:04:38,579 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:38,579 DEBUG --- stdout ---
2024-06-23 11:04:38,579 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-23 11:04:38,579 DEBUG --- stderr ---
2024-06-23 11:04:38,579 DEBUG
2024-06-23 11:04:38,580 INFO
2024-06-23 11:04:38,580 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-100/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/stderr.txt
2024-06-23 11:04:38,580 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-23 11:04:39,307 INFO [loop_until]: OK (rc = 0)
2024-06-23 11:04:39,308 DEBUG --- stdout ---
2024-06-23 11:04:39,308 DEBUG tar: Removing leading `/' from member names
2024-06-23 11:04:39,308 DEBUG --- stderr ---
2024-06-23 11:04:39,308 DEBUG
2024-06-23 11:04:39,308 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/10_Reporting-login-tree-100/stderr.txt is small (0 lines), printing all lines:
2024-06-23 11:04:39,308 DEBUG ----- output -----
2024-06-23 11:04:39,308 DEBUG
2024-06-23 11:04:39,308 INFO
________________________________________________________________________________
[2024-06-23 11:04:39] Reporting-login-tree-100 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-06-23 11:04:39] Reporting-login-tree-100 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/02_login-tree-100/gatling/req_pingoneprotecte-ee094.html - cannot check for spikes
checking simulation request restloginProgressiveProfileCallback
no spikes found
________________________________________________________________________________
[2024-06-23 11:04:39] Reporting-login-tree-100 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 1454413,
"ok": 1454087,
"ko": 326
},
"minResponseTime": {
"total": 34,
"ok": 39,
"ko": 34
},
"maxResponseTime": {
"total": 15647,
"ok": 15647,
"ko": 12877
},
"meanResponseTime": {
"total": 141,
"ok": 140,
"ko": 4600
},
"standardDeviation": {
"total": 365,
"ok": 350,
"ko": 5323
},
"percentiles1": {
"total": 54,
"ok": 54,
"ko": 51
},
"percentiles2": {
"total": 179,
"ok": 178,
"ko": 10495
},
"percentiles3": {
"total": 326,
"ok": 326,
"ko": 11565
},
"percentiles4": {
"total": 1210,
"ok": 1204,
"ko": 12119
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 1430576,
"percentage": 98
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 8904,
"percentage": 1
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 14607,
"percentage": 1
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 326,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 400.55439272927566,
"ok": 400.46461030019276,
"ko": 0.08978242908289727
}
},
"details": [
{
"name": "protectLoginInitiate",
"numberOfRequests": {
"total": 361627,
"ok": 361625,
"ko": 2
},
"minResponseTime": {
"total": 40,
"ok": 42,
"ko": 40
},
"maxResponseTime": {
"total": 1109,
"ok": 1109,
"ko": 41
},
"meanResponseTime": {
"total": 50,
"ok": 50,
"ko": 41
},
"standardDeviation": {
"total": 5,
"ok": 5,
"ko": 1
},
"percentiles1": {
"total": 50,
"ok": 50,
"ko": 41
},
"percentiles2": {
"total": 52,
"ok": 52,
"ko": 41
},
"percentiles3": {
"total": 54,
"ok": 54,
"ko": 41
},
"percentiles4": {
"total": 59,
"ok": 59,
"ko": 41
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 361621,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 4,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 2,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 99.59432663178188,
"ok": 99.59377581933352,
"ko": 0.000550812448361333
},
"spikes": []
},
{
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"total": 361625,
"ok": 361623,
"ko": 2
},
"minResponseTime": {
"total": 37,
"ok": 39,
"ko": 37
},
"maxResponseTime": {
"total": 276,
"ok": 276,
"ko": 71
},
"meanResponseTime": {
"total": 47,
"ok": 47,
"ko": 54
},
"standardDeviation": {
"total": 3,
"ok": 3,
"ko": 17
},
"percentiles1": {
"total": 47,
"ok": 47,
"ko": 54
},
"percentiles2": {
"total": 49,
"ok": 49,
"ko": 63
},
"percentiles3": {
"total": 52,
"ok": 52,
"ko": 69
},
"percentiles4": {
"total": 56,
"ok": 56,
"ko": 71
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 361623,
"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": 2,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 99.59377581933352,
"ok": 99.59322500688515,
"ko": 0.000550812448361333
},
"spikes": []
},
{
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"total": 361625,
"ok": 361619,
"ko": 6
},
"minResponseTime": {
"total": 34,
"ok": 46,
"ko": 34
},
"maxResponseTime": {
"total": 280,
"ok": 280,
"ko": 112
},
"meanResponseTime": {
"total": 59,
"ok": 59,
"ko": 48
},
"standardDeviation": {
"total": 5,
"ok": 5,
"ko": 28
},
"percentiles1": {
"total": 58,
"ok": 58,
"ko": 36
},
"percentiles2": {
"total": 61,
"ok": 61,
"ko": 37
},
"percentiles3": {
"total": 66,
"ok": 66,
"ko": 93
},
"percentiles4": {
"total": 71,
"ok": 71,
"ko": 108
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 361619,
"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": 6,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 99.59377581933352,
"ok": 99.59212338198843,
"ko": 0.0016524373450839988
},
"spikes": []
},
{
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"total": 361625,
"ok": 361465,
"ko": 160
},
"minResponseTime": {
"total": 34,
"ok": 48,
"ko": 34
},
"maxResponseTime": {
"total": 15647,
"ok": 15647,
"ko": 12877
},
"meanResponseTime": {
"total": 407,
"ok": 403,
"ko": 9325
},
"standardDeviation": {
"total": 665,
"ok": 633,
"ko": 3728
},
"percentiles1": {
"total": 262,
"ok": 262,
"ko": 10561
},
"percentiles2": {
"total": 303,
"ok": 303,
"ko": 11029
},
"percentiles3": {
"total": 1053,
"ok": 1048,
"ko": 11820
},
"percentiles4": {
"total": 3070,
"ok": 2993,
"ko": 12255
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 337958,
"percentage": 93
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 8900,
"percentage": 2
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 14607,
"percentage": 4
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 160,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 99.59377581933352,
"ok": 99.54971082346461,
"ko": 0.04406499586890664
},
"spikes": []
},
{
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"total": 7911,
"ok": 7755,
"ko": 156
},
"minResponseTime": {
"total": 40,
"ok": 120,
"ko": 40
},
"maxResponseTime": {
"total": 419,
"ok": 419,
"ko": 54
},
"meanResponseTime": {
"total": 148,
"ok": 150,
"ko": 46
},
"standardDeviation": {
"total": 20,
"ok": 14,
"ko": 3
},
"percentiles1": {
"total": 150,
"ok": 150,
"ko": 46
},
"percentiles2": {
"total": 159,
"ok": 159,
"ko": 48
},
"percentiles3": {
"total": 169,
"ok": 169,
"ko": 51
},
"percentiles4": {
"total": 180,
"ok": 180,
"ko": 53
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 7755,
"percentage": 98
},
"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": 156,
"percentage": 2
},
"meanNumberOfRequestsPerSecond": {
"total": 2.1787386394932526,
"ok": 2.1357752685210687,
"ko": 0.04296337097218397
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 401,
"avg_response_time": 141,
"max_response_time": 15647,
"min_response_time": 39,
"num_requests": 1454413,
"num_requests_pass": 1454087,
"num_requests_percent_pass": 99.978
},
"options": "; testCase:idc.loginProtect; testMode:open; throughput:100; rampup-duration:30; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 361621,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 4,
"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": 2,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 41,
"ok": 1109,
"total": 1109
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.000550812448361333,
"ok": 99.59377581933352,
"total": 99.59432663178188
},
"meanResponseTime": {
"ko": 41,
"ok": 50,
"total": 50
},
"minResponseTime": {
"ko": 40,
"ok": 42,
"total": 40
},
"name": "protectLoginInitiate",
"numberOfRequests": {
"ko": 2,
"ok": 361625,
"total": 361627
},
"percentiles1": {
"ko": 41,
"ok": 50,
"total": 50
},
"percentiles2": {
"ko": 41,
"ok": 52,
"total": 52
},
"percentiles3": {
"ko": 41,
"ok": 54,
"total": 54
},
"percentiles4": {
"ko": 41,
"ok": 59,
"total": 59
},
"spikes": [],
"standardDeviation": {
"ko": 1,
"ok": 5,
"total": 5
}
},
{
"group1": {
"count": 361623,
"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": 2,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 71,
"ok": 276,
"total": 276
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.000550812448361333,
"ok": 99.59322500688515,
"total": 99.59377581933352
},
"meanResponseTime": {
"ko": 54,
"ok": 47,
"total": 47
},
"minResponseTime": {
"ko": 37,
"ok": 39,
"total": 37
},
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"ko": 2,
"ok": 361623,
"total": 361625
},
"percentiles1": {
"ko": 54,
"ok": 47,
"total": 47
},
"percentiles2": {
"ko": 63,
"ok": 49,
"total": 49
},
"percentiles3": {
"ko": 69,
"ok": 52,
"total": 52
},
"percentiles4": {
"ko": 71,
"ok": 56,
"total": 56
},
"spikes": [],
"standardDeviation": {
"ko": 17,
"ok": 3,
"total": 3
}
},
{
"group1": {
"count": 361619,
"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": 6,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 112,
"ok": 280,
"total": 280
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.0016524373450839988,
"ok": 99.59212338198843,
"total": 99.59377581933352
},
"meanResponseTime": {
"ko": 48,
"ok": 59,
"total": 59
},
"minResponseTime": {
"ko": 34,
"ok": 46,
"total": 34
},
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"ko": 6,
"ok": 361619,
"total": 361625
},
"percentiles1": {
"ko": 36,
"ok": 58,
"total": 58
},
"percentiles2": {
"ko": 37,
"ok": 61,
"total": 61
},
"percentiles3": {
"ko": 93,
"ok": 66,
"total": 66
},
"percentiles4": {
"ko": 108,
"ok": 71,
"total": 71
},
"spikes": [],
"standardDeviation": {
"ko": 28,
"ok": 5,
"total": 5
}
},
{
"group1": {
"count": 337958,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 93
},
"group2": {
"count": 8900,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 2
},
"group3": {
"count": 14607,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 4
},
"group4": {
"count": 160,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 12877,
"ok": 15647,
"total": 15647
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.04406499586890664,
"ok": 99.54971082346461,
"total": 99.59377581933352
},
"meanResponseTime": {
"ko": 9325,
"ok": 403,
"total": 407
},
"minResponseTime": {
"ko": 34,
"ok": 48,
"total": 34
},
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"ko": 160,
"ok": 361465,
"total": 361625
},
"percentiles1": {
"ko": 10561,
"ok": 262,
"total": 262
},
"percentiles2": {
"ko": 11029,
"ok": 303,
"total": 303
},
"percentiles3": {
"ko": 11820,
"ok": 1048,
"total": 1053
},
"percentiles4": {
"ko": 12255,
"ok": 2993,
"total": 3070
},
"spikes": [],
"standardDeviation": {
"ko": 3728,
"ok": 633,
"total": 665
}
},
{
"group1": {
"count": 7755,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 98
},
"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": 156,
"htmlName": "failed",
"name": "failed",
"percentage": 2
},
"maxResponseTime": {
"ko": 54,
"ok": 419,
"total": 419
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.04296337097218397,
"ok": 2.1357752685210687,
"total": 2.1787386394932526
},
"meanResponseTime": {
"ko": 46,
"ok": 150,
"total": 148
},
"minResponseTime": {
"ko": 40,
"ok": 120,
"total": 40
},
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"ko": 156,
"ok": 7755,
"total": 7911
},
"percentiles1": {
"ko": 46,
"ok": 150,
"total": 150
},
"percentiles2": {
"ko": 48,
"ok": 159,
"total": 159
},
"percentiles3": {
"ko": 51,
"ok": 169,
"total": 169
},
"percentiles4": {
"ko": 53,
"ok": 180,
"total": 180
},
"spikes": [],
"standardDeviation": {
"ko": 3,
"ok": 14,
"total": 20
}
}
],
"global": {
"group1": {
"count": 1430576,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 98
},
"group2": {
"count": 8904,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 1
},
"group3": {
"count": 14607,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 1
},
"group4": {
"count": 326,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 12877,
"ok": 15647,
"total": 15647
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.08978242908289727,
"ok": 400.46461030019276,
"total": 400.55439272927566
},
"meanResponseTime": {
"ko": 4600,
"ok": 140,
"total": 141
},
"minResponseTime": {
"ko": 34,
"ok": 39,
"total": 34
},
"name": "All Requests",
"numberOfRequests": {
"ko": 326,
"ok": 1454087,
"total": 1454413
},
"percentiles1": {
"ko": 51,
"ok": 54,
"total": 54
},
"percentiles2": {
"ko": 10495,
"ok": 178,
"total": 179
},
"percentiles3": {
"ko": 11565,
"ok": 326,
"total": 326
},
"percentiles4": {
"ko": 12119,
"ok": 1204,
"total": 1210
},
"standardDeviation": {
"ko": 5323,
"ok": 350,
"total": 365
}
}
},
"target_hostname": "openam-ema-perf-p1.forgeblocks.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-06-23 11:04:39] Reporting-login-tree-100 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-06-23 11:04:39] Reporting-login-tree-100 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/02_login-tree-100/stdout.txt
Compressing Gatling stdout.txt file..
________________________________________________________________________________
[2024-06-23 11:04:39] Reporting-login-tree-100 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped