--Task-- name: Reporting-authn-users-6500 enabled: True class_name: GatlingResultTask source_name: overseer-0 source_namespace: >default< target_name: overseer-0 target_namespace: >default< start: 0.0 stop: None timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow loop: False interval: None dependencies: [] wait_for: ['Reporting-authn-users-100', 'Reporting-authn-users-3000', 'Reporting-authn-users-6000'] preceding_task: None options: {'task_name': 'authn-users-6500'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-04-19 11:59:29] Reporting-authn-users-6500 pre : N/A ________________________________________________________________________________ source (overseer-0) is a component [2024-04-19 11:59:29] - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds) [2024-04-19 11:59:29] - 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-authn-users-6500/stdout.txt Pod stderr file : /results/orders/Reporting-authn-users-6500/stderr.txt Pod log : /results/orders/Reporting-authn-users-6500 ________________________________________________________________________________ [2024-04-19 11:59:29] Reporting-authn-users-6500 step1 : Write order for overseer to generate the report ________________________________________________________________________________ 2024-04-19 11:59:29,319 INFO 2024-04-19 11:59:29,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-04-19 11:59:29,319 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 11:59:29,656 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 11:59:29,656 INFO [loop_until]: OK (rc = 0) 2024-04-19 11:59:29,656 DEBUG --- stdout --- 2024-04-19 11:59:29,656 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 11:59:29,656 DEBUG --- stderr --- 2024-04-19 11:59:29,656 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/order.json { "name": "Reporting-authn-users-6500", "command": "/lodestar/clients/gatling-report-only-for-pyrock.sh authn-users-6500 --extra-run-jvm-options \"-Xmx4G\"", "out-dir": "/results/orders/Reporting-authn-users-6500" } ________________________________________________________________________________ [2024-04-19 11:59:29] Reporting-authn-users-6500 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2024-04-19 11:59:29,657 INFO 2024-04-19 11:59:29,657 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-04-19 11:59:29,658 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2024-04-19 11:59:29,940 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-19 11:59:29,940 INFO [loop_until]: OK (rc = 0) 2024-04-19 11:59:29,940 DEBUG --- stdout --- 2024-04-19 11:59:29,940 DEBUG WAITING 2024-04-19 11:59:29,940 DEBUG --- stderr --- 2024-04-19 11:59:29,940 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 27 0 --:--:-- --:--:-- --:--:-- 27 ________________________________________________________________________________ [2024-04-19 11:59:29] Reporting-authn-users-6500 step3 : Send order to overseer ________________________________________________________________________________ 2024-04-19 11:59:29,941 INFO 2024-04-19 11:59:29,941 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-04-19 11:59:29,941 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 11:59:30,261 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 11:59:30,262 INFO [loop_until]: OK (rc = 0) 2024-04-19 11:59:30,262 DEBUG --- stdout --- 2024-04-19 11:59:30,262 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 11:59:30,262 DEBUG --- stderr --- 2024-04-19 11:59:30,262 DEBUG 2024-04-19 11:59:30,262 INFO 2024-04-19 11:59:30,262 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/order.json overseer-0-5c67bf94db-77mh9:/results/orders/order.json 2024-04-19 11:59:30,262 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-19 11:59:31,641 INFO [loop_until]: OK (rc = 0) 2024-04-19 11:59:31,641 DEBUG --- stdout --- 2024-04-19 11:59:31,641 DEBUG 2024-04-19 11:59:31,641 DEBUG --- stderr --- 2024-04-19 11:59:31,641 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2024-04-19 11:59:31] Reporting-authn-users-6500 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2024-04-19 11:59:36,648 INFO 2024-04-19 11:59:36,648 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-04-19 11:59:36,648 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0] 2024-04-19 11:59:36,891 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 11:59:42,136 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 11:59:47,383 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 11:59:52,641 INFO [loop_until]: Function succeeded after 15s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 11:59:57,899 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:03,189 INFO [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:08,443 INFO [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:13,690 INFO [loop_until]: Function succeeded after 37s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:18,936 INFO [loop_until]: Function succeeded after 42s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:24,176 INFO [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:29,423 INFO [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:34,734 INFO [loop_until]: Function succeeded after 58s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:39,988 INFO [loop_until]: Function succeeded after 1m 03s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:45,227 INFO [loop_until]: Function succeeded after 1m 08s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:50,479 INFO [loop_until]: Function succeeded after 1m 13s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:00:55,715 INFO [loop_until]: Function succeeded after 1m 19s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:00,963 INFO [loop_until]: Function succeeded after 1m 24s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:06,203 INFO [loop_until]: Function succeeded after 1m 29s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:11,489 INFO [loop_until]: Function succeeded after 1m 34s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:16,786 INFO [loop_until]: Function succeeded after 1m 40s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:22,024 INFO [loop_until]: Function succeeded after 1m 45s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:27,261 INFO [loop_until]: Function succeeded after 1m 50s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:32,505 INFO [loop_until]: Function succeeded after 1m 55s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:37,752 INFO [loop_until]: Function succeeded after 2m 01s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:43,099 INFO [loop_until]: Function succeeded after 2m 06s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:48,355 INFO [loop_until]: Function succeeded after 2m 11s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:53,603 INFO [loop_until]: Function succeeded after 2m 16s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:01:58,849 INFO [loop_until]: Function succeeded after 2m 22s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:04,101 INFO [loop_until]: Function succeeded after 2m 27s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:09,343 INFO [loop_until]: Function succeeded after 2m 32s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:14,631 INFO [loop_until]: Function succeeded after 2m 37s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:19,867 INFO [loop_until]: Function succeeded after 2m 43s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:25,105 INFO [loop_until]: Function succeeded after 2m 48s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:30,342 INFO [loop_until]: Function succeeded after 2m 53s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:35,588 INFO [loop_until]: Function succeeded after 2m 58s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:40,847 INFO [loop_until]: Function succeeded after 3m 04s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:46,136 INFO [loop_until]: Function succeeded after 3m 09s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:51,391 INFO [loop_until]: Function succeeded after 3m 14s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:02:56,628 INFO [loop_until]: Function succeeded after 3m 19s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:03:01,874 INFO [loop_until]: Function succeeded after 3m 25s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:03:07,111 INFO [loop_until]: Function succeeded after 3m 30s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:03:12,353 INFO [loop_until]: Function succeeded after 3m 35s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:03:17,657 INFO [loop_until]: Function succeeded after 3m 41s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:03:22,894 INFO [loop_until]: Function succeeded after 3m 46s (rc=0) - failed to find expected output: WAITING - retry 2024-04-19 12:03:28,130 INFO [loop_until]: Function succeeded after 3m 51s (rc=0) - expected pattern found 2024-04-19 12:03:28,130 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:28,130 DEBUG --- stdout --- 2024-04-19 12:03:28,130 DEBUG WAITING 2024-04-19 12:03:28,130 DEBUG --- stderr --- 2024-04-19 12:03:28,130 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-04-19 12:03:28] Reporting-authn-users-6500 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2024-04-19 12:03:28,131 INFO 2024-04-19 12:03:28,131 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-04-19 12:03:28,131 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:28,466 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:28,466 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:28,466 DEBUG --- stdout --- 2024-04-19 12:03:28,466 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:28,466 DEBUG --- stderr --- 2024-04-19 12:03:28,466 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-19 12:03:28,467 INFO 2024-04-19 12:03:28,467 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-04-19 12:03:28,467 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:28,790 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:28,790 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:28,790 DEBUG --- stdout --- 2024-04-19 12:03:28,790 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:28,791 DEBUG --- stderr --- 2024-04-19 12:03:28,791 DEBUG 2024-04-19 12:03:28,791 INFO 2024-04-19 12:03:28,791 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/gatling/authn-users-6500.tar.gz" ]; then echo "/results/gatling/authn-users-6500.tar.gz file found"; exit 0; else echo "/results/gatling/authn-users-6500.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/authn-users-6500.tar.gz file found" 2024-04-19 12:03:28,791 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-19 12:03:29,680 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-19 12:03:29,680 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:29,680 DEBUG --- stdout --- 2024-04-19 12:03:29,680 DEBUG /results/gatling/authn-users-6500.tar.gz file found 2024-04-19 12:03:29,680 DEBUG --- stderr --- 2024-04-19 12:03:29,680 DEBUG 2024-04-19 12:03:29,681 INFO 2024-04-19 12:03:29,681 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-04-19 12:03:29,681 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:30,008 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:30,009 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:30,009 DEBUG --- stdout --- 2024-04-19 12:03:30,009 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:30,009 DEBUG --- stderr --- 2024-04-19 12:03:30,009 DEBUG 2024-04-19 12:03:30,009 INFO 2024-04-19 12:03:30,009 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/gatling/authn-users-6500.tar.gz 2024-04-19 12:03:30,848 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-19 12:03:30,849 DEBUG --- stdout --- 2024-04-19 12:03:30,849 DEBUG 228 /results/gatling/authn-users-6500.tar.gz 2024-04-19 12:03:30,849 DEBUG --- stderr --- 2024-04-19 12:03:30,849 DEBUG 2024-04-19 12:03:30,849 INFO - Download file (size 228k) 2024-04-19 12:03:30,849 INFO 2024-04-19 12:03:30,849 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-04-19 12:03:30,849 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:31,165 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:31,165 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:31,165 DEBUG --- stdout --- 2024-04-19 12:03:31,165 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:31,165 DEBUG --- stderr --- 2024-04-19 12:03:31,165 DEBUG source : /results/gatling/authn-users-6500.tar.gz @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-6500.tar.gz 2024-04-19 12:03:31,166 INFO 2024-04-19 12:03:31,166 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-19 12:03:31,166 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:31,467 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:31,467 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:31,467 DEBUG --- stdout --- 2024-04-19 12:03:31,467 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:31,467 DEBUG --- stderr --- 2024-04-19 12:03:31,467 DEBUG 2024-04-19 12:03:31,468 INFO 2024-04-19 12:03:31,468 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/gatling/authn-users-6500.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-6500.tar.gz 2024-04-19 12:03:31,468 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-19 12:03:32,452 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:32,452 DEBUG --- stdout --- 2024-04-19 12:03:32,452 DEBUG tar: Removing leading `/' from member names 2024-04-19 12:03:32,452 DEBUG --- stderr --- 2024-04-19 12:03:32,452 DEBUG ________________________________________________________________________________ [2024-04-19 12:03:32] Reporting-authn-users-6500 step6 : Unzip the result ________________________________________________________________________________ 2024-04-19 12:03:32,454 INFO 2024-04-19 12:03:32,454 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-6500.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-6500/gatling 2024-04-19 12:03:32,496 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-19 12:03:32,496 DEBUG --- stdout --- 2024-04-19 12:03:32,496 DEBUG 2024-04-19 12:03:32,496 DEBUG --- stderr --- 2024-04-19 12:03:32,496 DEBUG 2024-04-19 12:03:32,496 INFO ________________________________________________________________________________ [2024-04-19 12:03:32] Reporting-authn-users-6500 step7 : Print rc order ________________________________________________________________________________ 2024-04-19 12:03:32,498 INFO 2024-04-19 12:03:32,498 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-04-19 12:03:32,498 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:32,827 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:32,827 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:32,827 DEBUG --- stdout --- 2024-04-19 12:03:32,828 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:32,828 DEBUG --- stderr --- 2024-04-19 12:03:32,828 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-19 12:03:32,828 INFO 2024-04-19 12:03:32,828 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-04-19 12:03:32,828 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:33,164 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:33,165 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:33,165 DEBUG --- stdout --- 2024-04-19 12:03:33,165 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:33,165 DEBUG --- stderr --- 2024-04-19 12:03:33,165 DEBUG 2024-04-19 12:03:33,166 INFO 2024-04-19 12:03:33,166 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-6500/rc.txt" ]; then echo "/results/orders/Reporting-authn-users-6500/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-6500/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-6500/rc.txt file found" 2024-04-19 12:03:33,166 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-19 12:03:34,018 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-19 12:03:34,018 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:34,018 DEBUG --- stdout --- 2024-04-19 12:03:34,018 DEBUG /results/orders/Reporting-authn-users-6500/rc.txt file found 2024-04-19 12:03:34,018 DEBUG --- stderr --- 2024-04-19 12:03:34,018 DEBUG 2024-04-19 12:03:34,019 INFO 2024-04-19 12:03:34,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-04-19 12:03:34,019 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:34,341 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:34,341 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:34,341 DEBUG --- stdout --- 2024-04-19 12:03:34,341 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:34,341 DEBUG --- stderr --- 2024-04-19 12:03:34,341 DEBUG 2024-04-19 12:03:34,341 INFO 2024-04-19 12:03:34,341 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/orders/Reporting-authn-users-6500/rc.txt 2024-04-19 12:03:35,192 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-19 12:03:35,192 DEBUG --- stdout --- 2024-04-19 12:03:35,192 DEBUG 4 /results/orders/Reporting-authn-users-6500/rc.txt 2024-04-19 12:03:35,193 DEBUG --- stderr --- 2024-04-19 12:03:35,193 DEBUG 2024-04-19 12:03:35,193 INFO - Download file (size 4k) 2024-04-19 12:03:35,193 INFO 2024-04-19 12:03:35,193 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-04-19 12:03:35,193 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:35,524 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:35,524 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:35,524 DEBUG --- stdout --- 2024-04-19 12:03:35,524 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:35,524 DEBUG --- stderr --- 2024-04-19 12:03:35,524 DEBUG source : /results/orders/Reporting-authn-users-6500/rc.txt @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/rc.txt 2024-04-19 12:03:35,525 INFO 2024-04-19 12:03:35,525 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-04-19 12:03:35,525 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:35,858 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:35,858 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:35,858 DEBUG --- stdout --- 2024-04-19 12:03:35,858 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:35,858 DEBUG --- stderr --- 2024-04-19 12:03:35,858 DEBUG 2024-04-19 12:03:35,859 INFO 2024-04-19 12:03:35,859 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/orders/Reporting-authn-users-6500/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/rc.txt 2024-04-19 12:03:35,859 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-19 12:03:36,618 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:36,618 DEBUG --- stdout --- 2024-04-19 12:03:36,618 DEBUG tar: Removing leading `/' from member names 2024-04-19 12:03:36,618 DEBUG --- stderr --- 2024-04-19 12:03:36,618 DEBUG 2024-04-19 12:03:36,619 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/rc.txt is small (1 lines), printing all lines: 2024-04-19 12:03:36,619 DEBUG ----- output ----- 2024-04-19 12:03:36,619 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-04-19 12:03:36,619 INFO ________________________________________________________________________________ [2024-04-19 12:03:36] Reporting-authn-users-6500 step8 : Check rc log ________________________________________________________________________________ PASS: no error found in rc log ________________________________________________________________________________ [2024-04-19 12:03:36] Reporting-authn-users-6500 step9 : Print stdout order ________________________________________________________________________________ 2024-04-19 12:03:36,620 INFO 2024-04-19 12:03:36,620 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-04-19 12:03:36,620 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:36,945 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:36,945 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:36,945 DEBUG --- stdout --- 2024-04-19 12:03:36,946 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:36,946 DEBUG --- stderr --- 2024-04-19 12:03:36,946 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-19 12:03:36,946 INFO 2024-04-19 12:03:36,946 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-04-19 12:03:36,946 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:37,257 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:37,257 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:37,258 DEBUG --- stdout --- 2024-04-19 12:03:37,258 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:37,258 DEBUG --- stderr --- 2024-04-19 12:03:37,258 DEBUG 2024-04-19 12:03:37,259 INFO 2024-04-19 12:03:37,259 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-6500/stdout.txt" ]; then echo "/results/orders/Reporting-authn-users-6500/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-6500/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-6500/stdout.txt file found" 2024-04-19 12:03:37,259 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-19 12:03:38,095 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-19 12:03:38,095 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:38,097 DEBUG --- stdout --- 2024-04-19 12:03:38,097 DEBUG /results/orders/Reporting-authn-users-6500/stdout.txt file found 2024-04-19 12:03:38,097 DEBUG --- stderr --- 2024-04-19 12:03:38,097 DEBUG 2024-04-19 12:03:38,097 INFO 2024-04-19 12:03:38,098 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-04-19 12:03:38,098 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:38,422 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:38,422 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:38,422 DEBUG --- stdout --- 2024-04-19 12:03:38,422 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:38,422 DEBUG --- stderr --- 2024-04-19 12:03:38,422 DEBUG 2024-04-19 12:03:38,422 INFO 2024-04-19 12:03:38,422 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/orders/Reporting-authn-users-6500/stdout.txt 2024-04-19 12:03:39,265 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-19 12:03:39,265 DEBUG --- stdout --- 2024-04-19 12:03:39,266 DEBUG 4 /results/orders/Reporting-authn-users-6500/stdout.txt 2024-04-19 12:03:39,266 DEBUG --- stderr --- 2024-04-19 12:03:39,266 DEBUG 2024-04-19 12:03:39,266 INFO - Download file (size 4k) 2024-04-19 12:03:39,266 INFO 2024-04-19 12:03:39,266 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-19 12:03:39,266 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:39,601 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:39,601 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:39,601 DEBUG --- stdout --- 2024-04-19 12:03:39,601 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:39,601 DEBUG --- stderr --- 2024-04-19 12:03:39,601 DEBUG source : /results/orders/Reporting-authn-users-6500/stdout.txt @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/stdout.txt 2024-04-19 12:03:39,601 INFO 2024-04-19 12:03:39,601 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-04-19 12:03:39,601 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:39,920 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:39,920 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:39,920 DEBUG --- stdout --- 2024-04-19 12:03:39,920 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:39,920 DEBUG --- stderr --- 2024-04-19 12:03:39,920 DEBUG 2024-04-19 12:03:39,921 INFO 2024-04-19 12:03:39,921 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/orders/Reporting-authn-users-6500/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/stdout.txt 2024-04-19 12:03:39,921 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-19 12:03:40,693 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:40,693 DEBUG --- stdout --- 2024-04-19 12:03:40,693 DEBUG tar: Removing leading `/' from member names 2024-04-19 12:03:40,693 DEBUG --- stderr --- 2024-04-19 12:03:40,693 DEBUG 2024-04-19 12:03:40,693 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/stdout.txt is small (72 lines), printing all lines: 2024-04-19 12:03:40,693 DEBUG ----- output ----- 2024-04-19 12:03:40,693 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/authn-users-6500/loadtest-20240419085547279 --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 23504163 (OK=23504163 KO=0 ) > min response time 7 (OK=7 KO=- ) > max response time 1254 (OK=1254 KO=- ) > mean response time 29 (OK=29 KO=- ) > std deviation 21 (OK=21 KO=- ) > response time 50th percentile 22 (OK=22 KO=- ) > response time 75th percentile 37 (OK=37 KO=- ) > response time 95th percentile 67 (OK=67 KO=- ) > response time 99th percentile 98 (OK=98 KO=- ) > mean requests/sec 6473.193 (OK=6473.193 KO=- ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 23502566 (100%) > 800 ms <= t < 1200 ms 1596 ( 0%) > t >= 1200 ms 1 ( 0%) > failed 0 ( 0%) ================================================================================ Reports generated in 0s. Please open the following file: file:///results/gatling/authn-users-6500/loadtest-20240419085547279/index.html ---------------------- [19/Apr/2024 13:03:26] Create tar file /results/gatling/authn-users-6500.tar.gz ---------------------- SIMULATION_PATH=/results/gatling/authn-users-6500/loadtest-20240419085547279 RESULT_FOLDER=authn-users-6500 RESULT_PATH=/results/gatling/authn-users-6500 PWD=/results/gatling/authn-users-6500/loadtest-20240419085547279 [cmd] tar -czvf /results/gatling/authn-users-6500.tar.gz --exclude=simulation.log * index.html js/ js/jquery-3.5.1.min.js js/unpack.js js/highstock.js js/stats.json js/assertions.xml js/assertions.json js/menu.js js/theme.js js/ellipsis.js js/all_sessions.js js/highcharts-more.js js/gatling.js js/global_stats.json js/bootstrap.min.js js/stats.js req_userrestlogin-03b82.html style/ style/sortable.png style/arrow_right.png style/stat-l-roue.png style/sorted-down.png style/sorted-up.png style/stat-fleche-bas.png style/little_arrow_right.png style/arrow_down_black.png style/favicon.ico style/logo-enterprise.svg style/style.css style/logo.svg style/arrow_down.png style/arrow_right_black.png style/bootstrap.min.css style/stat-l-temps.png 2024-04-19 12:03:40,693 INFO ________________________________________________________________________________ [2024-04-19 12:03:40] Reporting-authn-users-6500 step10 : Check stdout log ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2024-04-19 12:03:40] Reporting-authn-users-6500 step11 : Print stderr order ________________________________________________________________________________ 2024-04-19 12:03:40,695 INFO 2024-04-19 12:03:40,695 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-04-19 12:03:40,695 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:40,997 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:40,997 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:40,997 DEBUG --- stdout --- 2024-04-19 12:03:40,997 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:40,997 DEBUG --- stderr --- 2024-04-19 12:03:40,997 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-19 12:03:40,998 INFO 2024-04-19 12:03:40,998 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-04-19 12:03:40,998 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:41,302 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:41,302 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:41,302 DEBUG --- stdout --- 2024-04-19 12:03:41,302 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:41,302 DEBUG --- stderr --- 2024-04-19 12:03:41,302 DEBUG 2024-04-19 12:03:41,303 INFO 2024-04-19 12:03:41,303 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-6500/stderr.txt" ]; then echo "/results/orders/Reporting-authn-users-6500/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-6500/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-6500/stderr.txt file found" 2024-04-19 12:03:41,303 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-19 12:03:42,129 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-19 12:03:42,129 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:42,129 DEBUG --- stdout --- 2024-04-19 12:03:42,129 DEBUG /results/orders/Reporting-authn-users-6500/stderr.txt file found 2024-04-19 12:03:42,129 DEBUG --- stderr --- 2024-04-19 12:03:42,129 DEBUG 2024-04-19 12:03:42,130 INFO 2024-04-19 12:03:42,130 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-04-19 12:03:42,130 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:42,454 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:42,454 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:42,454 DEBUG --- stdout --- 2024-04-19 12:03:42,454 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:42,454 DEBUG --- stderr --- 2024-04-19 12:03:42,454 DEBUG 2024-04-19 12:03:42,454 INFO 2024-04-19 12:03:42,455 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/orders/Reporting-authn-users-6500/stderr.txt 2024-04-19 12:03:43,303 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-19 12:03:43,304 DEBUG --- stdout --- 2024-04-19 12:03:43,304 DEBUG 0 /results/orders/Reporting-authn-users-6500/stderr.txt 2024-04-19 12:03:43,304 DEBUG --- stderr --- 2024-04-19 12:03:43,304 DEBUG 2024-04-19 12:03:43,304 INFO - Download file (size 0k) 2024-04-19 12:03:43,304 INFO 2024-04-19 12:03:43,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-04-19 12:03:43,304 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:43,606 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:43,606 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:43,606 DEBUG --- stdout --- 2024-04-19 12:03:43,606 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:43,606 DEBUG --- stderr --- 2024-04-19 12:03:43,606 DEBUG source : /results/orders/Reporting-authn-users-6500/stderr.txt @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/stderr.txt 2024-04-19 12:03:43,606 INFO 2024-04-19 12:03:43,606 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-04-19 12:03:43,606 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-19 12:03:43,914 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-19 12:03:43,914 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:43,914 DEBUG --- stdout --- 2024-04-19 12:03:43,915 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-19 12:03:43,915 DEBUG --- stderr --- 2024-04-19 12:03:43,915 DEBUG 2024-04-19 12:03:43,915 INFO 2024-04-19 12:03:43,916 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/orders/Reporting-authn-users-6500/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/stderr.txt 2024-04-19 12:03:43,916 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-19 12:03:44,676 INFO [loop_until]: OK (rc = 0) 2024-04-19 12:03:44,676 DEBUG --- stdout --- 2024-04-19 12:03:44,676 DEBUG tar: Removing leading `/' from member names 2024-04-19 12:03:44,676 DEBUG --- stderr --- 2024-04-19 12:03:44,676 DEBUG 2024-04-19 12:03:44,676 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-6500/stderr.txt is small (0 lines), printing all lines: 2024-04-19 12:03:44,676 DEBUG ----- output ----- 2024-04-19 12:03:44,676 DEBUG 2024-04-19 12:03:44,676 INFO ________________________________________________________________________________ [2024-04-19 12:03:44] Reporting-authn-users-6500 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2024-04-19 12:03:44] Reporting-authn-users-6500 step13 : Analyze graphs for spikes ________________________________________________________________________________ Analyze Gatling graphs for spikes checking parameters open overall stats JSON file checking simulation request userRestLogin no spikes found ________________________________________________________________________________ [2024-04-19 12:03:44] Reporting-authn-users-6500 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 23504163, "ok": 23504163, "ko": 0 }, "minResponseTime": { "total": 7, "ok": 7, "ko": 0 }, "maxResponseTime": { "total": 1254, "ok": 1254, "ko": 0 }, "meanResponseTime": { "total": 29, "ok": 29, "ko": 0 }, "standardDeviation": { "total": 21, "ok": 21, "ko": 0 }, "percentiles1": { "total": 22, "ok": 22, "ko": 0 }, "percentiles2": { "total": 37, "ok": 37, "ko": 0 }, "percentiles3": { "total": 67, "ok": 67, "ko": 0 }, "percentiles4": { "total": 98, "ok": 98, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 23502566, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 1596, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 1, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 6473.1927843569265, "ok": 6473.1927843569265, "ko": 0 } }, "details": [ { "name": "userRestLogin", "numberOfRequests": { "total": 23504163, "ok": 23504163, "ko": 0 }, "minResponseTime": { "total": 7, "ok": 7, "ko": 0 }, "maxResponseTime": { "total": 1254, "ok": 1254, "ko": 0 }, "meanResponseTime": { "total": 29, "ok": 29, "ko": 0 }, "standardDeviation": { "total": 21, "ok": 21, "ko": 0 }, "percentiles1": { "total": 22, "ok": 22, "ko": 0 }, "percentiles2": { "total": 37, "ok": 37, "ko": 0 }, "percentiles3": { "total": 67, "ok": 67, "ko": 0 }, "percentiles4": { "total": 98, "ok": 98, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 23502566, "percentage": 100 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 1596, "percentage": 0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 1, "percentage": 0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0 }, "meanNumberOfRequestsPerSecond": { "total": 6473.1927843569265, "ok": 6473.1927843569265, "ko": 0 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 6473, "avg_response_time": 29, "max_response_time": 1254, "min_response_time": 7, "num_requests": 23504163, "num_requests_pass": 23504163, "num_requests_percent_pass": 100.0 }, "options": "; testMode:open; testCase:am.AMAuthN; throughput:6500; duration:3600", "stats": { "details": [ { "group1": { "count": 23502566, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 1596, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 1, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 1254, "total": 1254 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 6473.1927843569265, "total": 6473.1927843569265 }, "meanResponseTime": { "ko": 0, "ok": 29, "total": 29 }, "minResponseTime": { "ko": 0, "ok": 7, "total": 7 }, "name": "userRestLogin", "numberOfRequests": { "ko": 0, "ok": 23504163, "total": 23504163 }, "percentiles1": { "ko": 0, "ok": 22, "total": 22 }, "percentiles2": { "ko": 0, "ok": 37, "total": 37 }, "percentiles3": { "ko": 0, "ok": 67, "total": 67 }, "percentiles4": { "ko": 0, "ok": 98, "total": 98 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 21, "total": 21 } } ], "global": { "group1": { "count": 23502566, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100 }, "group2": { "count": 1596, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0 }, "group3": { "count": 1, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0 }, "maxResponseTime": { "ko": 0, "ok": 1254, "total": 1254 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 6473.1927843569265, "total": 6473.1927843569265 }, "meanResponseTime": { "ko": 0, "ok": 29, "total": 29 }, "minResponseTime": { "ko": 0, "ok": 7, "total": 7 }, "name": "All Requests", "numberOfRequests": { "ko": 0, "ok": 23504163, "total": 23504163 }, "percentiles1": { "ko": 0, "ok": 22, "total": 22 }, "percentiles2": { "ko": 0, "ok": 37, "total": 37 }, "percentiles3": { "ko": 0, "ok": 67, "total": 67 }, "percentiles4": { "ko": 0, "ok": 98, "total": 98 }, "standardDeviation": { "ko": 0, "ok": 21, "total": 21 } } }, "target_hostname": "xlou.iam.xlou-cdm.engineeringpit.com", "tool_name": "gatling" } ________________________________________________________________________________ [2024-04-19 12:03:44] Reporting-authn-users-6500 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2024-04-19 12:03:44] Reporting-authn-users-6500 step16 : Remove gatling task's stdout file ________________________________________________________________________________ Cleanup of Gatling stdout file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-6500/stdout.txt Gatling stdout.txt found, but is small - leave it intact. ________________________________________________________________________________ [2024-04-19 12:03:44] Reporting-authn-users-6500 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped