--Task--
name: Reporting-authn-users-4500
enabled: True
class_name: GatlingResultTask
source_name: overseer-0
source_namespace: >default<
target_name: overseer-0
target_namespace: >default<
start: 0.0
stop: None
timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates bellow
loop: False
interval: None
dependencies: []
wait_for: ['Reporting-authn-users-100', 'Reporting-authn-users-2000', 'Reporting-authn-users-4000']
preceding_task: None
options: {'task_name': 'authn-users-4500'}
group_name: None
Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock
________________________________________________________________________________
[2024-04-13 02:31:50] Reporting-authn-users-4500 pre : N/A
________________________________________________________________________________
source (overseer-0) is a component
[2024-04-13 02:31:50] - INFO: Timeout for this Task has changed to 3h (10800 seconds)
[2024-04-13 02:31:50] - 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-4500/stdout.txt
Pod stderr file : /results/orders/Reporting-authn-users-4500/stderr.txt
Pod log : /results/orders/Reporting-authn-users-4500
________________________________________________________________________________
[2024-04-13 02:31:50] Reporting-authn-users-4500 step1 : Write order for overseer to generate the report
________________________________________________________________________________
2024-04-13 02:31:50,286 INFO
2024-04-13 02:31:50,286 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-13 02:31:50,286 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:31:50,598 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:31:50,599 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:31:50,599 DEBUG --- stdout ---
2024-04-13 02:31:50,599 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:31:50,599 DEBUG --- stderr ---
2024-04-13 02:31:50,599 DEBUG
Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/order.json
{
"name": "Reporting-authn-users-4500",
"command": "/lodestar/clients/gatling-report-only-for-pyrock.sh authn-users-4500 --extra-run-jvm-options \"-Xmx4G\"",
"out-dir": "/results/orders/Reporting-authn-users-4500"
}
________________________________________________________________________________
[2024-04-13 02:31:50] Reporting-authn-users-4500 step2 : Make sure overseer is ready to accept order (not already busy)
________________________________________________________________________________
2024-04-13 02:31:50,600 INFO
2024-04-13 02:31:50,600 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-13 02:31:50,600 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0]
2024-04-13 02:31:50,886 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-13 02:31:50,886 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:31:50,886 DEBUG --- stdout ---
2024-04-13 02:31:50,886 DEBUG WAITING
2024-04-13 02:31:50,887 DEBUG --- stderr ---
2024-04-13 02:31:50,887 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-13 02:31:50] Reporting-authn-users-4500 step3 : Send order to overseer
________________________________________________________________________________
2024-04-13 02:31:50,888 INFO
2024-04-13 02:31:50,888 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-13 02:31:50,888 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:31:51,205 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:31:51,205 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:31:51,205 DEBUG --- stdout ---
2024-04-13 02:31:51,205 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:31:51,205 DEBUG --- stderr ---
2024-04-13 02:31:51,205 DEBUG
2024-04-13 02:31:51,206 INFO
2024-04-13 02:31:51,206 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-4500/order.json overseer-0-59d79dcbf-spbbl:/results/orders/order.json
2024-04-13 02:31:51,206 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-13 02:31:52,609 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:31:52,609 DEBUG --- stdout ---
2024-04-13 02:31:52,609 DEBUG
2024-04-13 02:31:52,609 DEBUG --- stderr ---
2024-04-13 02:31:52,609 DEBUG
Order has been successfully forwarded to overseer
________________________________________________________________________________
[2024-04-13 02:31:52] Reporting-authn-users-4500 step4 : Wait order is done
________________________________________________________________________________
Workaround for PERF-1966. Sleeping for 5 seconds.
2024-04-13 02:31:57,616 INFO
2024-04-13 02:31:57,616 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING"
2024-04-13 02:31:57,616 INFO [loop_until]: (max_time=10800, interval=5, expected_rc=[0]
2024-04-13 02:31:57,855 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:03,122 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:08,377 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:13,623 INFO [loop_until]: Function succeeded after 16s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:18,866 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:24,145 INFO [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:29,392 INFO [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:34,638 INFO [loop_until]: Function succeeded after 37s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:39,882 INFO [loop_until]: Function succeeded after 42s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:45,140 INFO [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:50,394 INFO [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:32:55,707 INFO [loop_until]: Function succeeded after 58s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:00,957 INFO [loop_until]: Function succeeded after 1m 03s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:06,208 INFO [loop_until]: Function succeeded after 1m 08s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:11,451 INFO [loop_until]: Function succeeded after 1m 13s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:16,702 INFO [loop_until]: Function succeeded after 1m 19s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:21,945 INFO [loop_until]: Function succeeded after 1m 24s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:27,270 INFO [loop_until]: Function succeeded after 1m 29s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:32,534 INFO [loop_until]: Function succeeded after 1m 34s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:37,787 INFO [loop_until]: Function succeeded after 1m 40s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:43,041 INFO [loop_until]: Function succeeded after 1m 45s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:48,295 INFO [loop_until]: Function succeeded after 1m 50s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:53,550 INFO [loop_until]: Function succeeded after 1m 55s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:33:58,848 INFO [loop_until]: Function succeeded after 2m 01s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:04,099 INFO [loop_until]: Function succeeded after 2m 06s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:09,343 INFO [loop_until]: Function succeeded after 2m 11s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:14,595 INFO [loop_until]: Function succeeded after 2m 16s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:19,919 INFO [loop_until]: Function succeeded after 2m 22s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:25,172 INFO [loop_until]: Function succeeded after 2m 27s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:30,470 INFO [loop_until]: Function succeeded after 2m 32s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:35,714 INFO [loop_until]: Function succeeded after 2m 38s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:40,977 INFO [loop_until]: Function succeeded after 2m 43s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:46,224 INFO [loop_until]: Function succeeded after 2m 48s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:51,476 INFO [loop_until]: Function succeeded after 2m 53s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:34:56,733 INFO [loop_until]: Function succeeded after 2m 59s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:35:02,022 INFO [loop_until]: Function succeeded after 3m 04s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:35:07,275 INFO [loop_until]: Function succeeded after 3m 09s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:35:12,518 INFO [loop_until]: Function succeeded after 3m 14s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:35:17,795 INFO [loop_until]: Function succeeded after 3m 20s (rc=0) - failed to find expected output: WAITING - retry
2024-04-13 02:35:23,047 INFO [loop_until]: Function succeeded after 3m 25s (rc=0) - expected pattern found
2024-04-13 02:35:23,049 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:23,049 DEBUG --- stdout ---
2024-04-13 02:35:23,049 DEBUG WAITING
2024-04-13 02:35:23,049 DEBUG --- stderr ---
2024-04-13 02:35:23,049 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-13 02:35:23] Reporting-authn-users-4500 step5 : Wait until gatling report is generated on overseer
________________________________________________________________________________
2024-04-13 02:35:23,050 INFO
2024-04-13 02:35:23,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-13 02:35:23,051 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:23,453 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:23,454 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:23,454 DEBUG --- stdout ---
2024-04-13 02:35:23,454 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:23,454 DEBUG --- stderr ---
2024-04-13 02:35:23,454 DEBUG
Checking pod: overseer-0-59d79dcbf-spbbl for file exists, if not wait.
2024-04-13 02:35:23,454 INFO
2024-04-13 02:35:23,454 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-13 02:35:23,455 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:23,806 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:23,807 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:23,807 DEBUG --- stdout ---
2024-04-13 02:35:23,807 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:23,807 DEBUG --- stderr ---
2024-04-13 02:35:23,807 DEBUG
2024-04-13 02:35:23,807 INFO
2024-04-13 02:35:23,807 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- bash -c 'if [ -f "/results/gatling/authn-users-4500.tar.gz" ]; then echo "/results/gatling/authn-users-4500.tar.gz file found"; exit 0; else echo "/results/gatling/authn-users-4500.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/authn-users-4500.tar.gz file found"
2024-04-13 02:35:23,807 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-13 02:35:24,675 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-13 02:35:24,675 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:24,675 DEBUG --- stdout ---
2024-04-13 02:35:24,675 DEBUG /results/gatling/authn-users-4500.tar.gz file found
2024-04-13 02:35:24,675 DEBUG --- stderr ---
2024-04-13 02:35:24,675 DEBUG
2024-04-13 02:35:24,675 INFO
2024-04-13 02:35:24,675 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-13 02:35:24,675 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:24,982 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:24,982 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:24,982 DEBUG --- stdout ---
2024-04-13 02:35:24,983 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:24,983 DEBUG --- stderr ---
2024-04-13 02:35:24,983 DEBUG
2024-04-13 02:35:24,983 INFO
2024-04-13 02:35:24,983 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- du -k /results/gatling/authn-users-4500.tar.gz
2024-04-13 02:35:25,808 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-13 02:35:25,808 DEBUG --- stdout ---
2024-04-13 02:35:25,808 DEBUG 228 /results/gatling/authn-users-4500.tar.gz
2024-04-13 02:35:25,808 DEBUG --- stderr ---
2024-04-13 02:35:25,809 DEBUG
2024-04-13 02:35:25,809 INFO
- Download file (size 228k)
2024-04-13 02:35:25,809 INFO
2024-04-13 02:35:25,809 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-13 02:35:25,809 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:26,120 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:26,121 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:26,121 DEBUG --- stdout ---
2024-04-13 02:35:26,121 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:26,121 DEBUG --- stderr ---
2024-04-13 02:35:26,121 DEBUG
source : /results/gatling/authn-users-4500.tar.gz @ overseer-0-59d79dcbf-spbbl
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-4500.tar.gz
2024-04-13 02:35:26,121 INFO
2024-04-13 02:35:26,121 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-13 02:35:26,121 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:26,431 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:26,431 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:26,431 DEBUG --- stdout ---
2024-04-13 02:35:26,431 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:26,431 DEBUG --- stderr ---
2024-04-13 02:35:26,431 DEBUG
2024-04-13 02:35:26,432 INFO
2024-04-13 02:35:26,432 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59d79dcbf-spbbl:/results/gatling/authn-users-4500.tar.gz /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-4500.tar.gz
2024-04-13 02:35:26,432 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-13 02:35:27,430 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:27,430 DEBUG --- stdout ---
2024-04-13 02:35:27,430 DEBUG tar: Removing leading `/' from member names
2024-04-13 02:35:27,430 DEBUG --- stderr ---
2024-04-13 02:35:27,430 DEBUG
________________________________________________________________________________
[2024-04-13 02:35:27] Reporting-authn-users-4500 step6 : Unzip the result
________________________________________________________________________________
2024-04-13 02:35:27,431 INFO
2024-04-13 02:35:27,431 INFO [run_command]: tar zxf /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/shared/authn-users-4500.tar.gz -C /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-4500/gatling
2024-04-13 02:35:27,467 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-13 02:35:27,467 DEBUG --- stdout ---
2024-04-13 02:35:27,467 DEBUG
2024-04-13 02:35:27,467 DEBUG --- stderr ---
2024-04-13 02:35:27,467 DEBUG
2024-04-13 02:35:27,467 INFO
________________________________________________________________________________
[2024-04-13 02:35:27] Reporting-authn-users-4500 step7 : Print rc order
________________________________________________________________________________
2024-04-13 02:35:27,469 INFO
2024-04-13 02:35:27,469 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-13 02:35:27,469 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:27,784 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:27,784 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:27,784 DEBUG --- stdout ---
2024-04-13 02:35:27,784 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:27,784 DEBUG --- stderr ---
2024-04-13 02:35:27,784 DEBUG
Checking pod: overseer-0-59d79dcbf-spbbl for file exists, if not wait.
2024-04-13 02:35:27,785 INFO
2024-04-13 02:35:27,785 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-13 02:35:27,785 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:28,093 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:28,095 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:28,095 DEBUG --- stdout ---
2024-04-13 02:35:28,095 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:28,095 DEBUG --- stderr ---
2024-04-13 02:35:28,095 DEBUG
2024-04-13 02:35:28,096 INFO
2024-04-13 02:35:28,096 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-4500/rc.txt" ]; then echo "/results/orders/Reporting-authn-users-4500/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-4500/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-4500/rc.txt file found"
2024-04-13 02:35:28,096 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-13 02:35:28,949 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-13 02:35:28,949 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:28,949 DEBUG --- stdout ---
2024-04-13 02:35:28,950 DEBUG /results/orders/Reporting-authn-users-4500/rc.txt file found
2024-04-13 02:35:28,950 DEBUG --- stderr ---
2024-04-13 02:35:28,950 DEBUG
2024-04-13 02:35:28,950 INFO
2024-04-13 02:35:28,950 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-13 02:35:28,950 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:29,332 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:29,332 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:29,332 DEBUG --- stdout ---
2024-04-13 02:35:29,332 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:29,332 DEBUG --- stderr ---
2024-04-13 02:35:29,332 DEBUG
2024-04-13 02:35:29,332 INFO
2024-04-13 02:35:29,332 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- du -k /results/orders/Reporting-authn-users-4500/rc.txt
2024-04-13 02:35:30,207 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-13 02:35:30,208 DEBUG --- stdout ---
2024-04-13 02:35:30,208 DEBUG 4 /results/orders/Reporting-authn-users-4500/rc.txt
2024-04-13 02:35:30,208 DEBUG --- stderr ---
2024-04-13 02:35:30,208 DEBUG
2024-04-13 02:35:30,208 INFO
- Download file (size 4k)
2024-04-13 02:35:30,208 INFO
2024-04-13 02:35:30,208 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-13 02:35:30,208 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:30,520 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:30,520 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:30,520 DEBUG --- stdout ---
2024-04-13 02:35:30,520 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:30,520 DEBUG --- stderr ---
2024-04-13 02:35:30,520 DEBUG
source : /results/orders/Reporting-authn-users-4500/rc.txt @ overseer-0-59d79dcbf-spbbl
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/rc.txt
2024-04-13 02:35:30,520 INFO
2024-04-13 02:35:30,521 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-13 02:35:30,521 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:30,832 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:30,832 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:30,832 DEBUG --- stdout ---
2024-04-13 02:35:30,832 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:30,832 DEBUG --- stderr ---
2024-04-13 02:35:30,832 DEBUG
2024-04-13 02:35:30,832 INFO
2024-04-13 02:35:30,832 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59d79dcbf-spbbl:/results/orders/Reporting-authn-users-4500/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/rc.txt
2024-04-13 02:35:30,833 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-13 02:35:31,581 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:31,581 DEBUG --- stdout ---
2024-04-13 02:35:31,581 DEBUG tar: Removing leading `/' from member names
2024-04-13 02:35:31,581 DEBUG --- stderr ---
2024-04-13 02:35:31,581 DEBUG
2024-04-13 02:35:31,582 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/rc.txt is small (1 lines), printing all lines:
2024-04-13 02:35:31,582 DEBUG ----- output -----
2024-04-13 02:35:31,582 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15])
2024-04-13 02:35:31,582 INFO
________________________________________________________________________________
[2024-04-13 02:35:31] Reporting-authn-users-4500 step8 : Check rc log
________________________________________________________________________________
PASS: no error found in rc log
________________________________________________________________________________
[2024-04-13 02:35:31] Reporting-authn-users-4500 step9 : Print stdout order
________________________________________________________________________________
2024-04-13 02:35:31,583 INFO
2024-04-13 02:35:31,583 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-13 02:35:31,583 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:31,905 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:31,906 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:31,906 DEBUG --- stdout ---
2024-04-13 02:35:31,906 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:31,906 DEBUG --- stderr ---
2024-04-13 02:35:31,906 DEBUG
Checking pod: overseer-0-59d79dcbf-spbbl for file exists, if not wait.
2024-04-13 02:35:31,906 INFO
2024-04-13 02:35:31,906 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1
2024-04-13 02:35:31,906 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:32,233 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:32,234 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:32,234 DEBUG --- stdout ---
2024-04-13 02:35:32,234 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:32,234 DEBUG --- stderr ---
2024-04-13 02:35:32,234 DEBUG
2024-04-13 02:35:32,234 INFO
2024-04-13 02:35:32,235 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-4500/stdout.txt" ]; then echo "/results/orders/Reporting-authn-users-4500/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-4500/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-4500/stdout.txt file found"
2024-04-13 02:35:32,235 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-13 02:35:33,076 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-13 02:35:33,076 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:33,076 DEBUG --- stdout ---
2024-04-13 02:35:33,076 DEBUG /results/orders/Reporting-authn-users-4500/stdout.txt file found
2024-04-13 02:35:33,076 DEBUG --- stderr ---
2024-04-13 02:35:33,076 DEBUG
2024-04-13 02:35:33,077 INFO
2024-04-13 02:35:33,077 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-13 02:35:33,077 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:33,436 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:33,437 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:33,438 DEBUG --- stdout ---
2024-04-13 02:35:33,438 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:33,438 DEBUG --- stderr ---
2024-04-13 02:35:33,438 DEBUG
2024-04-13 02:35:33,438 INFO
2024-04-13 02:35:33,439 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- du -k /results/orders/Reporting-authn-users-4500/stdout.txt
2024-04-13 02:35:34,284 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-13 02:35:34,284 DEBUG --- stdout ---
2024-04-13 02:35:34,284 DEBUG 4 /results/orders/Reporting-authn-users-4500/stdout.txt
2024-04-13 02:35:34,284 DEBUG --- stderr ---
2024-04-13 02:35:34,284 DEBUG
2024-04-13 02:35:34,284 INFO
- Download file (size 4k)
2024-04-13 02:35:34,284 INFO
2024-04-13 02:35:34,284 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-13 02:35:34,285 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:34,639 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:34,639 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:34,639 DEBUG --- stdout ---
2024-04-13 02:35:34,640 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:34,640 DEBUG --- stderr ---
2024-04-13 02:35:34,640 DEBUG
source : /results/orders/Reporting-authn-users-4500/stdout.txt @ overseer-0-59d79dcbf-spbbl
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/stdout.txt
2024-04-13 02:35:34,640 INFO
2024-04-13 02:35:34,640 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-13 02:35:34,640 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:35,024 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:35,024 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:35,024 DEBUG --- stdout ---
2024-04-13 02:35:35,024 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:35,024 DEBUG --- stderr ---
2024-04-13 02:35:35,024 DEBUG
2024-04-13 02:35:35,025 INFO
2024-04-13 02:35:35,025 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59d79dcbf-spbbl:/results/orders/Reporting-authn-users-4500/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/stdout.txt
2024-04-13 02:35:35,025 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-13 02:35:35,835 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:35,836 DEBUG --- stdout ---
2024-04-13 02:35:35,836 DEBUG tar: Removing leading `/' from member names
2024-04-13 02:35:35,836 DEBUG --- stderr ---
2024-04-13 02:35:35,836 DEBUG
2024-04-13 02:35:35,836 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/stdout.txt is small (75 lines), printing all lines:
2024-04-13 02:35:35,836 DEBUG ----- output -----
2024-04-13 02:35:35,836 DEBUG [cmd] /lodestar/clients/gatling/bin/gatling.sh --reports-only /results/gatling/authn-users-4500/loadtest-20240413001824074 --extra-run-jvm-options -Xmx4G
GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling
Generating Gatling reports locally
Parsing log file(s)...
Parsing log file(s) done
Generating reports...
================================================================================
---- Global Information --------------------------------------------------------
> request count 16268085 (OK=16268082 KO=3 )
> min response time 9 (OK=9 KO=10 )
> max response time 1110 (OK=1110 KO=40 )
> mean response time 23 (OK=23 KO=24 )
> std deviation 26 (OK=26 KO=12 )
> response time 50th percentile 16 (OK=16 KO=22 )
> response time 75th percentile 22 (OK=22 KO=31 )
> response time 95th percentile 59 (OK=59 KO=38 )
> response time 99th percentile 125 (OK=125 KO=40 )
> mean requests/sec 4480.332 (OK=4480.331 KO=0.001 )
---- Response Time Distribution ------------------------------------------------
> t < 800 ms 16268029 (100%)
> 800 ms <= t < 1200 ms 53 ( 0%)
> t >= 1200 ms 0 ( 0%)
> failed 3 ( 0%)
---- Errors --------------------------------------------------------------------
> status.find.in(200,201,202,203,204,205,206,207,208,209,304,401 3 (100.0%)
), but actually found 502
================================================================================
Reports generated in 0s.
Please open the following file: file:///results/gatling/authn-users-4500/loadtest-20240413001824074/index.html
----------------------
[13/Apr/2024 03:35:18] Create tar file /results/gatling/authn-users-4500.tar.gz
----------------------
SIMULATION_PATH=/results/gatling/authn-users-4500/loadtest-20240413001824074
RESULT_FOLDER=authn-users-4500
RESULT_PATH=/results/gatling/authn-users-4500
PWD=/results/gatling/authn-users-4500/loadtest-20240413001824074
[cmd] tar -czvf /results/gatling/authn-users-4500.tar.gz --exclude=simulation.log *
index.html
js/
js/stats.js
js/global_stats.json
js/unpack.js
js/all_sessions.js
js/gatling.js
js/assertions.json
js/ellipsis.js
js/menu.js
js/highcharts-more.js
js/highstock.js
js/bootstrap.min.js
js/stats.json
js/assertions.xml
js/jquery-3.5.1.min.js
js/theme.js
req_userrestlogin-03b82.html
style/
style/logo.svg
style/stat-l-roue.png
style/little_arrow_right.png
style/sorted-up.png
style/stat-fleche-bas.png
style/stat-l-temps.png
style/sorted-down.png
style/arrow_down_black.png
style/style.css
style/arrow_right_black.png
style/arrow_right.png
style/favicon.ico
style/bootstrap.min.css
style/logo-enterprise.svg
style/arrow_down.png
style/sortable.png
2024-04-13 02:35:35,836 INFO
________________________________________________________________________________
[2024-04-13 02:35:35] Reporting-authn-users-4500 step10 : Check stdout log
________________________________________________________________________________
PASS: no error found in stdout log
________________________________________________________________________________
[2024-04-13 02:35:35] Reporting-authn-users-4500 step11 : Print stderr order
________________________________________________________________________________
2024-04-13 02:35:35,837 INFO
2024-04-13 02:35:35,838 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-13 02:35:35,838 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:36,182 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:36,182 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:36,183 DEBUG --- stdout ---
2024-04-13 02:35:36,183 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:36,183 DEBUG --- stderr ---
2024-04-13 02:35:36,183 DEBUG
Checking pod: overseer-0-59d79dcbf-spbbl for file exists, if not wait.
2024-04-13 02:35:36,183 INFO
2024-04-13 02:35:36,183 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-13 02:35:36,183 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:36,512 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:36,513 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:36,513 DEBUG --- stdout ---
2024-04-13 02:35:36,513 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:36,513 DEBUG --- stderr ---
2024-04-13 02:35:36,513 DEBUG
2024-04-13 02:35:36,513 INFO
2024-04-13 02:35:36,513 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- bash -c 'if [ -f "/results/orders/Reporting-authn-users-4500/stderr.txt" ]; then echo "/results/orders/Reporting-authn-users-4500/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-authn-users-4500/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-authn-users-4500/stderr.txt file found"
2024-04-13 02:35:36,514 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0]
2024-04-13 02:35:37,360 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found
2024-04-13 02:35:37,360 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:37,360 DEBUG --- stdout ---
2024-04-13 02:35:37,360 DEBUG /results/orders/Reporting-authn-users-4500/stderr.txt file found
2024-04-13 02:35:37,360 DEBUG --- stderr ---
2024-04-13 02:35:37,360 DEBUG
2024-04-13 02:35:37,360 INFO
2024-04-13 02:35:37,360 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-13 02:35:37,360 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:37,673 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:37,673 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:37,673 DEBUG --- stdout ---
2024-04-13 02:35:37,673 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:37,673 DEBUG --- stderr ---
2024-04-13 02:35:37,673 DEBUG
2024-04-13 02:35:37,674 INFO
2024-04-13 02:35:37,674 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59d79dcbf-spbbl --stdin -- du -k /results/orders/Reporting-authn-users-4500/stderr.txt
2024-04-13 02:35:38,496 INFO [run_command]: OK (rc = 0 - expected to be in [0])
2024-04-13 02:35:38,498 DEBUG --- stdout ---
2024-04-13 02:35:38,498 DEBUG 0 /results/orders/Reporting-authn-users-4500/stderr.txt
2024-04-13 02:35:38,498 DEBUG --- stderr ---
2024-04-13 02:35:38,498 DEBUG
2024-04-13 02:35:38,498 INFO
- Download file (size 0k)
2024-04-13 02:35:38,499 INFO
2024-04-13 02:35:38,499 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-13 02:35:38,499 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:38,810 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:38,811 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:38,811 DEBUG --- stdout ---
2024-04-13 02:35:38,811 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:38,811 DEBUG --- stderr ---
2024-04-13 02:35:38,811 DEBUG
source : /results/orders/Reporting-authn-users-4500/stderr.txt @ overseer-0-59d79dcbf-spbbl
destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/stderr.txt
2024-04-13 02:35:38,811 INFO
2024-04-13 02:35:38,812 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-13 02:35:38,812 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0]
2024-04-13 02:35:39,179 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found
2024-04-13 02:35:39,179 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:39,179 DEBUG --- stdout ---
2024-04-13 02:35:39,179 DEBUG overseer-0-59d79dcbf-spbbl
2024-04-13 02:35:39,180 DEBUG --- stderr ---
2024-04-13 02:35:39,180 DEBUG
2024-04-13 02:35:39,180 INFO
2024-04-13 02:35:39,180 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59d79dcbf-spbbl:/results/orders/Reporting-authn-users-4500/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/stderr.txt
2024-04-13 02:35:39,180 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0]
2024-04-13 02:35:40,002 INFO [loop_until]: OK (rc = 0)
2024-04-13 02:35:40,002 DEBUG --- stdout ---
2024-04-13 02:35:40,002 DEBUG tar: Removing leading `/' from member names
2024-04-13 02:35:40,003 DEBUG --- stderr ---
2024-04-13 02:35:40,003 DEBUG
2024-04-13 02:35:40,003 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/08_Verification/12_Reporting-authn-users-4500/stderr.txt is small (0 lines), printing all lines:
2024-04-13 02:35:40,003 DEBUG ----- output -----
2024-04-13 02:35:40,003 DEBUG
2024-04-13 02:35:40,003 INFO
________________________________________________________________________________
[2024-04-13 02:35:40] Reporting-authn-users-4500 step12 : Check stderr log
________________________________________________________________________________
PASS: no error found in stderr log
________________________________________________________________________________
[2024-04-13 02:35:40] Reporting-authn-users-4500 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-13 02:35:40] Reporting-authn-users-4500 step14 : Collect Gatling simulation data
________________________________________________________________________________
collected stats :
{
"global": {
"name": "All Requests",
"numberOfRequests": {
"total": 16268085,
"ok": 16268082,
"ko": 3
},
"minResponseTime": {
"total": 9,
"ok": 9,
"ko": 10
},
"maxResponseTime": {
"total": 1110,
"ok": 1110,
"ko": 40
},
"meanResponseTime": {
"total": 23,
"ok": 23,
"ko": 24
},
"standardDeviation": {
"total": 26,
"ok": 26,
"ko": 12
},
"percentiles1": {
"total": 16,
"ok": 16,
"ko": 22
},
"percentiles2": {
"total": 22,
"ok": 22,
"ko": 31
},
"percentiles3": {
"total": 59,
"ok": 59,
"ko": 38
},
"percentiles4": {
"total": 125,
"ok": 125,
"ko": 40
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 16268029,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 53,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 3,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 4480.331864500137,
"ok": 4480.331038281465,
"ko": 0.0008262186725419994
}
},
"details": [
{
"name": "userRestLogin",
"numberOfRequests": {
"total": 16268085,
"ok": 16268082,
"ko": 3
},
"minResponseTime": {
"total": 9,
"ok": 9,
"ko": 10
},
"maxResponseTime": {
"total": 1110,
"ok": 1110,
"ko": 40
},
"meanResponseTime": {
"total": 23,
"ok": 23,
"ko": 24
},
"standardDeviation": {
"total": 26,
"ok": 26,
"ko": 12
},
"percentiles1": {
"total": 16,
"ok": 16,
"ko": 22
},
"percentiles2": {
"total": 22,
"ok": 22,
"ko": 31
},
"percentiles3": {
"total": 59,
"ok": 59,
"ko": 38
},
"percentiles4": {
"total": 125,
"ok": 125,
"ko": 40
},
"group1": {
"name": "t < 800 ms",
"htmlName": "t < 800 ms",
"count": 16268029,
"percentage": 100
},
"group2": {
"name": "800 ms <= t < 1200 ms",
"htmlName": "t >= 800 ms
t < 1200 ms",
"count": 53,
"percentage": 0
},
"group3": {
"name": "t >= 1200 ms",
"htmlName": "t >= 1200 ms",
"count": 0,
"percentage": 0
},
"group4": {
"name": "failed",
"htmlName": "failed",
"count": 3,
"percentage": 0
},
"meanNumberOfRequestsPerSecond": {
"total": 4480.331864500137,
"ok": 4480.331038281465,
"ko": 0.0008262186725419994
},
"spikes": []
}
]
}
{
"concurrency": null,
"generic_stats": {
"avg_num_of_requests_per_second": 4480,
"avg_response_time": 23,
"max_response_time": 1110,
"min_response_time": 9,
"num_requests": 16268085,
"num_requests_pass": 16268082,
"num_requests_percent_pass": 100.0
},
"options": "; testMode:open; testCase:am.AMAuthN; throughput:4500; duration:3600",
"stats": {
"details": [
{
"group1": {
"count": 16268029,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 53,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 0,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 3,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 40,
"ok": 1110,
"total": 1110
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.0008262186725419994,
"ok": 4480.331038281465,
"total": 4480.331864500137
},
"meanResponseTime": {
"ko": 24,
"ok": 23,
"total": 23
},
"minResponseTime": {
"ko": 10,
"ok": 9,
"total": 9
},
"name": "userRestLogin",
"numberOfRequests": {
"ko": 3,
"ok": 16268082,
"total": 16268085
},
"percentiles1": {
"ko": 22,
"ok": 16,
"total": 16
},
"percentiles2": {
"ko": 31,
"ok": 22,
"total": 22
},
"percentiles3": {
"ko": 38,
"ok": 59,
"total": 59
},
"percentiles4": {
"ko": 40,
"ok": 125,
"total": 125
},
"spikes": [],
"standardDeviation": {
"ko": 12,
"ok": 26,
"total": 26
}
}
],
"global": {
"group1": {
"count": 16268029,
"htmlName": "t < 800 ms",
"name": "t < 800 ms",
"percentage": 100
},
"group2": {
"count": 53,
"htmlName": "t >= 800 ms
t < 1200 ms",
"name": "800 ms <= t < 1200 ms",
"percentage": 0
},
"group3": {
"count": 0,
"htmlName": "t >= 1200 ms",
"name": "t >= 1200 ms",
"percentage": 0
},
"group4": {
"count": 3,
"htmlName": "failed",
"name": "failed",
"percentage": 0
},
"maxResponseTime": {
"ko": 40,
"ok": 1110,
"total": 1110
},
"meanNumberOfRequestsPerSecond": {
"ko": 0.0008262186725419994,
"ok": 4480.331038281465,
"total": 4480.331864500137
},
"meanResponseTime": {
"ko": 24,
"ok": 23,
"total": 23
},
"minResponseTime": {
"ko": 10,
"ok": 9,
"total": 9
},
"name": "All Requests",
"numberOfRequests": {
"ko": 3,
"ok": 16268082,
"total": 16268085
},
"percentiles1": {
"ko": 22,
"ok": 16,
"total": 16
},
"percentiles2": {
"ko": 31,
"ok": 22,
"total": 22
},
"percentiles3": {
"ko": 38,
"ok": 59,
"total": 59
},
"percentiles4": {
"ko": 40,
"ok": 125,
"total": 125
},
"standardDeviation": {
"ko": 12,
"ok": 26,
"total": 26
}
}
},
"target_hostname": "xlou.iam.xlou-cdm.engineeringpit.com",
"tool_name": "gatling"
}
________________________________________________________________________________
[2024-04-13 02:35:40] Reporting-authn-users-4500 step15 : Update run description in the Gatling HTML report
________________________________________________________________________________
________________________________________________________________________________
[2024-04-13 02:35:40] Reporting-authn-users-4500 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-4500/stdout.txt
Gatling stdout.txt found, but is small - leave it intact.
________________________________________________________________________________
[2024-04-13 02:35:40] Reporting-authn-users-4500 post : Check output
________________________________________________________________________________
Setting result to PASS
Task has been successfully stopped