--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-22 10:39:10] Reporting-login-tree-100 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
2024-06-22 10:39:10 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds)
2024-06-22 10:39:10 - INFO: timeout was set to GatlingResultTask default (half of global_duration or 3600 seconds (whatever is higher)), because it was unset
Pod stdout file : /results/orders/Reporting-login-tree-100/stdout.txt
Pod stderr file : /results/orders/Reporting-login-tree-100/stderr.txt
Pod log : /results/orders/Reporting-login-tree-100
________________________________________________________________________________
[2024-06-22 10:39:10] Reporting-login-tree-100 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-06-22 10:39:10,353 INFO
2024-06-22 10:39:10,353 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-22 10:39:10,353 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:10,684 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:10,684 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:10,684 DEBUG --- stdout ---
2024-06-22 10:39:10,684 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:10,684 DEBUG --- stderr ---
2024-06-22 10:39:10,684 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-22 10:39:10] Reporting-login-tree-100 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-06-22 10:39:10,686 INFO
2024-06-22 10:39:10,686 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-22 10:39:10,686 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-06-22 10:39:10,972 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-22 10:39:10,972 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:10,973 DEBUG --- stdout ---
2024-06-22 10:39:10,973 DEBUG WAITING
2024-06-22 10:39:10,973 DEBUG --- stderr ---
2024-06-22 10:39:10,973 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
100 7 100 7 0 0 27 0 --:--:-- --:--:-- --:--:-- 27
________________________________________________________________________________
[2024-06-22 10:39:10] Reporting-login-tree-100 step3 : Send order to overseer
________________________________________________________________________________
2024-06-22 10:39:10,974 INFO
2024-06-22 10:39:10,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-22 10:39:10,974 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:11,302 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:11,302 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:11,302 DEBUG --- stdout ---
2024-06-22 10:39:11,302 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:11,302 DEBUG --- stderr ---
2024-06-22 10:39:11,302 DEBUG
2024-06-22 10:39:11,303 INFO
2024-06-22 10:39:11,303 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-22 10:39:11,303 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-22 10:39:12,670 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:12,670 DEBUG --- stdout ---
2024-06-22 10:39:12,670 DEBUG
2024-06-22 10:39:12,670 DEBUG --- stderr ---
2024-06-22 10:39:12,670 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-06-22 10:39:12] Reporting-login-tree-100 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-06-22 10:39:17,674 INFO
2024-06-22 10:39:17,675 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-06-22 10:39:17,675 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0]
2024-06-22 10:39:17,911 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-06-22 10:39:23,161 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-06-22 10:39:28,444 INFO [loop_until]: Function succeeded after 10s (rc=0) - expected pattern found
2024-06-22 10:39:28,444 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:28,444 DEBUG --- stdout ---
2024-06-22 10:39:28,444 DEBUG WAITING
2024-06-22 10:39:28,444 DEBUG --- stderr ---
2024-06-22 10:39:28,444 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 27 0 --:--:-- --:--:-- --:--:-- 27
________________________________________________________________________________
[2024-06-22 10:39:28] Reporting-login-tree-100 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-06-22 10:39:28,445 INFO
2024-06-22 10:39:28,445 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-22 10:39:28,446 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:28,757 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:28,757 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:28,757 DEBUG --- stdout ---
2024-06-22 10:39:28,757 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:28,757 DEBUG --- stderr ---
2024-06-22 10:39:28,757 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-22 10:39:28,757 INFO
2024-06-22 10:39:28,757 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-06-22 10:39:28,757 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:29,063 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:29,063 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:29,063 DEBUG --- stdout ---
2024-06-22 10:39:29,063 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:29,063 DEBUG --- stderr ---
2024-06-22 10:39:29,063 DEBUG
2024-06-22 10:39:29,064 INFO
2024-06-22 10:39:29,064 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-22 10:39:29,064 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-22 10:39:29,870 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-22 10:39:29,870 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:29,870 DEBUG --- stdout ---
2024-06-22 10:39:29,870 DEBUG /results/gatling/login-tree-100.tar.gz file found
2024-06-22 10:39:29,870 DEBUG --- stderr ---
2024-06-22 10:39:29,870 DEBUG
2024-06-22 10:39:29,871 INFO
2024-06-22 10:39:29,871 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-22 10:39:29,871 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:30,174 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:30,174 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:30,174 DEBUG --- stdout ---
2024-06-22 10:39:30,174 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:30,174 DEBUG --- stderr ---
2024-06-22 10:39:30,174 DEBUG
2024-06-22 10:39:30,174 INFO
2024-06-22 10:39:30,175 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-22 10:39:30,994 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-22 10:39:30,994 DEBUG --- stdout ---
2024-06-22 10:39:30,994 DEBUG 312 /results/gatling/login-tree-100.tar.gz
2024-06-22 10:39:30,995 DEBUG --- stderr ---
2024-06-22 10:39:30,995 DEBUG
2024-06-22 10:39:30,995 INFO
- Download file (size 312k)
2024-06-22 10:39:30,995 INFO
2024-06-22 10:39:30,995 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-22 10:39:30,995 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:31,327 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:31,327 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:31,327 DEBUG --- stdout ---
2024-06-22 10:39:31,327 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:31,327 DEBUG --- stderr ---
2024-06-22 10:39:31,327 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-22 10:39:31,328 INFO
2024-06-22 10:39:31,328 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-22 10:39:31,328 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:31,633 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:31,633 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:31,633 DEBUG --- stdout ---
2024-06-22 10:39:31,633 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:31,633 DEBUG --- stderr ---
2024-06-22 10:39:31,633 DEBUG
2024-06-22 10:39:31,634 INFO
2024-06-22 10:39:31,634 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-22 10:39:31,634 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-22 10:39:32,630 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:32,630 DEBUG --- stdout ---
2024-06-22 10:39:32,630 DEBUG tar: Removing leading `/' from member names
2024-06-22 10:39:32,630 DEBUG --- stderr ---
2024-06-22 10:39:32,630 DEBUG
________________________________________________________________________________
[2024-06-22 10:39:32] Reporting-login-tree-100 step6 : Unzip the result
________________________________________________________________________________
2024-06-22 10:39:32,631 INFO
2024-06-22 10:39:32,632 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-22 10:39:32,663 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-22 10:39:32,664 DEBUG --- stdout ---
2024-06-22 10:39:32,664 DEBUG
2024-06-22 10:39:32,664 DEBUG --- stderr ---
2024-06-22 10:39:32,664 DEBUG
2024-06-22 10:39:32,664 INFO
________________________________________________________________________________
[2024-06-22 10:39:32] Reporting-login-tree-100 step7 : Print rc order
________________________________________________________________________________
2024-06-22 10:39:32,665 INFO
2024-06-22 10:39:32,665 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-22 10:39:32,665 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:32,987 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:32,987 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:32,989 DEBUG --- stdout ---
2024-06-22 10:39:32,989 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:32,989 DEBUG --- stderr ---
2024-06-22 10:39:32,989 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-22 10:39:32,990 INFO
2024-06-22 10:39:32,990 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-22 10:39:32,990 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:33,314 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:33,315 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:33,315 DEBUG --- stdout ---
2024-06-22 10:39:33,315 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:33,315 DEBUG --- stderr ---
2024-06-22 10:39:33,315 DEBUG
2024-06-22 10:39:33,315 INFO
2024-06-22 10:39:33,315 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-22 10:39:33,315 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-22 10:39:34,116 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-22 10:39:34,117 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:34,117 DEBUG --- stdout ---
2024-06-22 10:39:34,117 DEBUG /results/orders/Reporting-login-tree-100/rc.txt file found
2024-06-22 10:39:34,117 DEBUG --- stderr ---
2024-06-22 10:39:34,117 DEBUG
2024-06-22 10:39:34,117 INFO
2024-06-22 10:39:34,117 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-22 10:39:34,117 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:34,502 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:34,503 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:34,503 DEBUG --- stdout ---
2024-06-22 10:39:34,503 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:34,503 DEBUG --- stderr ---
2024-06-22 10:39:34,503 DEBUG
2024-06-22 10:39:34,503 INFO
2024-06-22 10:39:34,503 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-22 10:39:35,307 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-22 10:39:35,308 DEBUG --- stdout ---
2024-06-22 10:39:35,308 DEBUG 4 /results/orders/Reporting-login-tree-100/rc.txt
2024-06-22 10:39:35,308 DEBUG --- stderr ---
2024-06-22 10:39:35,308 DEBUG
2024-06-22 10:39:35,308 INFO
- Download file (size 4k)
2024-06-22 10:39:35,308 INFO
2024-06-22 10:39: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-22 10:39:35,308 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:35,621 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:35,622 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:35,622 DEBUG --- stdout ---
2024-06-22 10:39:35,622 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:35,622 DEBUG --- stderr ---
2024-06-22 10:39:35,622 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-22 10:39:35,622 INFO
2024-06-22 10:39:35,622 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-22 10:39:35,622 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:35,927 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:35,927 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:35,927 DEBUG --- stdout ---
2024-06-22 10:39:35,927 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:35,927 DEBUG --- stderr ---
2024-06-22 10:39:35,927 DEBUG
2024-06-22 10:39:35,928 INFO
2024-06-22 10:39:35,928 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-22 10:39:35,928 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-22 10:39:36,652 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:36,652 DEBUG --- stdout ---
2024-06-22 10:39:36,652 DEBUG tar: Removing leading `/' from member names
2024-06-22 10:39:36,652 DEBUG --- stderr ---
2024-06-22 10:39:36,652 DEBUG
2024-06-22 10:39:36,652 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-22 10:39:36,653 DEBUG ----- output -----
2024-06-22 10:39:36,653 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-06-22 10:39:36,653 INFO
________________________________________________________________________________
[2024-06-22 10:39:36] Reporting-login-tree-100 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-06-22 10:39:36] Reporting-login-tree-100 step9 : Print stdout order
________________________________________________________________________________
2024-06-22 10:39:36,654 INFO
2024-06-22 10:39:36,654 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-06-22 10:39:36,654 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:36,959 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:36,959 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:36,959 DEBUG --- stdout ---
2024-06-22 10:39:36,959 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:36,959 DEBUG --- stderr ---
2024-06-22 10:39:36,959 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-22 10:39:36,959 INFO
2024-06-22 10:39:36,960 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-22 10:39:36,960 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:37,265 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:37,265 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:37,265 DEBUG --- stdout ---
2024-06-22 10:39:37,265 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:37,265 DEBUG --- stderr ---
2024-06-22 10:39:37,265 DEBUG
2024-06-22 10:39:37,266 INFO
2024-06-22 10:39:37,266 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-22 10:39:37,266 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-22 10:39:38,118 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-22 10:39:38,118 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:38,120 DEBUG --- stdout ---
2024-06-22 10:39:38,120 DEBUG /results/orders/Reporting-login-tree-100/stdout.txt file found
2024-06-22 10:39:38,120 DEBUG --- stderr ---
2024-06-22 10:39:38,120 DEBUG
2024-06-22 10:39:38,121 INFO
2024-06-22 10:39:38,121 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-22 10:39:38,121 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:38,441 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:38,441 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:38,441 DEBUG --- stdout ---
2024-06-22 10:39:38,441 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:38,441 DEBUG --- stderr ---
2024-06-22 10:39:38,441 DEBUG
2024-06-22 10:39:38,442 INFO
2024-06-22 10:39:38,442 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-22 10:39:39,265 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-22 10:39:39,265 DEBUG --- stdout ---
2024-06-22 10:39:39,265 DEBUG 4 /results/orders/Reporting-login-tree-100/stdout.txt
2024-06-22 10:39:39,265 DEBUG --- stderr ---
2024-06-22 10:39:39,265 DEBUG
2024-06-22 10:39:39,265 INFO
- Download file (size 4k)
2024-06-22 10:39:39,266 INFO
2024-06-22 10:39:39,266 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-22 10:39:39,266 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:39,586 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:39,586 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:39,586 DEBUG --- stdout ---
2024-06-22 10:39:39,586 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:39,586 DEBUG --- stderr ---
2024-06-22 10:39:39,586 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-22 10:39:39,586 INFO
2024-06-22 10:39:39,587 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-22 10:39:39,587 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:39,909 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:39,909 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:39,909 DEBUG --- stdout ---
2024-06-22 10:39:39,909 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:39,909 DEBUG --- stderr ---
2024-06-22 10:39:39,909 DEBUG
2024-06-22 10:39:39,910 INFO
2024-06-22 10:39:39,910 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-22 10:39:39,910 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-22 10:39:40,705 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:40,705 DEBUG --- stdout ---
2024-06-22 10:39:40,705 DEBUG tar: Removing leading `/' from member names
2024-06-22 10:39:40,705 DEBUG --- stderr ---
2024-06-22 10:39:40,705 DEBUG
2024-06-22 10:39:40,706 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-22 10:39:40,706 DEBUG ----- output -----
2024-06-22 10:39:40,706 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-100/loadtest-20240622042304506 --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 1455374 (OK=1455308 KO=66 )
> min response time 33 (OK=40 KO=33 )
> max response time 9286 (OK=9286 KO=610 )
> mean response time 111 (OK=111 KO=85 )
> std deviation 160 (OK=160 KO=104 )
> response time 50th percentile 55 (OK=55 KO=47 )
> response time 75th percentile 174 (OK=174 KO=95 )
> response time 95th percentile 279 (OK=279 KO=312 )
> response time 99th percentile 356 (OK=356 KO=522 )
> mean requests/sec 400.819 (OK=400.801 KO=0.018 )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 1452561 (100%)
> 800 ms <= t < 1200 ms 1056 ( 0%)
> t >= 1200 ms 1691 ( 0%)
> failed 66 ( 0%)
---- Errors --------------------------------------------------------------------
> jsonPath($.tokenId).find.exists, found nothing 24 (29.27%)
> status.find.is(200), but actually found 502 22 (26.83%)
> status.find.is(200), but actually found 401 20 (24.39%)
> restLoginUsernamePasswordCallback: Failed to build request: No 4 ( 4.88%)
attribute named 'callbacks' is defined
> restloginProgressiveProfileCallback: Failed to build request: 4 ( 4.88%)
No attribute named 'callbacks' is defined
> PingOneProtectEvaluationCallback: Failed to build request: No 4 ( 4.88%)
attribute named 'callbacks' is defined
> PingOneProtectInitializeCallback: Failed to build request: No 4 ( 4.88%)
attribute named 'callbacks' is defined
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/login-tree-100/loadtest-20240622042304506/index.html
----------------------
[22/Jun/2024 11:39:25] Create tar file /results/gatling/login-tree-100.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/login-tree-100/loadtest-20240622042304506
RESULT_FOLDER=login-tree-100
RESULT_PATH=/results/gatling/login-tree-100
PWD=/results/gatling/login-tree-100/loadtest-20240622042304506
[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-22 10:39:40,706 INFO
________________________________________________________________________________
[2024-06-22 10:39:40] Reporting-login-tree-100 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-06-22 10:39:40] Reporting-login-tree-100 step11 : Print stderr order
________________________________________________________________________________
2024-06-22 10:39:40,708 INFO
2024-06-22 10:39:40,708 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-22 10:39:40,708 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:41,030 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:41,030 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:41,030 DEBUG --- stdout ---
2024-06-22 10:39:41,030 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:41,030 DEBUG --- stderr ---
2024-06-22 10:39:41,030 DEBUG
Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait.
2024-06-22 10:39:41,031 INFO
2024-06-22 10:39:41,031 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-22 10:39:41,031 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:41,349 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:41,349 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:41,349 DEBUG --- stdout ---
2024-06-22 10:39:41,349 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:41,349 DEBUG --- stderr ---
2024-06-22 10:39:41,349 DEBUG
2024-06-22 10:39:41,350 INFO
2024-06-22 10:39:41,350 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-22 10:39:41,350 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-06-22 10:39:42,165 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-06-22 10:39:42,165 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:42,166 DEBUG --- stdout ---
2024-06-22 10:39:42,166 DEBUG /results/orders/Reporting-login-tree-100/stderr.txt file found
2024-06-22 10:39:42,166 DEBUG --- stderr ---
2024-06-22 10:39:42,166 DEBUG
2024-06-22 10:39:42,166 INFO
2024-06-22 10:39:42,166 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-22 10:39:42,166 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:42,486 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:42,486 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:42,487 DEBUG --- stdout ---
2024-06-22 10:39:42,487 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:42,487 DEBUG --- stderr ---
2024-06-22 10:39:42,487 DEBUG
2024-06-22 10:39:42,487 INFO
2024-06-22 10:39:42,487 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-22 10:39:43,289 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-06-22 10:39:43,289 DEBUG --- stdout ---
2024-06-22 10:39:43,291 DEBUG 0 /results/orders/Reporting-login-tree-100/stderr.txt
2024-06-22 10:39:43,291 DEBUG --- stderr ---
2024-06-22 10:39:43,291 DEBUG
2024-06-22 10:39:43,291 INFO
- Download file (size 0k)
2024-06-22 10:39:43,291 INFO
2024-06-22 10:39:43,292 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-22 10:39:43,292 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:43,606 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:43,606 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:43,606 DEBUG --- stdout ---
2024-06-22 10:39:43,606 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:43,606 DEBUG --- stderr ---
2024-06-22 10:39:43,606 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-22 10:39:43,607 INFO
2024-06-22 10:39:43,607 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-22 10:39:43,607 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-06-22 10:39:43,932 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-06-22 10:39:43,933 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:43,933 DEBUG --- stdout ---
2024-06-22 10:39:43,933 DEBUG overseer-0-5b6f9464fd-slbm8
2024-06-22 10:39:43,933 DEBUG --- stderr ---
2024-06-22 10:39:43,933 DEBUG
2024-06-22 10:39:43,933 INFO
2024-06-22 10:39:43,933 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-22 10:39:43,933 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-06-22 10:39:44,705 INFO [loop_until]: OK (rc = 0)
2024-06-22 10:39:44,705 DEBUG --- stdout ---
2024-06-22 10:39:44,705 DEBUG tar: Removing leading `/' from member names
2024-06-22 10:39:44,705 DEBUG --- stderr ---
2024-06-22 10:39:44,705 DEBUG
2024-06-22 10:39:44,705 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-22 10:39:44,705 DEBUG ----- output -----
2024-06-22 10:39:44,705 DEBUG
2024-06-22 10:39:44,705 INFO
________________________________________________________________________________
[2024-06-22 10:39:44] Reporting-login-tree-100 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-06-22 10:39:44] 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-22 10:39:44] Reporting-login-tree-100 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 1455374,
"ok": 1455308,
"ko": 66
},
"minResponseTime": {
"total": 33,
"ok": 40,
"ko": 33
},
"maxResponseTime": {
"total": 9286,
"ok": 9286,
"ko": 610
},
"meanResponseTime": {
"total": 111,
"ok": 111,
"ko": 85
},
"standardDeviation": {
"total": 160,
"ok": 160,
"ko": 104
},
"percentiles1": {
"total": 55,
"ok": 55,
"ko": 47
},
"percentiles2": {
"total": 174,
"ok": 174,
"ko": 95
},
"percentiles3": {
"total": 279,
"ok": 279,
"ko": 312
},
"percentiles4": {
"total": 356,
"ok": 356,
"ko": 522
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 1452561,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 1056,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 1691,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 66,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 400.8190581107133,
"ok": 400.80088129991736,
"ko": 0.018176810795923988
}
},
"details": [
{
"name": "protectLoginInitiate",
"numberOfRequests": {
"total": 361913,
"ok": 361909,
"ko": 4
},
"minResponseTime": {
"total": 38,
"ok": 42,
"ko": 38
},
"maxResponseTime": {
"total": 1106,
"ok": 1106,
"ko": 41
},
"meanResponseTime": {
"total": 51,
"ok": 51,
"ko": 40
},
"standardDeviation": {
"total": 4,
"ok": 4,
"ko": 1
},
"percentiles1": {
"total": 50,
"ok": 50,
"ko": 41
},
"percentiles2": {
"total": 52,
"ok": 52,
"ko": 41
},
"percentiles3": {
"total": 55,
"ok": 55,
"ko": 41
},
"percentiles4": {
"total": 59,
"ok": 59,
"ko": 41
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 361907,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 2,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 4,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 99.67309281189755,
"ok": 99.67199118700083,
"ko": 0.001101624896722666
},
"spikes": []
},
{
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"total": 361909,
"ok": 361905,
"ko": 4
},
"minResponseTime": {
"total": 34,
"ok": 40,
"ko": 34
},
"maxResponseTime": {
"total": 263,
"ok": 263,
"ko": 36
},
"meanResponseTime": {
"total": 48,
"ok": 48,
"ko": 35
},
"standardDeviation": {
"total": 3,
"ok": 3,
"ko": 1
},
"percentiles1": {
"total": 48,
"ok": 48,
"ko": 35
},
"percentiles2": {
"total": 49,
"ok": 49,
"ko": 35
},
"percentiles3": {
"total": 53,
"ok": 53,
"ko": 36
},
"percentiles4": {
"total": 56,
"ok": 56,
"ko": 36
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 361905,
"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": 4,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 99.67199118700083,
"ok": 99.67088956210411,
"ko": 0.001101624896722666
},
"spikes": []
},
{
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"total": 361909,
"ok": 361903,
"ko": 6
},
"minResponseTime": {
"total": 34,
"ok": 48,
"ko": 34
},
"maxResponseTime": {
"total": 274,
"ok": 274,
"ko": 39
},
"meanResponseTime": {
"total": 60,
"ok": 60,
"ko": 37
},
"standardDeviation": {
"total": 5,
"ok": 5,
"ko": 2
},
"percentiles1": {
"total": 60,
"ok": 60,
"ko": 38
},
"percentiles2": {
"total": 63,
"ok": 63,
"ko": 38
},
"percentiles3": {
"total": 67,
"ok": 67,
"ko": 39
},
"percentiles4": {
"total": 72,
"ok": 72,
"ko": 39
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 361903,
"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.67199118700083,
"ok": 99.67033874965574,
"ko": 0.0016524373450839988
},
"spikes": []
},
{
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"total": 361909,
"ok": 361881,
"ko": 28
},
"minResponseTime": {
"total": 33,
"ok": 52,
"ko": 33
},
"maxResponseTime": {
"total": 9286,
"ok": 9286,
"ko": 610
},
"meanResponseTime": {
"total": 286,
"ok": 286,
"ko": 141
},
"standardDeviation": {
"total": 248,
"ok": 248,
"ko": 141
},
"percentiles1": {
"total": 260,
"ok": 260,
"ko": 97
},
"percentiles2": {
"total": 274,
"ok": 274,
"ko": 129
},
"percentiles3": {
"total": 335,
"ok": 335,
"ko": 443
},
"percentiles4": {
"total": 691,
"ok": 691,
"ko": 574
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 359136,
"percentage": 99
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 1054,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 1691,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 28,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 99.67199118700083,
"ok": 99.66427981272376,
"ko": 0.007711374277058662
},
"spikes": []
},
{
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"total": 7734,
"ok": 7710,
"ko": 24
},
"minResponseTime": {
"total": 44,
"ok": 124,
"ko": 44
},
"maxResponseTime": {
"total": 356,
"ok": 356,
"ko": 53
},
"meanResponseTime": {
"total": 156,
"ok": 157,
"ko": 48
},
"standardDeviation": {
"total": 16,
"ok": 14,
"ko": 2
},
"percentiles1": {
"total": 157,
"ok": 157,
"ko": 48
},
"percentiles2": {
"total": 167,
"ok": 167,
"ko": 49
},
"percentiles3": {
"total": 178,
"ok": 177,
"ko": 51
},
"percentiles4": {
"total": 186,
"ok": 186,
"ko": 53
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 7710,
"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": 24,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 2.1299917378132744,
"ok": 2.123381988432939,
"ko": 0.006609749380335995
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 401,
"avg_response_time": 111,
"max_response_time": 9286,
"min_response_time": 40,
"num_requests": 1455374,
"num_requests_pass": 1455308,
"num_requests_percent_pass": 99.995
},
"options": "; testCase:idc.loginProtect; testMode:open; throughput:100; rampup-duration:30; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 361907,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 2,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 0,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 4,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 41,
"ok": 1106,
"total": 1106
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.001101624896722666,
"ok": 99.67199118700083,
"total": 99.67309281189755
},
"meanResponseTime": {
"ko": 40,
"ok": 51,
"total": 51
},
"minResponseTime": {
"ko": 38,
"ok": 42,
"total": 38
},
"name": "protectLoginInitiate",
"numberOfRequests": {
"ko": 4,
"ok": 361909,
"total": 361913
},
"percentiles1": {
"ko": 41,
"ok": 50,
"total": 50
},
"percentiles2": {
"ko": 41,
"ok": 52,
"total": 52
},
"percentiles3": {
"ko": 41,
"ok": 55,
"total": 55
},
"percentiles4": {
"ko": 41,
"ok": 59,
"total": 59
},
"spikes": [],
"standardDeviation": {
"ko": 1,
"ok": 4,
"total": 4
}
},
{
"group1": {
"count": 361905,
"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": 4,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 36,
"ok": 263,
"total": 263
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.001101624896722666,
"ok": 99.67088956210411,
"total": 99.67199118700083
},
"meanResponseTime": {
"ko": 35,
"ok": 48,
"total": 48
},
"minResponseTime": {
"ko": 34,
"ok": 40,
"total": 34
},
"name": "PingOneProtectInitializeCallback",
"numberOfRequests": {
"ko": 4,
"ok": 361905,
"total": 361909
},
"percentiles1": {
"ko": 35,
"ok": 48,
"total": 48
},
"percentiles2": {
"ko": 35,
"ok": 49,
"total": 49
},
"percentiles3": {
"ko": 36,
"ok": 53,
"total": 53
},
"percentiles4": {
"ko": 36,
"ok": 56,
"total": 56
},
"spikes": [],
"standardDeviation": {
"ko": 1,
"ok": 3,
"total": 3
}
},
{
"group1": {
"count": 361903,
"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": 39,
"ok": 274,
"total": 274
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.0016524373450839988,
"ok": 99.67033874965574,
"total": 99.67199118700083
},
"meanResponseTime": {
"ko": 37,
"ok": 60,
"total": 60
},
"minResponseTime": {
"ko": 34,
"ok": 48,
"total": 34
},
"name": "restLoginUsernamePasswordCallback",
"numberOfRequests": {
"ko": 6,
"ok": 361903,
"total": 361909
},
"percentiles1": {
"ko": 38,
"ok": 60,
"total": 60
},
"percentiles2": {
"ko": 38,
"ok": 63,
"total": 63
},
"percentiles3": {
"ko": 39,
"ok": 67,
"total": 67
},
"percentiles4": {
"ko": 39,
"ok": 72,
"total": 72
},
"spikes": [],
"standardDeviation": {
"ko": 2,
"ok": 5,
"total": 5
}
},
{
"group1": {
"count": 359136,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 99
},
"group2": {
"count": 1054,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 1691,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 28,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 610,
"ok": 9286,
"total": 9286
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.007711374277058662,
"ok": 99.66427981272376,
"total": 99.67199118700083
},
"meanResponseTime": {
"ko": 141,
"ok": 286,
"total": 286
},
"minResponseTime": {
"ko": 33,
"ok": 52,
"total": 33
},
"name": "PingOneProtectEvaluationCallback",
"numberOfRequests": {
"ko": 28,
"ok": 361881,
"total": 361909
},
"percentiles1": {
"ko": 97,
"ok": 260,
"total": 260
},
"percentiles2": {
"ko": 129,
"ok": 274,
"total": 274
},
"percentiles3": {
"ko": 443,
"ok": 335,
"total": 335
},
"percentiles4": {
"ko": 574,
"ok": 691,
"total": 691
},
"spikes": [],
"standardDeviation": {
"ko": 141,
"ok": 248,
"total": 248
}
},
{
"group1": {
"count": 7710,
"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": 24,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 53,
"ok": 356,
"total": 356
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.006609749380335995,
"ok": 2.123381988432939,
"total": 2.1299917378132744
},
"meanResponseTime": {
"ko": 48,
"ok": 157,
"total": 156
},
"minResponseTime": {
"ko": 44,
"ok": 124,
"total": 44
},
"name": "restloginProgressiveProfileCallback",
"numberOfRequests": {
"ko": 24,
"ok": 7710,
"total": 7734
},
"percentiles1": {
"ko": 48,
"ok": 157,
"total": 157
},
"percentiles2": {
"ko": 49,
"ok": 167,
"total": 167
},
"percentiles3": {
"ko": 51,
"ok": 177,
"total": 178
},
"percentiles4": {
"ko": 53,
"ok": 186,
"total": 186
},
"spikes": [],
"standardDeviation": {
"ko": 2,
"ok": 14,
"total": 16
}
}
],
"global": {
"group1": {
"count": 1452561,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 1056,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 1691,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 66,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 610,
"ok": 9286,
"total": 9286
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.018176810795923988,
"ok": 400.80088129991736,
"total": 400.8190581107133
},
"meanResponseTime": {
"ko": 85,
"ok": 111,
"total": 111
},
"minResponseTime": {
"ko": 33,
"ok": 40,
"total": 33
},
"name": "All Requests",
"numberOfRequests": {
"ko": 66,
"ok": 1455308,
"total": 1455374
},
"percentiles1": {
"ko": 47,
"ok": 55,
"total": 55
},
"percentiles2": {
"ko": 95,
"ok": 174,
"total": 174
},
"percentiles3": {
"ko": 312,
"ok": 279,
"total": 279
},
"percentiles4": {
"ko": 522,
"ok": 356,
"total": 356
},
"standardDeviation": {
"ko": 104,
"ok": 160,
"total": 160
}
}
},
"target_hostname": "openam-ema-perf-p1.forgeblocks.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-06-22 10:39:44] Reporting-login-tree-100 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-06-22 10:39:44] 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-22 10:39:44] Reporting-login-tree-100 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped