--Task--
name: Reporting-authn-users-10000
enabled: True
class_name: GatlingResultTask
source_name: overseer-0
source_namespace: >default<
target_name: overseer-0
target_namespace: >default<
start: 0.0
stop: None
timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow
loop: False
interval: None
dependencies: []
wait_for: ['Reporting-authn-users-100', 'Reporting-authn-users-3000', 'Reporting-authn-users-6000', 'Reporting-authn-users-9000', 'Reporting-authn-users-9500']
preceding_task: None
options: {'task_name': 'authn-users-10000'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-04-22 04:51:53] Reporting-authn-users-10000 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
[2024-04-22 04:51:53] - INFO: Timeout for this Task has changed to 3h (10800 seconds)
[2024-04-22 04:51:53] - 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-10000/stdout.txt
Pod stderr file : /results/orders/Reporting-authn-users-10000/stderr.txt
Pod log : /results/orders/Reporting-authn-users-10000
________________________________________________________________________________
[2024-04-22 04:51:53] Reporting-authn-users-10000 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-04-22 04:51:53,545 INFO
2024-04-22 04:51:53,545 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-22 04:51:53,545 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:51:53,865 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:51:53,865 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:51:53,866 DEBUG --- stdout ---
2024-04-22 04:51:53,866 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:51:53,866 DEBUG --- stderr ---
2024-04-22 04:51:53,866 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/order.json
{
"name": "Reporting-authn-users-10000",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh authn-users-10000 --extra-run-jvm-options \"-Xmx12G\"",
"out-dir": "/results/orders/Reporting-authn-users-10000"
}
________________________________________________________________________________
[2024-04-22 04:51:53] Reporting-authn-users-10000 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-04-22 04:51:53,867 INFO
2024-04-22 04:51:53,867 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-22 04:51:53,867 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-04-22 04:51:54,150 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:51:54,150 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:51:54,150 DEBUG --- stdout ---
2024-04-22 04:51:54,150 DEBUG WAITING
2024-04-22 04:51:54,150 DEBUG --- stderr ---
2024-04-22 04:51:54,150 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-22 04:51:54] Reporting-authn-users-10000 step3 : Send order to overseer
________________________________________________________________________________
2024-04-22 04:51:54,151 INFO
2024-04-22 04:51:54,152 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-22 04:51:54,152 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:51:54,475 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:51:54,476 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:51:54,476 DEBUG --- stdout ---
2024-04-22 04:51:54,476 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:51:54,476 DEBUG --- stderr ---
2024-04-22 04:51:54,476 DEBUG
2024-04-22 04:51:54,476 INFO
2024-04-22 04:51:54,476 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/14_Reporting-authn-users-10000/order.json overseer-0-68c5d5b884-p97w5:/results/orders/order.json
2024-04-22 04:51:54,476 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:51:55,865 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:51:55,865 DEBUG --- stdout ---
2024-04-22 04:51:55,865 DEBUG
2024-04-22 04:51:55,865 DEBUG --- stderr ---
2024-04-22 04:51:55,865 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-04-22 04:51:55] Reporting-authn-users-10000 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-04-22 04:52:00,871 INFO
2024-04-22 04:52:00,871 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-22 04:52:00,872 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0]
2024-04-22 04:52:01,112 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:06,356 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:11,600 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:16,845 INFO [loop_until]: Function succeeded after 15s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:22,095 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:27,386 INFO [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:32,637 INFO [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:37,878 INFO [loop_until]: Function succeeded after 37s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:43,126 INFO [loop_until]: Function succeeded after 42s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:48,370 INFO [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:53,615 INFO [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:52:58,901 INFO [loop_until]: Function succeeded after 58s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:04,144 INFO [loop_until]: Function succeeded after 1m 03s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:09,392 INFO [loop_until]: Function succeeded after 1m 08s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:14,643 INFO [loop_until]: Function succeeded after 1m 13s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:19,893 INFO [loop_until]: Function succeeded after 1m 19s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:25,138 INFO [loop_until]: Function succeeded after 1m 24s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:30,452 INFO [loop_until]: Function succeeded after 1m 29s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:35,705 INFO [loop_until]: Function succeeded after 1m 34s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:40,952 INFO [loop_until]: Function succeeded after 1m 40s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:46,193 INFO [loop_until]: Function succeeded after 1m 45s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:51,438 INFO [loop_until]: Function succeeded after 1m 50s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:53:56,683 INFO [loop_until]: Function succeeded after 1m 55s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:01,973 INFO [loop_until]: Function succeeded after 2m 01s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:07,220 INFO [loop_until]: Function succeeded after 2m 06s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:12,471 INFO [loop_until]: Function succeeded after 2m 11s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:17,732 INFO [loop_until]: Function succeeded after 2m 16s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:22,979 INFO [loop_until]: Function succeeded after 2m 22s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:28,223 INFO [loop_until]: Function succeeded after 2m 27s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:33,515 INFO [loop_until]: Function succeeded after 2m 32s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:38,760 INFO [loop_until]: Function succeeded after 2m 37s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:44,007 INFO [loop_until]: Function succeeded after 2m 43s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:49,252 INFO [loop_until]: Function succeeded after 2m 48s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:54,498 INFO [loop_until]: Function succeeded after 2m 53s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:54:59,749 INFO [loop_until]: Function succeeded after 2m 58s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:05,055 INFO [loop_until]: Function succeeded after 3m 04s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:10,299 INFO [loop_until]: Function succeeded after 3m 09s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:15,558 INFO [loop_until]: Function succeeded after 3m 14s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:20,802 INFO [loop_until]: Function succeeded after 3m 19s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:26,047 INFO [loop_until]: Function succeeded after 3m 25s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:31,291 INFO [loop_until]: Function succeeded after 3m 30s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:36,603 INFO [loop_until]: Function succeeded after 3m 35s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:41,846 INFO [loop_until]: Function succeeded after 3m 40s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:47,103 INFO [loop_until]: Function succeeded after 3m 46s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:52,351 INFO [loop_until]: Function succeeded after 3m 51s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:55:57,602 INFO [loop_until]: Function succeeded after 3m 56s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:56:02,861 INFO [loop_until]: Function succeeded after 4m 01s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:56:08,158 INFO [loop_until]: Function succeeded after 4m 07s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:56:13,471 INFO [loop_until]: Function succeeded after 4m 12s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:56:18,717 INFO [loop_until]: Function succeeded after 4m 17s (rc=0) - expected pattern found
2024-04-22 04:56:18,717 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:18,717 DEBUG --- stdout ---
2024-04-22 04:56:18,717 DEBUG WAITING
2024-04-22 04:56:18,717 DEBUG --- stderr ---
2024-04-22 04:56:18,717 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed
0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33
________________________________________________________________________________
[2024-04-22 04:56:18] Reporting-authn-users-10000 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-04-22 04:56:18,718 INFO
2024-04-22 04:56:18,719 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-22 04:56:18,719 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:19,071 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:19,071 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:19,071 DEBUG --- stdout ---
2024-04-22 04:56:19,071 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:19,071 DEBUG --- stderr ---
2024-04-22 04:56:19,072 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:56:19,072 INFO
2024-04-22 04:56:19,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-22 04:56:19,072 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:19,398 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:19,398 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:19,398 DEBUG --- stdout ---
2024-04-22 04:56:19,399 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:19,399 DEBUG --- stderr ---
2024-04-22 04:56:19,399 DEBUG
2024-04-22 04:56:19,399 INFO
2024-04-22 04:56:19,399 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- bash -c 'if [ -f "/results/gatling/authn-users-10000.tar.gz" ]; then echo "/results/gatling/authn-users-10000.tar.gz file found"; exit 0; else echo "/results/gatling/authn-users-10000.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/authn-users-10000.tar.gz file found"
2024-04-22 04:56:19,399 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:56:20,410 INFO [loop_until]: Function succeeded after 1s (rc=0) - expected pattern found
2024-04-22 04:56:20,410 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:20,411 DEBUG --- stdout ---
2024-04-22 04:56:20,411 DEBUG /results/gatling/authn-users-10000.tar.gz file found
2024-04-22 04:56:20,411 DEBUG --- stderr ---
2024-04-22 04:56:20,411 DEBUG
2024-04-22 04:56:20,411 INFO
2024-04-22 04:56:20,411 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-22 04:56:20,411 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:20,738 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:20,738 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:20,738 DEBUG --- stdout ---
2024-04-22 04:56:20,738 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:20,738 DEBUG --- stderr ---
2024-04-22 04:56:20,738 DEBUG
2024-04-22 04:56:20,738 INFO
2024-04-22 04:56:20,739 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- du -k /results/gatling/authn-users-10000.tar.gz
2024-04-22 04:56:21,571 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:56:21,571 DEBUG --- stdout ---
2024-04-22 04:56:21,571 DEBUG 252 /results/gatling/authn-users-10000.tar.gz
2024-04-22 04:56:21,571 DEBUG --- stderr ---
2024-04-22 04:56:21,571 DEBUG
2024-04-22 04:56:21,571 INFO
- Download file (size 252k)
2024-04-22 04:56:21,572 INFO
2024-04-22 04:56:21,572 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-22 04:56:21,572 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:21,902 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:21,903 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:21,904 DEBUG --- stdout ---
2024-04-22 04:56:21,904 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:21,904 DEBUG --- stderr ---
2024-04-22 04:56:21,904 DEBUG
source : /results/gatling/authn-users-10000.tar.gz @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-10000.tar.gz
2024-04-22 04:56:21,904 INFO
2024-04-22 04:56:21,904 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-04-22 04:56:21,904 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:22,229 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:22,229 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:22,229 DEBUG --- stdout ---
2024-04-22 04:56:22,229 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:22,229 DEBUG --- stderr ---
2024-04-22 04:56:22,230 DEBUG
2024-04-22 04:56:22,230 INFO
2024-04-22 04:56:22,230 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68c5d5b884-p97w5:/results/gatling/authn-users-10000.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-10000.tar.gz
2024-04-22 04:56:22,230 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:56:23,268 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:23,269 DEBUG --- stdout ---
2024-04-22 04:56:23,269 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:56:23,269 DEBUG --- stderr ---
2024-04-22 04:56:23,269 DEBUG
________________________________________________________________________________
[2024-04-22 04:56:23] Reporting-authn-users-10000 step6 : Unzip the result
________________________________________________________________________________
2024-04-22 04:56:23,270 INFO
2024-04-22 04:56:23,270 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-10000.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-10000/gatling
2024-04-22 04:56:23,299 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:56:23,299 DEBUG --- stdout ---
2024-04-22 04:56:23,300 DEBUG
2024-04-22 04:56:23,300 DEBUG --- stderr ---
2024-04-22 04:56:23,300 DEBUG
2024-04-22 04:56:23,300 INFO
________________________________________________________________________________
[2024-04-22 04:56:23] Reporting-authn-users-10000 step7 : Print rc order
________________________________________________________________________________
2024-04-22 04:56:23,301 INFO
2024-04-22 04:56:23,301 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-22 04:56:23,302 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:23,624 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:23,624 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:23,625 DEBUG --- stdout ---
2024-04-22 04:56:23,625 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:23,625 DEBUG --- stderr ---
2024-04-22 04:56:23,625 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:56:23,625 INFO
2024-04-22 04:56:23,625 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-22 04:56:23,625 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:23,951 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:23,952 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:23,952 DEBUG --- stdout ---
2024-04-22 04:56:23,952 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:23,952 DEBUG --- stderr ---
2024-04-22 04:56:23,952 DEBUG
2024-04-22 04:56:23,952 INFO
2024-04-22 04:56:23,953 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-10000/rc.txt" ]; then echo "/results/orders/Reporting-authn-users-10000/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-10000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-10000/rc.txt file found"
2024-04-22 04:56:23,953 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:56:24,787 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:56:24,787 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:24,787 DEBUG --- stdout ---
2024-04-22 04:56:24,787 DEBUG /results/orders/Reporting-authn-users-10000/rc.txt file found
2024-04-22 04:56:24,787 DEBUG --- stderr ---
2024-04-22 04:56:24,787 DEBUG
2024-04-22 04:56:24,788 INFO
2024-04-22 04:56:24,788 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-22 04:56:24,788 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:25,111 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:25,111 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:25,111 DEBUG --- stdout ---
2024-04-22 04:56:25,111 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:25,111 DEBUG --- stderr ---
2024-04-22 04:56:25,111 DEBUG
2024-04-22 04:56:25,111 INFO
2024-04-22 04:56:25,111 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- du -k /results/orders/Reporting-authn-users-10000/rc.txt
2024-04-22 04:56:25,954 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:56:25,954 DEBUG --- stdout ---
2024-04-22 04:56:25,954 DEBUG 4 /results/orders/Reporting-authn-users-10000/rc.txt
2024-04-22 04:56:25,955 DEBUG --- stderr ---
2024-04-22 04:56:25,955 DEBUG
2024-04-22 04:56:25,955 INFO
- Download file (size 4k)
2024-04-22 04:56:25,955 INFO
2024-04-22 04:56:25,955 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-22 04:56:25,955 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:26,278 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:26,279 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:26,279 DEBUG --- stdout ---
2024-04-22 04:56:26,279 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:26,279 DEBUG --- stderr ---
2024-04-22 04:56:26,279 DEBUG
source : /results/orders/Reporting-authn-users-10000/rc.txt @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/rc.txt
2024-04-22 04:56:26,279 INFO
2024-04-22 04:56:26,279 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-22 04:56:26,279 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:26,599 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:26,599 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:26,599 DEBUG --- stdout ---
2024-04-22 04:56:26,599 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:26,599 DEBUG --- stderr ---
2024-04-22 04:56:26,599 DEBUG
2024-04-22 04:56:26,600 INFO
2024-04-22 04:56:26,600 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68c5d5b884-p97w5:/results/orders/Reporting-authn-users-10000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/rc.txt
2024-04-22 04:56:26,600 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:56:27,432 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:27,432 DEBUG --- stdout ---
2024-04-22 04:56:27,432 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:56:27,432 DEBUG --- stderr ---
2024-04-22 04:56:27,432 DEBUG
2024-04-22 04:56:27,432 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/rc.txt is small (1 lines), printing all lines:
2024-04-22 04:56:27,433 DEBUG ----- output -----
2024-04-22 04:56:27,433 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-04-22 04:56:27,433 INFO
________________________________________________________________________________
[2024-04-22 04:56:27] Reporting-authn-users-10000 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-04-22 04:56:27] Reporting-authn-users-10000 step9 : Print stdout order
________________________________________________________________________________
2024-04-22 04:56:27,434 INFO
2024-04-22 04:56:27,434 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-22 04:56:27,434 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:27,781 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:27,781 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:27,781 DEBUG --- stdout ---
2024-04-22 04:56:27,781 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:27,781 DEBUG --- stderr ---
2024-04-22 04:56:27,781 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:56:27,782 INFO
2024-04-22 04:56:27,782 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-22 04:56:27,782 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:28,141 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:28,142 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:28,142 DEBUG --- stdout ---
2024-04-22 04:56:28,142 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:28,142 DEBUG --- stderr ---
2024-04-22 04:56:28,142 DEBUG
2024-04-22 04:56:28,143 INFO
2024-04-22 04:56:28,143 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-10000/stdout.txt" ]; then echo "/results/orders/Reporting-authn-users-10000/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-10000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-10000/stdout.txt file found"
2024-04-22 04:56:28,143 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:56:29,056 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:56:29,056 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:29,056 DEBUG --- stdout ---
2024-04-22 04:56:29,056 DEBUG /results/orders/Reporting-authn-users-10000/stdout.txt file found
2024-04-22 04:56:29,056 DEBUG --- stderr ---
2024-04-22 04:56:29,056 DEBUG
2024-04-22 04:56:29,056 INFO
2024-04-22 04:56:29,056 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-22 04:56:29,056 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:29,377 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:29,377 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:29,377 DEBUG --- stdout ---
2024-04-22 04:56:29,377 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:29,377 DEBUG --- stderr ---
2024-04-22 04:56:29,377 DEBUG
2024-04-22 04:56:29,377 INFO
2024-04-22 04:56:29,377 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- du -k /results/orders/Reporting-authn-users-10000/stdout.txt
2024-04-22 04:56:30,250 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:56:30,250 DEBUG --- stdout ---
2024-04-22 04:56:30,251 DEBUG 4 /results/orders/Reporting-authn-users-10000/stdout.txt
2024-04-22 04:56:30,251 DEBUG --- stderr ---
2024-04-22 04:56:30,251 DEBUG
2024-04-22 04:56:30,251 INFO
- Download file (size 4k)
2024-04-22 04:56:30,251 INFO
2024-04-22 04:56:30,251 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-22 04:56:30,251 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:30,572 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:30,572 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:30,572 DEBUG --- stdout ---
2024-04-22 04:56:30,572 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:30,572 DEBUG --- stderr ---
2024-04-22 04:56:30,572 DEBUG
source : /results/orders/Reporting-authn-users-10000/stdout.txt @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/stdout.txt
2024-04-22 04:56:30,572 INFO
2024-04-22 04:56:30,573 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-04-22 04:56:30,573 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:30,896 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:30,896 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:30,896 DEBUG --- stdout ---
2024-04-22 04:56:30,896 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:30,896 DEBUG --- stderr ---
2024-04-22 04:56:30,896 DEBUG
2024-04-22 04:56:30,897 INFO
2024-04-22 04:56:30,897 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68c5d5b884-p97w5:/results/orders/Reporting-authn-users-10000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/stdout.txt
2024-04-22 04:56:30,897 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:56:31,699 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:31,700 DEBUG --- stdout ---
2024-04-22 04:56:31,700 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:56:31,700 DEBUG --- stderr ---
2024-04-22 04:56:31,700 DEBUG
2024-04-22 04:56:31,700 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/stdout.txt is small (72 lines), printing all lines:
2024-04-22 04:56:31,700 DEBUG ----- output -----
2024-04-22 04:56:31,700 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/authn-users-10000/loadtest-20240422032730531 --extra-run-jvm-options -Xmx12G
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 36159314 (OK=36159314 KO=0 )
> min response time 8 (OK=8 KO=- )
> max response time 17513 (OK=17513 KO=- )
> mean response time 219 (OK=219 KO=- )
> std deviation 326 (OK=326 KO=- )
> response time 50th percentile 106 (OK=106 KO=- )
> response time 75th percentile 251 (OK=251 KO=- )
> response time 95th percentile 951 (OK=951 KO=- )
> response time 99th percentile 1416 (OK=1416 KO=- )
> mean requests/sec 9955.758 (OK=9955.758 KO=- )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 34139914 ( 94%)
> 800 ms <= t < 1200 ms 1158633 ( 3%)
> t >= 1200 ms 860767 ( 2%)
> failed 0 ( 0%)
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/authn-users-10000/loadtest-20240422032730531/index.html
----------------------
[22/Apr/2024 05:56:13] Create tar file /results/gatling/authn-users-10000.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/authn-users-10000/loadtest-20240422032730531
RESULT_FOLDER=authn-users-10000
RESULT_PATH=/results/gatling/authn-users-10000
PWD=/results/gatling/authn-users-10000/loadtest-20240422032730531
[cmd] tar -czvf /results/gatling/authn-users-10000.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-22 04:56:31,700 INFO
________________________________________________________________________________
[2024-04-22 04:56:31] Reporting-authn-users-10000 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-04-22 04:56:31] Reporting-authn-users-10000 step11 : Print stderr order
________________________________________________________________________________
2024-04-22 04:56:31,702 INFO
2024-04-22 04:56:31,702 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-22 04:56:31,702 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:32,019 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:32,019 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:32,019 DEBUG --- stdout ---
2024-04-22 04:56:32,019 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:32,019 DEBUG --- stderr ---
2024-04-22 04:56:32,019 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:56:32,020 INFO
2024-04-22 04:56:32,020 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-22 04:56:32,020 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:32,341 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:32,341 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:32,341 DEBUG --- stdout ---
2024-04-22 04:56:32,341 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:32,342 DEBUG --- stderr ---
2024-04-22 04:56:32,342 DEBUG
2024-04-22 04:56:32,342 INFO
2024-04-22 04:56:32,342 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-10000/stderr.txt" ]; then echo "/results/orders/Reporting-authn-users-10000/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-10000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-10000/stderr.txt file found"
2024-04-22 04:56:32,342 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:56:33,183 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:56:33,184 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:33,184 DEBUG --- stdout ---
2024-04-22 04:56:33,184 DEBUG /results/orders/Reporting-authn-users-10000/stderr.txt file found
2024-04-22 04:56:33,184 DEBUG --- stderr ---
2024-04-22 04:56:33,184 DEBUG
2024-04-22 04:56:33,184 INFO
2024-04-22 04:56:33,184 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-22 04:56:33,184 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:33,508 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:33,509 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:33,509 DEBUG --- stdout ---
2024-04-22 04:56:33,509 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:33,509 DEBUG --- stderr ---
2024-04-22 04:56:33,509 DEBUG
2024-04-22 04:56:33,509 INFO
2024-04-22 04:56:33,509 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-68c5d5b884-p97w5 --stdin -- du -k /results/orders/Reporting-authn-users-10000/stderr.txt
2024-04-22 04:56:34,344 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:56:34,344 DEBUG --- stdout ---
2024-04-22 04:56:34,344 DEBUG 0 /results/orders/Reporting-authn-users-10000/stderr.txt
2024-04-22 04:56:34,344 DEBUG --- stderr ---
2024-04-22 04:56:34,344 DEBUG
2024-04-22 04:56:34,344 INFO
- Download file (size 0k)
2024-04-22 04:56:34,345 INFO
2024-04-22 04:56:34,345 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-22 04:56:34,345 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:34,732 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:34,732 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:34,732 DEBUG --- stdout ---
2024-04-22 04:56:34,732 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:34,732 DEBUG --- stderr ---
2024-04-22 04:56:34,732 DEBUG
source : /results/orders/Reporting-authn-users-10000/stderr.txt @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/stderr.txt
2024-04-22 04:56:34,733 INFO
2024-04-22 04:56:34,733 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-22 04:56:34,733 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:56:35,075 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:56:35,075 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:35,075 DEBUG --- stdout ---
2024-04-22 04:56:35,075 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:56:35,075 DEBUG --- stderr ---
2024-04-22 04:56:35,075 DEBUG
2024-04-22 04:56:35,075 INFO
2024-04-22 04:56:35,075 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-68c5d5b884-p97w5:/results/orders/Reporting-authn-users-10000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/stderr.txt
2024-04-22 04:56:35,075 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:56:35,850 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:56:35,851 DEBUG --- stdout ---
2024-04-22 04:56:35,851 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:56:35,851 DEBUG --- stderr ---
2024-04-22 04:56:35,851 DEBUG
2024-04-22 04:56:35,851 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/14_Reporting-authn-users-10000/stderr.txt is small (0 lines), printing all lines:
2024-04-22 04:56:35,851 DEBUG ----- output -----
2024-04-22 04:56:35,851 DEBUG
2024-04-22 04:56:35,851 INFO
________________________________________________________________________________
[2024-04-22 04:56:35] Reporting-authn-users-10000 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-04-22 04:56:35] Reporting-authn-users-10000 step13 : Analyze graphs for spikes
________________________________________________________________________________
Analyze Gatling graphs for spikes
checking parameters
open overall stats JSON file
checking simulation request userRestLogin
[warn] responseTimePercentiles was not found in /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-10000/gatling/req_userrestlogin-03b82.html - cannot check for spikes
no spikes found
________________________________________________________________________________
[2024-04-22 04:56:35] Reporting-authn-users-10000 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 36159314,
"ok": 36159314,
"ko": 0
},
"minResponseTime": {
"total": 8,
"ok": 8,
"ko": 0
},
"maxResponseTime": {
"total": 17513,
"ok": 17513,
"ko": 0
},
"meanResponseTime": {
"total": 219,
"ok": 219,
"ko": 0
},
"standardDeviation": {
"total": 326,
"ok": 326,
"ko": 0
},
"percentiles1": {
"total": 106,
"ok": 106,
"ko": 0
},
"percentiles2": {
"total": 251,
"ok": 251,
"ko": 0
},
"percentiles3": {
"total": 951,
"ok": 951,
"ko": 0
},
"percentiles4": {
"total": 1416,
"ok": 1416,
"ko": 0
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 34139914,
"percentage": 94
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 1158633,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 860767,
"percentage": 2
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 0,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 9955.758259911894,
"ok": 9955.758259911894,
"ko": 0
}
},
"details": [
{
"name": "userRestLogin",
"numberOfRequests": {
"total": 36159314,
"ok": 36159314,
"ko": 0
},
"minResponseTime": {
"total": 8,
"ok": 8,
"ko": 0
},
"maxResponseTime": {
"total": 17513,
"ok": 17513,
"ko": 0
},
"meanResponseTime": {
"total": 219,
"ok": 219,
"ko": 0
},
"standardDeviation": {
"total": 326,
"ok": 326,
"ko": 0
},
"percentiles1": {
"total": 106,
"ok": 106,
"ko": 0
},
"percentiles2": {
"total": 251,
"ok": 251,
"ko": 0
},
"percentiles3": {
"total": 951,
"ok": 947,
"ko": 0
},
"percentiles4": {
"total": 1416,
"ok": 1416,
"ko": 0
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 34139914,
"percentage": 94
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 1158633,
"percentage": 3
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 860767,
"percentage": 2
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 0,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 9955.758259911894,
"ok": 9955.758259911894,
"ko": 0
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 9956,
"avg_response_time": 219,
"max_response_time": 17513,
"min_response_time": 8,
"num_requests": 36159314,
"num_requests_pass": 36159314,
"num_requests_percent_pass": 100.0
},
"options": "; testMode:open; testCase:am.AMAuthN; throughput:10000; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 34139914,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 94
},
"group2": {
"count": 1158633,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 860767,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 2
},
"group4": {
"count": 0,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 0,
"ok": 17513,
"total": 17513
},
"meanNumberOfRequestsPerSecond": {
"ko": 0,
"ok": 9955.758259911894,
"total": 9955.758259911894
},
"meanResponseTime": {
"ko": 0,
"ok": 219,
"total": 219
},
"minResponseTime": {
"ko": 0,
"ok": 8,
"total": 8
},
"name": "userRestLogin",
"numberOfRequests": {
"ko": 0,
"ok": 36159314,
"total": 36159314
},
"percentiles1": {
"ko": 0,
"ok": 106,
"total": 106
},
"percentiles2": {
"ko": 0,
"ok": 251,
"total": 251
},
"percentiles3": {
"ko": 0,
"ok": 947,
"total": 951
},
"percentiles4": {
"ko": 0,
"ok": 1416,
"total": 1416
},
"spikes": [],
"standardDeviation": {
"ko": 0,
"ok": 326,
"total": 326
}
}
],
"global": {
"group1": {
"count": 34139914,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 94
},
"group2": {
"count": 1158633,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 3
},
"group3": {
"count": 860767,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 2
},
"group4": {
"count": 0,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 0,
"ok": 17513,
"total": 17513
},
"meanNumberOfRequestsPerSecond": {
"ko": 0,
"ok": 9955.758259911894,
"total": 9955.758259911894
},
"meanResponseTime": {
"ko": 0,
"ok": 219,
"total": 219
},
"minResponseTime": {
"ko": 0,
"ok": 8,
"total": 8
},
"name": "All Requests",
"numberOfRequests": {
"ko": 0,
"ok": 36159314,
"total": 36159314
},
"percentiles1": {
"ko": 0,
"ok": 106,
"total": 106
},
"percentiles2": {
"ko": 0,
"ok": 251,
"total": 251
},
"percentiles3": {
"ko": 0,
"ok": 951,
"total": 951
},
"percentiles4": {
"ko": 0,
"ok": 1416,
"total": 1416
},
"standardDeviation": {
"ko": 0,
"ok": 326,
"total": 326
}
}
},
"target_hostname": "xlou.iam.xlou-cdm.engineeringpit.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-04-22 04:56:35] Reporting-authn-users-10000 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-04-22 04:56:35] Reporting-authn-users-10000 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/06_authn-users-10000/stdout.txt
Gatling stdout.txt found, but is small - leave it intact.
________________________________________________________________________________
[2024-04-22 04:56:35] Reporting-authn-users-10000 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped