--Task-- name: Reporting-login-tree-10 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: [] preceding_task: None options: {'task_name': 'login-tree-10'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-06-22 10:38:46] Reporting-login-tree-10 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component 2024-06-22 10:38:46 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds) 2024-06-22 10:38:46 - 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-10/stdout.txt Pod stderr file : /results/orders/Reporting-login-tree-10/stderr.txt Pod log : /results/orders/Reporting-login-tree-10 ________________________________________________________________________________ [2024-06-22 10:38:46] Reporting-login-tree-10 step1 : Write order for overseer to generate the report ________________________________________________________________________________ 2024-06-22 10:38:46,121 INFO 2024-06-22 10:38:46,121 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:38:46,121 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:46,444 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:46,445 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:46,445 DEBUG --- stdout --- 2024-06-22 10:38:46,445 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:46,445 DEBUG --- stderr --- 2024-06-22 10:38:46,445 DEBUG 2024-06-22 10:38:46 - INFO: Get overseer pod resources requests memory 2024-06-22 10:38:46,446 INFO 2024-06-22 10:38:46,446 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods overseer-0-5b6f9464fd-slbm8 --output jsonpath={.spec.containers[].resources.requests.memory} 2024-06-22 10:38:46,446 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:38:46,761 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:46,761 DEBUG --- stdout --- 2024-06-22 10:38:46,762 DEBUG 4Gi 2024-06-22 10:38:46,762 DEBUG --- stderr --- 2024-06-22 10:38:46,762 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/order.json { "name": "Reporting-login-tree-10", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh login-tree-10 --extra-run-jvm-options \"-Xmx4G\"", "out-dir": "/results/orders/Reporting-login-tree-10" } ________________________________________________________________________________ [2024-06-22 10:38:46] Reporting-login-tree-10 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2024-06-22 10:38:46,764 INFO 2024-06-22 10:38:46,764 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-22 10:38:46,764 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2024-06-22 10:38:47,017 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:38:47,017 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:47,017 DEBUG --- stdout --- 2024-06-22 10:38:47,018 DEBUG WAITING 2024-06-22 10:38:47,018 DEBUG --- stderr --- 2024-06-22 10:38:47,018 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 32 0 --:--:-- --:--:-- --:--:-- 32 ________________________________________________________________________________ [2024-06-22 10:38:47] Reporting-login-tree-10 step3 : Send order to overseer ________________________________________________________________________________ 2024-06-22 10:38:47,019 INFO 2024-06-22 10:38:47,019 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:38:47,019 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:47,346 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:47,346 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:47,346 DEBUG --- stdout --- 2024-06-22 10:38:47,347 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:47,347 DEBUG --- stderr --- 2024-06-22 10:38:47,347 DEBUG 2024-06-22 10:38:47,347 INFO 2024-06-22 10:38:47,347 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/09_Reporting-login-tree-10/order.json overseer-0-5b6f9464fd-slbm8:/results/orders/order.json 2024-06-22 10:38:47,347 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:38:48,719 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:48,719 DEBUG --- stdout --- 2024-06-22 10:38:48,719 DEBUG 2024-06-22 10:38:48,719 DEBUG --- stderr --- 2024-06-22 10:38:48,719 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2024-06-22 10:38:48] Reporting-login-tree-10 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2024-06-22 10:38:53,722 INFO 2024-06-22 10:38:53,723 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-22 10:38:53,723 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0] 2024-06-22 10:38:53,960 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:38:53,960 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:53,960 DEBUG --- stdout --- 2024-06-22 10:38:53,960 DEBUG WAITING 2024-06-22 10:38:53,960 DEBUG --- stderr --- 2024-06-22 10:38:53,960 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 32 0 --:--:-- --:--:-- --:--:-- 32 ________________________________________________________________________________ [2024-06-22 10:38:53] Reporting-login-tree-10 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2024-06-22 10:38:53,962 INFO 2024-06-22 10:38:53,962 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:38:53,962 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:54,277 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:54,278 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:54,278 DEBUG --- stdout --- 2024-06-22 10:38:54,278 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:54,278 DEBUG --- stderr --- 2024-06-22 10:38:54,278 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:38:54,278 INFO 2024-06-22 10:38:54,278 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:38:54,278 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:54,612 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:54,613 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:54,613 DEBUG --- stdout --- 2024-06-22 10:38:54,613 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:54,613 DEBUG --- stderr --- 2024-06-22 10:38:54,613 DEBUG 2024-06-22 10:38:54,613 INFO 2024-06-22 10:38:54,613 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-10.tar.gz" ]; then echo "/results/gatling/login-tree-10.tar.gz file found"; exit 0; else echo "/results/gatling/login-tree-10.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/login-tree-10.tar.gz file found" 2024-06-22 10:38:54,613 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:38:55,441 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:38:55,441 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:55,441 DEBUG --- stdout --- 2024-06-22 10:38:55,441 DEBUG /results/gatling/login-tree-10.tar.gz file found 2024-06-22 10:38:55,441 DEBUG --- stderr --- 2024-06-22 10:38:55,441 DEBUG 2024-06-22 10:38:55,442 INFO 2024-06-22 10:38:55,442 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:38:55,442 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:55,753 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:55,753 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:55,753 DEBUG --- stdout --- 2024-06-22 10:38:55,753 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:55,753 DEBUG --- stderr --- 2024-06-22 10:38:55,754 DEBUG 2024-06-22 10:38:55,754 INFO 2024-06-22 10:38:55,754 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-10.tar.gz 2024-06-22 10:38:56,584 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:38:56,584 DEBUG --- stdout --- 2024-06-22 10:38:56,584 DEBUG 292 /results/gatling/login-tree-10.tar.gz 2024-06-22 10:38:56,584 DEBUG --- stderr --- 2024-06-22 10:38:56,585 DEBUG 2024-06-22 10:38:56,585 INFO - Download file (size 292k) 2024-06-22 10:38:56,585 INFO 2024-06-22 10:38:56,585 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:38:56,585 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:56,901 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:56,901 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:56,901 DEBUG --- stdout --- 2024-06-22 10:38:56,901 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:56,901 DEBUG --- stderr --- 2024-06-22 10:38:56,901 DEBUG source : /results/gatling/login-tree-10.tar.gz @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-10.tar.gz 2024-06-22 10:38:56,902 INFO 2024-06-22 10:38:56,902 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:38:56,902 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:57,214 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:57,214 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:57,214 DEBUG --- stdout --- 2024-06-22 10:38:57,214 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:57,215 DEBUG --- stderr --- 2024-06-22 10:38:57,215 DEBUG 2024-06-22 10:38:57,215 INFO 2024-06-22 10:38:57,215 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-10.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-10.tar.gz 2024-06-22 10:38:57,215 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:38:58,220 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:58,220 DEBUG --- stdout --- 2024-06-22 10:38:58,220 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:38:58,220 DEBUG --- stderr --- 2024-06-22 10:38:58,220 DEBUG ________________________________________________________________________________ [2024-06-22 10:38:58] Reporting-login-tree-10 step6 : Unzip the result ________________________________________________________________________________ 2024-06-22 10:38:58,221 INFO 2024-06-22 10:38:58,221 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/shared/login-tree-10.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/01_login-tree-10/gatling 2024-06-22 10:38:58,248 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:38:58,248 DEBUG --- stdout --- 2024-06-22 10:38:58,248 DEBUG 2024-06-22 10:38:58,248 DEBUG --- stderr --- 2024-06-22 10:38:58,248 DEBUG 2024-06-22 10:38:58,248 INFO ________________________________________________________________________________ [2024-06-22 10:38:58] Reporting-login-tree-10 step7 : Print rc order ________________________________________________________________________________ 2024-06-22 10:38:58,250 INFO 2024-06-22 10:38:58,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-22 10:38:58,250 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:58,555 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:58,555 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:58,555 DEBUG --- stdout --- 2024-06-22 10:38:58,555 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:58,555 DEBUG --- stderr --- 2024-06-22 10:38:58,555 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:38:58,556 INFO 2024-06-22 10:38:58,556 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:38:58,556 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:58,867 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:58,867 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:58,867 DEBUG --- stdout --- 2024-06-22 10:38:58,867 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:58,867 DEBUG --- stderr --- 2024-06-22 10:38:58,867 DEBUG 2024-06-22 10:38:58,868 INFO 2024-06-22 10:38:58,868 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-10/rc.txt" ]; then echo "/results/orders/Reporting-login-tree-10/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-10/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-10/rc.txt file found" 2024-06-22 10:38:58,868 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:38:59,668 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:38:59,668 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:59,668 DEBUG --- stdout --- 2024-06-22 10:38:59,668 DEBUG /results/orders/Reporting-login-tree-10/rc.txt file found 2024-06-22 10:38:59,668 DEBUG --- stderr --- 2024-06-22 10:38:59,668 DEBUG 2024-06-22 10:38:59,669 INFO 2024-06-22 10:38:59,669 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:38:59,669 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:38:59,978 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:38:59,978 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:38:59,978 DEBUG --- stdout --- 2024-06-22 10:38:59,978 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:38:59,978 DEBUG --- stderr --- 2024-06-22 10:38:59,978 DEBUG 2024-06-22 10:38:59,978 INFO 2024-06-22 10:38:59,979 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-10/rc.txt 2024-06-22 10:39:00,800 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:39:00,801 DEBUG --- stdout --- 2024-06-22 10:39:00,801 DEBUG 4 /results/orders/Reporting-login-tree-10/rc.txt 2024-06-22 10:39:00,801 DEBUG --- stderr --- 2024-06-22 10:39:00,801 DEBUG 2024-06-22 10:39:00,801 INFO - Download file (size 4k) 2024-06-22 10:39:00,803 INFO 2024-06-22 10:39:00,803 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:00,803 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:01,197 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:01,197 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:01,197 DEBUG --- stdout --- 2024-06-22 10:39:01,198 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:01,198 DEBUG --- stderr --- 2024-06-22 10:39:01,198 DEBUG source : /results/orders/Reporting-login-tree-10/rc.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/rc.txt 2024-06-22 10:39:01,198 INFO 2024-06-22 10:39:01,198 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:01,198 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:01,514 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:01,514 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:01,514 DEBUG --- stdout --- 2024-06-22 10:39:01,514 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:01,514 DEBUG --- stderr --- 2024-06-22 10:39:01,514 DEBUG 2024-06-22 10:39:01,515 INFO 2024-06-22 10:39:01,515 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-10/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/rc.txt 2024-06-22 10:39:01,515 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:39:02,305 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:02,305 DEBUG --- stdout --- 2024-06-22 10:39:02,306 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:39:02,306 DEBUG --- stderr --- 2024-06-22 10:39:02,306 DEBUG 2024-06-22 10:39:02,306 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/rc.txt is small (1 lines), printing all lines: 2024-06-22 10:39:02,306 DEBUG ----- output ----- 2024-06-22 10:39:02,306 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-06-22 10:39:02,306 INFO ________________________________________________________________________________ [2024-06-22 10:39:02] Reporting-login-tree-10 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [2024-06-22 10:39:02] Reporting-login-tree-10 step9 : Print stdout order ________________________________________________________________________________ 2024-06-22 10:39:02,308 INFO 2024-06-22 10:39:02,308 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:02,308 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:02,612 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:02,612 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:02,612 DEBUG --- stdout --- 2024-06-22 10:39:02,612 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:02,612 DEBUG --- stderr --- 2024-06-22 10:39:02,612 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:39:02,612 INFO 2024-06-22 10:39:02,612 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:02,613 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:02,916 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:02,917 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:02,917 DEBUG --- stdout --- 2024-06-22 10:39:02,917 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:02,917 DEBUG --- stderr --- 2024-06-22 10:39:02,917 DEBUG 2024-06-22 10:39:02,917 INFO 2024-06-22 10:39:02,918 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-10/stdout.txt" ]; then echo "/results/orders/Reporting-login-tree-10/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-10/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-10/stdout.txt file found" 2024-06-22 10:39:02,918 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:39:03,719 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:39:03,719 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:03,719 DEBUG --- stdout --- 2024-06-22 10:39:03,719 DEBUG /results/orders/Reporting-login-tree-10/stdout.txt file found 2024-06-22 10:39:03,719 DEBUG --- stderr --- 2024-06-22 10:39:03,719 DEBUG 2024-06-22 10:39:03,720 INFO 2024-06-22 10:39:03,720 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:03,720 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:04,046 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:04,047 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:04,047 DEBUG --- stdout --- 2024-06-22 10:39:04,047 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:04,047 DEBUG --- stderr --- 2024-06-22 10:39:04,047 DEBUG 2024-06-22 10:39:04,047 INFO 2024-06-22 10:39:04,047 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-10/stdout.txt 2024-06-22 10:39:04,863 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:39:04,864 DEBUG --- stdout --- 2024-06-22 10:39:04,864 DEBUG 4 /results/orders/Reporting-login-tree-10/stdout.txt 2024-06-22 10:39:04,864 DEBUG --- stderr --- 2024-06-22 10:39:04,864 DEBUG 2024-06-22 10:39:04,864 INFO - Download file (size 4k) 2024-06-22 10:39:04,864 INFO 2024-06-22 10:39:04,864 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:04,864 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:05,168 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:05,169 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:05,169 DEBUG --- stdout --- 2024-06-22 10:39:05,169 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:05,169 DEBUG --- stderr --- 2024-06-22 10:39:05,169 DEBUG source : /results/orders/Reporting-login-tree-10/stdout.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/stdout.txt 2024-06-22 10:39:05,169 INFO 2024-06-22 10:39:05,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:39:05,169 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:05,476 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:05,476 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:05,476 DEBUG --- stdout --- 2024-06-22 10:39:05,477 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:05,477 DEBUG --- stderr --- 2024-06-22 10:39:05,477 DEBUG 2024-06-22 10:39:05,477 INFO 2024-06-22 10:39:05,477 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-10/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/stdout.txt 2024-06-22 10:39:05,477 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:39:06,204 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:06,204 DEBUG --- stdout --- 2024-06-22 10:39:06,204 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:39:06,204 DEBUG --- stderr --- 2024-06-22 10:39:06,204 DEBUG 2024-06-22 10:39:06,204 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/stdout.txt is small (80 lines), printing all lines: 2024-06-22 10:39:06,204 DEBUG ----- output ----- 2024-06-22 10:39:06,204 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-10/loadtest-20240622032020202 --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 144066 (OK=144056 KO=10 ) > min response time 35 (OK=41 KO=35 ) > max response time 7944 (OK=7944 KO=4806 ) > mean response time 118 (OK=118 KO=557 ) > std deviation 154 (OK=153 KO=1419 ) > response time 50th percentile 57 (OK=57 KO=50 ) > response time 75th percentile 158 (OK=158 KO=100 ) > response time 95th percentile 310 (OK=310 KO=2799 ) > response time 99th percentile 396 (OK=396 KO=4405 ) > mean requests/sec 39.699 (OK=39.696 KO=0.003 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 143628 (100%) > 800 ms <= t < 1200 ms 159 ( 0%) > t >= 1200 ms 269 ( 0%) > failed 10 ( 0%) ---- Errors -------------------------------------------------------------------- > jsonPath($.tokenId).find.exists, found nothing 4 (40.00%) > status.find.is(200), but actually found 502 3 (30.00%) > status.find.is(200), but actually found 401 3 (30.00%) ================================================================================ Reports generated in 0s. Please open the following file: file:///results/gatling/login-tree-10/loadtest-20240622032020202/index.html ---------------------- [22/Jun/2024 11:38:53] Create tar file /results/gatling/login-tree-10.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/login-tree-10/loadtest-20240622032020202 RESULT_FOLDER=login-tree-10 RESULT_PATH=/results/gatling/login-tree-10 PWD=/results/gatling/login-tree-10/loadtest-20240622032020202 [cmd] tar -czvf /results/gatling/login-tree-10.tar.gz --exclude=simulation.log * index.html js/ js/gatling.js js/highcharts-more.js js/highstock.js js/ellipsis.js js/bootstrap.min.js js/stats.json js/stats.js js/global_stats.json js/all_sessions.js js/assertions.xml js/menu.js js/theme.js js/unpack.js js/jquery-3.5.1.min.js js/assertions.json req_pingoneprotecte-ee094.html req_pingoneprotecti-dd6e3.html req_protectloginini-66072.html req_restloginprogre-9fc93.html req_restloginuserna-d98ea.html style/ style/bootstrap.min.css style/stat-l-temps.png style/favicon.ico style/style.css style/arrow_down_black.png style/sorted-down.png style/arrow_right.png style/stat-l-roue.png style/stat-fleche-bas.png style/sorted-up.png style/logo-enterprise.svg style/little_arrow_right.png style/logo.svg style/sortable.png style/arrow_down.png style/arrow_right_black.png 2024-06-22 10:39:06,205 INFO ________________________________________________________________________________ [2024-06-22 10:39:06] Reporting-login-tree-10 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2024-06-22 10:39:06] Reporting-login-tree-10 step11 : Print stderr order ________________________________________________________________________________ 2024-06-22 10:39:06,206 INFO 2024-06-22 10:39:06,206 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:06,206 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:06,517 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:06,517 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:06,517 DEBUG --- stdout --- 2024-06-22 10:39:06,517 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:06,517 DEBUG --- stderr --- 2024-06-22 10:39:06,518 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-22 10:39:06,518 INFO 2024-06-22 10:39:06,518 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:06,518 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:06,823 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:06,824 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:06,824 DEBUG --- stdout --- 2024-06-22 10:39:06,824 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:06,824 DEBUG --- stderr --- 2024-06-22 10:39:06,824 DEBUG 2024-06-22 10:39:06,824 INFO 2024-06-22 10:39:06,824 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-10/stderr.txt" ]; then echo "/results/orders/Reporting-login-tree-10/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-login-tree-10/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-login-tree-10/stderr.txt file found" 2024-06-22 10:39:06,824 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-22 10:39:07,793 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-22 10:39:07,793 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:07,793 DEBUG --- stdout --- 2024-06-22 10:39:07,793 DEBUG /results/orders/Reporting-login-tree-10/stderr.txt file found 2024-06-22 10:39:07,793 DEBUG --- stderr --- 2024-06-22 10:39:07,794 DEBUG 2024-06-22 10:39:07,794 INFO 2024-06-22 10:39:07,794 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:07,794 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:08,121 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:08,121 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:08,121 DEBUG --- stdout --- 2024-06-22 10:39:08,121 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:08,121 DEBUG --- stderr --- 2024-06-22 10:39:08,122 DEBUG 2024-06-22 10:39:08,122 INFO 2024-06-22 10:39:08,122 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-10/stderr.txt 2024-06-22 10:39:08,991 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-22 10:39:08,992 DEBUG --- stdout --- 2024-06-22 10:39:08,992 DEBUG 0 /results/orders/Reporting-login-tree-10/stderr.txt 2024-06-22 10:39:08,992 DEBUG --- stderr --- 2024-06-22 10:39:08,992 DEBUG 2024-06-22 10:39:08,992 INFO - Download file (size 0k) 2024-06-22 10:39:08,992 INFO 2024-06-22 10:39:08,992 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:08,993 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:09,303 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:09,304 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:09,304 DEBUG --- stdout --- 2024-06-22 10:39:09,304 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:09,304 DEBUG --- stderr --- 2024-06-22 10:39:09,304 DEBUG source : /results/orders/Reporting-login-tree-10/stderr.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/stderr.txt 2024-06-22 10:39:09,304 INFO 2024-06-22 10:39:09,304 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-22 10:39:09,304 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-22 10:39:09,605 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-22 10:39:09,605 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:09,605 DEBUG --- stdout --- 2024-06-22 10:39:09,605 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-22 10:39:09,605 DEBUG --- stderr --- 2024-06-22 10:39:09,605 DEBUG 2024-06-22 10:39:09,606 INFO 2024-06-22 10:39:09,606 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-10/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/stderr.txt 2024-06-22 10:39:09,606 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-22 10:39:10,337 INFO [loop_until]: OK (rc = 0) 2024-06-22 10:39:10,337 DEBUG --- stdout --- 2024-06-22 10:39:10,337 DEBUG tar: Removing leading `/' from member names 2024-06-22 10:39:10,337 DEBUG --- stderr --- 2024-06-22 10:39:10,337 DEBUG 2024-06-22 10:39:10,338 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/08_Verification/09_Reporting-login-tree-10/stderr.txt is small (0 lines), printing all lines: 2024-06-22 10:39:10,338 DEBUG ----- output ----- 2024-06-22 10:39:10,338 DEBUG 2024-06-22 10:39:10,338 INFO ________________________________________________________________________________ [2024-06-22 10:39:10] Reporting-login-tree-10 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2024-06-22 10:39:10] Reporting-login-tree-10 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/01_login-tree-10/gatling/req_pingoneprotecte-ee094.html - cannot check for spikes checking simulation request restloginProgressiveProfileCallback no spikes found ________________________________________________________________________________ [2024-06-22 10:39:10] Reporting-login-tree-10 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 144066, "ok": 144056, "ko": 10 }, "minResponseTime": { "total": 35, "ok": 41, "ko": 35 }, "maxResponseTime": { "total": 7944, "ok": 7944, "ko": 4806 }, "meanResponseTime": { "total": 118, "ok": 118, "ko": 557 }, "standardDeviation": { "total": 154, "ok": 153, "ko": 1419 }, "percentiles1": { "total": 57, "ok": 57, "ko": 50 }, "percentiles2": { "total": 158, "ok": 158, "ko": 100 }, "percentiles3": { "total": 310, "ok": 310, "ko": 2799 }, "percentiles4": { "total": 396, "ok": 396, "ko": 4405 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 143628, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 159, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 269, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 10, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 39.69853954257371, "ok": 39.69578396252411, "ko": 0.002755580049600441 } }, "details": [ { "name": "protectLoginInitiate", "numberOfRequests": { "total": 36013, "ok": 36013, "ko": 0 }, "minResponseTime": { "total": 44, "ok": 44, "ko": 0 }, "maxResponseTime": { "total": 168, "ok": 168, "ko": 0 }, "meanResponseTime": { "total": 52, "ok": 52, "ko": 0 }, "standardDeviation": { "total": 4, "ok": 4, "ko": 0 }, "percentiles1": { "total": 52, "ok": 52, "ko": 0 }, "percentiles2": { "total": 54, "ok": 54, "ko": 0 }, "percentiles3": { "total": 57, "ok": 57, "ko": 0 }, "percentiles4": { "total": 62, "ok": 62, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 36013, "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": 9.923670432626068, "ok": 9.923670432626068, "ko": 0 }, "spikes": [] }, { "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "total": 36013, "ok": 36012, "ko": 1 }, "minResponseTime": { "total": 35, "ok": 41, "ko": 35 }, "maxResponseTime": { "total": 1104, "ok": 1104, "ko": 35 }, "meanResponseTime": { "total": 49, "ok": 49, "ko": 35 }, "standardDeviation": { "total": 7, "ok": 7, "ko": 0 }, "percentiles1": { "total": 49, "ok": 49, "ko": 35 }, "percentiles2": { "total": 51, "ok": 51, "ko": 35 }, "percentiles3": { "total": 54, "ok": 54, "ko": 35 }, "percentiles4": { "total": 56, "ok": 56, "ko": 35 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 36011, "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": 1, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 9.923670432626068, "ok": 9.923394874621108, "ko": 0.0002755580049600441 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 36013, "ok": 36011, "ko": 2 }, "minResponseTime": { "total": 35, "ok": 50, "ko": 35 }, "maxResponseTime": { "total": 277, "ok": 277, "ko": 36 }, "meanResponseTime": { "total": 62, "ok": 62, "ko": 36 }, "standardDeviation": { "total": 5, "ok": 5, "ko": 1 }, "percentiles1": { "total": 62, "ok": 62, "ko": 36 }, "percentiles2": { "total": 65, "ok": 65, "ko": 36 }, "percentiles3": { "total": 69, "ok": 69, "ko": 36 }, "percentiles4": { "total": 73, "ok": 73, "ko": 36 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 36011, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 2, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 9.923670432626068, "ok": 9.923119316616148, "ko": 0.0005511160099200882 }, "spikes": [] }, { "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "total": 36013, "ok": 36010, "ko": 3 }, "minResponseTime": { "total": 52, "ok": 52, "ko": 116 }, "maxResponseTime": { "total": 7944, "ok": 7944, "ko": 4806 }, "meanResponseTime": { "total": 308, "ok": 308, "ko": 1756 }, "standardDeviation": { "total": 215, "ok": 213, "ko": 2159 }, "percentiles1": { "total": 279, "ok": 279, "ko": 347 }, "percentiles2": { "total": 302, "ok": 302, "ko": 2577 }, "percentiles3": { "total": 374, "ok": 374, "ko": 4360 }, "percentiles4": { "total": 913, "ok": 908, "ko": 4717 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 35583, "percentage": 99 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 158, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 269, "percentage": 1 }, "group4": { "name": "failed", "htmlName": "failed", "count": 3, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 9.923670432626068, "ok": 9.922843758611188, "ko": 0.0008266740148801323 }, "spikes": [] }, { "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "total": 14, "ok": 10, "ko": 4 }, "minResponseTime": { "total": 45, "ok": 137, "ko": 45 }, "maxResponseTime": { "total": 273, "ok": 273, "ko": 53 }, "meanResponseTime": { "total": 139, "ok": 175, "ko": 50 }, "standardDeviation": { "total": 70, "ok": 48, "ko": 3 }, "percentiles1": { "total": 143, "ok": 155, "ko": 50 }, "percentiles2": { "total": 166, "ok": 176, "ko": 52 }, "percentiles3": { "total": 265, "ok": 268, "ko": 53 }, "percentiles4": { "total": 271, "ok": 272, "ko": 53 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 10, "percentage": 71 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 4, "percentage": 29 }, "meanNumberOfRequestsPerSecond": { "total": 0.0038578120694406173, "ok": 0.002755580049600441, "ko": 0.0011022320198401765 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 40, "avg_response_time": 118, "max_response_time": 7944, "min_response_time": 41, "num_requests": 144066, "num_requests_pass": 144056, "num_requests_percent_pass": 99.993 }, "options": "; testCase:idc.loginProtect; testMode:open; throughput:10; rampup-duration:30; duration:3600", "stats": { "details": [ { "group1": { "count": 36013, "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": 168, "total": 168 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 9.923670432626068, "total": 9.923670432626068 }, "meanResponseTime": { "ko": 0, "ok": 52, "total": 52 }, "minResponseTime": { "ko": 0, "ok": 44, "total": 44 }, "name": "protectLoginInitiate", "numberOfRequests": { "ko": 0, "ok": 36013, "total": 36013 }, "percentiles1": { "ko": 0, "ok": 52, "total": 52 }, "percentiles2": { "ko": 0, "ok": 54, "total": 54 }, "percentiles3": { "ko": 0, "ok": 57, "total": 57 }, "percentiles4": { "ko": 0, "ok": 62, "total": 62 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 4, "total": 4 } }, { "group1": { "count": 36011, "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": 1, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 35, "ok": 1104, "total": 1104 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0002755580049600441, "ok": 9.923394874621108, "total": 9.923670432626068 }, "meanResponseTime": { "ko": 35, "ok": 49, "total": 49 }, "minResponseTime": { "ko": 35, "ok": 41, "total": 35 }, "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "ko": 1, "ok": 36012, "total": 36013 }, "percentiles1": { "ko": 35, "ok": 49, "total": 49 }, "percentiles2": { "ko": 35, "ok": 51, "total": 51 }, "percentiles3": { "ko": 35, "ok": 54, "total": 54 }, "percentiles4": { "ko": 35, "ok": 56, "total": 56 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 7, "total": 7 } }, { "group1": { "count": 36011, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 2, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 36, "ok": 277, "total": 277 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0005511160099200882, "ok": 9.923119316616148, "total": 9.923670432626068 }, "meanResponseTime": { "ko": 36, "ok": 62, "total": 62 }, "minResponseTime": { "ko": 35, "ok": 50, "total": 35 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 2, "ok": 36011, "total": 36013 }, "percentiles1": { "ko": 36, "ok": 62, "total": 62 }, "percentiles2": { "ko": 36, "ok": 65, "total": 65 }, "percentiles3": { "ko": 36, "ok": 69, "total": 69 }, "percentiles4": { "ko": 36, "ok": 73, "total": 73 }, "spikes": [], "standardDeviation": { "ko": 1, "ok": 5, "total": 5 } }, { "group1": { "count": 35583, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99 }, "group2": { "count": 158, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 269, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 1 }, "group4": { "count": 3, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 4806, "ok": 7944, "total": 7944 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0008266740148801323, "ok": 9.922843758611188, "total": 9.923670432626068 }, "meanResponseTime": { "ko": 1756, "ok": 308, "total": 308 }, "minResponseTime": { "ko": 116, "ok": 52, "total": 52 }, "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "ko": 3, "ok": 36010, "total": 36013 }, "percentiles1": { "ko": 347, "ok": 279, "total": 279 }, "percentiles2": { "ko": 2577, "ok": 302, "total": 302 }, "percentiles3": { "ko": 4360, "ok": 374, "total": 374 }, "percentiles4": { "ko": 4717, "ok": 908, "total": 913 }, "spikes": [], "standardDeviation": { "ko": 2159, "ok": 213, "total": 215 } }, { "group1": { "count": 10, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 71 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 4, "htmlName": "failed", "name": "failed", "percentage": 29 }, "maxResponseTime": { "ko": 53, "ok": 273, "total": 273 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0011022320198401765, "ok": 0.002755580049600441, "total": 0.0038578120694406173 }, "meanResponseTime": { "ko": 50, "ok": 175, "total": 139 }, "minResponseTime": { "ko": 45, "ok": 137, "total": 45 }, "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "ko": 4, "ok": 10, "total": 14 }, "percentiles1": { "ko": 50, "ok": 155, "total": 143 }, "percentiles2": { "ko": 52, "ok": 176, "total": 166 }, "percentiles3": { "ko": 53, "ok": 268, "total": 265 }, "percentiles4": { "ko": 53, "ok": 272, "total": 271 }, "spikes": [], "standardDeviation": { "ko": 3, "ok": 48, "total": 70 } } ], "global": { "group1": { "count": 143628, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 159, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 269, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 10, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 4806, "ok": 7944, "total": 7944 }, "meanNumberOfRequestsPerSecond": { "ko": 0.002755580049600441, "ok": 39.69578396252411, "total": 39.69853954257371 }, "meanResponseTime": { "ko": 557, "ok": 118, "total": 118 }, "minResponseTime": { "ko": 35, "ok": 41, "total": 35 }, "name": "All Requests", "numberOfRequests": { "ko": 10, "ok": 144056, "total": 144066 }, "percentiles1": { "ko": 50, "ok": 57, "total": 57 }, "percentiles2": { "ko": 100, "ok": 158, "total": 158 }, "percentiles3": { "ko": 2799, "ok": 310, "total": 310 }, "percentiles4": { "ko": 4405, "ok": 396, "total": 396 }, "standardDeviation": { "ko": 1419, "ok": 153, "total": 154 } } }, "target_hostname": "openam-ema-perf-p1.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2024-06-22 10:39:10] Reporting-login-tree-10 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2024-06-22 10:39:10] Reporting-login-tree-10 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/01_login-tree-10/stdout.txt Gatling stdout.txt found, but is small - leave it intact. ________________________________________________________________________________ [2024-06-22 10:39:10] Reporting-login-tree-10 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped