--Task--
name: Reporting-authn-users-6000
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']
preceding_task: None
options: {'task_name': 'authn-users-6000'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-04-20 03:30:35] Reporting-authn-users-6000 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
[2024-04-20 03:30:35] - INFO: Timeout for this Task has changed to 3h (10800 seconds)
[2024-04-20 03:30:35] - 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-6000/stdout.txt
Pod stderr file : /results/orders/Reporting-authn-users-6000/stderr.txt
Pod log : /results/orders/Reporting-authn-users-6000
________________________________________________________________________________
[2024-04-20 03:30:35] Reporting-authn-users-6000 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-04-20 03:30:35,412 INFO
2024-04-20 03:30:35,412 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-20 03:30:35,412 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:30:35,767 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:30:35,767 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:30:35,767 DEBUG --- stdout ---
2024-04-20 03:30:35,767 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:30:35,767 DEBUG --- stderr ---
2024-04-20 03:30:35,767 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/order.json
{
"name": "Reporting-authn-users-6000",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh authn-users-6000 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-authn-users-6000"
}
________________________________________________________________________________
[2024-04-20 03:30:35] Reporting-authn-users-6000 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-04-20 03:30:35,768 INFO
2024-04-20 03:30:35,768 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-20 03:30:35,768 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-04-20 03:30:36,068 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-20 03:30:36,068 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:30:36,068 DEBUG --- stdout ---
2024-04-20 03:30:36,068 DEBUG WAITING
2024-04-20 03:30:36,068 DEBUG --- stderr ---
2024-04-20 03:30:36,068 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
100 7 100 7 0 0 25 0 --:--:-- --:--:-- --:--:-- 25
________________________________________________________________________________
[2024-04-20 03:30:36] Reporting-authn-users-6000 step3 : Send order to overseer
________________________________________________________________________________
2024-04-20 03:30:36,069 INFO
2024-04-20 03:30:36,069 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-20 03:30:36,069 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:30:36,375 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:30:36,375 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:30:36,375 DEBUG --- stdout ---
2024-04-20 03:30:36,376 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:30:36,376 DEBUG --- stderr ---
2024-04-20 03:30:36,376 DEBUG
2024-04-20 03:30:36,376 INFO
2024-04-20 03:30:36,376 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/11_Reporting-authn-users-6000/order.json overseer-0-5c67bf94db-77mh9:/results/orders/order.json
2024-04-20 03:30:36,376 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-20 03:30:37,735 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:30:37,735 DEBUG --- stdout ---
2024-04-20 03:30:37,735 DEBUG
2024-04-20 03:30:37,735 DEBUG --- stderr ---
2024-04-20 03:30:37,735 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-04-20 03:30:37] Reporting-authn-users-6000 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-04-20 03:30:42,739 INFO
2024-04-20 03:30:42,740 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-20 03:30:42,740 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0]
2024-04-20 03:30:43,007 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:30:48,243 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:30:53,480 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:30:58,741 INFO [loop_until]: Function succeeded after 16s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:03,986 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:09,271 INFO [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:14,517 INFO [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:19,763 INFO [loop_until]: Function succeeded after 37s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:25,007 INFO [loop_until]: Function succeeded after 42s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:30,244 INFO [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:35,487 INFO [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:40,733 INFO [loop_until]: Function succeeded after 57s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:45,980 INFO [loop_until]: Function succeeded after 1m 03s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:51,300 INFO [loop_until]: Function succeeded after 1m 08s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:31:56,561 INFO [loop_until]: Function succeeded after 1m 13s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:01,807 INFO [loop_until]: Function succeeded after 1m 19s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:07,055 INFO [loop_until]: Function succeeded after 1m 24s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:12,294 INFO [loop_until]: Function succeeded after 1m 29s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:17,539 INFO [loop_until]: Function succeeded after 1m 34s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:22,823 INFO [loop_until]: Function succeeded after 1m 40s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:28,060 INFO [loop_until]: Function succeeded after 1m 45s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:33,320 INFO [loop_until]: Function succeeded after 1m 50s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:38,569 INFO [loop_until]: Function succeeded after 1m 55s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:43,815 INFO [loop_until]: Function succeeded after 2m 01s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:49,070 INFO [loop_until]: Function succeeded after 2m 06s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:54,375 INFO [loop_until]: Function succeeded after 2m 11s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:32:59,619 INFO [loop_until]: Function succeeded after 2m 16s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:04,864 INFO [loop_until]: Function succeeded after 2m 22s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:10,107 INFO [loop_until]: Function succeeded after 2m 27s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:15,350 INFO [loop_until]: Function succeeded after 2m 32s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:20,594 INFO [loop_until]: Function succeeded after 2m 37s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:25,880 INFO [loop_until]: Function succeeded after 2m 43s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:31,121 INFO [loop_until]: Function succeeded after 2m 48s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:36,358 INFO [loop_until]: Function succeeded after 2m 53s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:41,598 INFO [loop_until]: Function succeeded after 2m 58s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:46,839 INFO [loop_until]: Function succeeded after 3m 04s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:52,086 INFO [loop_until]: Function succeeded after 3m 09s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:33:57,384 INFO [loop_until]: Function succeeded after 3m 14s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:02,630 INFO [loop_until]: Function succeeded after 3m 19s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:07,874 INFO [loop_until]: Function succeeded after 3m 25s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:13,119 INFO [loop_until]: Function succeeded after 3m 30s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:18,364 INFO [loop_until]: Function succeeded after 3m 35s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:23,602 INFO [loop_until]: Function succeeded after 3m 40s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:28,847 INFO [loop_until]: Function succeeded after 3m 46s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:34,093 INFO [loop_until]: Function succeeded after 3m 51s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:39,348 INFO [loop_until]: Function succeeded after 3m 56s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:44,599 INFO [loop_until]: Function succeeded after 4m 01s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:49,845 INFO [loop_until]: Function succeeded after 4m 07s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:34:55,089 INFO [loop_until]: Function succeeded after 4m 12s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:00,375 INFO [loop_until]: Function succeeded after 4m 17s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:05,620 INFO [loop_until]: Function succeeded after 4m 22s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:10,904 INFO [loop_until]: Function succeeded after 4m 28s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:16,142 INFO [loop_until]: Function succeeded after 4m 33s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:21,385 INFO [loop_until]: Function succeeded after 4m 38s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:26,620 INFO [loop_until]: Function succeeded after 4m 43s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:31,908 INFO [loop_until]: Function succeeded after 4m 49s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:37,156 INFO [loop_until]: Function succeeded after 4m 54s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:42,407 INFO [loop_until]: Function succeeded after 4m 59s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:47,653 INFO [loop_until]: Function succeeded after 5m 04s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:52,892 INFO [loop_until]: Function succeeded after 5m 10s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:35:58,137 INFO [loop_until]: Function succeeded after 5m 15s (rc=0) - failed to find expected output: WAITING - retry
2024-04-20 03:36:03,422 INFO [loop_until]: Function succeeded after 5m 20s (rc=0) - expected pattern found
2024-04-20 03:36:03,422 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:03,422 DEBUG --- stdout ---
2024-04-20 03:36:03,422 DEBUG WAITING
2024-04-20 03:36:03,422 DEBUG --- stderr ---
2024-04-20 03:36:03,422 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-20 03:36:03] Reporting-authn-users-6000 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-04-20 03:36:03,423 INFO
2024-04-20 03:36:03,423 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-20 03:36:03,423 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:03,744 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:03,744 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:03,744 DEBUG --- stdout ---
2024-04-20 03:36:03,744 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:03,744 DEBUG --- stderr ---
2024-04-20 03:36:03,744 DEBUG
Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait.
2024-04-20 03:36:03,744 INFO
2024-04-20 03:36:03,745 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-20 03:36:03,745 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:04,049 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:04,049 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:04,049 DEBUG --- stdout ---
2024-04-20 03:36:04,049 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:04,049 DEBUG --- stderr ---
2024-04-20 03:36:04,049 DEBUG
2024-04-20 03:36:04,050 INFO
2024-04-20 03:36:04,050 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-6000.tar.gz" ]; then echo "/results/gatling/authn-users-6000.tar.gz file found"; exit 0; else echo "/results/gatling/authn-users-6000.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/authn-users-6000.tar.gz file found"
2024-04-20 03:36:04,050 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-20 03:36:04,905 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-20 03:36:04,905 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:04,905 DEBUG --- stdout ---
2024-04-20 03:36:04,905 DEBUG /results/gatling/authn-users-6000.tar.gz file found
2024-04-20 03:36:04,905 DEBUG --- stderr ---
2024-04-20 03:36:04,905 DEBUG
2024-04-20 03:36:04,906 INFO
2024-04-20 03:36:04,906 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-20 03:36:04,906 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:05,229 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:05,229 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:05,229 DEBUG --- stdout ---
2024-04-20 03:36:05,229 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:05,229 DEBUG --- stderr ---
2024-04-20 03:36:05,229 DEBUG
2024-04-20 03:36:05,229 INFO
2024-04-20 03:36:05,229 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-6000.tar.gz
2024-04-20 03:36:06,050 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-20 03:36:06,050 DEBUG --- stdout ---
2024-04-20 03:36:06,050 DEBUG 224 /results/gatling/authn-users-6000.tar.gz
2024-04-20 03:36:06,050 DEBUG --- stderr ---
2024-04-20 03:36:06,050 DEBUG
2024-04-20 03:36:06,050 INFO
- Download file (size 224k)
2024-04-20 03:36:06,051 INFO
2024-04-20 03:36:06,051 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-20 03:36:06,051 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:06,359 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:06,360 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:06,361 DEBUG --- stdout ---
2024-04-20 03:36:06,361 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:06,361 DEBUG --- stderr ---
2024-04-20 03:36:06,361 DEBUG
source : /results/gatling/authn-users-6000.tar.gz @ overseer-0-5c67bf94db-77mh9
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-6000.tar.gz
2024-04-20 03:36:06,361 INFO
2024-04-20 03:36:06,361 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-20 03:36:06,361 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:06,661 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:06,661 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:06,661 DEBUG --- stdout ---
2024-04-20 03:36:06,661 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:06,661 DEBUG --- stderr ---
2024-04-20 03:36:06,662 DEBUG
2024-04-20 03:36:06,662 INFO
2024-04-20 03:36:06,662 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-6000.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-6000.tar.gz
2024-04-20 03:36:06,662 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-20 03:36:07,662 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:07,663 DEBUG --- stdout ---
2024-04-20 03:36:07,663 DEBUG tar: Removing leading `/' from member names
2024-04-20 03:36:07,663 DEBUG --- stderr ---
2024-04-20 03:36:07,663 DEBUG
________________________________________________________________________________
[2024-04-20 03:36:07] Reporting-authn-users-6000 step6 : Unzip the result
________________________________________________________________________________
2024-04-20 03:36:07,663 INFO
2024-04-20 03:36:07,664 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-6000.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/03_authn-users-6000/gatling
2024-04-20 03:36:07,692 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-20 03:36:07,692 DEBUG --- stdout ---
2024-04-20 03:36:07,693 DEBUG
2024-04-20 03:36:07,693 DEBUG --- stderr ---
2024-04-20 03:36:07,693 DEBUG
2024-04-20 03:36:07,693 INFO
________________________________________________________________________________
[2024-04-20 03:36:07] Reporting-authn-users-6000 step7 : Print rc order
________________________________________________________________________________
2024-04-20 03:36:07,694 INFO
2024-04-20 03:36:07,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-04-20 03:36:07,694 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:08,022 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:08,022 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:08,022 DEBUG --- stdout ---
2024-04-20 03:36:08,023 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:08,023 DEBUG --- stderr ---
2024-04-20 03:36:08,023 DEBUG
Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait.
2024-04-20 03:36:08,023 INFO
2024-04-20 03:36:08,023 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-20 03:36:08,023 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:08,342 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:08,342 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:08,342 DEBUG --- stdout ---
2024-04-20 03:36:08,342 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:08,343 DEBUG --- stderr ---
2024-04-20 03:36:08,343 DEBUG
2024-04-20 03:36:08,343 INFO
2024-04-20 03:36:08,343 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-6000/rc.txt" ]; then echo "/results/orders/Reporting-authn-users-6000/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-6000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-6000/rc.txt file found"
2024-04-20 03:36:08,343 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-20 03:36:09,197 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-20 03:36:09,197 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:09,197 DEBUG --- stdout ---
2024-04-20 03:36:09,197 DEBUG /results/orders/Reporting-authn-users-6000/rc.txt file found
2024-04-20 03:36:09,197 DEBUG --- stderr ---
2024-04-20 03:36:09,197 DEBUG
2024-04-20 03:36:09,198 INFO
2024-04-20 03:36:09,198 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-04-20 03:36:09,198 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:09,515 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:09,515 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:09,515 DEBUG --- stdout ---
2024-04-20 03:36:09,515 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:09,515 DEBUG --- stderr ---
2024-04-20 03:36:09,515 DEBUG
2024-04-20 03:36:09,515 INFO
2024-04-20 03:36:09,516 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-6000/rc.txt
2024-04-20 03:36:10,348 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-20 03:36:10,348 DEBUG --- stdout ---
2024-04-20 03:36:10,348 DEBUG 4 /results/orders/Reporting-authn-users-6000/rc.txt
2024-04-20 03:36:10,348 DEBUG --- stderr ---
2024-04-20 03:36:10,349 DEBUG
2024-04-20 03:36:10,349 INFO
- Download file (size 4k)
2024-04-20 03:36:10,349 INFO
2024-04-20 03:36:10,349 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-20 03:36:10,349 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:10,653 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:10,653 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:10,654 DEBUG --- stdout ---
2024-04-20 03:36:10,654 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:10,654 DEBUG --- stderr ---
2024-04-20 03:36:10,654 DEBUG
source : /results/orders/Reporting-authn-users-6000/rc.txt @ overseer-0-5c67bf94db-77mh9
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/rc.txt
2024-04-20 03:36:10,654 INFO
2024-04-20 03:36:10,654 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-20 03:36:10,654 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:10,957 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:10,958 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:10,958 DEBUG --- stdout ---
2024-04-20 03:36:10,958 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:10,958 DEBUG --- stderr ---
2024-04-20 03:36:10,958 DEBUG
2024-04-20 03:36:10,958 INFO
2024-04-20 03:36:10,958 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-6000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/rc.txt
2024-04-20 03:36:10,958 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-20 03:36:11,707 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:11,707 DEBUG --- stdout ---
2024-04-20 03:36:11,707 DEBUG tar: Removing leading `/' from member names
2024-04-20 03:36:11,707 DEBUG --- stderr ---
2024-04-20 03:36:11,707 DEBUG
2024-04-20 03:36:11,708 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/rc.txt is small (1 lines), printing all lines:
2024-04-20 03:36:11,708 DEBUG ----- output -----
2024-04-20 03:36:11,708 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-04-20 03:36:11,708 INFO
________________________________________________________________________________
[2024-04-20 03:36:11] Reporting-authn-users-6000 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-04-20 03:36:11] Reporting-authn-users-6000 step9 : Print stdout order
________________________________________________________________________________
2024-04-20 03:36:11,709 INFO
2024-04-20 03:36:11,709 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-20 03:36:11,709 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:12,013 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:12,014 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:12,014 DEBUG --- stdout ---
2024-04-20 03:36:12,014 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:12,014 DEBUG --- stderr ---
2024-04-20 03:36:12,014 DEBUG
Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait.
2024-04-20 03:36:12,014 INFO
2024-04-20 03:36:12,014 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-20 03:36:12,014 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:12,314 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:12,315 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:12,315 DEBUG --- stdout ---
2024-04-20 03:36:12,315 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:12,315 DEBUG --- stderr ---
2024-04-20 03:36:12,315 DEBUG
2024-04-20 03:36:12,315 INFO
2024-04-20 03:36:12,315 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-6000/stdout.txt" ]; then echo "/results/orders/Reporting-authn-users-6000/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-6000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-6000/stdout.txt file found"
2024-04-20 03:36:12,315 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-20 03:36:13,143 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-20 03:36:13,144 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:13,144 DEBUG --- stdout ---
2024-04-20 03:36:13,144 DEBUG /results/orders/Reporting-authn-users-6000/stdout.txt file found
2024-04-20 03:36:13,144 DEBUG --- stderr ---
2024-04-20 03:36:13,144 DEBUG
2024-04-20 03:36:13,144 INFO
2024-04-20 03:36:13,144 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-20 03:36:13,144 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:13,451 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:13,451 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:13,451 DEBUG --- stdout ---
2024-04-20 03:36:13,451 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:13,451 DEBUG --- stderr ---
2024-04-20 03:36:13,452 DEBUG
2024-04-20 03:36:13,452 INFO
2024-04-20 03:36:13,452 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-6000/stdout.txt
2024-04-20 03:36:14,309 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-20 03:36:14,310 DEBUG --- stdout ---
2024-04-20 03:36:14,310 DEBUG 4 /results/orders/Reporting-authn-users-6000/stdout.txt
2024-04-20 03:36:14,310 DEBUG --- stderr ---
2024-04-20 03:36:14,310 DEBUG
2024-04-20 03:36:14,310 INFO
- Download file (size 4k)
2024-04-20 03:36:14,310 INFO
2024-04-20 03:36:14,310 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-20 03:36:14,310 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:14,631 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:14,631 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:14,631 DEBUG --- stdout ---
2024-04-20 03:36:14,631 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:14,631 DEBUG --- stderr ---
2024-04-20 03:36:14,631 DEBUG
source : /results/orders/Reporting-authn-users-6000/stdout.txt @ overseer-0-5c67bf94db-77mh9
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/stdout.txt
2024-04-20 03:36:14,632 INFO
2024-04-20 03:36:14,632 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-20 03:36:14,632 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:14,937 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:14,937 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:14,937 DEBUG --- stdout ---
2024-04-20 03:36:14,937 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:14,937 DEBUG --- stderr ---
2024-04-20 03:36:14,937 DEBUG
2024-04-20 03:36:14,938 INFO
2024-04-20 03:36:14,938 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-6000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/stdout.txt
2024-04-20 03:36:14,938 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-20 03:36:15,685 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:15,685 DEBUG --- stdout ---
2024-04-20 03:36:15,685 DEBUG tar: Removing leading `/' from member names
2024-04-20 03:36:15,686 DEBUG --- stderr ---
2024-04-20 03:36:15,686 DEBUG
2024-04-20 03:36:15,686 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/stdout.txt is small (72 lines), printing all lines:
2024-04-20 03:36:15,686 DEBUG ----- output -----
2024-04-20 03:36:15,686 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/authn-users-6000/loadtest-20240419231344870 --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 21686474 (OK=21686474 KO=0 )
> min response time 7 (OK=7 KO=- )
> max response time 1119 (OK=1119 KO=- )
> mean response time 15 (OK=15 KO=- )
> std deviation 10 (OK=10 KO=- )
> response time 50th percentile 12 (OK=12 KO=- )
> response time 75th percentile 15 (OK=15 KO=- )
> response time 95th percentile 31 (OK=31 KO=- )
> response time 99th percentile 60 (OK=60 KO=- )
> mean requests/sec 5972.59 (OK=5972.59 KO=- )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 21686293 (100%)
> 800 ms <= t < 1200 ms 181 ( 0%)
> t >= 1200 ms 0 ( 0%)
> failed 0 ( 0%)
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/authn-users-6000/loadtest-20240419231344870/index.html
----------------------
[20/Apr/2024 04:35:57] Create tar file /results/gatling/authn-users-6000.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/authn-users-6000/loadtest-20240419231344870
RESULT_FOLDER=authn-users-6000
RESULT_PATH=/results/gatling/authn-users-6000
PWD=/results/gatling/authn-users-6000/loadtest-20240419231344870
[cmd] tar -czvf /results/gatling/authn-users-6000.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-20 03:36:15,686 INFO
________________________________________________________________________________
[2024-04-20 03:36:15] Reporting-authn-users-6000 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-04-20 03:36:15] Reporting-authn-users-6000 step11 : Print stderr order
________________________________________________________________________________
2024-04-20 03:36:15,688 INFO
2024-04-20 03:36:15,688 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-20 03:36:15,688 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:16,010 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:16,011 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:16,011 DEBUG --- stdout ---
2024-04-20 03:36:16,011 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:16,011 DEBUG --- stderr ---
2024-04-20 03:36:16,011 DEBUG
Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait.
2024-04-20 03:36:16,011 INFO
2024-04-20 03:36:16,011 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-20 03:36:16,011 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:16,335 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:16,335 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:16,335 DEBUG --- stdout ---
2024-04-20 03:36:16,335 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:16,335 DEBUG --- stderr ---
2024-04-20 03:36:16,335 DEBUG
2024-04-20 03:36:16,336 INFO
2024-04-20 03:36:16,336 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-6000/stderr.txt" ]; then echo "/results/orders/Reporting-authn-users-6000/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-6000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-6000/stderr.txt file found"
2024-04-20 03:36:16,336 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-20 03:36:17,172 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-20 03:36:17,173 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:17,173 DEBUG --- stdout ---
2024-04-20 03:36:17,173 DEBUG /results/orders/Reporting-authn-users-6000/stderr.txt file found
2024-04-20 03:36:17,173 DEBUG --- stderr ---
2024-04-20 03:36:17,173 DEBUG
2024-04-20 03:36:17,174 INFO
2024-04-20 03:36:17,174 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-20 03:36:17,174 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:17,480 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:17,480 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:17,480 DEBUG --- stdout ---
2024-04-20 03:36:17,480 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:17,480 DEBUG --- stderr ---
2024-04-20 03:36:17,480 DEBUG
2024-04-20 03:36:17,481 INFO
2024-04-20 03:36:17,481 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-6000/stderr.txt
2024-04-20 03:36:18,296 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-20 03:36:18,297 DEBUG --- stdout ---
2024-04-20 03:36:18,297 DEBUG 0 /results/orders/Reporting-authn-users-6000/stderr.txt
2024-04-20 03:36:18,297 DEBUG --- stderr ---
2024-04-20 03:36:18,297 DEBUG
2024-04-20 03:36:18,297 INFO
- Download file (size 0k)
2024-04-20 03:36:18,298 INFO
2024-04-20 03:36:18,298 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-20 03:36:18,298 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:18,626 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:18,626 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:18,626 DEBUG --- stdout ---
2024-04-20 03:36:18,626 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:18,626 DEBUG --- stderr ---
2024-04-20 03:36:18,626 DEBUG
source : /results/orders/Reporting-authn-users-6000/stderr.txt @ overseer-0-5c67bf94db-77mh9
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/stderr.txt
2024-04-20 03:36:18,626 INFO
2024-04-20 03:36:18,627 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-20 03:36:18,627 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-20 03:36:18,929 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-20 03:36:18,929 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:18,930 DEBUG --- stdout ---
2024-04-20 03:36:18,930 DEBUG overseer-0-5c67bf94db-77mh9
2024-04-20 03:36:18,930 DEBUG --- stderr ---
2024-04-20 03:36:18,930 DEBUG
2024-04-20 03:36:18,930 INFO
2024-04-20 03:36:18,930 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-6000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/stderr.txt
2024-04-20 03:36:18,930 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-20 03:36:19,676 INFO [loop_until]: OK (rc = 0)
2024-04-20 03:36:19,676 DEBUG --- stdout ---
2024-04-20 03:36:19,677 DEBUG tar: Removing leading `/' from member names
2024-04-20 03:36:19,677 DEBUG --- stderr ---
2024-04-20 03:36:19,677 DEBUG
2024-04-20 03:36:19,677 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/11_Reporting-authn-users-6000/stderr.txt is small (0 lines), printing all lines:
2024-04-20 03:36:19,677 DEBUG ----- output -----
2024-04-20 03:36:19,677 DEBUG
2024-04-20 03:36:19,677 INFO
________________________________________________________________________________
[2024-04-20 03:36:19] Reporting-authn-users-6000 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-04-20 03:36:19] Reporting-authn-users-6000 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-20 03:36:19] Reporting-authn-users-6000 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 21686474,
"ok": 21686474,
"ko": 0
},
"minResponseTime": {
"total": 7,
"ok": 7,
"ko": 0
},
"maxResponseTime": {
"total": 1119,
"ok": 1119,
"ko": 0
},
"meanResponseTime": {
"total": 15,
"ok": 15,
"ko": 0
},
"standardDeviation": {
"total": 10,
"ok": 10,
"ko": 0
},
"percentiles1": {
"total": 12,
"ok": 12,
"ko": 0
},
"percentiles2": {
"total": 15,
"ok": 15,
"ko": 0
},
"percentiles3": {
"total": 31,
"ok": 31,
"ko": 0
},
"percentiles4": {
"total": 60,
"ok": 60,
"ko": 0
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 21686293,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 181,
"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": 5972.589920132195,
"ok": 5972.589920132195,
"ko": 0
}
},
"details": [
{
"name": "userRestLogin",
"numberOfRequests": {
"total": 21686474,
"ok": 21686474,
"ko": 0
},
"minResponseTime": {
"total": 7,
"ok": 7,
"ko": 0
},
"maxResponseTime": {
"total": 1119,
"ok": 1119,
"ko": 0
},
"meanResponseTime": {
"total": 15,
"ok": 15,
"ko": 0
},
"standardDeviation": {
"total": 10,
"ok": 10,
"ko": 0
},
"percentiles1": {
"total": 12,
"ok": 12,
"ko": 0
},
"percentiles2": {
"total": 15,
"ok": 15,
"ko": 0
},
"percentiles3": {
"total": 31,
"ok": 31,
"ko": 0
},
"percentiles4": {
"total": 60,
"ok": 60,
"ko": 0
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 21686293,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 181,
"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": 5972.589920132195,
"ok": 5972.589920132195,
"ko": 0
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 5973,
"avg_response_time": 15,
"max_response_time": 1119,
"min_response_time": 7,
"num_requests": 21686474,
"num_requests_pass": 21686474,
"num_requests_percent_pass": 100.0
},
"options": "; testMode:open; testCase:am.AMAuthN; throughput:6000; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 21686293,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 181,
"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": 1119,
"total": 1119
},
"meanNumberOfRequestsPerSecond": {
"ko": 0,
"ok": 5972.589920132195,
"total": 5972.589920132195
},
"meanResponseTime": {
"ko": 0,
"ok": 15,
"total": 15
},
"minResponseTime": {
"ko": 0,
"ok": 7,
"total": 7
},
"name": "userRestLogin",
"numberOfRequests": {
"ko": 0,
"ok": 21686474,
"total": 21686474
},
"percentiles1": {
"ko": 0,
"ok": 12,
"total": 12
},
"percentiles2": {
"ko": 0,
"ok": 15,
"total": 15
},
"percentiles3": {
"ko": 0,
"ok": 31,
"total": 31
},
"percentiles4": {
"ko": 0,
"ok": 60,
"total": 60
},
"spikes": [],
"standardDeviation": {
"ko": 0,
"ok": 10,
"total": 10
}
}
],
"global": {
"group1": {
"count": 21686293,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 181,
"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": 1119,
"total": 1119
},
"meanNumberOfRequestsPerSecond": {
"ko": 0,
"ok": 5972.589920132195,
"total": 5972.589920132195
},
"meanResponseTime": {
"ko": 0,
"ok": 15,
"total": 15
},
"minResponseTime": {
"ko": 0,
"ok": 7,
"total": 7
},
"name": "All Requests",
"numberOfRequests": {
"ko": 0,
"ok": 21686474,
"total": 21686474
},
"percentiles1": {
"ko": 0,
"ok": 12,
"total": 12
},
"percentiles2": {
"ko": 0,
"ok": 15,
"total": 15
},
"percentiles3": {
"ko": 0,
"ok": 31,
"total": 31
},
"percentiles4": {
"ko": 0,
"ok": 60,
"total": 60
},
"standardDeviation": {
"ko": 0,
"ok": 10,
"total": 10
}
}
},
"target_hostname": "xlou.iam.xlou-cdm.engineeringpit.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-04-20 03:36:19] Reporting-authn-users-6000 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-04-20 03:36:19] Reporting-authn-users-6000 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/03_authn-users-6000/stdout.txt
Gatling stdout.txt found, but is small - leave it intact.
________________________________________________________________________________
[2024-04-20 03:36:19] Reporting-authn-users-6000 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped