--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', 'Reporting-login-tree-50'] preceding_task: None options: {'task_name': 'login-tree-100'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-06-13 06:10:36] Reporting-login-tree-100 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component 2024-06-13 06:10:36 - INFO: Timeout for this Task has changed to 3h (10800 seconds) 2024-06-13 06:10:36 - 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-13 06:10:36] Reporting-login-tree-100 step1 : Write order for overseer to generate the report ________________________________________________________________________________ 2024-06-13 06:10:36,839 INFO 2024-06-13 06:10:36,839 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:36,839 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:37,137 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:37,137 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:37,137 DEBUG --- stdout --- 2024-06-13 06:10:37,137 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:37,137 DEBUG --- stderr --- 2024-06-13 06:10:37,137 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_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-13 06:10:37] Reporting-login-tree-100 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2024-06-13 06:10:37,139 INFO 2024-06-13 06:10:37,139 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-13 06:10:37,139 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2024-06-13 06:10:37,370 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-13 06:10:37,370 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:37,370 DEBUG --- stdout --- 2024-06-13 06:10:37,370 DEBUG WAITING 2024-06-13 06:10:37,371 DEBUG --- stderr --- 2024-06-13 06:10:37,371 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 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2024-06-13 06:10:37] Reporting-login-tree-100 step3 : Send order to overseer ________________________________________________________________________________ 2024-06-13 06:10:37,371 INFO 2024-06-13 06:10:37,372 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:37,372 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:37,682 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:37,682 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:37,682 DEBUG --- stdout --- 2024-06-13 06:10:37,682 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:37,682 DEBUG --- stderr --- 2024-06-13 06:10:37,682 DEBUG 2024-06-13 06:10:37,683 INFO 2024-06-13 06:10:37,683 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/11_Reporting-login-tree-100/order.json overseer-0-6c7d65494f-sln6z:/results/orders/order.json 2024-06-13 06:10:37,683 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-13 06:10:39,051 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:39,051 DEBUG --- stdout --- 2024-06-13 06:10:39,051 DEBUG 2024-06-13 06:10:39,051 DEBUG --- stderr --- 2024-06-13 06:10:39,051 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2024-06-13 06:10:39] Reporting-login-tree-100 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2024-06-13 06:10:44,057 INFO 2024-06-13 06:10:44,058 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-13 06:10:44,058 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0] 2024-06-13 06:10:44,290 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2024-06-13 06:10:49,531 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry 2024-06-13 06:10:54,834 INFO [loop_until]: Function succeeded after 10s (rc=0) - expected pattern found 2024-06-13 06:10:54,835 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:54,835 DEBUG --- stdout --- 2024-06-13 06:10:54,835 DEBUG WAITING 2024-06-13 06:10:54,835 DEBUG --- stderr --- 2024-06-13 06:10:54,835 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 25 0 --:--:-- --:--:-- --:--:-- 25 ________________________________________________________________________________ [2024-06-13 06:10:54] Reporting-login-tree-100 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2024-06-13 06:10:54,836 INFO 2024-06-13 06:10:54,836 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:54,836 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:55,148 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:55,149 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:55,149 DEBUG --- stdout --- 2024-06-13 06:10:55,149 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:55,149 DEBUG --- stderr --- 2024-06-13 06:10:55,149 DEBUG Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait. 2024-06-13 06:10:55,150 INFO 2024-06-13 06:10:55,150 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:55,150 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:55,522 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:55,522 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:55,522 DEBUG --- stdout --- 2024-06-13 06:10:55,522 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:55,522 DEBUG --- stderr --- 2024-06-13 06:10:55,522 DEBUG 2024-06-13 06:10:55,523 INFO 2024-06-13 06:10:55,523 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/gatling/login-tree-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-13 06:10:55,523 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-13 06:10:56,331 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-13 06:10:56,332 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:56,332 DEBUG --- stdout --- 2024-06-13 06:10:56,332 DEBUG /results/gatling/login-tree-100.tar.gz file found 2024-06-13 06:10:56,332 DEBUG --- stderr --- 2024-06-13 06:10:56,332 DEBUG 2024-06-13 06:10:56,332 INFO 2024-06-13 06:10:56,332 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:56,332 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:56,641 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:56,642 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:56,642 DEBUG --- stdout --- 2024-06-13 06:10:56,642 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:56,642 DEBUG --- stderr --- 2024-06-13 06:10:56,642 DEBUG 2024-06-13 06:10:56,642 INFO 2024-06-13 06:10:56,642 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/gatling/login-tree-100.tar.gz 2024-06-13 06:10:57,446 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-13 06:10:57,447 DEBUG --- stdout --- 2024-06-13 06:10:57,447 DEBUG 332 /results/gatling/login-tree-100.tar.gz 2024-06-13 06:10:57,447 DEBUG --- stderr --- 2024-06-13 06:10:57,447 DEBUG 2024-06-13 06:10:57,447 INFO - Download file (size 332k) 2024-06-13 06:10:57,447 INFO 2024-06-13 06:10:57,447 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:57,447 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:57,751 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:57,751 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:57,751 DEBUG --- stdout --- 2024-06-13 06:10:57,751 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:57,751 DEBUG --- stderr --- 2024-06-13 06:10:57,751 DEBUG source : /results/gatling/login-tree-100.tar.gz @ overseer-0-6c7d65494f-sln6z destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-100.tar.gz 2024-06-13 06:10:57,752 INFO 2024-06-13 06:10:57,752 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:57,752 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:58,049 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:58,049 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:58,049 DEBUG --- stdout --- 2024-06-13 06:10:58,049 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:58,049 DEBUG --- stderr --- 2024-06-13 06:10:58,049 DEBUG 2024-06-13 06:10:58,050 INFO 2024-06-13 06:10:58,050 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/gatling/login-tree-100.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-100.tar.gz 2024-06-13 06:10:58,050 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-13 06:10:59,042 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:59,042 DEBUG --- stdout --- 2024-06-13 06:10:59,042 DEBUG tar: Removing leading `/' from member names 2024-06-13 06:10:59,042 DEBUG --- stderr --- 2024-06-13 06:10:59,042 DEBUG ________________________________________________________________________________ [2024-06-13 06:10:59] Reporting-login-tree-100 step6 : Unzip the result ________________________________________________________________________________ 2024-06-13 06:10:59,043 INFO 2024-06-13 06:10:59,043 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/03_login-tree-100/gatling 2024-06-13 06:10:59,071 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-13 06:10:59,071 DEBUG --- stdout --- 2024-06-13 06:10:59,071 DEBUG 2024-06-13 06:10:59,071 DEBUG --- stderr --- 2024-06-13 06:10:59,071 DEBUG 2024-06-13 06:10:59,071 INFO ________________________________________________________________________________ [2024-06-13 06:10:59] Reporting-login-tree-100 step7 : Print rc order ________________________________________________________________________________ 2024-06-13 06:10:59,073 INFO 2024-06-13 06:10:59,073 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:59,073 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:59,387 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:59,387 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:59,387 DEBUG --- stdout --- 2024-06-13 06:10:59,387 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:59,387 DEBUG --- stderr --- 2024-06-13 06:10:59,387 DEBUG Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait. 2024-06-13 06:10:59,388 INFO 2024-06-13 06:10:59,388 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:10:59,388 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:10:59,699 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:10:59,699 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:10:59,699 DEBUG --- stdout --- 2024-06-13 06:10:59,699 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:10:59,699 DEBUG --- stderr --- 2024-06-13 06:10:59,699 DEBUG 2024-06-13 06:10:59,700 INFO 2024-06-13 06:10:59,700 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-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-13 06:10:59,700 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-13 06:11:00,509 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-13 06:11:00,510 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:00,510 DEBUG --- stdout --- 2024-06-13 06:11:00,510 DEBUG /results/orders/Reporting-login-tree-100/rc.txt file found 2024-06-13 06:11:00,510 DEBUG --- stderr --- 2024-06-13 06:11:00,510 DEBUG 2024-06-13 06:11:00,510 INFO 2024-06-13 06:11:00,510 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:00,510 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:00,814 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:00,814 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:00,814 DEBUG --- stdout --- 2024-06-13 06:11:00,814 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:00,814 DEBUG --- stderr --- 2024-06-13 06:11:00,814 DEBUG 2024-06-13 06:11:00,814 INFO 2024-06-13 06:11:00,815 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/orders/Reporting-login-tree-100/rc.txt 2024-06-13 06:11:01,609 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-13 06:11:01,609 DEBUG --- stdout --- 2024-06-13 06:11:01,609 DEBUG 4 /results/orders/Reporting-login-tree-100/rc.txt 2024-06-13 06:11:01,609 DEBUG --- stderr --- 2024-06-13 06:11:01,609 DEBUG 2024-06-13 06:11:01,609 INFO - Download file (size 4k) 2024-06-13 06:11:01,610 INFO 2024-06-13 06:11:01,610 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:01,610 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:01,922 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:01,922 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:01,922 DEBUG --- stdout --- 2024-06-13 06:11:01,922 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:01,922 DEBUG --- stderr --- 2024-06-13 06:11:01,922 DEBUG source : /results/orders/Reporting-login-tree-100/rc.txt @ overseer-0-6c7d65494f-sln6z destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/rc.txt 2024-06-13 06:11:01,923 INFO 2024-06-13 06:11:01,923 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:01,923 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:02,233 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:02,233 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:02,233 DEBUG --- stdout --- 2024-06-13 06:11:02,233 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:02,233 DEBUG --- stderr --- 2024-06-13 06:11:02,233 DEBUG 2024-06-13 06:11:02,234 INFO 2024-06-13 06:11:02,234 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/orders/Reporting-login-tree-100/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/rc.txt 2024-06-13 06:11:02,234 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-13 06:11:02,949 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:02,949 DEBUG --- stdout --- 2024-06-13 06:11:02,949 DEBUG tar: Removing leading `/' from member names 2024-06-13 06:11:02,949 DEBUG --- stderr --- 2024-06-13 06:11:02,949 DEBUG 2024-06-13 06:11:02,949 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/rc.txt is small (1 lines), printing all lines: 2024-06-13 06:11:02,949 DEBUG ----- output ----- 2024-06-13 06:11:02,950 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-06-13 06:11:02,950 INFO ________________________________________________________________________________ [2024-06-13 06:11:02] Reporting-login-tree-100 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [2024-06-13 06:11:02] Reporting-login-tree-100 step9 : Print stdout order ________________________________________________________________________________ 2024-06-13 06:11:02,951 INFO 2024-06-13 06:11:02,951 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:02,951 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:03,249 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:03,250 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:03,250 DEBUG --- stdout --- 2024-06-13 06:11:03,250 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:03,250 DEBUG --- stderr --- 2024-06-13 06:11:03,250 DEBUG Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait. 2024-06-13 06:11:03,250 INFO 2024-06-13 06:11:03,250 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:03,250 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:03,558 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:03,558 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:03,559 DEBUG --- stdout --- 2024-06-13 06:11:03,559 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:03,559 DEBUG --- stderr --- 2024-06-13 06:11:03,559 DEBUG 2024-06-13 06:11:03,559 INFO 2024-06-13 06:11:03,559 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-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-13 06:11:03,559 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-13 06:11:04,362 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-13 06:11:04,362 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:04,362 DEBUG --- stdout --- 2024-06-13 06:11:04,362 DEBUG /results/orders/Reporting-login-tree-100/stdout.txt file found 2024-06-13 06:11:04,362 DEBUG --- stderr --- 2024-06-13 06:11:04,362 DEBUG 2024-06-13 06:11:04,362 INFO 2024-06-13 06:11:04,363 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:04,363 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:04,662 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:04,662 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:04,662 DEBUG --- stdout --- 2024-06-13 06:11:04,662 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:04,662 DEBUG --- stderr --- 2024-06-13 06:11:04,662 DEBUG 2024-06-13 06:11:04,663 INFO 2024-06-13 06:11:04,663 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/orders/Reporting-login-tree-100/stdout.txt 2024-06-13 06:11:05,453 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-13 06:11:05,454 DEBUG --- stdout --- 2024-06-13 06:11:05,454 DEBUG 4 /results/orders/Reporting-login-tree-100/stdout.txt 2024-06-13 06:11:05,454 DEBUG --- stderr --- 2024-06-13 06:11:05,454 DEBUG 2024-06-13 06:11:05,454 INFO - Download file (size 4k) 2024-06-13 06:11:05,454 INFO 2024-06-13 06:11:05,454 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:05,454 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:05,765 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:05,766 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:05,767 DEBUG --- stdout --- 2024-06-13 06:11:05,767 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:05,767 DEBUG --- stderr --- 2024-06-13 06:11:05,767 DEBUG source : /results/orders/Reporting-login-tree-100/stdout.txt @ overseer-0-6c7d65494f-sln6z destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/stdout.txt 2024-06-13 06:11:05,768 INFO 2024-06-13 06:11:05,768 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:05,768 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:06,079 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:06,080 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:06,080 DEBUG --- stdout --- 2024-06-13 06:11:06,080 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:06,080 DEBUG --- stderr --- 2024-06-13 06:11:06,080 DEBUG 2024-06-13 06:11:06,080 INFO 2024-06-13 06:11:06,080 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/orders/Reporting-login-tree-100/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/stdout.txt 2024-06-13 06:11:06,080 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-13 06:11:06,815 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:06,815 DEBUG --- stdout --- 2024-06-13 06:11:06,815 DEBUG tar: Removing leading `/' from member names 2024-06-13 06:11:06,815 DEBUG --- stderr --- 2024-06-13 06:11:06,815 DEBUG 2024-06-13 06:11:06,815 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/stdout.txt is small (79 lines), printing all lines: 2024-06-13 06:11:06,815 DEBUG ----- output ----- 2024-06-13 06:11:06,815 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-100/loadtest-20240613015523005 --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 1465595 (OK=1465557 KO=38 ) > min response time 95 (OK=95 KO=103 ) > max response time 10172 (OK=10172 KO=248 ) > mean response time 217 (OK=217 KO=165 ) > std deviation 230 (OK=230 KO=59 ) > response time 50th percentile 117 (OK=117 KO=160 ) > response time 75th percentile 290 (OK=290 KO=224 ) > response time 95th percentile 494 (OK=494 KO=232 ) > response time 99th percentile 801 (OK=801 KO=245 ) > mean requests/sec 403.523 (OK=403.512 KO=0.01 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 1450732 ( 99%) > 800 ms <= t < 1200 ms 8444 ( 1%) > t >= 1200 ms 6381 ( 0%) > failed 38 ( 0%) ---- Errors -------------------------------------------------------------------- > status.find.is(200), but actually found 401 19 (50.00%) > jsonPath($.tokenId).find.exists, found nothing 19 (50.00%) ================================================================================ Reports generated in 0s. Please open the following file: file:///results/gatling/login-tree-100/loadtest-20240613015523005/index.html ---------------------- [13/Jun/2024 07:10:50] Create tar file /results/gatling/login-tree-100.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/login-tree-100/loadtest-20240613015523005 RESULT_FOLDER=login-tree-100 RESULT_PATH=/results/gatling/login-tree-100 PWD=/results/gatling/login-tree-100/loadtest-20240613015523005 [cmd] tar -czvf /results/gatling/login-tree-100.tar.gz --exclude=simulation.log * index.html js/ js/bootstrap.min.js js/ellipsis.js js/assertions.xml js/menu.js js/jquery-3.5.1.min.js js/global_stats.json js/stats.js js/gatling.js js/all_sessions.js js/highstock.js js/stats.json js/highcharts-more.js js/unpack.js js/assertions.json js/theme.js req_pingoneprotecte-ee094.html req_pingoneprotecti-dd6e3.html req_protectloginini-66072.html req_restloginprogre-9fc93.html req_restloginuserna-d98ea.html style/ style/arrow_right_black.png style/style.css style/arrow_down_black.png style/bootstrap.min.css style/sortable.png style/arrow_down.png style/favicon.ico style/little_arrow_right.png style/sorted-down.png style/stat-fleche-bas.png style/logo-enterprise.svg style/stat-l-temps.png style/logo.svg style/arrow_right.png style/stat-l-roue.png style/sorted-up.png 2024-06-13 06:11:06,815 INFO ________________________________________________________________________________ [2024-06-13 06:11:06] Reporting-login-tree-100 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2024-06-13 06:11:06] Reporting-login-tree-100 step11 : Print stderr order ________________________________________________________________________________ 2024-06-13 06:11:06,817 INFO 2024-06-13 06:11:06,817 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:06,817 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:07,116 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:07,117 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:07,117 DEBUG --- stdout --- 2024-06-13 06:11:07,117 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:07,117 DEBUG --- stderr --- 2024-06-13 06:11:07,117 DEBUG Checking pod: overseer-0-6c7d65494f-sln6z for file exists, if not wait. 2024-06-13 06:11:07,117 INFO 2024-06-13 06:11:07,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-13 06:11:07,117 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:07,433 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:07,433 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:07,433 DEBUG --- stdout --- 2024-06-13 06:11:07,433 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:07,433 DEBUG --- stderr --- 2024-06-13 06:11:07,433 DEBUG 2024-06-13 06:11:07,434 INFO 2024-06-13 06:11:07,434 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-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-13 06:11:07,434 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-13 06:11:08,233 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-13 06:11:08,233 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:08,233 DEBUG --- stdout --- 2024-06-13 06:11:08,233 DEBUG /results/orders/Reporting-login-tree-100/stderr.txt file found 2024-06-13 06:11:08,233 DEBUG --- stderr --- 2024-06-13 06:11:08,233 DEBUG 2024-06-13 06:11:08,233 INFO 2024-06-13 06:11:08,233 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:08,233 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:08,545 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:08,546 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:08,546 DEBUG --- stdout --- 2024-06-13 06:11:08,546 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:08,546 DEBUG --- stderr --- 2024-06-13 06:11:08,546 DEBUG 2024-06-13 06:11:08,546 INFO 2024-06-13 06:11:08,547 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6c7d65494f-sln6z --stdin -- du -k /results/orders/Reporting-login-tree-100/stderr.txt 2024-06-13 06:11:09,361 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-13 06:11:09,362 DEBUG --- stdout --- 2024-06-13 06:11:09,362 DEBUG 0 /results/orders/Reporting-login-tree-100/stderr.txt 2024-06-13 06:11:09,362 DEBUG --- stderr --- 2024-06-13 06:11:09,362 DEBUG 2024-06-13 06:11:09,362 INFO - Download file (size 0k) 2024-06-13 06:11:09,362 INFO 2024-06-13 06:11:09,362 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:09,362 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:09,665 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:09,665 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:09,665 DEBUG --- stdout --- 2024-06-13 06:11:09,665 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:09,665 DEBUG --- stderr --- 2024-06-13 06:11:09,665 DEBUG source : /results/orders/Reporting-login-tree-100/stderr.txt @ overseer-0-6c7d65494f-sln6z destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/stderr.txt 2024-06-13 06:11:09,666 INFO 2024-06-13 06:11:09,666 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-13 06:11:09,666 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-13 06:11:09,964 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-13 06:11:09,964 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:09,964 DEBUG --- stdout --- 2024-06-13 06:11:09,964 DEBUG overseer-0-6c7d65494f-sln6z 2024-06-13 06:11:09,964 DEBUG --- stderr --- 2024-06-13 06:11:09,964 DEBUG 2024-06-13 06:11:09,964 INFO 2024-06-13 06:11:09,964 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6c7d65494f-sln6z:/results/orders/Reporting-login-tree-100/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/stderr.txt 2024-06-13 06:11:09,965 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-13 06:11:10,684 INFO [loop_until]: OK (rc = 0) 2024-06-13 06:11:10,684 DEBUG --- stdout --- 2024-06-13 06:11:10,684 DEBUG tar: Removing leading `/' from member names 2024-06-13 06:11:10,684 DEBUG --- stderr --- 2024-06-13 06:11:10,684 DEBUG 2024-06-13 06:11:10,685 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/11_Reporting-login-tree-100/stderr.txt is small (0 lines), printing all lines: 2024-06-13 06:11:10,685 DEBUG ----- output ----- 2024-06-13 06:11:10,685 DEBUG 2024-06-13 06:11:10,685 INFO ________________________________________________________________________________ [2024-06-13 06:11:10] Reporting-login-tree-100 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2024-06-13 06:11:10] 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/03_login-tree-100/gatling/req_pingoneprotecte-ee094.html - cannot check for spikes checking simulation request restloginProgressiveProfileCallback no spikes found ________________________________________________________________________________ [2024-06-13 06:11:10] Reporting-login-tree-100 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 1465595, "ok": 1465557, "ko": 38 }, "minResponseTime": { "total": 95, "ok": 95, "ko": 103 }, "maxResponseTime": { "total": 10172, "ok": 10172, "ko": 248 }, "meanResponseTime": { "total": 217, "ok": 217, "ko": 165 }, "standardDeviation": { "total": 230, "ok": 230, "ko": 59 }, "percentiles1": { "total": 117, "ok": 117, "ko": 160 }, "percentiles2": { "total": 290, "ok": 290, "ko": 224 }, "percentiles3": { "total": 494, "ok": 494, "ko": 232 }, "percentiles4": { "total": 801, "ok": 801, "ko": 245 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1450732, "percentage": 99 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 8444, "percentage": 1 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 6381, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 38, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 403.5228524229075, "ok": 403.5123898678414, "ko": 0.010462555066079295 } }, "details": [ { "name": "protectLoginInitiate", "numberOfRequests": { "total": 361493, "ok": 361493, "ko": 0 }, "minResponseTime": { "total": 98, "ok": 98, "ko": 0 }, "maxResponseTime": { "total": 1402, "ok": 1402, "ko": 0 }, "meanResponseTime": { "total": 109, "ok": 109, "ko": 0 }, "standardDeviation": { "total": 10, "ok": 10, "ko": 0 }, "percentiles1": { "total": 108, "ok": 108, "ko": 0 }, "percentiles2": { "total": 111, "ok": 111, "ko": 0 }, "percentiles3": { "total": 115, "ok": 115, "ko": 0 }, "percentiles4": { "total": 128, "ok": 128, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 361492, "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": 1, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 99.53001101321586, "ok": 99.53001101321586, "ko": 0 }, "spikes": [] }, { "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "total": 361493, "ok": 361493, "ko": 0 }, "minResponseTime": { "total": 95, "ok": 95, "ko": 0 }, "maxResponseTime": { "total": 618, "ok": 618, "ko": 0 }, "meanResponseTime": { "total": 113, "ok": 113, "ko": 0 }, "standardDeviation": { "total": 25, "ok": 25, "ko": 0 }, "percentiles1": { "total": 111, "ok": 111, "ko": 0 }, "percentiles2": { "total": 114, "ok": 114, "ko": 0 }, "percentiles3": { "total": 120, "ok": 120, "ko": 0 }, "percentiles4": { "total": 192, "ok": 192, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 361493, "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": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 99.53001101321586, "ok": 99.53001101321586, "ko": 0 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 361493, "ok": 361493, "ko": 0 }, "minResponseTime": { "total": 103, "ok": 103, "ko": 0 }, "maxResponseTime": { "total": 647, "ok": 647, "ko": 0 }, "meanResponseTime": { "total": 127, "ok": 127, "ko": 0 }, "standardDeviation": { "total": 25, "ok": 25, "ko": 0 }, "percentiles1": { "total": 125, "ok": 125, "ko": 0 }, "percentiles2": { "total": 129, "ok": 129, "ko": 0 }, "percentiles3": { "total": 142, "ok": 142, "ko": 0 }, "percentiles4": { "total": 196, "ok": 196, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 361493, "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": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 99.53001101321586, "ok": 99.53001101321586, "ko": 0 }, "spikes": [] }, { "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "total": 361493, "ok": 361474, "ko": 19 }, "minResponseTime": { "total": 209, "ok": 406, "ko": 209 }, "maxResponseTime": { "total": 10172, "ok": 10172, "ko": 248 }, "meanResponseTime": { "total": 518, "ok": 518, "ko": 224 }, "standardDeviation": { "total": 303, "ok": 303, "ko": 9 }, "percentiles1": { "total": 461, "ok": 461, "ko": 224 }, "percentiles2": { "total": 484, "ok": 484, "ko": 229 }, "percentiles3": { "total": 758, "ok": 758, "ko": 242 }, "percentiles4": { "total": 1569, "ok": 1569, "ko": 247 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 346650, "percentage": 96 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 8444, "percentage": 2 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 6380, "percentage": 2 }, "group4": { "name": "failed", "htmlName": "failed", "count": 19, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 99.53001101321586, "ok": 99.52477973568281, "ko": 0.0052312775330396475 }, "spikes": [] }, { "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "total": 19623, "ok": 19604, "ko": 19 }, "minResponseTime": { "total": 103, "ok": 173, "ko": 103 }, "maxResponseTime": { "total": 616, "ok": 616, "ko": 110 }, "meanResponseTime": { "total": 228, "ok": 229, "ko": 106 }, "standardDeviation": { "total": 24, "ok": 23, "ko": 2 }, "percentiles1": { "total": 228, "ok": 228, "ko": 106 }, "percentiles2": { "total": 238, "ok": 238, "ko": 108 }, "percentiles3": { "total": 263, "ok": 263, "ko": 109 }, "percentiles4": { "total": 290, "ok": 290, "ko": 110 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 19604, "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": 19, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 5.402808370044053, "ok": 5.397577092511013, "ko": 0.0052312775330396475 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 404, "avg_response_time": 217, "max_response_time": 10172, "min_response_time": 95, "num_requests": 1465595, "num_requests_pass": 1465557, "num_requests_percent_pass": 99.997 }, "options": "; testCase:idc.loginProtect; testMode:open; throughput:100; rampup-duration:30; duration:3600", "stats": { "details": [ { "group1": { "count": 361492, "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": 1, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 1402, "total": 1402 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 99.53001101321586, "total": 99.53001101321586 }, "meanResponseTime": { "ko": 0, "ok": 109, "total": 109 }, "minResponseTime": { "ko": 0, "ok": 98, "total": 98 }, "name": "protectLoginInitiate", "numberOfRequests": { "ko": 0, "ok": 361493, "total": 361493 }, "percentiles1": { "ko": 0, "ok": 108, "total": 108 }, "percentiles2": { "ko": 0, "ok": 111, "total": 111 }, "percentiles3": { "ko": 0, "ok": 115, "total": 115 }, "percentiles4": { "ko": 0, "ok": 128, "total": 128 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 10, "total": 10 } }, { "group1": { "count": 361493, "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": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 618, "total": 618 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 99.53001101321586, "total": 99.53001101321586 }, "meanResponseTime": { "ko": 0, "ok": 113, "total": 113 }, "minResponseTime": { "ko": 0, "ok": 95, "total": 95 }, "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "ko": 0, "ok": 361493, "total": 361493 }, "percentiles1": { "ko": 0, "ok": 111, "total": 111 }, "percentiles2": { "ko": 0, "ok": 114, "total": 114 }, "percentiles3": { "ko": 0, "ok": 120, "total": 120 }, "percentiles4": { "ko": 0, "ok": 192, "total": 192 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 25, "total": 25 } }, { "group1": { "count": 361493, "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": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 647, "total": 647 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 99.53001101321586, "total": 99.53001101321586 }, "meanResponseTime": { "ko": 0, "ok": 127, "total": 127 }, "minResponseTime": { "ko": 0, "ok": 103, "total": 103 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 0, "ok": 361493, "total": 361493 }, "percentiles1": { "ko": 0, "ok": 125, "total": 125 }, "percentiles2": { "ko": 0, "ok": 129, "total": 129 }, "percentiles3": { "ko": 0, "ok": 142, "total": 142 }, "percentiles4": { "ko": 0, "ok": 196, "total": 196 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 25, "total": 25 } }, { "group1": { "count": 346650, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 96 }, "group2": { "count": 8444, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 2 }, "group3": { "count": 6380, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 2 }, "group4": { "count": 19, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 248, "ok": 10172, "total": 10172 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0052312775330396475, "ok": 99.52477973568281, "total": 99.53001101321586 }, "meanResponseTime": { "ko": 224, "ok": 518, "total": 518 }, "minResponseTime": { "ko": 209, "ok": 406, "total": 209 }, "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "ko": 19, "ok": 361474, "total": 361493 }, "percentiles1": { "ko": 224, "ok": 461, "total": 461 }, "percentiles2": { "ko": 229, "ok": 484, "total": 484 }, "percentiles3": { "ko": 242, "ok": 758, "total": 758 }, "percentiles4": { "ko": 247, "ok": 1569, "total": 1569 }, "spikes": [], "standardDeviation": { "ko": 9, "ok": 303, "total": 303 } }, { "group1": { "count": 19604, "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": 19, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 110, "ok": 616, "total": 616 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0052312775330396475, "ok": 5.397577092511013, "total": 5.402808370044053 }, "meanResponseTime": { "ko": 106, "ok": 229, "total": 228 }, "minResponseTime": { "ko": 103, "ok": 173, "total": 103 }, "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "ko": 19, "ok": 19604, "total": 19623 }, "percentiles1": { "ko": 106, "ok": 228, "total": 228 }, "percentiles2": { "ko": 108, "ok": 238, "total": 238 }, "percentiles3": { "ko": 109, "ok": 263, "total": 263 }, "percentiles4": { "ko": 110, "ok": 290, "total": 290 }, "spikes": [], "standardDeviation": { "ko": 2, "ok": 23, "total": 24 } } ], "global": { "group1": { "count": 1450732, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99 }, "group2": { "count": 8444, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 1 }, "group3": { "count": 6381, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 38, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 248, "ok": 10172, "total": 10172 }, "meanNumberOfRequestsPerSecond": { "ko": 0.010462555066079295, "ok": 403.5123898678414, "total": 403.5228524229075 }, "meanResponseTime": { "ko": 165, "ok": 217, "total": 217 }, "minResponseTime": { "ko": 103, "ok": 95, "total": 95 }, "name": "All Requests", "numberOfRequests": { "ko": 38, "ok": 1465557, "total": 1465595 }, "percentiles1": { "ko": 160, "ok": 117, "total": 117 }, "percentiles2": { "ko": 224, "ok": 290, "total": 290 }, "percentiles3": { "ko": 232, "ok": 494, "total": 494 }, "percentiles4": { "ko": 245, "ok": 801, "total": 801 }, "standardDeviation": { "ko": 59, "ok": 230, "total": 230 } } }, "target_hostname": "openam-ema-perf-p1protect.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2024-06-13 06:11:10] Reporting-login-tree-100 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2024-06-13 06:11:10] 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/03_login-tree-100/stdout.txt Compressing Gatling stdout.txt file.. ________________________________________________________________________________ [2024-06-13 06:11:10] Reporting-login-tree-100 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped