--Task-- name: Reporting-login-tree-300 enabled: True class_name: GatlingResultTask source_name: overseer-0 source_namespace: >default< target_name: overseer-0 target_namespace: >default< start: 0.0 stop: None timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow loop: False interval: None dependencies: [] wait_for: ['Reporting-login-tree-10', 'Reporting-login-tree-100', 'Reporting-login-tree-150', 'Reporting-login-tree-200', 'Reporting-login-tree-250', 'Reporting-login-tree-275'] preceding_task: None options: {'task_name': 'login-tree-300'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-06-22 10:42:39] Reporting-login-tree-300 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component 2024-06-22 10:42:39 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds) 2024-06-22 10:42:39 - INFO: timeout was set to GatlingResultTask default (half of global_duration or 3600 seconds (whatever is higher)), because it was unset Pod stdout file : /results/orders/Reporting-login-tree-300/stdout.txt Pod stderr file : /results/orders/Reporting-login-tree-300/stderr.txt Pod log : /results/orders/Reporting-login-tree-300 ________________________________________________________________________________ [2024-06-22 10:42:39] Reporting-login-tree-300 step1 : Write order for overseer to generate the report ________________________________________________________________________________ 2024-06-22 10:42:39,323 INFO 2024-06-22 10:42:39,323 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:42:39,323 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:42:39,647 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:42:39,647 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:42:39,647 DEBUG --- stdout --- 2024-06-22 10:42:39,647 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:42:39,647 DEBUG --- stderr --- 2024-06-22 10:42:39,647 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/order.json { "name": "Reporting-login-tree-300", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-300 --extra-run-jvm-options \"-Xmx4G\"", "out-dir": "/results/orders/Reporting-login-tree-300" } ________________________________________________________________________________ [2024-06-22 10:42:39] Reporting-login-tree-300 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2024-06-22 10:42:39,649 INFO 2024-06-22 10:42:39,649 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-22 10:42:39,649 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2024-06-22 10:42:39,952 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:42:39,952 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:42:39,952 DEBUG --- stdout --- 2024-06-22 10:42:39,952 DEBUG WAITING 2024-06-22 10:42:39,952 DEBUG --- stderr --- 2024-06-22 10:42:39,952 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-22 10:42:39] Reporting-login-tree-300 step3 : Send order to overseer ________________________________________________________________________________ 2024-06-22 10:42:39,953 INFO 2024-06-22 10:42:39,953 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:42:39,953 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:42:40,264 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:42:40,264 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:42:40,264 DEBUG --- stdout --- 2024-06-22 10:42:40,264 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:42:40,264 DEBUG --- stderr --- 2024-06-22 10:42:40,264 DEBUG 2024-06-22 10:42:40,265 INFO 2024-06-22 10:42:40,265 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/15_Reporting-login-tree-300/order.json overseer-0-5b6f9464fd-slbm8:/results/orders/order.json 2024-06-22 10:42:40,265 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:42:41,622 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:42:41,622 DEBUG --- stdout --- 2024-06-22 10:42:41,623 DEBUG 2024-06-22 10:42:41,623 DEBUG --- stderr --- 2024-06-22 10:42:41,623 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2024-06-22 10:42:41] Reporting-login-tree-300 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2024-06-22 10:42:46,629 INFO 2024-06-22 10:42:46,629 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-22 10:42:46,629 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0] 2024-06-22 10:42:46,872 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2024-06-22 10:42:52,116 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry 2024-06-22 10:42:57,361 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry 2024-06-22 10:43:02,603 INFO [loop_until]: Function succeeded after 15s (rc=0) - failed to find expected output: WAITING - retry 2024-06-22 10:43:07,840 INFO [loop_until]: Function succeeded after 21s (rc=0) - expected pattern found 2024-06-22 10:43:07,840 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:07,840 DEBUG --- stdout --- 2024-06-22 10:43:07,840 DEBUG WAITING 2024-06-22 10:43:07,841 DEBUG --- stderr --- 2024-06-22 10:43:07,841 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2024-06-22 10:43:07] Reporting-login-tree-300 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2024-06-22 10:43:07,841 INFO 2024-06-22 10:43:07,841 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:43:07,842 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:08,149 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:08,149 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:08,149 DEBUG --- stdout --- 2024-06-22 10:43:08,149 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:08,149 DEBUG --- stderr --- 2024-06-22 10:43:08,149 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:43:08,149 INFO 2024-06-22 10:43:08,149 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:43:08,149 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:08,455 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:08,455 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:08,455 DEBUG --- stdout --- 2024-06-22 10:43:08,456 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:08,456 DEBUG --- stderr --- 2024-06-22 10:43:08,456 DEBUG 2024-06-22 10:43:08,456 INFO 2024-06-22 10:43:08,456 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/gatling/login-tree-300.tar.gz" ]; then echo "/results/gatling/login-tree-300.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-300.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-300.tar.gz file found" 2024-06-22 10:43:08,456 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:43:09,275 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:43:09,275 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:09,275 DEBUG --- stdout --- 2024-06-22 10:43:09,276 DEBUG /results/gatling/login-tree-300.tar.gz file found 2024-06-22 10:43:09,276 DEBUG --- stderr --- 2024-06-22 10:43:09,276 DEBUG 2024-06-22 10:43:09,276 INFO 2024-06-22 10:43:09,276 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:43:09,276 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:09,592 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:09,592 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:09,592 DEBUG --- stdout --- 2024-06-22 10:43:09,592 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:09,592 DEBUG --- stderr --- 2024-06-22 10:43:09,592 DEBUG 2024-06-22 10:43:09,593 INFO 2024-06-22 10:43:09,593 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/gatling/login-tree-300.tar.gz 2024-06-22 10:43:10,407 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:43:10,408 DEBUG --- stdout --- 2024-06-22 10:43:10,408 DEBUG 364 /results/gatling/login-tree-300.tar.gz 2024-06-22 10:43:10,408 DEBUG --- stderr --- 2024-06-22 10:43:10,408 DEBUG 2024-06-22 10:43:10,408 INFO - Download file (size 364k) 2024-06-22 10:43:10,408 INFO 2024-06-22 10:43:10,408 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:43:10,409 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:10,739 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:10,739 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:10,739 DEBUG --- stdout --- 2024-06-22 10:43:10,739 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:10,739 DEBUG --- stderr --- 2024-06-22 10:43:10,739 DEBUG source : /results/gatling/login-tree-300.tar.gz @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz 2024-06-22 10:43:10,740 INFO 2024-06-22 10:43:10,740 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:43:10,740 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:11,113 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:11,113 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:11,113 DEBUG --- stdout --- 2024-06-22 10:43:11,113 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:11,113 DEBUG --- stderr --- 2024-06-22 10:43:11,113 DEBUG 2024-06-22 10:43:11,114 INFO 2024-06-22 10:43:11,114 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/gatling/login-tree-300.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz 2024-06-22 10:43:11,114 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:43:12,132 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:12,132 DEBUG --- stdout --- 2024-06-22 10:43:12,132 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:43:12,132 DEBUG --- stderr --- 2024-06-22 10:43:12,132 DEBUG ________________________________________________________________________________ [2024-06-22 10:43:12] Reporting-login-tree-300 step6 : Unzip the result ________________________________________________________________________________ 2024-06-22 10:43:12,133 INFO 2024-06-22 10:43:12,134 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-300.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/07_login-tree-300/gatling 2024-06-22 10:43:12,167 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:43:12,167 DEBUG --- stdout --- 2024-06-22 10:43:12,167 DEBUG 2024-06-22 10:43:12,167 DEBUG --- stderr --- 2024-06-22 10:43:12,167 DEBUG 2024-06-22 10:43:12,167 INFO ________________________________________________________________________________ [2024-06-22 10:43:12] Reporting-login-tree-300 step7 : Print rc order ________________________________________________________________________________ 2024-06-22 10:43:12,169 INFO 2024-06-22 10:43:12,169 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:43:12,169 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:12,491 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:12,491 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:12,491 DEBUG --- stdout --- 2024-06-22 10:43:12,491 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:12,491 DEBUG --- stderr --- 2024-06-22 10:43:12,491 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:43:12,492 INFO 2024-06-22 10:43:12,492 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:43:12,492 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:12,817 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:12,817 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:12,818 DEBUG --- stdout --- 2024-06-22 10:43:12,819 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:12,819 DEBUG --- stderr --- 2024-06-22 10:43:12,819 DEBUG 2024-06-22 10:43:12,820 INFO 2024-06-22 10:43:12,820 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-300/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/rc.txt file found" 2024-06-22 10:43:12,820 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:43:13,636 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:43:13,636 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:13,636 DEBUG --- stdout --- 2024-06-22 10:43:13,637 DEBUG /results/orders/Reporting-login-tree-300/rc.txt file found 2024-06-22 10:43:13,637 DEBUG --- stderr --- 2024-06-22 10:43:13,637 DEBUG 2024-06-22 10:43:13,637 INFO 2024-06-22 10:43:13,637 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:43:13,637 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:13,939 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:13,939 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:13,939 DEBUG --- stdout --- 2024-06-22 10:43:13,939 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:13,940 DEBUG --- stderr --- 2024-06-22 10:43:13,940 DEBUG 2024-06-22 10:43:13,940 INFO 2024-06-22 10:43:13,940 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/Reporting-login-tree-300/rc.txt 2024-06-22 10:43:14,743 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:43:14,743 DEBUG --- stdout --- 2024-06-22 10:43:14,743 DEBUG 4 /results/orders/Reporting-login-tree-300/rc.txt 2024-06-22 10:43:14,743 DEBUG --- stderr --- 2024-06-22 10:43:14,743 DEBUG 2024-06-22 10:43:14,743 INFO - Download file (size 4k) 2024-06-22 10:43:14,743 INFO 2024-06-22 10:43:14,743 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:43:14,743 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:15,044 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:15,045 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:15,045 DEBUG --- stdout --- 2024-06-22 10:43:15,045 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:15,045 DEBUG --- stderr --- 2024-06-22 10:43:15,045 DEBUG source : /results/orders/Reporting-login-tree-300/rc.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/rc.txt 2024-06-22 10:43:15,045 INFO 2024-06-22 10:43:15,045 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:43:15,045 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:15,350 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:15,350 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:15,350 DEBUG --- stdout --- 2024-06-22 10:43:15,350 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:15,350 DEBUG --- stderr --- 2024-06-22 10:43:15,350 DEBUG 2024-06-22 10:43:15,351 INFO 2024-06-22 10:43:15,351 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/Reporting-login-tree-300/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/rc.txt 2024-06-22 10:43:15,351 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:43:16,143 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:16,143 DEBUG --- stdout --- 2024-06-22 10:43:16,144 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:43:16,144 DEBUG --- stderr --- 2024-06-22 10:43:16,144 DEBUG 2024-06-22 10:43:16,144 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/rc.txt is small (1 lines), printing all lines: 2024-06-22 10:43:16,144 DEBUG ----- output ----- 2024-06-22 10:43:16,144 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-06-22 10:43:16,144 INFO ________________________________________________________________________________ [2024-06-22 10:43:16] Reporting-login-tree-300 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [2024-06-22 10:43:16] Reporting-login-tree-300 step9 : Print stdout order ________________________________________________________________________________ 2024-06-22 10:43:16,145 INFO 2024-06-22 10:43:16,146 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:43:16,146 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:16,461 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:16,461 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:16,461 DEBUG --- stdout --- 2024-06-22 10:43:16,461 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:16,461 DEBUG --- stderr --- 2024-06-22 10:43:16,461 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:43:16,462 INFO 2024-06-22 10:43:16,462 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:43:16,462 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:16,784 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:16,784 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:16,784 DEBUG --- stdout --- 2024-06-22 10:43:16,785 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:16,785 DEBUG --- stderr --- 2024-06-22 10:43:16,785 DEBUG 2024-06-22 10:43:16,785 INFO 2024-06-22 10:43:16,785 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-300/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/stdout.txt file found" 2024-06-22 10:43:16,785 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:43:17,603 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:43:17,604 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:17,604 DEBUG --- stdout --- 2024-06-22 10:43:17,604 DEBUG /results/orders/Reporting-login-tree-300/stdout.txt file found 2024-06-22 10:43:17,604 DEBUG --- stderr --- 2024-06-22 10:43:17,604 DEBUG 2024-06-22 10:43:17,604 INFO 2024-06-22 10:43:17,604 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:43:17,605 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:17,913 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:17,913 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:17,913 DEBUG --- stdout --- 2024-06-22 10:43:17,913 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:17,914 DEBUG --- stderr --- 2024-06-22 10:43:17,914 DEBUG 2024-06-22 10:43:17,914 INFO 2024-06-22 10:43:17,914 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/Reporting-login-tree-300/stdout.txt 2024-06-22 10:43:18,711 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:43:18,711 DEBUG --- stdout --- 2024-06-22 10:43:18,711 DEBUG 4 /results/orders/Reporting-login-tree-300/stdout.txt 2024-06-22 10:43:18,711 DEBUG --- stderr --- 2024-06-22 10:43:18,711 DEBUG 2024-06-22 10:43:18,711 INFO - Download file (size 4k) 2024-06-22 10:43:18,712 INFO 2024-06-22 10:43:18,712 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:43:18,712 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:19,033 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:19,034 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:19,034 DEBUG --- stdout --- 2024-06-22 10:43:19,034 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:19,034 DEBUG --- stderr --- 2024-06-22 10:43:19,034 DEBUG source : /results/orders/Reporting-login-tree-300/stdout.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stdout.txt 2024-06-22 10:43:19,034 INFO 2024-06-22 10:43:19,034 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:43:19,034 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:19,355 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:19,356 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:19,356 DEBUG --- stdout --- 2024-06-22 10:43:19,356 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:19,356 DEBUG --- stderr --- 2024-06-22 10:43:19,356 DEBUG 2024-06-22 10:43:19,356 INFO 2024-06-22 10:43:19,356 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/Reporting-login-tree-300/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stdout.txt 2024-06-22 10:43:19,356 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:43:20,101 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:20,101 DEBUG --- stdout --- 2024-06-22 10:43:20,101 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:43:20,101 DEBUG --- stderr --- 2024-06-22 10:43:20,101 DEBUG 2024-06-22 10:43:20,102 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stdout.txt is small (88 lines), printing all lines: 2024-06-22 10:43:20,102 DEBUG ----- output ----- 2024-06-22 10:43:20,102 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-300/loadtest-20240622093614159 --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 4484312 (OK=4484264 KO=48 ) > min response time 33 (OK=40 KO=33 ) > max response time 5179 (OK=5179 KO=366 ) > mean response time 177 (OK=177 KO=80 ) > std deviation 181 (OK=181 KO=58 ) > response time 50th percentile 87 (OK=87 KO=58 ) > response time 75th percentile 320 (OK=320 KO=111 ) > response time 95th percentile 477 (OK=477 KO=140 ) > response time 99th percentile 724 (OK=724 KO=295 ) > mean requests/sec 1235.007 (OK=1234.994 KO=0.013 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 4451272 ( 99%) > 800 ms <= t < 1200 ms 21625 ( 0%) > t >= 1200 ms 11367 ( 0%) > failed 48 ( 0%) ---- Errors -------------------------------------------------------------------- > jsonPath($.tokenId).find.exists, found nothing 20 (33.33%) > status.find.is(200), but actually found 502 15 (25.00%) > status.find.is(200), but actually found 401 13 (21.67%) > restLoginUsernamePasswordCallback: Failed to build request: No 3 ( 5.00%) attribute named 'callbacks' is defined > restloginProgressiveProfileCallback: Failed to build request: 3 ( 5.00%) No attribute named 'callbacks' is defined > PingOneProtectEvaluationCallback: Failed to build request: No 3 ( 5.00%) attribute named 'callbacks' is defined > PingOneProtectInitializeCallback: Failed to build request: No 3 ( 5.00%) attribute named 'callbacks' is defined ================================================================================ Reports generated in 0s. Please open the following file: file:///results/gatling/login-tree-300/loadtest-20240622093614159/index.html ---------------------- [22/Jun/2024 11:43:07] Create tar file /results/gatling/login-tree-300.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/login-tree-300/loadtest-20240622093614159 RESULT_FOLDER=login-tree-300 RESULT_PATH=/results/gatling/login-tree-300 PWD=/results/gatling/login-tree-300/loadtest-20240622093614159 [cmd] tar -czvf /results/gatling/login-tree-300.tar.gz --exclude=simulation.log * index.html js/ js/gatling.js js/highcharts-more.js js/highstock.js js/ellipsis.js js/bootstrap.min.js js/stats.json js/stats.js js/global_stats.json js/all_sessions.js js/assertions.xml js/menu.js js/theme.js js/unpack.js js/jquery-3.5.1.min.js js/assertions.json req_pingoneprotecte-ee094.html req_pingoneprotecti-dd6e3.html req_protectloginini-66072.html req_restloginprogre-9fc93.html req_restloginuserna-d98ea.html style/ style/bootstrap.min.css style/stat-l-temps.png style/favicon.ico style/style.css style/arrow_down_black.png style/sorted-down.png style/arrow_right.png style/stat-l-roue.png style/stat-fleche-bas.png style/sorted-up.png style/logo-enterprise.svg style/little_arrow_right.png style/logo.svg style/sortable.png style/arrow_down.png style/arrow_right_black.png 2024-06-22 10:43:20,102 INFO ________________________________________________________________________________ [2024-06-22 10:43:20] Reporting-login-tree-300 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2024-06-22 10:43:20] Reporting-login-tree-300 step11 : Print stderr order ________________________________________________________________________________ 2024-06-22 10:43:20,104 INFO 2024-06-22 10:43:20,104 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:43:20,104 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:20,408 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:20,408 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:20,408 DEBUG --- stdout --- 2024-06-22 10:43:20,409 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:20,409 DEBUG --- stderr --- 2024-06-22 10:43:20,409 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:43:20,409 INFO 2024-06-22 10:43:20,409 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:43:20,409 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:20,712 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:20,712 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:20,712 DEBUG --- stdout --- 2024-06-22 10:43:20,712 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:20,712 DEBUG --- stderr --- 2024-06-22 10:43:20,712 DEBUG 2024-06-22 10:43:20,713 INFO 2024-06-22 10:43:20,713 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-login-tree-300/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-300/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-300/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-300/stderr.txt file found" 2024-06-22 10:43:20,713 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:43:21,528 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:43:21,528 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:21,528 DEBUG --- stdout --- 2024-06-22 10:43:21,528 DEBUG /results/orders/Reporting-login-tree-300/stderr.txt file found 2024-06-22 10:43:21,528 DEBUG --- stderr --- 2024-06-22 10:43:21,528 DEBUG 2024-06-22 10:43:21,529 INFO 2024-06-22 10:43:21,529 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:43:21,529 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:21,848 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:21,848 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:21,848 DEBUG --- stdout --- 2024-06-22 10:43:21,848 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:21,848 DEBUG --- stderr --- 2024-06-22 10:43:21,848 DEBUG 2024-06-22 10:43:21,848 INFO 2024-06-22 10:43:21,849 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/Reporting-login-tree-300/stderr.txt 2024-06-22 10:43:22,700 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:43:22,701 DEBUG --- stdout --- 2024-06-22 10:43:22,701 DEBUG 0 /results/orders/Reporting-login-tree-300/stderr.txt 2024-06-22 10:43:22,701 DEBUG --- stderr --- 2024-06-22 10:43:22,701 DEBUG 2024-06-22 10:43:22,701 INFO - Download file (size 0k) 2024-06-22 10:43:22,701 INFO 2024-06-22 10:43:22,701 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:43:22,702 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:23,025 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:23,026 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:23,027 DEBUG --- stdout --- 2024-06-22 10:43:23,027 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:23,027 DEBUG --- stderr --- 2024-06-22 10:43:23,027 DEBUG source : /results/orders/Reporting-login-tree-300/stderr.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stderr.txt 2024-06-22 10:43:23,028 INFO 2024-06-22 10:43:23,028 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:43:23,028 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:43:23,355 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:43:23,356 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:23,356 DEBUG --- stdout --- 2024-06-22 10:43:23,356 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:43:23,356 DEBUG --- stderr --- 2024-06-22 10:43:23,356 DEBUG 2024-06-22 10:43:23,357 INFO 2024-06-22 10:43:23,357 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/Reporting-login-tree-300/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stderr.txt 2024-06-22 10:43:23,357 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:43:24,104 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:43:24,104 DEBUG --- stdout --- 2024-06-22 10:43:24,105 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:43:24,105 DEBUG --- stderr --- 2024-06-22 10:43:24,105 DEBUG 2024-06-22 10:43:24,105 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/15_Reporting-login-tree-300/stderr.txt is small (0 lines), printing all lines: 2024-06-22 10:43:24,105 DEBUG ----- output ----- 2024-06-22 10:43:24,105 DEBUG 2024-06-22 10:43:24,105 INFO ________________________________________________________________________________ [2024-06-22 10:43:24] Reporting-login-tree-300 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2024-06-22 10:43:24] Reporting-login-tree-300 step13 : Analyze graphs for spikes ________________________________________________________________________________ Analyze Gatling graphs for spikes checking parameters open overall stats JSON file checking simulation request protectLoginInitiate 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/07_login-tree-300/gatling/req_pingoneprotecte-ee094.html - cannot check for spikes checking simulation request restloginProgressiveProfileCallback [warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/07_login-tree-300/gatling/req_restloginprogre-9fc93.html - cannot check for spikes no spikes found ________________________________________________________________________________ [2024-06-22 10:43:24] Reporting-login-tree-300 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 4484312, "ok": 4484264, "ko": 48 }, "minResponseTime": { "total": 33, "ok": 40, "ko": 33 }, "maxResponseTime": { "total": 5179, "ok": 5179, "ko": 366 }, "meanResponseTime": { "total": 177, "ok": 177, "ko": 80 }, "standardDeviation": { "total": 181, "ok": 181, "ko": 58 }, "percentiles1": { "total": 87, "ok": 87, "ko": 58 }, "percentiles2": { "total": 320, "ok": 320, "ko": 111 }, "percentiles3": { "total": 477, "ok": 477, "ko": 140 }, "percentiles4": { "total": 724, "ok": 724, "ko": 295 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 4451272, "percentage": 99 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 21625, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 11367, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 48, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 1235.007435968053, "ok": 1234.9942164692923, "ko": 0.01321949876067199 } }, "details": [ { "name": "protectLoginInitiate", "numberOfRequests": { "total": 1083101, "ok": 1083098, "ko": 3 }, "minResponseTime": { "total": 36, "ok": 43, "ko": 36 }, "maxResponseTime": { "total": 601, "ok": 601, "ko": 42 }, "meanResponseTime": { "total": 67, "ok": 67, "ko": 38 }, "standardDeviation": { "total": 19, "ok": 19, "ko": 3 }, "percentiles1": { "total": 62, "ok": 62, "ko": 37 }, "percentiles2": { "total": 72, "ok": 72, "ko": 40 }, "percentiles3": { "total": 101, "ok": 101, "ko": 42 }, "percentiles4": { "total": 144, "ok": 144, "ko": 42 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1083098, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 3, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 298.29275681630406, "ok": 298.2919305976315, "ko": 0.0008262186725419994 }, "spikes": [] }, { "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "total": 1083098, "ok": 1083092, "ko": 6 }, "minResponseTime": { "total": 34, "ok": 40, "ko": 34 }, "maxResponseTime": { "total": 1094, "ok": 1094, "ko": 40 }, "meanResponseTime": { "total": 65, "ok": 65, "ko": 36 }, "standardDeviation": { "total": 21, "ok": 21, "ko": 2 }, "percentiles1": { "total": 60, "ok": 60, "ko": 36 }, "percentiles2": { "total": 70, "ok": 70, "ko": 36 }, "percentiles3": { "total": 102, "ok": 102, "ko": 39 }, "percentiles4": { "total": 149, "ok": 149, "ko": 40 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1083091, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 1, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 6, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 298.2919305976315, "ok": 298.29027816028645, "ko": 0.0016524373450839988 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 1083098, "ok": 1083097, "ko": 1 }, "minResponseTime": { "total": 37, "ok": 51, "ko": 37 }, "maxResponseTime": { "total": 1047, "ok": 1047, "ko": 37 }, "meanResponseTime": { "total": 116, "ok": 116, "ko": 37 }, "standardDeviation": { "total": 57, "ok": 57, "ko": 0 }, "percentiles1": { "total": 101, "ok": 101, "ko": 37 }, "percentiles2": { "total": 125, "ok": 125, "ko": 37 }, "percentiles3": { "total": 206, "ok": 206, "ko": 37 }, "percentiles4": { "total": 360, "ok": 360, "ko": 37 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1082702, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 395, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 1, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 298.2919305976315, "ok": 298.2916551914073, "ko": 0.0002754062241806665 }, "spikes": [] }, { "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "total": 1083098, "ok": 1083080, "ko": 18 }, "minResponseTime": { "total": 33, "ok": 60, "ko": 33 }, "maxResponseTime": { "total": 5179, "ok": 5179, "ko": 214 }, "meanResponseTime": { "total": 433, "ok": 433, "ko": 102 }, "standardDeviation": { "total": 170, "ok": 170, "ko": 47 }, "percentiles1": { "total": 395, "ok": 395, "ko": 111 }, "percentiles2": { "total": 451, "ok": 451, "ko": 130 }, "percentiles3": { "total": 660, "ok": 660, "ko": 154 }, "percentiles4": { "total": 1178, "ok": 1178, "ko": 202 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1053687, "percentage": 97 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 19096, "percentage": 2 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 10297, "percentage": 1 }, "group4": { "name": "failed", "htmlName": "failed", "count": 18, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 298.2919305976315, "ok": 298.2869732855963, "ko": 0.004957312035251997 }, "spikes": [] }, { "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "total": 151917, "ok": 151897, "ko": 20 }, "minResponseTime": { "total": 43, "ok": 126, "ko": 43 }, "maxResponseTime": { "total": 2657, "ok": 2657, "ko": 366 }, "meanResponseTime": { "total": 375, "ok": 375, "ko": 83 }, "standardDeviation": { "total": 159, "ok": 159, "ko": 69 }, "percentiles1": { "total": 342, "ok": 342, "ko": 60 }, "percentiles2": { "total": 401, "ok": 401, "ko": 86 }, "percentiles3": { "total": 601, "ok": 601, "ko": 130 }, "percentiles4": { "total": 1056, "ok": 1056, "ko": 319 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 148694, "percentage": 98 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 2133, "percentage": 1 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 1070, "percentage": 1 }, "group4": { "name": "failed", "htmlName": "failed", "count": 20, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 41.83888735885431, "ok": 41.833379234370696, "ko": 0.00550812448361333 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 1235, "avg_response_time": 177, "max_response_time": 5179, "min_response_time": 40, "num_requests": 4484312, "num_requests_pass": 4484264, "num_requests_percent_pass": 99.999 }, "options": "; testCase:idc.loginProtect; testMode:open; throughput:300; rampup-duration:30; duration:3600", "stats": { "details": [ { "group1": { "count": 1083098, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 3, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 42, "ok": 601, "total": 601 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0008262186725419994, "ok": 298.2919305976315, "total": 298.29275681630406 }, "meanResponseTime": { "ko": 38, "ok": 67, "total": 67 }, "minResponseTime": { "ko": 36, "ok": 43, "total": 36 }, "name": "protectLoginInitiate", "numberOfRequests": { "ko": 3, "ok": 1083098, "total": 1083101 }, "percentiles1": { "ko": 37, "ok": 62, "total": 62 }, "percentiles2": { "ko": 40, "ok": 72, "total": 72 }, "percentiles3": { "ko": 42, "ok": 101, "total": 101 }, "percentiles4": { "ko": 42, "ok": 144, "total": 144 }, "spikes": [], "standardDeviation": { "ko": 3, "ok": 19, "total": 19 } }, { "group1": { "count": 1083091, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 1, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 6, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 40, "ok": 1094, "total": 1094 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0016524373450839988, "ok": 298.29027816028645, "total": 298.2919305976315 }, "meanResponseTime": { "ko": 36, "ok": 65, "total": 65 }, "minResponseTime": { "ko": 34, "ok": 40, "total": 34 }, "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "ko": 6, "ok": 1083092, "total": 1083098 }, "percentiles1": { "ko": 36, "ok": 60, "total": 60 }, "percentiles2": { "ko": 36, "ok": 70, "total": 70 }, "percentiles3": { "ko": 39, "ok": 102, "total": 102 }, "percentiles4": { "ko": 40, "ok": 149, "total": 149 }, "spikes": [], "standardDeviation": { "ko": 2, "ok": 21, "total": 21 } }, { "group1": { "count": 1082702, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 395, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 1, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 37, "ok": 1047, "total": 1047 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0002754062241806665, "ok": 298.2916551914073, "total": 298.2919305976315 }, "meanResponseTime": { "ko": 37, "ok": 116, "total": 116 }, "minResponseTime": { "ko": 37, "ok": 51, "total": 37 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 1, "ok": 1083097, "total": 1083098 }, "percentiles1": { "ko": 37, "ok": 101, "total": 101 }, "percentiles2": { "ko": 37, "ok": 125, "total": 125 }, "percentiles3": { "ko": 37, "ok": 206, "total": 206 }, "percentiles4": { "ko": 37, "ok": 360, "total": 360 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 57, "total": 57 } }, { "group1": { "count": 1053687, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 97 }, "group2": { "count": 19096, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 2 }, "group3": { "count": 10297, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 1 }, "group4": { "count": 18, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 214, "ok": 5179, "total": 5179 }, "meanNumberOfRequestsPerSecond": { "ko": 0.004957312035251997, "ok": 298.2869732855963, "total": 298.2919305976315 }, "meanResponseTime": { "ko": 102, "ok": 433, "total": 433 }, "minResponseTime": { "ko": 33, "ok": 60, "total": 33 }, "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "ko": 18, "ok": 1083080, "total": 1083098 }, "percentiles1": { "ko": 111, "ok": 395, "total": 395 }, "percentiles2": { "ko": 130, "ok": 451, "total": 451 }, "percentiles3": { "ko": 154, "ok": 660, "total": 660 }, "percentiles4": { "ko": 202, "ok": 1178, "total": 1178 }, "spikes": [], "standardDeviation": { "ko": 47, "ok": 170, "total": 170 } }, { "group1": { "count": 148694, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 98 }, "group2": { "count": 2133, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 1 }, "group3": { "count": 1070, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 1 }, "group4": { "count": 20, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 366, "ok": 2657, "total": 2657 }, "meanNumberOfRequestsPerSecond": { "ko": 0.00550812448361333, "ok": 41.833379234370696, "total": 41.83888735885431 }, "meanResponseTime": { "ko": 83, "ok": 375, "total": 375 }, "minResponseTime": { "ko": 43, "ok": 126, "total": 43 }, "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "ko": 20, "ok": 151897, "total": 151917 }, "percentiles1": { "ko": 60, "ok": 342, "total": 342 }, "percentiles2": { "ko": 86, "ok": 401, "total": 401 }, "percentiles3": { "ko": 130, "ok": 601, "total": 601 }, "percentiles4": { "ko": 319, "ok": 1056, "total": 1056 }, "spikes": [], "standardDeviation": { "ko": 69, "ok": 159, "total": 159 } } ], "global": { "group1": { "count": 4451272, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99 }, "group2": { "count": 21625, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 11367, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 48, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 366, "ok": 5179, "total": 5179 }, "meanNumberOfRequestsPerSecond": { "ko": 0.01321949876067199, "ok": 1234.9942164692923, "total": 1235.007435968053 }, "meanResponseTime": { "ko": 80, "ok": 177, "total": 177 }, "minResponseTime": { "ko": 33, "ok": 40, "total": 33 }, "name": "All Requests", "numberOfRequests": { "ko": 48, "ok": 4484264, "total": 4484312 }, "percentiles1": { "ko": 58, "ok": 87, "total": 87 }, "percentiles2": { "ko": 111, "ok": 320, "total": 320 }, "percentiles3": { "ko": 140, "ok": 477, "total": 477 }, "percentiles4": { "ko": 295, "ok": 724, "total": 724 }, "standardDeviation": { "ko": 58, "ok": 181, "total": 181 } } }, "target_hostname": "openam-ema-perf-p1.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2024-06-22 10:43:24] Reporting-login-tree-300 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2024-06-22 10:43:24] Reporting-login-tree-300 step16 : Remove gatling task's stdout file ________________________________________________________________________________ Cleanup of Gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/07_login-tree-300/stdout.txt Compressing Gatling stdout.txt file.. ________________________________________________________________________________ [2024-06-22 10:43:24] Reporting-login-tree-300 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped