--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-23 11:03:40] Reporting-login-tree-10 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component 2024-06-23 11:03:40 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds) 2024-06-23 11:03:40 - 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-23 11:03:40] Reporting-login-tree-10 step1 : Write order for overseer to generate the report ________________________________________________________________________________ 2024-06-23 11:03:40,699 INFO 2024-06-23 11:03:40,699 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:40,699 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:41,040 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:41,040 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:41,040 DEBUG --- stdout --- 2024-06-23 11:03:41,040 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:41,040 DEBUG --- stderr --- 2024-06-23 11:03:41,040 DEBUG 2024-06-23 11:03:41 - INFO: Get overseer pod resources requests memory 2024-06-23 11:03:41,041 INFO 2024-06-23 11:03:41,041 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-23 11:03:41,041 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-23 11:03:41,358 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:41,359 DEBUG --- stdout --- 2024-06-23 11:03:41,359 DEBUG 4Gi 2024-06-23 11:03:41,359 DEBUG --- stderr --- 2024-06-23 11:03:41,359 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-23 11:03:41] Reporting-login-tree-10 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2024-06-23 11:03:41,360 INFO 2024-06-23 11:03:41,360 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-23 11:03:41,360 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2024-06-23 11:03:41,740 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-23 11:03:41,740 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:41,740 DEBUG --- stdout --- 2024-06-23 11:03:41,740 DEBUG WAITING 2024-06-23 11:03:41,740 DEBUG --- stderr --- 2024-06-23 11:03:41,740 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 23 0 --:--:-- --:--:-- --:--:-- 23 ________________________________________________________________________________ [2024-06-23 11:03:41] Reporting-login-tree-10 step3 : Send order to overseer ________________________________________________________________________________ 2024-06-23 11:03:41,742 INFO 2024-06-23 11:03:41,742 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:41,742 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:42,073 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:42,074 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:42,074 DEBUG --- stdout --- 2024-06-23 11:03:42,074 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:42,074 DEBUG --- stderr --- 2024-06-23 11:03:42,074 DEBUG 2024-06-23 11:03:42,074 INFO 2024-06-23 11:03:42,074 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-23 11:03:42,074 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-23 11:03:43,449 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:43,449 DEBUG --- stdout --- 2024-06-23 11:03:43,449 DEBUG 2024-06-23 11:03:43,449 DEBUG --- stderr --- 2024-06-23 11:03:43,449 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2024-06-23 11:03:43] Reporting-login-tree-10 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2024-06-23 11:03:48,456 INFO 2024-06-23 11:03:48,457 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-23 11:03:48,458 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0] 2024-06-23 11:03:48,692 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-23 11:03:48,692 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:48,692 DEBUG --- stdout --- 2024-06-23 11:03:48,692 DEBUG WAITING 2024-06-23 11:03:48,692 DEBUG --- stderr --- 2024-06-23 11:03:48,693 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2024-06-23 11:03:48] Reporting-login-tree-10 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2024-06-23 11:03:48,694 INFO 2024-06-23 11:03:48,694 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:48,694 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:49,003 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:49,003 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:49,003 DEBUG --- stdout --- 2024-06-23 11:03:49,003 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:49,003 DEBUG --- stderr --- 2024-06-23 11:03:49,003 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-23 11:03:49,003 INFO 2024-06-23 11:03:49,003 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:49,003 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:49,309 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:49,309 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:49,309 DEBUG --- stdout --- 2024-06-23 11:03:49,309 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:49,309 DEBUG --- stderr --- 2024-06-23 11:03:49,309 DEBUG 2024-06-23 11:03:49,310 INFO 2024-06-23 11:03:49,310 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-23 11:03:49,310 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-23 11:03:50,113 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-23 11:03:50,113 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:50,113 DEBUG --- stdout --- 2024-06-23 11:03:50,113 DEBUG /results/gatling/login-tree-10.tar.gz file found 2024-06-23 11:03:50,113 DEBUG --- stderr --- 2024-06-23 11:03:50,113 DEBUG 2024-06-23 11:03:50,114 INFO 2024-06-23 11:03:50,114 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:50,114 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:50,436 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:50,436 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:50,436 DEBUG --- stdout --- 2024-06-23 11:03:50,436 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:50,436 DEBUG --- stderr --- 2024-06-23 11:03:50,436 DEBUG 2024-06-23 11:03:50,436 INFO 2024-06-23 11:03:50,437 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-23 11:03:51,256 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-23 11:03:51,256 DEBUG --- stdout --- 2024-06-23 11:03:51,256 DEBUG 292 /results/gatling/login-tree-10.tar.gz 2024-06-23 11:03:51,257 DEBUG --- stderr --- 2024-06-23 11:03:51,257 DEBUG 2024-06-23 11:03:51,257 INFO - Download file (size 292k) 2024-06-23 11:03:51,257 INFO 2024-06-23 11:03:51,257 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:51,257 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:51,575 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:51,575 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:51,575 DEBUG --- stdout --- 2024-06-23 11:03:51,575 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:51,575 DEBUG --- stderr --- 2024-06-23 11:03:51,575 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-23 11:03:51,576 INFO 2024-06-23 11:03:51,576 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:51,576 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:51,882 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:51,883 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:51,883 DEBUG --- stdout --- 2024-06-23 11:03:51,883 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:51,883 DEBUG --- stderr --- 2024-06-23 11:03:51,883 DEBUG 2024-06-23 11:03:51,883 INFO 2024-06-23 11:03:51,883 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-23 11:03:51,883 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-23 11:03:52,969 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:52,969 DEBUG --- stdout --- 2024-06-23 11:03:52,969 DEBUG tar: Removing leading `/' from member names 2024-06-23 11:03:52,969 DEBUG --- stderr --- 2024-06-23 11:03:52,969 DEBUG ________________________________________________________________________________ [2024-06-23 11:03:52] Reporting-login-tree-10 step6 : Unzip the result ________________________________________________________________________________ 2024-06-23 11:03:52,970 INFO 2024-06-23 11:03:52,970 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-23 11:03:53,007 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-23 11:03:53,007 DEBUG --- stdout --- 2024-06-23 11:03:53,007 DEBUG 2024-06-23 11:03:53,007 DEBUG --- stderr --- 2024-06-23 11:03:53,007 DEBUG 2024-06-23 11:03:53,007 INFO ________________________________________________________________________________ [2024-06-23 11:03:53] Reporting-login-tree-10 step7 : Print rc order ________________________________________________________________________________ 2024-06-23 11:03:53,008 INFO 2024-06-23 11:03:53,008 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:53,008 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:53,318 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:53,318 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:53,318 DEBUG --- stdout --- 2024-06-23 11:03:53,318 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:53,318 DEBUG --- stderr --- 2024-06-23 11:03:53,318 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-23 11:03:53,319 INFO 2024-06-23 11:03:53,319 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:53,319 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:53,634 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:53,635 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:53,637 DEBUG --- stdout --- 2024-06-23 11:03:53,637 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:53,637 DEBUG --- stderr --- 2024-06-23 11:03:53,637 DEBUG 2024-06-23 11:03:53,638 INFO 2024-06-23 11:03:53,639 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-23 11:03:53,639 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-23 11:03:54,480 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-23 11:03:54,481 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:54,481 DEBUG --- stdout --- 2024-06-23 11:03:54,481 DEBUG /results/orders/Reporting-login-tree-10/rc.txt file found 2024-06-23 11:03:54,481 DEBUG --- stderr --- 2024-06-23 11:03:54,481 DEBUG 2024-06-23 11:03:54,481 INFO 2024-06-23 11:03:54,481 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:54,481 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:54,812 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:54,812 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:54,812 DEBUG --- stdout --- 2024-06-23 11:03:54,812 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:54,812 DEBUG --- stderr --- 2024-06-23 11:03:54,812 DEBUG 2024-06-23 11:03:54,813 INFO 2024-06-23 11:03:54,813 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-23 11:03:55,612 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-23 11:03:55,612 DEBUG --- stdout --- 2024-06-23 11:03:55,612 DEBUG 4 /results/orders/Reporting-login-tree-10/rc.txt 2024-06-23 11:03:55,612 DEBUG --- stderr --- 2024-06-23 11:03:55,612 DEBUG 2024-06-23 11:03:55,612 INFO - Download file (size 4k) 2024-06-23 11:03:55,613 INFO 2024-06-23 11:03:55,613 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:55,613 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:55,934 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:55,934 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:55,934 DEBUG --- stdout --- 2024-06-23 11:03:55,935 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:55,935 DEBUG --- stderr --- 2024-06-23 11:03:55,935 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-23 11:03:55,935 INFO 2024-06-23 11:03:55,935 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:55,935 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:56,247 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:56,247 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:56,247 DEBUG --- stdout --- 2024-06-23 11:03:56,247 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:56,247 DEBUG --- stderr --- 2024-06-23 11:03:56,247 DEBUG 2024-06-23 11:03:56,247 INFO 2024-06-23 11:03:56,247 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-23 11:03:56,248 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-23 11:03:56,977 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:56,977 DEBUG --- stdout --- 2024-06-23 11:03:56,977 DEBUG tar: Removing leading `/' from member names 2024-06-23 11:03:56,977 DEBUG --- stderr --- 2024-06-23 11:03:56,978 DEBUG 2024-06-23 11:03:56,978 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-23 11:03:56,978 DEBUG ----- output ----- 2024-06-23 11:03:56,978 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-06-23 11:03:56,978 INFO ________________________________________________________________________________ [2024-06-23 11:03:56] Reporting-login-tree-10 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [2024-06-23 11:03:56] Reporting-login-tree-10 step9 : Print stdout order ________________________________________________________________________________ 2024-06-23 11:03:56,980 INFO 2024-06-23 11:03:56,980 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:56,980 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:57,307 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:57,308 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:57,308 DEBUG --- stdout --- 2024-06-23 11:03:57,308 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:57,308 DEBUG --- stderr --- 2024-06-23 11:03:57,308 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-23 11:03:57,308 INFO 2024-06-23 11:03:57,308 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:57,308 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:57,636 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:57,637 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:57,637 DEBUG --- stdout --- 2024-06-23 11:03:57,637 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:57,637 DEBUG --- stderr --- 2024-06-23 11:03:57,637 DEBUG 2024-06-23 11:03:57,638 INFO 2024-06-23 11:03:57,638 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-23 11:03:57,638 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-23 11:03:58,442 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-23 11:03:58,442 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:58,443 DEBUG --- stdout --- 2024-06-23 11:03:58,443 DEBUG /results/orders/Reporting-login-tree-10/stdout.txt file found 2024-06-23 11:03:58,443 DEBUG --- stderr --- 2024-06-23 11:03:58,443 DEBUG 2024-06-23 11:03:58,443 INFO 2024-06-23 11:03:58,443 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:58,443 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:58,749 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:58,749 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:58,749 DEBUG --- stdout --- 2024-06-23 11:03:58,749 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:58,749 DEBUG --- stderr --- 2024-06-23 11:03:58,749 DEBUG 2024-06-23 11:03:58,749 INFO 2024-06-23 11:03:58,749 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-23 11:03:59,572 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-23 11:03:59,572 DEBUG --- stdout --- 2024-06-23 11:03:59,572 DEBUG 4 /results/orders/Reporting-login-tree-10/stdout.txt 2024-06-23 11:03:59,572 DEBUG --- stderr --- 2024-06-23 11:03:59,572 DEBUG 2024-06-23 11:03:59,572 INFO - Download file (size 4k) 2024-06-23 11:03:59,573 INFO 2024-06-23 11:03:59,573 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:59,573 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:03:59,904 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:03:59,904 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:03:59,904 DEBUG --- stdout --- 2024-06-23 11:03:59,904 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:03:59,904 DEBUG --- stderr --- 2024-06-23 11:03:59,904 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-23 11:03:59,904 INFO 2024-06-23 11:03:59,904 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:03:59,905 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:04:00,230 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:04:00,230 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:00,230 DEBUG --- stdout --- 2024-06-23 11:04:00,230 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:04:00,230 DEBUG --- stderr --- 2024-06-23 11:04:00,230 DEBUG 2024-06-23 11:04:00,231 INFO 2024-06-23 11:04:00,231 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-23 11:04:00,231 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-23 11:04:00,976 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:00,976 DEBUG --- stdout --- 2024-06-23 11:04:00,976 DEBUG tar: Removing leading `/' from member names 2024-06-23 11:04:00,976 DEBUG --- stderr --- 2024-06-23 11:04:00,976 DEBUG 2024-06-23 11:04:00,977 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 (88 lines), printing all lines: 2024-06-23 11:04:00,977 DEBUG ----- output ----- 2024-06-23 11:04:00,977 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/login-tree-10/loadtest-20240623034319840 --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 144167 (OK=144158 KO=9 ) > min response time 37 (OK=40 KO=37 ) > max response time 2311 (OK=2311 KO=135 ) > mean response time 112 (OK=112 KO=68 ) > std deviation 109 (OK=109 KO=35 ) > response time 50th percentile 56 (OK=56 KO=48 ) > response time 75th percentile 160 (OK=158 KO=105 ) > response time 95th percentile 300 (OK=300 KO=124 ) > response time 99th percentile 386 (OK=386 KO=133 ) > mean requests/sec 39.726 (OK=39.724 KO=0.002 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 143944 (100%) > 800 ms <= t < 1200 ms 168 ( 0%) > t >= 1200 ms 46 ( 0%) > failed 9 ( 0%) ---- Errors -------------------------------------------------------------------- > status.find.is(200), but actually found 502 3 (23.08%) > status.find.is(200), but actually found 401 3 (23.08%) > jsonPath($.tokenId).find.exists, found nothing 3 (23.08%) > restLoginUsernamePasswordCallback: Failed to build request: No 1 ( 7.69%) attribute named 'callbacks' is defined > restloginProgressiveProfileCallback: Failed to build request: 1 ( 7.69%) No attribute named 'callbacks' is defined > PingOneProtectEvaluationCallback: Failed to build request: No 1 ( 7.69%) attribute named 'callbacks' is defined > PingOneProtectInitializeCallback: Failed to build request: No 1 ( 7.69%) attribute named 'callbacks' is defined ================================================================================ Reports generated in 0s. Please open the following file: file:///results/gatling/login-tree-10/loadtest-20240623034319840/index.html ---------------------- [23/Jun/2024 12:03:47] Create tar file /results/gatling/login-tree-10.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/login-tree-10/loadtest-20240623034319840 RESULT_FOLDER=login-tree-10 RESULT_PATH=/results/gatling/login-tree-10 PWD=/results/gatling/login-tree-10/loadtest-20240623034319840 [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-23 11:04:00,977 INFO ________________________________________________________________________________ [2024-06-23 11:04:00] Reporting-login-tree-10 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2024-06-23 11:04:00] Reporting-login-tree-10 step11 : Print stderr order ________________________________________________________________________________ 2024-06-23 11:04:00,978 INFO 2024-06-23 11:04:00,979 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:04:00,979 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:04:01,285 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:04:01,285 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:01,285 DEBUG --- stdout --- 2024-06-23 11:04:01,285 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:04:01,285 DEBUG --- stderr --- 2024-06-23 11:04:01,285 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-23 11:04:01,286 INFO 2024-06-23 11:04:01,286 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:04:01,286 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:04:01,594 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:04:01,594 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:01,594 DEBUG --- stdout --- 2024-06-23 11:04:01,594 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:04:01,594 DEBUG --- stderr --- 2024-06-23 11:04:01,594 DEBUG 2024-06-23 11:04:01,595 INFO 2024-06-23 11:04:01,595 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-23 11:04:01,595 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-23 11:04:02,431 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-23 11:04:02,432 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:02,432 DEBUG --- stdout --- 2024-06-23 11:04:02,432 DEBUG /results/orders/Reporting-login-tree-10/stderr.txt file found 2024-06-23 11:04:02,432 DEBUG --- stderr --- 2024-06-23 11:04:02,432 DEBUG 2024-06-23 11:04:02,432 INFO 2024-06-23 11:04:02,432 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:04:02,432 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:04:02,755 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:04:02,755 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:02,755 DEBUG --- stdout --- 2024-06-23 11:04:02,755 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:04:02,755 DEBUG --- stderr --- 2024-06-23 11:04:02,756 DEBUG 2024-06-23 11:04:02,756 INFO 2024-06-23 11:04:02,756 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-23 11:04:03,555 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-23 11:04:03,556 DEBUG --- stdout --- 2024-06-23 11:04:03,556 DEBUG 0 /results/orders/Reporting-login-tree-10/stderr.txt 2024-06-23 11:04:03,556 DEBUG --- stderr --- 2024-06-23 11:04:03,556 DEBUG 2024-06-23 11:04:03,556 INFO - Download file (size 0k) 2024-06-23 11:04:03,556 INFO 2024-06-23 11:04:03,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-23 11:04:03,556 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:04:03,870 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:04:03,871 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:03,871 DEBUG --- stdout --- 2024-06-23 11:04:03,871 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:04:03,871 DEBUG --- stderr --- 2024-06-23 11:04:03,871 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-23 11:04:03,871 INFO 2024-06-23 11:04:03,871 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-23 11:04:03,871 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-23 11:04:04,178 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-23 11:04:04,179 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:04,179 DEBUG --- stdout --- 2024-06-23 11:04:04,179 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-23 11:04:04,179 DEBUG --- stderr --- 2024-06-23 11:04:04,179 DEBUG 2024-06-23 11:04:04,179 INFO 2024-06-23 11:04:04,179 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-23 11:04:04,179 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-23 11:04:04,907 INFO [loop_until]: OK (rc = 0) 2024-06-23 11:04:04,907 DEBUG --- stdout --- 2024-06-23 11:04:04,907 DEBUG tar: Removing leading `/' from member names 2024-06-23 11:04:04,907 DEBUG --- stderr --- 2024-06-23 11:04:04,907 DEBUG 2024-06-23 11:04:04,908 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-23 11:04:04,908 DEBUG ----- output ----- 2024-06-23 11:04:04,908 DEBUG 2024-06-23 11:04:04,908 INFO ________________________________________________________________________________ [2024-06-23 11:04:04] Reporting-login-tree-10 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2024-06-23 11:04:04] 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-23 11:04:04] Reporting-login-tree-10 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 144167, "ok": 144158, "ko": 9 }, "minResponseTime": { "total": 37, "ok": 40, "ko": 37 }, "maxResponseTime": { "total": 2311, "ok": 2311, "ko": 135 }, "meanResponseTime": { "total": 112, "ok": 112, "ko": 68 }, "standardDeviation": { "total": 109, "ok": 109, "ko": 35 }, "percentiles1": { "total": 56, "ok": 56, "ko": 48 }, "percentiles2": { "total": 160, "ok": 158, "ko": 105 }, "percentiles3": { "total": 300, "ok": 300, "ko": 124 }, "percentiles4": { "total": 386, "ok": 386, "ko": 133 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 143944, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 168, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 46, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 9, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 39.726370901074674, "ok": 39.72389087903004, "ko": 0.002480022044640397 } }, "details": [ { "name": "protectLoginInitiate", "numberOfRequests": { "total": 36039, "ok": 36038, "ko": 1 }, "minResponseTime": { "total": 41, "ok": 44, "ko": 41 }, "maxResponseTime": { "total": 217, "ok": 217, "ko": 41 }, "meanResponseTime": { "total": 52, "ok": 52, "ko": 41 }, "standardDeviation": { "total": 4, "ok": 4, "ko": 0 }, "percentiles1": { "total": 52, "ok": 52, "ko": 41 }, "percentiles2": { "total": 54, "ok": 54, "ko": 41 }, "percentiles3": { "total": 56, "ok": 56, "ko": 41 }, "percentiles4": { "total": 60, "ok": 60, "ko": 41 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 36038, "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": 1, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 9.930834940755028, "ok": 9.930559382750069, "ko": 0.0002755580049600441 }, "spikes": [] }, { "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "total": 36038, "ok": 36038, "ko": 0 }, "minResponseTime": { "total": 40, "ok": 40, "ko": 0 }, "maxResponseTime": { "total": 1083, "ok": 1083, "ko": 0 }, "meanResponseTime": { "total": 48, "ok": 48, "ko": 0 }, "standardDeviation": { "total": 6, "ok": 6, "ko": 0 }, "percentiles1": { "total": 48, "ok": 48, "ko": 0 }, "percentiles2": { "total": 50, "ok": 50, "ko": 0 }, "percentiles3": { "total": 53, "ok": 53, "ko": 0 }, "percentiles4": { "total": 56, "ok": 56, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 36037, "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": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 9.930559382750069, "ok": 9.930559382750069, "ko": 0 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 36038, "ok": 36037, "ko": 1 }, "minResponseTime": { "total": 38, "ok": 49, "ko": 38 }, "maxResponseTime": { "total": 227, "ok": 227, "ko": 38 }, "meanResponseTime": { "total": 61, "ok": 61, "ko": 38 }, "standardDeviation": { "total": 5, "ok": 5, "ko": 0 }, "percentiles1": { "total": 61, "ok": 61, "ko": 38 }, "percentiles2": { "total": 64, "ok": 64, "ko": 38 }, "percentiles3": { "total": 69, "ok": 69, "ko": 38 }, "percentiles4": { "total": 72, "ok": 72, "ko": 38 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 36037, "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": 1, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 9.930559382750069, "ok": 9.930283824745109, "ko": 0.0002755580049600441 }, "spikes": [] }, { "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "total": 36038, "ok": 36034, "ko": 4 }, "minResponseTime": { "total": 37, "ok": 61, "ko": 37 }, "maxResponseTime": { "total": 2311, "ok": 2311, "ko": 135 }, "meanResponseTime": { "total": 286, "ok": 286, "ko": 96 }, "standardDeviation": { "total": 84, "ok": 84, "ko": 36 }, "percentiles1": { "total": 267, "ok": 267, "ko": 106 }, "percentiles2": { "total": 291, "ok": 291, "ko": 114 }, "percentiles3": { "total": 365, "ok": 365, "ko": 131 }, "percentiles4": { "total": 665, "ok": 665, "ko": 134 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 35821, "percentage": 99 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 167, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 46, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 4, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 9.930559382750069, "ok": 9.92945715073023, "ko": 0.0011022320198401765 }, "spikes": [] }, { "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "total": 14, "ok": 11, "ko": 3 }, "minResponseTime": { "total": 48, "ok": 131, "ko": 48 }, "maxResponseTime": { "total": 376, "ok": 376, "ko": 49 }, "meanResponseTime": { "total": 150, "ok": 178, "ko": 48 }, "standardDeviation": { "total": 86, "ok": 77, "ko": 0 }, "percentiles1": { "total": 139, "ok": 142, "ko": 48 }, "percentiles2": { "total": 158, "ok": 163, "ko": 49 }, "percentiles3": { "total": 323, "ok": 336, "ko": 49 }, "percentiles4": { "total": 365, "ok": 368, "ko": 49 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 11, "percentage": 79 }, "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": 21 }, "meanNumberOfRequestsPerSecond": { "total": 0.0038578120694406173, "ok": 0.003031138054560485, "ko": 0.0008266740148801323 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 40, "avg_response_time": 112, "max_response_time": 2311, "min_response_time": 40, "num_requests": 144167, "num_requests_pass": 144158, "num_requests_percent_pass": 99.994 }, "options": "; testCase:idc.loginProtect; testMode:open; throughput:10; rampup-duration:30; duration:3600", "stats": { "details": [ { "group1": { "count": 36038, "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": 1, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 41, "ok": 217, "total": 217 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0002755580049600441, "ok": 9.930559382750069, "total": 9.930834940755028 }, "meanResponseTime": { "ko": 41, "ok": 52, "total": 52 }, "minResponseTime": { "ko": 41, "ok": 44, "total": 41 }, "name": "protectLoginInitiate", "numberOfRequests": { "ko": 1, "ok": 36038, "total": 36039 }, "percentiles1": { "ko": 41, "ok": 52, "total": 52 }, "percentiles2": { "ko": 41, "ok": 54, "total": 54 }, "percentiles3": { "ko": 41, "ok": 56, "total": 56 }, "percentiles4": { "ko": 41, "ok": 60, "total": 60 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 4, "total": 4 } }, { "group1": { "count": 36037, "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": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 1083, "total": 1083 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 9.930559382750069, "total": 9.930559382750069 }, "meanResponseTime": { "ko": 0, "ok": 48, "total": 48 }, "minResponseTime": { "ko": 0, "ok": 40, "total": 40 }, "name": "PingOneProtectInitializeCallback", "numberOfRequests": { "ko": 0, "ok": 36038, "total": 36038 }, "percentiles1": { "ko": 0, "ok": 48, "total": 48 }, "percentiles2": { "ko": 0, "ok": 50, "total": 50 }, "percentiles3": { "ko": 0, "ok": 53, "total": 53 }, "percentiles4": { "ko": 0, "ok": 56, "total": 56 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 6, "total": 6 } }, { "group1": { "count": 36037, "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": 1, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 38, "ok": 227, "total": 227 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0002755580049600441, "ok": 9.930283824745109, "total": 9.930559382750069 }, "meanResponseTime": { "ko": 38, "ok": 61, "total": 61 }, "minResponseTime": { "ko": 38, "ok": 49, "total": 38 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 1, "ok": 36037, "total": 36038 }, "percentiles1": { "ko": 38, "ok": 61, "total": 61 }, "percentiles2": { "ko": 38, "ok": 64, "total": 64 }, "percentiles3": { "ko": 38, "ok": 69, "total": 69 }, "percentiles4": { "ko": 38, "ok": 72, "total": 72 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 5, "total": 5 } }, { "group1": { "count": 35821, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99 }, "group2": { "count": 167, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 46, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 4, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 135, "ok": 2311, "total": 2311 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0011022320198401765, "ok": 9.92945715073023, "total": 9.930559382750069 }, "meanResponseTime": { "ko": 96, "ok": 286, "total": 286 }, "minResponseTime": { "ko": 37, "ok": 61, "total": 37 }, "name": "PingOneProtectEvaluationCallback", "numberOfRequests": { "ko": 4, "ok": 36034, "total": 36038 }, "percentiles1": { "ko": 106, "ok": 267, "total": 267 }, "percentiles2": { "ko": 114, "ok": 291, "total": 291 }, "percentiles3": { "ko": 131, "ok": 365, "total": 365 }, "percentiles4": { "ko": 134, "ok": 665, "total": 665 }, "spikes": [], "standardDeviation": { "ko": 36, "ok": 84, "total": 84 } }, { "group1": { "count": 11, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 79 }, "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": 21 }, "maxResponseTime": { "ko": 49, "ok": 376, "total": 376 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0008266740148801323, "ok": 0.003031138054560485, "total": 0.0038578120694406173 }, "meanResponseTime": { "ko": 48, "ok": 178, "total": 150 }, "minResponseTime": { "ko": 48, "ok": 131, "total": 48 }, "name": "restloginProgressiveProfileCallback", "numberOfRequests": { "ko": 3, "ok": 11, "total": 14 }, "percentiles1": { "ko": 48, "ok": 142, "total": 139 }, "percentiles2": { "ko": 49, "ok": 163, "total": 158 }, "percentiles3": { "ko": 49, "ok": 336, "total": 323 }, "percentiles4": { "ko": 49, "ok": 368, "total": 365 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 77, "total": 86 } } ], "global": { "group1": { "count": 143944, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 168, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 46, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 9, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 135, "ok": 2311, "total": 2311 }, "meanNumberOfRequestsPerSecond": { "ko": 0.002480022044640397, "ok": 39.72389087903004, "total": 39.726370901074674 }, "meanResponseTime": { "ko": 68, "ok": 112, "total": 112 }, "minResponseTime": { "ko": 37, "ok": 40, "total": 37 }, "name": "All Requests", "numberOfRequests": { "ko": 9, "ok": 144158, "total": 144167 }, "percentiles1": { "ko": 48, "ok": 56, "total": 56 }, "percentiles2": { "ko": 105, "ok": 158, "total": 160 }, "percentiles3": { "ko": 124, "ok": 300, "total": 300 }, "percentiles4": { "ko": 133, "ok": 386, "total": 386 }, "standardDeviation": { "ko": 35, "ok": 109, "total": 109 } } }, "target_hostname": "openam-ema-perf-p1.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2024-06-23 11:04:04] Reporting-login-tree-10 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2024-06-23 11:04:04] 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 Compressing Gatling stdout.txt file.. ________________________________________________________________________________ [2024-06-23 11:04:04] Reporting-login-tree-10 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped