--Task--
name: Reporting-authn-users-9000
enabled: True
class_name: GatlingResultTask
source_name: overseer-0
source_namespace: >default<
target_name: overseer-0
target_namespace: >default<
start: 0.0
stop: None
timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow
loop: False
interval: None
dependencies: []
wait_for: ['Reporting-authn-users-100', 'Reporting-authn-users-3000', 'Reporting-authn-users-6000']
preceding_task: None
options: {'task_name': 'authn-users-9000'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-04-22 04:41:14] Reporting-authn-users-9000 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
[2024-04-22 04:41:14] - INFO: Timeout for this Task has changed to 3h (10800 seconds)
[2024-04-22 04:41:14] - 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-9000/stdout.txt
Pod stderr file : /results/orders/Reporting-authn-users-9000/stderr.txt
Pod log : /results/orders/Reporting-authn-users-9000
________________________________________________________________________________
[2024-04-22 04:41:14] Reporting-authn-users-9000 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-04-22 04:41:14,722 INFO
2024-04-22 04:41:14,722 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:41:14,722 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:41:15,042 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:41:15,043 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:41:15,043 DEBUG --- stdout ---
2024-04-22 04:41:15,043 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:41:15,043 DEBUG --- stderr ---
2024-04-22 04:41:15,043 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/order.json
{
"name": "Reporting-authn-users-9000",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh authn-users-9000 --extra-run-jvm-options \"-Xmx12G\"",
"out-dir": "/results/orders/Reporting-authn-users-9000"
}
________________________________________________________________________________
[2024-04-22 04:41:15] Reporting-authn-users-9000 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-04-22 04:41:15,045 INFO
2024-04-22 04:41:15,045 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-22 04:41:15,045 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-04-22 04:41:15,286 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:41:15,286 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:41:15,286 DEBUG --- stdout ---
2024-04-22 04:41:15,286 DEBUG WAITING
2024-04-22 04:41:15,286 DEBUG --- stderr ---
2024-04-22 04:41:15,286 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:41:15] Reporting-authn-users-9000 step3 : Send order to overseer
________________________________________________________________________________
2024-04-22 04:41:15,287 INFO
2024-04-22 04:41:15,287 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:41:15,287 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:41:15,610 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:41:15,611 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:41:15,611 DEBUG --- stdout ---
2024-04-22 04:41:15,611 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:41:15,611 DEBUG --- stderr ---
2024-04-22 04:41:15,611 DEBUG
2024-04-22 04:41:15,611 INFO
2024-04-22 04:41:15,611 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-9000/order.json overseer-0-68c5d5b884-p97w5:/results/orders/order.json
2024-04-22 04:41:15,611 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:41:17,017 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:41:17,017 DEBUG --- stdout ---
2024-04-22 04:41:17,017 DEBUG
2024-04-22 04:41:17,017 DEBUG --- stderr ---
2024-04-22 04:41:17,017 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-04-22 04:41:17] Reporting-authn-users-9000 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-04-22 04:41:22,023 INFO
2024-04-22 04:41:22,024 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-22 04:41:22,024 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0]
2024-04-22 04:41:22,307 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:41:27,553 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:41:32,797 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:41:38,042 INFO [loop_until]: Function succeeded after 16s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:41:43,289 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:41:48,553 INFO [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:41:53,867 INFO [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:41:59,110 INFO [loop_until]: Function succeeded after 37s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:04,376 INFO [loop_until]: Function succeeded after 42s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:09,627 INFO [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:14,871 INFO [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:20,118 INFO [loop_until]: Function succeeded after 58s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:25,421 INFO [loop_until]: Function succeeded after 1m 03s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:30,731 INFO [loop_until]: Function succeeded after 1m 08s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:35,976 INFO [loop_until]: Function succeeded after 1m 13s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:41,227 INFO [loop_until]: Function succeeded after 1m 19s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:46,485 INFO [loop_until]: Function succeeded after 1m 24s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:51,731 INFO [loop_until]: Function succeeded after 1m 29s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:42:57,051 INFO [loop_until]: Function succeeded after 1m 35s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:02,294 INFO [loop_until]: Function succeeded after 1m 40s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:07,538 INFO [loop_until]: Function succeeded after 1m 45s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:12,785 INFO [loop_until]: Function succeeded after 1m 50s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:18,030 INFO [loop_until]: Function succeeded after 1m 56s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:23,274 INFO [loop_until]: Function succeeded after 2m 01s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:28,572 INFO [loop_until]: Function succeeded after 2m 06s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:33,834 INFO [loop_until]: Function succeeded after 2m 11s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:39,080 INFO [loop_until]: Function succeeded after 2m 17s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:44,330 INFO [loop_until]: Function succeeded after 2m 22s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:49,585 INFO [loop_until]: Function succeeded after 2m 27s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:43:54,833 INFO [loop_until]: Function succeeded after 2m 32s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:00,139 INFO [loop_until]: Function succeeded after 2m 38s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:05,387 INFO [loop_until]: Function succeeded after 2m 43s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:10,633 INFO [loop_until]: Function succeeded after 2m 48s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:15,878 INFO [loop_until]: Function succeeded after 2m 53s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:21,125 INFO [loop_until]: Function succeeded after 2m 59s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:26,375 INFO [loop_until]: Function succeeded after 3m 04s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:31,676 INFO [loop_until]: Function succeeded after 3m 09s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:36,922 INFO [loop_until]: Function succeeded after 3m 14s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:42,180 INFO [loop_until]: Function succeeded after 3m 20s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:47,426 INFO [loop_until]: Function succeeded after 3m 25s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:52,672 INFO [loop_until]: Function succeeded after 3m 30s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:44:57,916 INFO [loop_until]: Function succeeded after 3m 35s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:03,230 INFO [loop_until]: Function succeeded after 3m 41s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:08,474 INFO [loop_until]: Function succeeded after 3m 46s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:13,720 INFO [loop_until]: Function succeeded after 3m 51s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:18,965 INFO [loop_until]: Function succeeded after 3m 56s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:24,214 INFO [loop_until]: Function succeeded after 4m 02s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:29,470 INFO [loop_until]: Function succeeded after 4m 07s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:34,783 INFO [loop_until]: Function succeeded after 4m 12s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:40,027 INFO [loop_until]: Function succeeded after 4m 18s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:45,272 INFO [loop_until]: Function succeeded after 4m 23s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:50,519 INFO [loop_until]: Function succeeded after 4m 28s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:45:55,764 INFO [loop_until]: Function succeeded after 4m 33s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:46:01,015 INFO [loop_until]: Function succeeded after 4m 38s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:46:06,306 INFO [loop_until]: Function succeeded after 4m 44s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:46:11,559 INFO [loop_until]: Function succeeded after 4m 49s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:46:16,807 INFO [loop_until]: Function succeeded after 4m 54s (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:46:22,060 INFO [loop_until]: Function succeeded after 5m (rc=0) - failed to find expected output: WAITING - retry
2024-04-22 04:46:27,316 INFO [loop_until]: Function succeeded after 5m 05s (rc=0) - expected pattern found
2024-04-22 04:46:27,316 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:27,316 DEBUG --- stdout ---
2024-04-22 04:46:27,317 DEBUG WAITING
2024-04-22 04:46:27,317 DEBUG --- stderr ---
2024-04-22 04:46:27,317 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-22 04:46:27] Reporting-authn-users-9000 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-04-22 04:46:27,318 INFO
2024-04-22 04:46:27,318 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:46:27,318 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:27,684 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:27,684 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:27,684 DEBUG --- stdout ---
2024-04-22 04:46:27,684 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:27,684 DEBUG --- stderr ---
2024-04-22 04:46:27,684 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:46:27,685 INFO
2024-04-22 04:46:27,685 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:46:27,685 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:28,007 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:28,007 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:28,007 DEBUG --- stdout ---
2024-04-22 04:46:28,007 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:28,007 DEBUG --- stderr ---
2024-04-22 04:46:28,007 DEBUG
2024-04-22 04:46:28,008 INFO
2024-04-22 04:46:28,008 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-9000.tar.gz" ]; then echo "/results/gatling/authn-users-9000.tar.gz file found"; exit 0; else echo "/results/gatling/authn-users-9000.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/authn-users-9000.tar.gz file found"
2024-04-22 04:46:28,008 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:46:28,918 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:46:28,918 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:28,919 DEBUG --- stdout ---
2024-04-22 04:46:28,919 DEBUG /results/gatling/authn-users-9000.tar.gz file found
2024-04-22 04:46:28,919 DEBUG --- stderr ---
2024-04-22 04:46:28,919 DEBUG
2024-04-22 04:46:28,919 INFO
2024-04-22 04:46:28,919 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:46:28,919 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:29,320 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:29,322 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:29,323 DEBUG --- stdout ---
2024-04-22 04:46:29,323 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:29,323 DEBUG --- stderr ---
2024-04-22 04:46:29,323 DEBUG
2024-04-22 04:46:29,323 INFO
2024-04-22 04:46:29,324 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-9000.tar.gz
2024-04-22 04:46:30,212 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:46:30,212 DEBUG --- stdout ---
2024-04-22 04:46:30,213 DEBUG 228 /results/gatling/authn-users-9000.tar.gz
2024-04-22 04:46:30,213 DEBUG --- stderr ---
2024-04-22 04:46:30,213 DEBUG
2024-04-22 04:46:30,213 INFO
- Download file (size 228k)
2024-04-22 04:46:30,213 INFO
2024-04-22 04:46:30,213 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:46:30,213 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:30,536 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:30,536 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:30,536 DEBUG --- stdout ---
2024-04-22 04:46:30,537 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:30,537 DEBUG --- stderr ---
2024-04-22 04:46:30,537 DEBUG
source : /results/gatling/authn-users-9000.tar.gz @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-9000.tar.gz
2024-04-22 04:46:30,537 INFO
2024-04-22 04:46:30,537 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:46:30,537 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:30,856 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:30,857 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:30,857 DEBUG --- stdout ---
2024-04-22 04:46:30,857 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:30,857 DEBUG --- stderr ---
2024-04-22 04:46:30,857 DEBUG
2024-04-22 04:46:30,857 INFO
2024-04-22 04:46:30,857 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-9000.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-9000.tar.gz
2024-04-22 04:46:30,857 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:46:31,856 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:31,857 DEBUG --- stdout ---
2024-04-22 04:46:31,857 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:46:31,857 DEBUG --- stderr ---
2024-04-22 04:46:31,857 DEBUG
________________________________________________________________________________
[2024-04-22 04:46:31] Reporting-authn-users-9000 step6 : Unzip the result
________________________________________________________________________________
2024-04-22 04:46:31,858 INFO
2024-04-22 04:46:31,858 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-9000.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-9000/gatling
2024-04-22 04:46:31,887 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:46:31,888 DEBUG --- stdout ---
2024-04-22 04:46:31,888 DEBUG
2024-04-22 04:46:31,888 DEBUG --- stderr ---
2024-04-22 04:46:31,888 DEBUG
2024-04-22 04:46:31,888 INFO
________________________________________________________________________________
[2024-04-22 04:46:31] Reporting-authn-users-9000 step7 : Print rc order
________________________________________________________________________________
2024-04-22 04:46:31,889 INFO
2024-04-22 04:46:31,889 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:46:31,889 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:32,212 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:32,212 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:32,212 DEBUG --- stdout ---
2024-04-22 04:46:32,212 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:32,212 DEBUG --- stderr ---
2024-04-22 04:46:32,212 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:46:32,212 INFO
2024-04-22 04:46:32,213 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:46:32,213 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:32,538 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:32,538 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:32,538 DEBUG --- stdout ---
2024-04-22 04:46:32,538 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:32,538 DEBUG --- stderr ---
2024-04-22 04:46:32,538 DEBUG
2024-04-22 04:46:32,539 INFO
2024-04-22 04:46:32,539 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-9000/rc.txt" ]; then echo "/results/orders/Reporting-authn-users-9000/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-9000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-9000/rc.txt file found"
2024-04-22 04:46:32,539 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:46:33,378 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:46:33,378 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:33,378 DEBUG --- stdout ---
2024-04-22 04:46:33,378 DEBUG /results/orders/Reporting-authn-users-9000/rc.txt file found
2024-04-22 04:46:33,378 DEBUG --- stderr ---
2024-04-22 04:46:33,378 DEBUG
2024-04-22 04:46:33,379 INFO
2024-04-22 04:46:33,379 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:46:33,379 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:33,747 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:33,748 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:33,748 DEBUG --- stdout ---
2024-04-22 04:46:33,748 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:33,748 DEBUG --- stderr ---
2024-04-22 04:46:33,748 DEBUG
2024-04-22 04:46:33,748 INFO
2024-04-22 04:46:33,748 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-9000/rc.txt
2024-04-22 04:46:34,605 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:46:34,607 DEBUG --- stdout ---
2024-04-22 04:46:34,607 DEBUG 4 /results/orders/Reporting-authn-users-9000/rc.txt
2024-04-22 04:46:34,608 DEBUG --- stderr ---
2024-04-22 04:46:34,608 DEBUG
2024-04-22 04:46:34,608 INFO
- Download file (size 4k)
2024-04-22 04:46:34,608 INFO
2024-04-22 04:46:34,608 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:46:34,608 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:35,006 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:35,006 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:35,007 DEBUG --- stdout ---
2024-04-22 04:46:35,007 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:35,007 DEBUG --- stderr ---
2024-04-22 04:46:35,007 DEBUG
source : /results/orders/Reporting-authn-users-9000/rc.txt @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/rc.txt
2024-04-22 04:46:35,007 INFO
2024-04-22 04:46:35,007 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:46:35,007 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:35,418 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:35,419 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:35,419 DEBUG --- stdout ---
2024-04-22 04:46:35,419 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:35,419 DEBUG --- stderr ---
2024-04-22 04:46:35,419 DEBUG
2024-04-22 04:46:35,420 INFO
2024-04-22 04:46:35,420 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-9000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/rc.txt
2024-04-22 04:46:35,420 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:46:36,239 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:36,239 DEBUG --- stdout ---
2024-04-22 04:46:36,239 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:46:36,239 DEBUG --- stderr ---
2024-04-22 04:46:36,239 DEBUG
2024-04-22 04:46:36,239 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/rc.txt is small (1 lines), printing all lines:
2024-04-22 04:46:36,239 DEBUG ----- output -----
2024-04-22 04:46:36,239 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-04-22 04:46:36,239 INFO
________________________________________________________________________________
[2024-04-22 04:46:36] Reporting-authn-users-9000 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-04-22 04:46:36] Reporting-authn-users-9000 step9 : Print stdout order
________________________________________________________________________________
2024-04-22 04:46:36,241 INFO
2024-04-22 04:46:36,241 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:46:36,241 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:36,563 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:36,563 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:36,563 DEBUG --- stdout ---
2024-04-22 04:46:36,563 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:36,563 DEBUG --- stderr ---
2024-04-22 04:46:36,563 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:46:36,564 INFO
2024-04-22 04:46:36,564 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:46:36,564 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:36,892 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:36,892 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:36,892 DEBUG --- stdout ---
2024-04-22 04:46:36,892 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:36,892 DEBUG --- stderr ---
2024-04-22 04:46:36,892 DEBUG
2024-04-22 04:46:36,893 INFO
2024-04-22 04:46:36,893 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-9000/stdout.txt" ]; then echo "/results/orders/Reporting-authn-users-9000/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-9000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-9000/stdout.txt file found"
2024-04-22 04:46:36,893 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:46:37,728 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:46:37,729 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:37,729 DEBUG --- stdout ---
2024-04-22 04:46:37,729 DEBUG /results/orders/Reporting-authn-users-9000/stdout.txt file found
2024-04-22 04:46:37,729 DEBUG --- stderr ---
2024-04-22 04:46:37,729 DEBUG
2024-04-22 04:46:37,729 INFO
2024-04-22 04:46:37,729 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:46:37,729 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:38,052 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:38,052 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:38,052 DEBUG --- stdout ---
2024-04-22 04:46:38,052 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:38,052 DEBUG --- stderr ---
2024-04-22 04:46:38,052 DEBUG
2024-04-22 04:46:38,052 INFO
2024-04-22 04:46:38,053 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-9000/stdout.txt
2024-04-22 04:46:38,903 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:46:38,903 DEBUG --- stdout ---
2024-04-22 04:46:38,903 DEBUG 4 /results/orders/Reporting-authn-users-9000/stdout.txt
2024-04-22 04:46:38,903 DEBUG --- stderr ---
2024-04-22 04:46:38,903 DEBUG
2024-04-22 04:46:38,903 INFO
- Download file (size 4k)
2024-04-22 04:46:38,904 INFO
2024-04-22 04:46:38,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:46:38,904 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:39,226 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:39,227 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:39,227 DEBUG --- stdout ---
2024-04-22 04:46:39,227 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:39,227 DEBUG --- stderr ---
2024-04-22 04:46:39,227 DEBUG
source : /results/orders/Reporting-authn-users-9000/stdout.txt @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/stdout.txt
2024-04-22 04:46:39,227 INFO
2024-04-22 04:46:39,227 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:46:39,227 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:39,555 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:39,556 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:39,556 DEBUG --- stdout ---
2024-04-22 04:46:39,556 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:39,556 DEBUG --- stderr ---
2024-04-22 04:46:39,556 DEBUG
2024-04-22 04:46:39,557 INFO
2024-04-22 04:46:39,557 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-9000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/stdout.txt
2024-04-22 04:46:39,557 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:46:40,385 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:40,386 DEBUG --- stdout ---
2024-04-22 04:46:40,386 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:46:40,386 DEBUG --- stderr ---
2024-04-22 04:46:40,386 DEBUG
2024-04-22 04:46:40,386 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/stdout.txt is small (72 lines), printing all lines:
2024-04-22 04:46:40,387 DEBUG ----- output -----
2024-04-22 04:46:40,387 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/authn-users-9000/loadtest-20240422012200629 --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 32524463 (OK=32524463 KO=0 )
> min response time 7 (OK=7 KO=- )
> max response time 1492 (OK=1492 KO=- )
> mean response time 41 (OK=41 KO=- )
> std deviation 43 (OK=43 KO=- )
> response time 50th percentile 32 (OK=32 KO=- )
> response time 75th percentile 51 (OK=51 KO=- )
> response time 95th percentile 91 (OK=91 KO=- )
> response time 99th percentile 127 (OK=127 KO=- )
> mean requests/sec 8957.44 (OK=8957.44 KO=- )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 32486872 (100%)
> 800 ms <= t < 1200 ms 37533 ( 0%)
> t >= 1200 ms 58 ( 0%)
> failed 0 ( 0%)
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/authn-users-9000/loadtest-20240422012200629/index.html
----------------------
[22/Apr/2024 05:46:22] Create tar file /results/gatling/authn-users-9000.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/authn-users-9000/loadtest-20240422012200629
RESULT_FOLDER=authn-users-9000
RESULT_PATH=/results/gatling/authn-users-9000
PWD=/results/gatling/authn-users-9000/loadtest-20240422012200629
[cmd] tar -czvf /results/gatling/authn-users-9000.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:46:40,387 INFO
________________________________________________________________________________
[2024-04-22 04:46:40] Reporting-authn-users-9000 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-04-22 04:46:40] Reporting-authn-users-9000 step11 : Print stderr order
________________________________________________________________________________
2024-04-22 04:46:40,389 INFO
2024-04-22 04:46:40,389 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:46:40,389 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:40,750 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:40,750 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:40,750 DEBUG --- stdout ---
2024-04-22 04:46:40,750 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:40,751 DEBUG --- stderr ---
2024-04-22 04:46:40,752 DEBUG
Checking pod: overseer-0-68c5d5b884-p97w5 for file exists, if not wait.
2024-04-22 04:46:40,752 INFO
2024-04-22 04:46:40,752 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:46:40,753 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:41,149 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:41,150 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:41,150 DEBUG --- stdout ---
2024-04-22 04:46:41,150 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:41,150 DEBUG --- stderr ---
2024-04-22 04:46:41,150 DEBUG
2024-04-22 04:46:41,151 INFO
2024-04-22 04:46:41,151 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-9000/stderr.txt" ]; then echo "/results/orders/Reporting-authn-users-9000/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-9000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-9000/stderr.txt file found"
2024-04-22 04:46:41,151 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-22 04:46:42,049 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-22 04:46:42,049 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:42,049 DEBUG --- stdout ---
2024-04-22 04:46:42,050 DEBUG /results/orders/Reporting-authn-users-9000/stderr.txt file found
2024-04-22 04:46:42,050 DEBUG --- stderr ---
2024-04-22 04:46:42,050 DEBUG
2024-04-22 04:46:42,050 INFO
2024-04-22 04:46:42,050 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:46:42,050 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:42,379 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:42,379 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:42,379 DEBUG --- stdout ---
2024-04-22 04:46:42,379 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:42,379 DEBUG --- stderr ---
2024-04-22 04:46:42,379 DEBUG
2024-04-22 04:46:42,379 INFO
2024-04-22 04:46:42,380 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-9000/stderr.txt
2024-04-22 04:46:43,213 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-22 04:46:43,213 DEBUG --- stdout ---
2024-04-22 04:46:43,213 DEBUG 0 /results/orders/Reporting-authn-users-9000/stderr.txt
2024-04-22 04:46:43,213 DEBUG --- stderr ---
2024-04-22 04:46:43,213 DEBUG
2024-04-22 04:46:43,213 INFO
- Download file (size 0k)
2024-04-22 04:46:43,214 INFO
2024-04-22 04:46:43,214 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:46:43,214 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:43,536 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:43,536 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:43,536 DEBUG --- stdout ---
2024-04-22 04:46:43,536 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:43,536 DEBUG --- stderr ---
2024-04-22 04:46:43,536 DEBUG
source : /results/orders/Reporting-authn-users-9000/stderr.txt @ overseer-0-68c5d5b884-p97w5
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/stderr.txt
2024-04-22 04:46:43,537 INFO
2024-04-22 04:46:43,537 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:46:43,537 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-22 04:46:43,873 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-22 04:46:43,873 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:43,873 DEBUG --- stdout ---
2024-04-22 04:46:43,873 DEBUG overseer-0-68c5d5b884-p97w5
2024-04-22 04:46:43,873 DEBUG --- stderr ---
2024-04-22 04:46:43,874 DEBUG
2024-04-22 04:46:43,874 INFO
2024-04-22 04:46:43,874 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-9000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/stderr.txt
2024-04-22 04:46:43,874 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-22 04:46:44,688 INFO [loop_until]: OK (rc = 0)
2024-04-22 04:46:44,688 DEBUG --- stdout ---
2024-04-22 04:46:44,688 DEBUG tar: Removing leading `/' from member names
2024-04-22 04:46:44,688 DEBUG --- stderr ---
2024-04-22 04:46:44,688 DEBUG
2024-04-22 04:46:44,689 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-9000/stderr.txt is small (0 lines), printing all lines:
2024-04-22 04:46:44,689 DEBUG ----- output -----
2024-04-22 04:46:44,689 DEBUG
2024-04-22 04:46:44,689 INFO
________________________________________________________________________________
[2024-04-22 04:46:44] Reporting-authn-users-9000 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-04-22 04:46:44] Reporting-authn-users-9000 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-22 04:46:44] Reporting-authn-users-9000 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 32524463,
"ok": 32524463,
"ko": 0
},
"minResponseTime": {
"total": 7,
"ok": 7,
"ko": 0
},
"maxResponseTime": {
"total": 1492,
"ok": 1492,
"ko": 0
},
"meanResponseTime": {
"total": 41,
"ok": 41,
"ko": 0
},
"standardDeviation": {
"total": 43,
"ok": 43,
"ko": 0
},
"percentiles1": {
"total": 32,
"ok": 32,
"ko": 0
},
"percentiles2": {
"total": 51,
"ok": 51,
"ko": 0
},
"percentiles3": {
"total": 91,
"ok": 91,
"ko": 0
},
"percentiles4": {
"total": 127,
"ok": 127,
"ko": 0
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 32486872,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 37533,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 58,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 0,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 8957.439548333792,
"ok": 8957.439548333792,
"ko": 0
}
},
"details": [
{
"name": "userRestLogin",
"numberOfRequests": {
"total": 32524463,
"ok": 32524463,
"ko": 0
},
"minResponseTime": {
"total": 7,
"ok": 7,
"ko": 0
},
"maxResponseTime": {
"total": 1492,
"ok": 1492,
"ko": 0
},
"meanResponseTime": {
"total": 41,
"ok": 41,
"ko": 0
},
"standardDeviation": {
"total": 43,
"ok": 43,
"ko": 0
},
"percentiles1": {
"total": 32,
"ok": 32,
"ko": 0
},
"percentiles2": {
"total": 51,
"ok": 51,
"ko": 0
},
"percentiles3": {
"total": 91,
"ok": 91,
"ko": 0
},
"percentiles4": {
"total": 127,
"ok": 127,
"ko": 0
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 32486872,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 37533,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 58,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 0,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 8957.439548333792,
"ok": 8957.439548333792,
"ko": 0
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 8957,
"avg_response_time": 41,
"max_response_time": 1492,
"min_response_time": 7,
"num_requests": 32524463,
"num_requests_pass": 32524463,
"num_requests_percent_pass": 100.0
},
"options": "; testMode:open; testCase:am.AMAuthN; throughput:9000; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 32486872,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 37533,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 58,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 0,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 0,
"ok": 1492,
"total": 1492
},
"meanNumberOfRequestsPerSecond": {
"ko": 0,
"ok": 8957.439548333792,
"total": 8957.439548333792
},
"meanResponseTime": {
"ko": 0,
"ok": 41,
"total": 41
},
"minResponseTime": {
"ko": 0,
"ok": 7,
"total": 7
},
"name": "userRestLogin",
"numberOfRequests": {
"ko": 0,
"ok": 32524463,
"total": 32524463
},
"percentiles1": {
"ko": 0,
"ok": 32,
"total": 32
},
"percentiles2": {
"ko": 0,
"ok": 51,
"total": 51
},
"percentiles3": {
"ko": 0,
"ok": 91,
"total": 91
},
"percentiles4": {
"ko": 0,
"ok": 127,
"total": 127
},
"spikes": [],
"standardDeviation": {
"ko": 0,
"ok": 43,
"total": 43
}
}
],
"global": {
"group1": {
"count": 32486872,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 37533,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 58,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 0,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 0,
"ok": 1492,
"total": 1492
},
"meanNumberOfRequestsPerSecond": {
"ko": 0,
"ok": 8957.439548333792,
"total": 8957.439548333792
},
"meanResponseTime": {
"ko": 0,
"ok": 41,
"total": 41
},
"minResponseTime": {
"ko": 0,
"ok": 7,
"total": 7
},
"name": "All Requests",
"numberOfRequests": {
"ko": 0,
"ok": 32524463,
"total": 32524463
},
"percentiles1": {
"ko": 0,
"ok": 32,
"total": 32
},
"percentiles2": {
"ko": 0,
"ok": 51,
"total": 51
},
"percentiles3": {
"ko": 0,
"ok": 91,
"total": 91
},
"percentiles4": {
"ko": 0,
"ok": 127,
"total": 127
},
"standardDeviation": {
"ko": 0,
"ok": 43,
"total": 43
}
}
},
"target_hostname": "xlou.iam.xlou-cdm.engineeringpit.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-04-22 04:46:44] Reporting-authn-users-9000 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-04-22 04:46:44] Reporting-authn-users-9000 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-9000/stdout.txt
Gatling stdout.txt found, but is small - leave it intact.
________________________________________________________________________________
[2024-04-22 04:46:44] Reporting-authn-users-9000 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped