--Task--
name: Reporting-authn-users-4000
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-2000', 'Reporting-authn-users-3000']
preceding_task: None
options: {'task_name': 'authn-users-4000'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-04-11 06:26:57] Reporting-authn-users-4000 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
[2024-04-11 06:26:57] - INFO: Timeout for this Task has changed to 2h 30m (9000 seconds)
[2024-04-11 06:26:57] - 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-4000/stdout.txt
Pod stderr file : /results/orders/Reporting-authn-users-4000/stderr.txt
Pod log : /results/orders/Reporting-authn-users-4000
________________________________________________________________________________
[2024-04-11 06:26:57] Reporting-authn-users-4000 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-04-11 06:26:57,700 INFO
2024-04-11 06:26:57,701 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-04-11 06:26:57,701 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:26:58,021 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:26:58,022 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:26:58,022 DEBUG --- stdout ---
2024-04-11 06:26:58,022 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:26:58,022 DEBUG --- stderr ---
2024-04-11 06:26:58,022 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/order.json
{
"name": "Reporting-authn-users-4000",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh authn-users-4000 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-authn-users-4000"
}
________________________________________________________________________________
[2024-04-11 06:26:58] Reporting-authn-users-4000 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-04-11 06:26:58,023 INFO
2024-04-11 06:26:58,023 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-11 06:26:58,023 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-04-11 06:26:58,266 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-11 06:26:58,266 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:26:58,266 DEBUG --- stdout ---
2024-04-11 06:26:58,266 DEBUG WAITING
2024-04-11 06:26:58,266 DEBUG --- stderr ---
2024-04-11 06:26:58,266 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
100 7 100 7 0 0 32 0 --:--:-- --:--:-- --:--:-- 32
________________________________________________________________________________
[2024-04-11 06:26:58] Reporting-authn-users-4000 step3 : Send order to overseer
________________________________________________________________________________
2024-04-11 06:26:58,267 INFO
2024-04-11 06:26:58,267 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-11 06:26:58,267 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:26:58,580 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:26:58,580 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:26:58,580 DEBUG --- stdout ---
2024-04-11 06:26:58,580 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:26:58,580 DEBUG --- stderr ---
2024-04-11 06:26:58,581 DEBUG
2024-04-11 06:26:58,581 INFO
2024-04-11 06:26:58,581 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-4000/order.json overseer-0-78845f4f8c-v2r2q:/results/orders/order.json
2024-04-11 06:26:58,581 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-11 06:26:59,992 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:26:59,992 DEBUG --- stdout ---
2024-04-11 06:26:59,992 DEBUG
2024-04-11 06:26:59,992 DEBUG --- stderr ---
2024-04-11 06:26:59,992 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-04-11 06:26:59] Reporting-authn-users-4000 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-04-11 06:27:04,995 INFO
2024-04-11 06:27:04,995 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-11 06:27:04,996 INFO [loop_until]: (max_time=9000, interval=5, expected_rc=[0]
2024-04-11 06:27:05,261 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:10,550 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:15,805 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:21,051 INFO [loop_until]: Function succeeded after 16s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:26,294 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:31,553 INFO [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:36,802 INFO [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:42,144 INFO [loop_until]: Function succeeded after 37s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:47,399 INFO [loop_until]: Function succeeded after 42s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:52,650 INFO [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:27:57,906 INFO [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:03,161 INFO [loop_until]: Function succeeded after 58s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:08,416 INFO [loop_until]: Function succeeded after 1m 03s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:13,735 INFO [loop_until]: Function succeeded after 1m 08s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:18,980 INFO [loop_until]: Function succeeded after 1m 13s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:24,232 INFO [loop_until]: Function succeeded after 1m 19s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:29,477 INFO [loop_until]: Function succeeded after 1m 24s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:34,738 INFO [loop_until]: Function succeeded after 1m 29s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:39,992 INFO [loop_until]: Function succeeded after 1m 34s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:45,247 INFO [loop_until]: Function succeeded after 1m 40s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:50,568 INFO [loop_until]: Function succeeded after 1m 45s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:28:55,816 INFO [loop_until]: Function succeeded after 1m 50s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:29:01,062 INFO [loop_until]: Function succeeded after 1m 56s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:29:06,316 INFO [loop_until]: Function succeeded after 2m 01s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:29:11,563 INFO [loop_until]: Function succeeded after 2m 06s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:29:16,811 INFO [loop_until]: Function succeeded after 2m 11s (rc=0) - failed to find expected output: WAITING - retry
2024-04-11 06:29:22,127 INFO [loop_until]: Function succeeded after 2m 17s (rc=0) - expected pattern found
2024-04-11 06:29:22,127 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:22,128 DEBUG --- stdout ---
2024-04-11 06:29:22,128 DEBUG WAITING
2024-04-11 06:29:22,128 DEBUG --- stderr ---
2024-04-11 06:29:22,128 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 26 0 --:--:-- --:--:-- --:--:-- 26
________________________________________________________________________________
[2024-04-11 06:29:22] Reporting-authn-users-4000 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-04-11 06:29:22,130 INFO
2024-04-11 06:29:22,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-11 06:29:22,130 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:22,524 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:22,525 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:22,525 DEBUG --- stdout ---
2024-04-11 06:29:22,525 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:22,525 DEBUG --- stderr ---
2024-04-11 06:29:22,525 DEBUG
Checking pod: overseer-0-78845f4f8c-v2r2q for file exists, if not wait.
2024-04-11 06:29:22,525 INFO
2024-04-11 06:29:22,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-11 06:29:22,525 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:22,908 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:22,908 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:22,908 DEBUG --- stdout ---
2024-04-11 06:29:22,908 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:22,908 DEBUG --- stderr ---
2024-04-11 06:29:22,908 DEBUG
2024-04-11 06:29:22,909 INFO
2024-04-11 06:29:22,909 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- bash -c 'if [ -f "/results/gatling/authn-users-4000.tar.gz" ]; then echo "/results/gatling/authn-users-4000.tar.gz file found"; exit 0; else echo "/results/gatling/authn-users-4000.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/authn-users-4000.tar.gz file found"
2024-04-11 06:29:22,909 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-11 06:29:23,806 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-11 06:29:23,807 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:23,807 DEBUG --- stdout ---
2024-04-11 06:29:23,807 DEBUG /results/gatling/authn-users-4000.tar.gz file found
2024-04-11 06:29:23,807 DEBUG --- stderr ---
2024-04-11 06:29:23,807 DEBUG
2024-04-11 06:29:23,807 INFO
2024-04-11 06:29:23,807 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-11 06:29:23,807 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:24,135 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:24,135 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:24,135 DEBUG --- stdout ---
2024-04-11 06:29:24,136 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:24,136 DEBUG --- stderr ---
2024-04-11 06:29:24,136 DEBUG
2024-04-11 06:29:24,136 INFO
2024-04-11 06:29:24,136 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- du -k /results/gatling/authn-users-4000.tar.gz
2024-04-11 06:29:24,997 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-11 06:29:24,997 DEBUG --- stdout ---
2024-04-11 06:29:24,997 DEBUG 240 /results/gatling/authn-users-4000.tar.gz
2024-04-11 06:29:24,997 DEBUG --- stderr ---
2024-04-11 06:29:24,997 DEBUG
2024-04-11 06:29:24,997 INFO
- Download file (size 240k)
2024-04-11 06:29:24,998 INFO
2024-04-11 06:29:24,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-11 06:29:24,998 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:25,310 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:25,310 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:25,310 DEBUG --- stdout ---
2024-04-11 06:29:25,311 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:25,311 DEBUG --- stderr ---
2024-04-11 06:29:25,311 DEBUG
source : /results/gatling/authn-users-4000.tar.gz @ overseer-0-78845f4f8c-v2r2q
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-4000.tar.gz
2024-04-11 06:29:25,311 INFO
2024-04-11 06:29:25,311 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-11 06:29:25,311 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:25,628 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:25,629 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:25,629 DEBUG --- stdout ---
2024-04-11 06:29:25,629 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:25,629 DEBUG --- stderr ---
2024-04-11 06:29:25,629 DEBUG
2024-04-11 06:29:25,629 INFO
2024-04-11 06:29:25,629 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-78845f4f8c-v2r2q:/results/gatling/authn-users-4000.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-4000.tar.gz
2024-04-11 06:29:25,629 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-11 06:29:26,662 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:26,662 DEBUG --- stdout ---
2024-04-11 06:29:26,662 DEBUG tar: Removing leading `/' from member names
2024-04-11 06:29:26,663 DEBUG --- stderr ---
2024-04-11 06:29:26,663 DEBUG
________________________________________________________________________________
[2024-04-11 06:29:26] Reporting-authn-users-4000 step6 : Unzip the result
________________________________________________________________________________
2024-04-11 06:29:26,663 INFO
2024-04-11 06:29:26,664 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-4000.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-4000/gatling
2024-04-11 06:29:26,695 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-11 06:29:26,695 DEBUG --- stdout ---
2024-04-11 06:29:26,696 DEBUG
2024-04-11 06:29:26,696 DEBUG --- stderr ---
2024-04-11 06:29:26,696 DEBUG
2024-04-11 06:29:26,696 INFO
________________________________________________________________________________
[2024-04-11 06:29:26] Reporting-authn-users-4000 step7 : Print rc order
________________________________________________________________________________
2024-04-11 06:29:26,697 INFO
2024-04-11 06:29:26,697 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-11 06:29:26,697 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:27,071 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:27,071 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:27,071 DEBUG --- stdout ---
2024-04-11 06:29:27,072 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:27,072 DEBUG --- stderr ---
2024-04-11 06:29:27,072 DEBUG
Checking pod: overseer-0-78845f4f8c-v2r2q for file exists, if not wait.
2024-04-11 06:29:27,072 INFO
2024-04-11 06:29:27,072 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-11 06:29:27,072 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:27,398 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:27,399 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:27,399 DEBUG --- stdout ---
2024-04-11 06:29:27,399 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:27,399 DEBUG --- stderr ---
2024-04-11 06:29:27,399 DEBUG
2024-04-11 06:29:27,399 INFO
2024-04-11 06:29:27,400 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-4000/rc.txt" ]; then echo "/results/orders/Reporting-authn-users-4000/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-4000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-4000/rc.txt file found"
2024-04-11 06:29:27,400 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-11 06:29:28,245 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-11 06:29:28,245 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:28,245 DEBUG --- stdout ---
2024-04-11 06:29:28,246 DEBUG /results/orders/Reporting-authn-users-4000/rc.txt file found
2024-04-11 06:29:28,246 DEBUG --- stderr ---
2024-04-11 06:29:28,246 DEBUG
2024-04-11 06:29:28,246 INFO
2024-04-11 06:29:28,246 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-11 06:29:28,246 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:28,581 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:28,582 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:28,582 DEBUG --- stdout ---
2024-04-11 06:29:28,582 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:28,582 DEBUG --- stderr ---
2024-04-11 06:29:28,582 DEBUG
2024-04-11 06:29:28,582 INFO
2024-04-11 06:29:28,583 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- du -k /results/orders/Reporting-authn-users-4000/rc.txt
2024-04-11 06:29:29,475 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-11 06:29:29,476 DEBUG --- stdout ---
2024-04-11 06:29:29,476 DEBUG 4 /results/orders/Reporting-authn-users-4000/rc.txt
2024-04-11 06:29:29,476 DEBUG --- stderr ---
2024-04-11 06:29:29,476 DEBUG
2024-04-11 06:29:29,476 INFO
- Download file (size 4k)
2024-04-11 06:29:29,476 INFO
2024-04-11 06:29:29,476 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-11 06:29:29,476 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:29,791 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:29,791 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:29,791 DEBUG --- stdout ---
2024-04-11 06:29:29,791 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:29,791 DEBUG --- stderr ---
2024-04-11 06:29:29,791 DEBUG
source : /results/orders/Reporting-authn-users-4000/rc.txt @ overseer-0-78845f4f8c-v2r2q
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/rc.txt
2024-04-11 06:29:29,792 INFO
2024-04-11 06:29:29,792 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-11 06:29:29,792 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:30,106 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:30,106 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:30,106 DEBUG --- stdout ---
2024-04-11 06:29:30,106 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:30,106 DEBUG --- stderr ---
2024-04-11 06:29:30,106 DEBUG
2024-04-11 06:29:30,107 INFO
2024-04-11 06:29:30,107 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-78845f4f8c-v2r2q:/results/orders/Reporting-authn-users-4000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/rc.txt
2024-04-11 06:29:30,107 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-11 06:29:30,870 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:30,870 DEBUG --- stdout ---
2024-04-11 06:29:30,870 DEBUG tar: Removing leading `/' from member names
2024-04-11 06:29:30,870 DEBUG --- stderr ---
2024-04-11 06:29:30,870 DEBUG
2024-04-11 06:29:30,871 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/rc.txt is small (1 lines), printing all lines:
2024-04-11 06:29:30,871 DEBUG ----- output -----
2024-04-11 06:29:30,871 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-04-11 06:29:30,871 INFO
________________________________________________________________________________
[2024-04-11 06:29:30] Reporting-authn-users-4000 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-04-11 06:29:30] Reporting-authn-users-4000 step9 : Print stdout order
________________________________________________________________________________
2024-04-11 06:29:30,872 INFO
2024-04-11 06:29:30,872 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-11 06:29:30,872 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:31,193 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:31,193 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:31,193 DEBUG --- stdout ---
2024-04-11 06:29:31,193 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:31,193 DEBUG --- stderr ---
2024-04-11 06:29:31,193 DEBUG
Checking pod: overseer-0-78845f4f8c-v2r2q for file exists, if not wait.
2024-04-11 06:29:31,194 INFO
2024-04-11 06:29:31,194 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-11 06:29:31,194 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:31,509 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:31,510 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:31,510 DEBUG --- stdout ---
2024-04-11 06:29:31,510 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:31,510 DEBUG --- stderr ---
2024-04-11 06:29:31,510 DEBUG
2024-04-11 06:29:31,511 INFO
2024-04-11 06:29:31,511 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-4000/stdout.txt" ]; then echo "/results/orders/Reporting-authn-users-4000/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-4000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-4000/stdout.txt file found"
2024-04-11 06:29:31,511 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-11 06:29:32,370 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-11 06:29:32,371 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:32,371 DEBUG --- stdout ---
2024-04-11 06:29:32,371 DEBUG /results/orders/Reporting-authn-users-4000/stdout.txt file found
2024-04-11 06:29:32,371 DEBUG --- stderr ---
2024-04-11 06:29:32,371 DEBUG
2024-04-11 06:29:32,371 INFO
2024-04-11 06:29:32,372 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-11 06:29:32,372 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:32,717 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:32,718 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:32,718 DEBUG --- stdout ---
2024-04-11 06:29:32,718 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:32,718 DEBUG --- stderr ---
2024-04-11 06:29:32,718 DEBUG
2024-04-11 06:29:32,718 INFO
2024-04-11 06:29:32,718 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- du -k /results/orders/Reporting-authn-users-4000/stdout.txt
2024-04-11 06:29:33,614 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-11 06:29:33,615 DEBUG --- stdout ---
2024-04-11 06:29:33,615 DEBUG 4 /results/orders/Reporting-authn-users-4000/stdout.txt
2024-04-11 06:29:33,615 DEBUG --- stderr ---
2024-04-11 06:29:33,615 DEBUG
2024-04-11 06:29:33,615 INFO
- Download file (size 4k)
2024-04-11 06:29:33,615 INFO
2024-04-11 06:29:33,615 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-11 06:29:33,615 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:33,935 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:33,935 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:33,935 DEBUG --- stdout ---
2024-04-11 06:29:33,935 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:33,935 DEBUG --- stderr ---
2024-04-11 06:29:33,935 DEBUG
source : /results/orders/Reporting-authn-users-4000/stdout.txt @ overseer-0-78845f4f8c-v2r2q
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/stdout.txt
2024-04-11 06:29:33,936 INFO
2024-04-11 06:29:33,936 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-11 06:29:33,936 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:34,258 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:34,258 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:34,258 DEBUG --- stdout ---
2024-04-11 06:29:34,259 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:34,259 DEBUG --- stderr ---
2024-04-11 06:29:34,259 DEBUG
2024-04-11 06:29:34,259 INFO
2024-04-11 06:29:34,259 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-78845f4f8c-v2r2q:/results/orders/Reporting-authn-users-4000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/stdout.txt
2024-04-11 06:29:34,259 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-11 06:29:35,030 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:35,031 DEBUG --- stdout ---
2024-04-11 06:29:35,031 DEBUG tar: Removing leading `/' from member names
2024-04-11 06:29:35,031 DEBUG --- stderr ---
2024-04-11 06:29:35,031 DEBUG
2024-04-11 06:29:35,031 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/stdout.txt is small (75 lines), printing all lines:
2024-04-11 06:29:35,031 DEBUG ----- output -----
2024-04-11 06:29:35,031 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/authn-users-4000/loadtest-20240411045837860 --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 14462160 (OK=14462158 KO=2 )
> min response time 9 (OK=9 KO=10 )
> max response time 1255 (OK=1255 KO=12 )
> mean response time 68 (OK=68 KO=11 )
> std deviation 73 (OK=73 KO=1 )
> response time 50th percentile 28 (OK=28 KO=11 )
> response time 75th percentile 102 (OK=102 KO=12 )
> response time 95th percentile 227 (OK=226 KO=12 )
> response time 99th percentile 289 (OK=289 KO=12 )
> mean requests/sec 3982.969 (OK=3982.968 KO=0.001 )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 14462123 (100%)
> 800 ms <= t < 1200 ms 33 ( 0%)
> t >= 1200 ms 2 ( 0%)
> failed 2 ( 0%)
---- Errors --------------------------------------------------------------------
> status.find.in(200,201,202,203,204,205,206,207,208,209,304,401 2 (100.0%)
), but actually found 502
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/authn-users-4000/loadtest-20240411045837860/index.html
----------------------
[11/Apr/2024 07:29:18] Create tar file /results/gatling/authn-users-4000.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/authn-users-4000/loadtest-20240411045837860
RESULT_FOLDER=authn-users-4000
RESULT_PATH=/results/gatling/authn-users-4000
PWD=/results/gatling/authn-users-4000/loadtest-20240411045837860
[cmd] tar -czvf /results/gatling/authn-users-4000.tar.gz --exclude=simulation.log *
index.html
js/
js/assertions.json
js/stats.js
js/highstock.js
js/assertions.xml
js/bootstrap.min.js
js/highcharts-more.js
js/ellipsis.js
js/gatling.js
js/theme.js
js/global_stats.json
js/all_sessions.js
js/unpack.js
js/menu.js
js/stats.json
js/jquery-3.5.1.min.js
req_userrestlogin-03b82.html
style/
style/stat-l-roue.png
style/arrow_right.png
style/stat-l-temps.png
style/style.css
style/arrow_down.png
style/arrow_down_black.png
style/logo-enterprise.svg
style/stat-fleche-bas.png
style/logo.svg
style/bootstrap.min.css
style/favicon.ico
style/arrow_right_black.png
style/sorted-down.png
style/sortable.png
style/sorted-up.png
style/little_arrow_right.png
2024-04-11 06:29:35,031 INFO
________________________________________________________________________________
[2024-04-11 06:29:35] Reporting-authn-users-4000 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-04-11 06:29:35] Reporting-authn-users-4000 step11 : Print stderr order
________________________________________________________________________________
2024-04-11 06:29:35,032 INFO
2024-04-11 06:29:35,032 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-11 06:29:35,032 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:35,355 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:35,355 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:35,355 DEBUG --- stdout ---
2024-04-11 06:29:35,355 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:35,355 DEBUG --- stderr ---
2024-04-11 06:29:35,355 DEBUG
Checking pod: overseer-0-78845f4f8c-v2r2q for file exists, if not wait.
2024-04-11 06:29:35,355 INFO
2024-04-11 06:29:35,355 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-11 06:29:35,355 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:35,673 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:35,674 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:35,674 DEBUG --- stdout ---
2024-04-11 06:29:35,674 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:35,674 DEBUG --- stderr ---
2024-04-11 06:29:35,674 DEBUG
2024-04-11 06:29:35,675 INFO
2024-04-11 06:29:35,675 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-4000/stderr.txt" ]; then echo "/results/orders/Reporting-authn-users-4000/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-4000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-4000/stderr.txt file found"
2024-04-11 06:29:35,675 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-11 06:29:36,518 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-11 06:29:36,518 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:36,518 DEBUG --- stdout ---
2024-04-11 06:29:36,518 DEBUG /results/orders/Reporting-authn-users-4000/stderr.txt file found
2024-04-11 06:29:36,518 DEBUG --- stderr ---
2024-04-11 06:29:36,518 DEBUG
2024-04-11 06:29:36,519 INFO
2024-04-11 06:29:36,519 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-11 06:29:36,519 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:36,850 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:36,850 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:36,850 DEBUG --- stdout ---
2024-04-11 06:29:36,850 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:36,851 DEBUG --- stderr ---
2024-04-11 06:29:36,851 DEBUG
2024-04-11 06:29:36,851 INFO
2024-04-11 06:29:36,851 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-78845f4f8c-v2r2q --stdin -- du -k /results/orders/Reporting-authn-users-4000/stderr.txt
2024-04-11 06:29:37,712 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-11 06:29:37,712 DEBUG --- stdout ---
2024-04-11 06:29:37,712 DEBUG 0 /results/orders/Reporting-authn-users-4000/stderr.txt
2024-04-11 06:29:37,712 DEBUG --- stderr ---
2024-04-11 06:29:37,712 DEBUG
2024-04-11 06:29:37,713 INFO
- Download file (size 0k)
2024-04-11 06:29:37,713 INFO
2024-04-11 06:29:37,713 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-11 06:29:37,713 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:38,045 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:38,047 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:38,047 DEBUG --- stdout ---
2024-04-11 06:29:38,047 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:38,047 DEBUG --- stderr ---
2024-04-11 06:29:38,047 DEBUG
source : /results/orders/Reporting-authn-users-4000/stderr.txt @ overseer-0-78845f4f8c-v2r2q
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/stderr.txt
2024-04-11 06:29:38,048 INFO
2024-04-11 06:29:38,048 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-11 06:29:38,048 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-11 06:29:38,386 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-11 06:29:38,386 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:38,386 DEBUG --- stdout ---
2024-04-11 06:29:38,386 DEBUG overseer-0-78845f4f8c-v2r2q
2024-04-11 06:29:38,386 DEBUG --- stderr ---
2024-04-11 06:29:38,386 DEBUG
2024-04-11 06:29:38,387 INFO
2024-04-11 06:29:38,387 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-78845f4f8c-v2r2q:/results/orders/Reporting-authn-users-4000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/stderr.txt
2024-04-11 06:29:38,387 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-11 06:29:39,159 INFO [loop_until]: OK (rc = 0)
2024-04-11 06:29:39,159 DEBUG --- stdout ---
2024-04-11 06:29:39,160 DEBUG tar: Removing leading `/' from member names
2024-04-11 06:29:39,160 DEBUG --- stderr ---
2024-04-11 06:29:39,160 DEBUG
2024-04-11 06:29:39,160 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4000/stderr.txt is small (0 lines), printing all lines:
2024-04-11 06:29:39,160 DEBUG ----- output -----
2024-04-11 06:29:39,160 DEBUG
2024-04-11 06:29:39,160 INFO
________________________________________________________________________________
[2024-04-11 06:29:39] Reporting-authn-users-4000 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-04-11 06:29:39] Reporting-authn-users-4000 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-11 06:29:39] Reporting-authn-users-4000 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 14462160,
"ok": 14462158,
"ko": 2
},
"minResponseTime": {
"total": 9,
"ok": 9,
"ko": 10
},
"maxResponseTime": {
"total": 1255,
"ok": 1255,
"ko": 12
},
"meanResponseTime": {
"total": 68,
"ok": 68,
"ko": 11
},
"standardDeviation": {
"total": 73,
"ok": 73,
"ko": 1
},
"percentiles1": {
"total": 28,
"ok": 28,
"ko": 11
},
"percentiles2": {
"total": 102,
"ok": 102,
"ko": 12
},
"percentiles3": {
"total": 227,
"ok": 226,
"ko": 12
},
"percentiles4": {
"total": 289,
"ok": 289,
"ko": 12
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 14462123,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 33,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 2,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 2,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 3982.9688790966675,
"ok": 3982.9683282842193,
"ko": 0.000550812448361333
}
},
"details": [
{
"name": "userRestLogin",
"numberOfRequests": {
"total": 14462160,
"ok": 14462158,
"ko": 2
},
"minResponseTime": {
"total": 9,
"ok": 9,
"ko": 10
},
"maxResponseTime": {
"total": 1255,
"ok": 1255,
"ko": 12
},
"meanResponseTime": {
"total": 68,
"ok": 68,
"ko": 11
},
"standardDeviation": {
"total": 73,
"ok": 73,
"ko": 1
},
"percentiles1": {
"total": 28,
"ok": 28,
"ko": 11
},
"percentiles2": {
"total": 102,
"ok": 102,
"ko": 12
},
"percentiles3": {
"total": 226,
"ok": 227,
"ko": 12
},
"percentiles4": {
"total": 289,
"ok": 289,
"ko": 12
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 14462123,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 33,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 2,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 2,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 3982.9688790966675,
"ok": 3982.9683282842193,
"ko": 0.000550812448361333
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 3983,
"avg_response_time": 68,
"max_response_time": 1255,
"min_response_time": 9,
"num_requests": 14462160,
"num_requests_pass": 14462158,
"num_requests_percent_pass": 100.0
},
"options": "; testMode:open; testCase:am.AMAuthN; throughput:4000; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 14462123,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 33,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 2,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 2,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 12,
"ok": 1255,
"total": 1255
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.000550812448361333,
"ok": 3982.9683282842193,
"total": 3982.9688790966675
},
"meanResponseTime": {
"ko": 11,
"ok": 68,
"total": 68
},
"minResponseTime": {
"ko": 10,
"ok": 9,
"total": 9
},
"name": "userRestLogin",
"numberOfRequests": {
"ko": 2,
"ok": 14462158,
"total": 14462160
},
"percentiles1": {
"ko": 11,
"ok": 28,
"total": 28
},
"percentiles2": {
"ko": 12,
"ok": 102,
"total": 102
},
"percentiles3": {
"ko": 12,
"ok": 227,
"total": 226
},
"percentiles4": {
"ko": 12,
"ok": 289,
"total": 289
},
"spikes": [],
"standardDeviation": {
"ko": 1,
"ok": 73,
"total": 73
}
}
],
"global": {
"group1": {
"count": 14462123,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 33,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 2,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 2,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 12,
"ok": 1255,
"total": 1255
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.000550812448361333,
"ok": 3982.9683282842193,
"total": 3982.9688790966675
},
"meanResponseTime": {
"ko": 11,
"ok": 68,
"total": 68
},
"minResponseTime": {
"ko": 10,
"ok": 9,
"total": 9
},
"name": "All Requests",
"numberOfRequests": {
"ko": 2,
"ok": 14462158,
"total": 14462160
},
"percentiles1": {
"ko": 11,
"ok": 28,
"total": 28
},
"percentiles2": {
"ko": 12,
"ok": 102,
"total": 102
},
"percentiles3": {
"ko": 12,
"ok": 226,
"total": 227
},
"percentiles4": {
"ko": 12,
"ok": 289,
"total": 289
},
"standardDeviation": {
"ko": 1,
"ok": 73,
"total": 73
}
}
},
"target_hostname": "xlou.iam.xlou-cdm.engineeringpit.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-04-11 06:29:39] Reporting-authn-users-4000 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-04-11 06:29:39] Reporting-authn-users-4000 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-4000/stdout.txt
Gatling stdout.txt found, but is small - leave it intact.
________________________________________________________________________________
[2024-04-11 06:29:39] Reporting-authn-users-4000 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped