--Task-- name: authn-users-8000 enabled: True class_name: GatlingTask source_name: overseer-0 source_namespace: >default< target_name: am 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: ['authn-users-7500'] preceding_task: authn-users-7500 options: {'testMode': 'open', 'testCase': 'am.AMAuthN', 'throughput': 8000, 'duration': 3600} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-04-20 02:21:48] authn-users-8000 pre : N/A ________________________________________________________________________________ [2024-04-20 02:21:48] - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) [2024-04-20 02:21:48] - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/authn-users-8000/stdout.txt Pod log : /results/orders/authn-users-8000 2024-04-20 02:21:48,323 INFO 2024-04-20 02:21:48,323 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 02:21:48,323 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 02:21:48,624 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 02:21:48,624 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:21:48,624 DEBUG --- stdout --- 2024-04-20 02:21:48,624 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 02:21:48,624 DEBUG --- stderr --- 2024-04-20 02:21:48,624 DEBUG ________________________________________________________________________________ [2024-04-20 02:21:48] authn-users-8000 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-04-20 02:21:48,625 INFO 2024-04-20 02:21:48,625 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 02:21:48,625 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 02:21:48,932 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 02:21:48,932 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:21:48,932 DEBUG --- stdout --- 2024-04-20 02:21:48,932 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 02:21:48,932 DEBUG --- stderr --- 2024-04-20 02:21:48,932 DEBUG /lodestar/clients/gatling-for-pyrock.sh --run-mode local --simulation com.forgerock.gatling.Loadtest --simulations-folder /lodestar/pyrock/shared/clients/gatling-open/ --run-description "am.AMAuthN@medium" --results-folder /results/gatling/authn-users-8000 --extra-run-jvm-options "-Xmx4G" --no-reports ________________________________________________________________________________ [2024-04-20 02:21:48] authn-users-8000 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-04-20 02:21:48,933 INFO 2024-04-20 02:21:48,933 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 02:21:48,933 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 02:21:49,230 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 02:21:49,231 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:21:49,231 DEBUG --- stdout --- 2024-04-20 02:21:49,231 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 02:21:49,231 DEBUG --- stderr --- 2024-04-20 02:21:49,231 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/order.json { "name": "authn-users-8000", "command": " /lodestar/clients/gatling-for-pyrock.sh --run-mode local --simulation com.forgerock.gatling.Loadtest --simulations-folder /lodestar/pyrock/shared/clients/gatling-open/ --run-description \"am.AMAuthN@medium\" --results-folder /results/gatling/authn-users-8000 --extra-run-jvm-options \"-Xmx4G\" --no-reports", "out-dir": "/results/orders/authn-users-8000", "environment": { "JAVA_OPTS": "-Dam_host=xlou.iam.xlou-cdm.engineeringpit.com -DamadminPassword=**** -DamadminUsername=amadmin -Dduration=3600 -Dnum_users=1000000 -DtestCase=am.AMAuthN -DtestMode=open -Dthroughput=8000 -Duser_password=T35tr0ck123" } } ________________________________________________________________________________ [2024-04-20 02:21:49] authn-users-8000 loop_until_ready : Wait for preceding task to finish if it uses same Overseer as a source, then loop for max_time until Overseer pod status is READY to accept order :param max_time: periodically check overseer status for this many seconds at maximum :param interval: interval between two periodical checks :return: ________________________________________________________________________________ 2024-04-20 02:21:49,232 INFO 2024-04-20 02:21:49,232 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-04-20 02:21:49,232 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-20 02:21:49,462 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-20 02:21:49,462 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:21:49,462 DEBUG --- stdout --- 2024-04-20 02:21:49,463 DEBUG WAITING 2024-04-20 02:21:49,463 DEBUG --- stderr --- 2024-04-20 02:21:49,463 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-20 02:21:49] authn-users-8000 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-04-20 02:21:49,464 INFO 2024-04-20 02:21:49,464 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 02:21:49,464 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 02:21:49,856 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 02:21:49,856 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:21:49,856 DEBUG --- stdout --- 2024-04-20 02:21:49,856 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 02:21:49,856 DEBUG --- stderr --- 2024-04-20 02:21:49,856 DEBUG 2024-04-20 02:21:49,857 INFO 2024-04-20 02:21:49,857 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/07_Scenario_AuthN/06_authn-users-8000/order.json overseer-0-5c67bf94db-77mh9:/results/orders/order.json 2024-04-20 02:21:49,857 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-20 02:21:51,269 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:21:51,270 DEBUG --- stdout --- 2024-04-20 02:21:51,270 DEBUG 2024-04-20 02:21:51,270 DEBUG --- stderr --- 2024-04-20 02:21:51,270 DEBUG Order has been successfully forwarded to overseer [2024-04-20 02:21:51] - INFO: Check if Gatling simulation started successfully 2024-04-20 02:21:51,270 INFO 2024-04-20 02:21:51,270 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 02:21:51,270 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 02:21:51,605 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 02:21:51,606 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:21:51,606 DEBUG --- stdout --- 2024-04-20 02:21:51,606 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 02:21:51,606 DEBUG --- stderr --- 2024-04-20 02:21:51,606 DEBUG 2024-04-20 02:21:51,606 INFO 2024-04-20 02:21:51,606 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 -- head -n 25 /results/orders/authn-users-8000/stdout.txt | grep "started..." 2024-04-20 02:21:51,606 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-20 02:21:52,383 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-04-20 02:21:58,164 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: started... - retry 2024-04-20 02:22:03,932 INFO [loop_until]: Function succeeded after 12s (rc=0) - expected pattern found 2024-04-20 02:22:03,932 INFO [loop_until]: OK (rc = 0) 2024-04-20 02:22:03,932 DEBUG --- stdout --- 2024-04-20 02:22:03,932 DEBUG GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling Gatling 3.10.5 is available! (you're using 3.9.5) Simulation com.forgerock.gatling.Loadtest started... 2024-04-20 02:22:03,932 DEBUG --- stderr --- 2024-04-20 02:22:03,932 DEBUG ________________________________________________________________________________ [2024-04-20 02:22:03] authn-users-8000 wait_stop_by_itself : Wait for the order to stop by itself ________________________________________________________________________________ Task may stop by itself (no stop defined in configuration file), wait until overseer ends the order - timeout is 1h 12m Waiting for status (curl --fail --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt) == WAITING Order is running since 2m, retry Order is running since 4m, retry Order is running since 6m, retry Order is running since 8m 01s, retry Order is running since 10m 01s, retry Order is running since 12m 02s, retry Order is running since 14m 02s, retry Order is running since 16m 02s, retry Order is running since 18m 03s, retry Order is running since 20m 03s, retry Order is running since 22m 04s, retry Order is running since 24m 04s, retry Order is running since 26m 04s, retry Order is running since 28m 05s, retry Order is running since 30m 05s, retry Order is running since 32m 05s, retry Order is running since 34m 06s, retry Order is running since 36m 06s, retry Order is running since 38m 07s, retry Order is running since 40m 07s, retry Order is running since 42m 07s, retry Order is running since 44m 08s, retry Order is running since 46m 08s, retry Order is running since 48m 08s, retry Order is running since 50m 09s, retry Order is running since 52m 09s, retry Order is running since 54m 09s, retry Order is running since 56m 10s, retry Order is running since 58m 10s, retry Order is running since 1h, retry PASS : Order stopped by itself after 1h 02m and before timeout (1h 12m) ________________________________________________________________________________ [2024-04-20 03:24:15] authn-users-8000 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-04-20 03:24:15,477 INFO 2024-04-20 03:24:15,478 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:15,478 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:15,855 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:15,855 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:15,855 DEBUG --- stdout --- 2024-04-20 03:24:15,855 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:15,855 DEBUG --- stderr --- 2024-04-20 03:24:15,855 DEBUG 2024-04-20 03:24:15,856 INFO 2024-04-20 03:24:15,856 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 -- rm -f /results/orders/order.json 2024-04-20 03:24:15,856 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-20 03:24:16,728 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:16,728 DEBUG --- stdout --- 2024-04-20 03:24:16,729 DEBUG 2024-04-20 03:24:16,729 DEBUG --- stderr --- 2024-04-20 03:24:16,729 DEBUG Order ran during 1h 02m ________________________________________________________________________________ [2024-04-20 03:24:16] authn-users-8000 download_logs : Download individual order files ________________________________________________________________________________ [2024-04-20 03:24:16] - PASS: file already downloaded /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/order.json 2024-04-20 03:24:16,730 INFO 2024-04-20 03:24:16,730 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:16,730 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:17,055 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:17,056 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:17,056 DEBUG --- stdout --- 2024-04-20 03:24:17,056 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:17,056 DEBUG --- stderr --- 2024-04-20 03:24:17,056 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-20 03:24:17,056 INFO 2024-04-20 03:24:17,056 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:17,057 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:17,387 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:17,387 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:17,387 DEBUG --- stdout --- 2024-04-20 03:24:17,387 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:17,387 DEBUG --- stderr --- 2024-04-20 03:24:17,387 DEBUG 2024-04-20 03:24:17,388 INFO 2024-04-20 03:24:17,388 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/orders/authn-users-8000/rc.txt" ]; then echo "/results/orders/authn-users-8000/rc.txt file found"; exit 0; else echo "/results/orders/authn-users-8000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-8000/rc.txt file found" 2024-04-20 03:24:17,388 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-20 03:24:18,231 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-20 03:24:18,231 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:18,231 DEBUG --- stdout --- 2024-04-20 03:24:18,231 DEBUG /results/orders/authn-users-8000/rc.txt file found 2024-04-20 03:24:18,231 DEBUG --- stderr --- 2024-04-20 03:24:18,231 DEBUG 2024-04-20 03:24:18,232 INFO 2024-04-20 03:24:18,232 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:18,232 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:18,533 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:18,533 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:18,534 DEBUG --- stdout --- 2024-04-20 03:24:18,534 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:18,534 DEBUG --- stderr --- 2024-04-20 03:24:18,534 DEBUG 2024-04-20 03:24:18,534 INFO 2024-04-20 03:24:18,534 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/orders/authn-users-8000/rc.txt 2024-04-20 03:24:19,344 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-20 03:24:19,344 DEBUG --- stdout --- 2024-04-20 03:24:19,344 DEBUG 4 /results/orders/authn-users-8000/rc.txt 2024-04-20 03:24:19,344 DEBUG --- stderr --- 2024-04-20 03:24:19,344 DEBUG 2024-04-20 03:24:19,344 INFO - Download file (size 4k) 2024-04-20 03:24:19,345 INFO 2024-04-20 03:24:19,345 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:19,345 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:19,645 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:19,645 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:19,645 DEBUG --- stdout --- 2024-04-20 03:24:19,645 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:19,645 DEBUG --- stderr --- 2024-04-20 03:24:19,645 DEBUG source : /results/orders/authn-users-8000/rc.txt @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/rc.txt 2024-04-20 03:24:19,645 INFO 2024-04-20 03:24:19,645 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:19,645 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:19,944 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:19,944 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:19,944 DEBUG --- stdout --- 2024-04-20 03:24:19,944 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:19,944 DEBUG --- stderr --- 2024-04-20 03:24:19,944 DEBUG 2024-04-20 03:24:19,945 INFO 2024-04-20 03:24:19,945 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/orders/authn-users-8000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/rc.txt 2024-04-20 03:24:19,945 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-20 03:24:20,685 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:20,685 DEBUG --- stdout --- 2024-04-20 03:24:20,685 DEBUG tar: Removing leading `/' from member names 2024-04-20 03:24:20,685 DEBUG --- stderr --- 2024-04-20 03:24:20,685 DEBUG 2024-04-20 03:24:20,686 INFO 2024-04-20 03:24:20,686 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:20,686 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:21,052 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:21,052 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:21,052 DEBUG --- stdout --- 2024-04-20 03:24:21,052 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:21,052 DEBUG --- stderr --- 2024-04-20 03:24:21,052 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-20 03:24:21,053 INFO 2024-04-20 03:24:21,053 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:21,053 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:21,417 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:21,417 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:21,417 DEBUG --- stdout --- 2024-04-20 03:24:21,417 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:21,417 DEBUG --- stderr --- 2024-04-20 03:24:21,417 DEBUG 2024-04-20 03:24:21,418 INFO 2024-04-20 03:24:21,418 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/orders/authn-users-8000/stderr.txt" ]; then echo "/results/orders/authn-users-8000/stderr.txt file found"; exit 0; else echo "/results/orders/authn-users-8000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-8000/stderr.txt file found" 2024-04-20 03:24:21,418 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-20 03:24:22,260 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-20 03:24:22,261 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:22,262 DEBUG --- stdout --- 2024-04-20 03:24:22,262 DEBUG /results/orders/authn-users-8000/stderr.txt file found 2024-04-20 03:24:22,262 DEBUG --- stderr --- 2024-04-20 03:24:22,262 DEBUG 2024-04-20 03:24:22,263 INFO 2024-04-20 03:24:22,263 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:22,263 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:22,631 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:22,631 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:22,631 DEBUG --- stdout --- 2024-04-20 03:24:22,631 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:22,631 DEBUG --- stderr --- 2024-04-20 03:24:22,631 DEBUG 2024-04-20 03:24:22,631 INFO 2024-04-20 03:24:22,632 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/orders/authn-users-8000/stderr.txt 2024-04-20 03:24:23,523 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-20 03:24:23,523 DEBUG --- stdout --- 2024-04-20 03:24:23,523 DEBUG 0 /results/orders/authn-users-8000/stderr.txt 2024-04-20 03:24:23,524 DEBUG --- stderr --- 2024-04-20 03:24:23,524 DEBUG 2024-04-20 03:24:23,524 INFO - Download file (size 0k) 2024-04-20 03:24:23,524 INFO 2024-04-20 03:24:23,524 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:23,524 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:23,846 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:23,846 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:23,846 DEBUG --- stdout --- 2024-04-20 03:24:23,846 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:23,846 DEBUG --- stderr --- 2024-04-20 03:24:23,846 DEBUG source : /results/orders/authn-users-8000/stderr.txt @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/stderr.txt 2024-04-20 03:24:23,847 INFO 2024-04-20 03:24:23,847 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:23,847 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:24,161 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:24,162 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:24,162 DEBUG --- stdout --- 2024-04-20 03:24:24,162 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:24,162 DEBUG --- stderr --- 2024-04-20 03:24:24,162 DEBUG 2024-04-20 03:24:24,162 INFO 2024-04-20 03:24:24,162 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/orders/authn-users-8000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/stderr.txt 2024-04-20 03:24:24,162 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-20 03:24:24,924 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:24,924 DEBUG --- stdout --- 2024-04-20 03:24:24,924 DEBUG tar: Removing leading `/' from member names 2024-04-20 03:24:24,924 DEBUG --- stderr --- 2024-04-20 03:24:24,924 DEBUG 2024-04-20 03:24:24,925 INFO 2024-04-20 03:24:24,925 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:24,925 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:25,240 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:25,241 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:25,241 DEBUG --- stdout --- 2024-04-20 03:24:25,241 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:25,241 DEBUG --- stderr --- 2024-04-20 03:24:25,241 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-20 03:24:25,241 INFO 2024-04-20 03:24:25,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-20 03:24:25,241 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:25,557 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:25,558 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:25,558 DEBUG --- stdout --- 2024-04-20 03:24:25,558 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:25,558 DEBUG --- stderr --- 2024-04-20 03:24:25,558 DEBUG 2024-04-20 03:24:25,559 INFO 2024-04-20 03:24:25,559 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/orders/authn-users-8000/stdout.txt" ]; then echo "/results/orders/authn-users-8000/stdout.txt file found"; exit 0; else echo "/results/orders/authn-users-8000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-8000/stdout.txt file found" 2024-04-20 03:24:25,559 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-20 03:24:26,381 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-20 03:24:26,382 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:26,382 DEBUG --- stdout --- 2024-04-20 03:24:26,382 DEBUG /results/orders/authn-users-8000/stdout.txt file found 2024-04-20 03:24:26,382 DEBUG --- stderr --- 2024-04-20 03:24:26,382 DEBUG 2024-04-20 03:24:26,382 INFO 2024-04-20 03:24:26,383 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:26,383 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:26,704 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:26,704 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:26,704 DEBUG --- stdout --- 2024-04-20 03:24:26,704 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:26,704 DEBUG --- stderr --- 2024-04-20 03:24:26,704 DEBUG 2024-04-20 03:24:26,704 INFO 2024-04-20 03:24:26,705 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/orders/authn-users-8000/stdout.txt 2024-04-20 03:24:27,593 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-20 03:24:27,595 DEBUG --- stdout --- 2024-04-20 03:24:27,595 DEBUG 508 /results/orders/authn-users-8000/stdout.txt 2024-04-20 03:24:27,595 DEBUG --- stderr --- 2024-04-20 03:24:27,595 DEBUG 2024-04-20 03:24:27,595 INFO - Download file (size 508k) 2024-04-20 03:24:27,596 INFO 2024-04-20 03:24:27,596 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:27,596 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:27,934 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:27,934 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:27,935 DEBUG --- stdout --- 2024-04-20 03:24:27,935 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:27,935 DEBUG --- stderr --- 2024-04-20 03:24:27,935 DEBUG source : /results/orders/authn-users-8000/stdout.txt @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/stdout.txt 2024-04-20 03:24:27,935 INFO 2024-04-20 03:24:27,935 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:27,935 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:28,332 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:28,332 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:28,333 DEBUG --- stdout --- 2024-04-20 03:24:28,333 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:28,333 DEBUG --- stderr --- 2024-04-20 03:24:28,333 DEBUG 2024-04-20 03:24:28,334 INFO 2024-04-20 03:24:28,334 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/orders/authn-users-8000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/stdout.txt 2024-04-20 03:24:28,334 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-20 03:24:29,483 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:29,484 DEBUG --- stdout --- 2024-04-20 03:24:29,484 DEBUG tar: Removing leading `/' from member names 2024-04-20 03:24:29,484 DEBUG --- stderr --- 2024-04-20 03:24:29,484 DEBUG ________________________________________________________________________________ [2024-04-20 03:24:29] authn-users-8000 show_cmd : Display order command ________________________________________________________________________________ 2024-04-20 03:24:29,484 INFO 2024-04-20 03:24:29,484 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:29,484 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:29,801 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:29,801 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:29,802 DEBUG --- stdout --- 2024-04-20 03:24:29,802 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:29,802 DEBUG --- stderr --- 2024-04-20 03:24:29,802 DEBUG Checking pod: overseer-0-5c67bf94db-77mh9 for file exists, if not wait. 2024-04-20 03:24:29,802 INFO 2024-04-20 03:24:29,802 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:29,802 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:30,119 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:30,119 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:30,119 DEBUG --- stdout --- 2024-04-20 03:24:30,119 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:30,119 DEBUG --- stderr --- 2024-04-20 03:24:30,119 DEBUG 2024-04-20 03:24:30,120 INFO 2024-04-20 03:24:30,120 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- bash -c 'if [ -f "/results/orders/authn-users-8000/cmd.txt" ]; then echo "/results/orders/authn-users-8000/cmd.txt file found"; exit 0; else echo "/results/orders/authn-users-8000/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-8000/cmd.txt file found" 2024-04-20 03:24:30,120 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-20 03:24:30,950 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-20 03:24:30,950 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:30,950 DEBUG --- stdout --- 2024-04-20 03:24:30,950 DEBUG /results/orders/authn-users-8000/cmd.txt file found 2024-04-20 03:24:30,950 DEBUG --- stderr --- 2024-04-20 03:24:30,950 DEBUG 2024-04-20 03:24:30,950 INFO 2024-04-20 03:24:30,951 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:30,951 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:31,265 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:31,266 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:31,266 DEBUG --- stdout --- 2024-04-20 03:24:31,266 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:31,266 DEBUG --- stderr --- 2024-04-20 03:24:31,266 DEBUG 2024-04-20 03:24:31,266 INFO 2024-04-20 03:24:31,266 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5c67bf94db-77mh9 --stdin -- du -k /results/orders/authn-users-8000/cmd.txt 2024-04-20 03:24:32,095 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-20 03:24:32,095 DEBUG --- stdout --- 2024-04-20 03:24:32,095 DEBUG 4 /results/orders/authn-users-8000/cmd.txt 2024-04-20 03:24:32,095 DEBUG --- stderr --- 2024-04-20 03:24:32,095 DEBUG 2024-04-20 03:24:32,095 INFO - Download file (size 4k) 2024-04-20 03:24:32,096 INFO 2024-04-20 03:24:32,096 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:32,096 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:32,413 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:32,414 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:32,414 DEBUG --- stdout --- 2024-04-20 03:24:32,414 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:32,414 DEBUG --- stderr --- 2024-04-20 03:24:32,414 DEBUG source : /results/orders/authn-users-8000/cmd.txt @ overseer-0-5c67bf94db-77mh9 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/cmd.txt 2024-04-20 03:24:32,415 INFO 2024-04-20 03:24:32,415 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-20 03:24:32,415 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-20 03:24:32,757 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-20 03:24:32,759 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:32,759 DEBUG --- stdout --- 2024-04-20 03:24:32,759 DEBUG overseer-0-5c67bf94db-77mh9 2024-04-20 03:24:32,759 DEBUG --- stderr --- 2024-04-20 03:24:32,759 DEBUG 2024-04-20 03:24:32,760 INFO 2024-04-20 03:24:32,760 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5c67bf94db-77mh9:/results/orders/authn-users-8000/cmd.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/cmd.txt 2024-04-20 03:24:32,760 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-20 03:24:33,555 INFO [loop_until]: OK (rc = 0) 2024-04-20 03:24:33,555 DEBUG --- stdout --- 2024-04-20 03:24:33,555 DEBUG tar: Removing leading `/' from member names 2024-04-20 03:24:33,555 DEBUG --- stderr --- 2024-04-20 03:24:33,555 DEBUG 2024-04-20 03:24:33,556 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/cmd.txt is small (1 lines), printing all lines: 2024-04-20 03:24:33,556 DEBUG ----- output ----- 2024-04-20 03:24:33,556 DEBUG /lodestar/clients/gatling-for-pyrock.sh --run-mode local --simulation com.forgerock.gatling.Loadtest --simulations-folder /lodestar/pyrock/shared/clients/gatling-open/ --run-description "am.AMAuthN@medium" --results-folder /results/gatling/authn-users-8000 --extra-run-jvm-options "-Xmx4G" --no-reports 2024-04-20 03:24:33,556 INFO ________________________________________________________________________________ [2024-04-20 03:24:33] authn-users-8000 show_rc : Display rc order ________________________________________________________________________________ 2024-04-20 03:24:33,556 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/rc.txt is small (1 lines), printing all lines: 2024-04-20 03:24:33,556 DEBUG ----- output ----- 2024-04-20 03:24:33,556 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-04-20 03:24:33,556 INFO ________________________________________________________________________________ [2024-04-20 03:24:33] authn-users-8000 show_stdout : Display stdout order ________________________________________________________________________________ 2024-04-20 03:24:33,558 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input file (/mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/stdout.txt is 8746 lines): 2024-04-20 03:24:33,558 DEBUG ----- output ----- 2024-04-20 03:24:33,558 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-04-20 03:24:33,558 INFO Gatling 3.10.5 is available! (you're using 3.9.5) 2024-04-20 03:24:33,558 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-04-20 03:24:33,558 INFO 2024-04-20 03:24:33,558 INFO ================================================================================ 2024-04-20 03:24:33,558 INFO 2024-04-20 03:22:05 5s elapsed 2024-04-20 03:24:33,558 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,558 INFO > Global (OK=3332 KO=0 ) 2024-04-20 03:24:33,558 INFO > userRestLogin (OK=3332 KO=0 ) 2024-04-20 03:24:33,558 INFO 2024-04-20 03:24:33,558 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,558 INFO [- ] 0% 2024-04-20 03:24:33,558 INFO waiting: 28923928 / active: 13 / done: 3332 2024-04-20 03:24:33,558 INFO ================================================================================ 2024-04-20 03:24:33,558 INFO 2024-04-20 03:24:33,558 INFO 2024-04-20 03:24:33,558 INFO ================================================================================ 2024-04-20 03:24:33,558 INFO 2024-04-20 03:22:10 10s elapsed 2024-04-20 03:24:33,558 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,558 INFO > Global (OK=13303 KO=0 ) 2024-04-20 03:24:33,558 INFO > userRestLogin (OK=13303 KO=0 ) 2024-04-20 03:24:33,558 INFO 2024-04-20 03:24:33,558 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,559 INFO [- ] 0% 2024-04-20 03:24:33,559 INFO waiting: 28913915 / active: 55 / done: 13303 2024-04-20 03:24:33,559 INFO ================================================================================ 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO ================================================================================ 2024-04-20 03:24:33,559 INFO 2024-04-20 03:22:15 15s elapsed 2024-04-20 03:24:33,559 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,559 INFO > Global (OK=30000 KO=0 ) 2024-04-20 03:24:33,559 INFO > userRestLogin (OK=30000 KO=0 ) 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,559 INFO [- ] 0% 2024-04-20 03:24:33,559 INFO waiting: 28897231 / active: 43 / done: 29999 2024-04-20 03:24:33,559 INFO ================================================================================ 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO ================================================================================ 2024-04-20 03:24:33,559 INFO 2024-04-20 03:22:20 20s elapsed 2024-04-20 03:24:33,559 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,559 INFO > Global (OK=53248 KO=0 ) 2024-04-20 03:24:33,559 INFO > userRestLogin (OK=53248 KO=0 ) 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,559 INFO [- ] 0% 2024-04-20 03:24:33,559 INFO waiting: 28873890 / active: 135 / done: 53248 2024-04-20 03:24:33,559 INFO ================================================================================ 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO ================================================================================ 2024-04-20 03:24:33,559 INFO 2024-04-20 03:22:25 25s elapsed 2024-04-20 03:24:33,559 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,559 INFO > Global (OK=83299 KO=0 ) 2024-04-20 03:24:33,559 INFO > userRestLogin (OK=83299 KO=0 ) 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,559 INFO [- ] 0% 2024-04-20 03:24:33,559 INFO waiting: 28843884 / active: 91 / done: 83298 2024-04-20 03:24:33,559 INFO ================================================================================ 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,559 INFO 2024-04-20 03:24:33,560 INFO ================================================================================ 2024-04-20 03:24:33,560 INFO 2024-04-20 03:22:30 30s elapsed 2024-04-20 03:24:33,560 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,560 INFO > Global (OK=119357 KO=0 ) 2024-04-20 03:24:33,560 INFO > userRestLogin (OK=119357 KO=0 ) 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,560 INFO [- ] 0% 2024-04-20 03:24:33,560 INFO waiting: 28807400 / active: 518 / done: 119355 2024-04-20 03:24:33,560 INFO ================================================================================ 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO ================================================================================ 2024-04-20 03:24:33,560 INFO 2024-04-20 03:22:35 35s elapsed 2024-04-20 03:24:33,560 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,560 INFO > Global (OK=159435 KO=0 ) 2024-04-20 03:24:33,560 INFO > userRestLogin (OK=159435 KO=0 ) 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,560 INFO [- ] 0% 2024-04-20 03:24:33,560 INFO waiting: 28767284 / active: 556 / done: 159433 2024-04-20 03:24:33,560 INFO ================================================================================ 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO ================================================================================ 2024-04-20 03:24:33,560 INFO 2024-04-20 03:22:40 40s elapsed 2024-04-20 03:24:33,560 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,560 INFO > Global (OK=199176 KO=0 ) 2024-04-20 03:24:33,560 INFO > userRestLogin (OK=199176 KO=0 ) 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,560 INFO [- ] 0% 2024-04-20 03:24:33,560 INFO waiting: 28727685 / active: 415 / done: 199173 2024-04-20 03:24:33,560 INFO ================================================================================ 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO 2024-04-20 03:24:33,560 INFO [...] 2024-04-20 03:24:33,563 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,563 INFO > Global (OK=28727213 KO=0 ) 2024-04-20 03:24:33,563 INFO > userRestLogin (OK=28727213 KO=0 ) 2024-04-20 03:24:33,563 INFO 2024-04-20 03:24:33,563 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,563 INFO [#########################################################################-] 99% 2024-04-20 03:24:33,563 INFO waiting: 199312 / active: 748 / done: 28727213 2024-04-20 03:24:33,563 INFO ================================================================================ 2024-04-20 03:24:33,563 INFO 2024-04-20 03:24:33,563 INFO 2024-04-20 03:24:33,563 INFO ================================================================================ 2024-04-20 03:24:33,563 INFO 2024-04-20 04:22:10 3610s elapsed 2024-04-20 03:24:33,563 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,563 INFO > Global (OK=28767060 KO=0 ) 2024-04-20 03:24:33,564 INFO > userRestLogin (OK=28767060 KO=0 ) 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,564 INFO [#########################################################################-] 99% 2024-04-20 03:24:33,564 INFO waiting: 159555 / active: 658 / done: 28767060 2024-04-20 03:24:33,564 INFO ================================================================================ 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO ================================================================================ 2024-04-20 03:24:33,564 INFO 2024-04-20 04:22:15 3615s elapsed 2024-04-20 03:24:33,564 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,564 INFO > Global (OK=28806965 KO=0 ) 2024-04-20 03:24:33,564 INFO > userRestLogin (OK=28806965 KO=0 ) 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,564 INFO [#########################################################################-] 99% 2024-04-20 03:24:33,564 INFO waiting: 119839 / active: 660 / done: 28806774 2024-04-20 03:24:33,564 INFO ================================================================================ 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO ================================================================================ 2024-04-20 03:24:33,564 INFO 2024-04-20 04:22:20 3620s elapsed 2024-04-20 03:24:33,564 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,564 INFO > Global (OK=28846529 KO=0 ) 2024-04-20 03:24:33,564 INFO > userRestLogin (OK=28846529 KO=0 ) 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,564 INFO [#########################################################################-] 99% 2024-04-20 03:24:33,564 INFO waiting: 79845 / active: 900 / done: 28846528 2024-04-20 03:24:33,564 INFO ================================================================================ 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO 2024-04-20 03:24:33,564 INFO ================================================================================ 2024-04-20 03:24:33,564 INFO 2024-04-20 04:22:25 3625s elapsed 2024-04-20 03:24:33,564 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,564 INFO > Global (OK=28886591 KO=0 ) 2024-04-20 03:24:33,565 INFO > userRestLogin (OK=28886591 KO=0 ) 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,565 INFO [#########################################################################-] 99% 2024-04-20 03:24:33,565 INFO waiting: 39966 / active: 719 / done: 28886588 2024-04-20 03:24:33,565 INFO ================================================================================ 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO ================================================================================ 2024-04-20 03:24:33,565 INFO 2024-04-20 04:22:30 3630s elapsed 2024-04-20 03:24:33,565 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,565 INFO > Global (OK=28926336 KO=0 ) 2024-04-20 03:24:33,565 INFO > userRestLogin (OK=28926336 KO=0 ) 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,565 INFO [#########################################################################-] 99% 2024-04-20 03:24:33,565 INFO waiting: 63 / active: 874 / done: 28926336 2024-04-20 03:24:33,565 INFO ================================================================================ 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO ================================================================================ 2024-04-20 03:24:33,565 INFO 2024-04-20 04:22:30 3630s elapsed 2024-04-20 03:24:33,565 INFO ---- Requests ------------------------------------------------------------------ 2024-04-20 03:24:33,565 INFO > Global (OK=28927273 KO=0 ) 2024-04-20 03:24:33,565 INFO > userRestLogin (OK=28927273 KO=0 ) 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-20 03:24:33,565 INFO [##########################################################################]100% 2024-04-20 03:24:33,565 INFO waiting: 0 / active: 0 / done: 28927273 2024-04-20 03:24:33,565 INFO ================================================================================ 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO Simulation com.forgerock.gatling.Loadtest completed in 3630 seconds 2024-04-20 03:24:33,565 INFO 2024-04-20 03:24:33,565 INFO ---------------------- 2024-04-20 03:24:33,565 INFO [20/Apr/2024 04:22:30] Create tar file authn-users-8000.tar.gz 2024-04-20 03:24:33,565 INFO ---------------------- 2024-04-20 03:24:33,565 INFO RESULTS_FOLDER=/results/gatling/ 2024-04-20 03:24:33,565 INFO RESULT_FOLDER=authn-users-8000 2024-04-20 03:24:33,566 INFO SIMULATION_PATH=authn-users-8000/loadtest-20240420022159470 2024-04-20 03:24:33,566 INFO PWD=/results/gatling/authn-users-8000/loadtest-20240420022159470 2024-04-20 03:24:33,566 INFO [cmd] tar -czvf /results/gatling//authn-users-8000.tar.gz --exclude=simulation.log * 2024-04-20 03:24:33,566 INFO /results/gatling 2024-04-20 03:24:33,566 INFO 2024-04-20 03:24:33,566 INFO ---------------------- 2024-04-20 03:24:33,566 INFO [20/Apr/2024 04:22:30] Update /results/gatling//latest 2024-04-20 03:24:33,566 INFO ---------------------- 2024-04-20 03:24:33,566 INFO 2024-04-20 03:24:33,566 INFO ---------------------- 2024-04-20 03:24:33,566 INFO [20/Apr/2024 04:22:30] Update /results/gatling//latest.tar.gz 2024-04-20 03:24:33,566 INFO ---------------------- 2024-04-20 03:24:33,566 INFO ________________________________________________________________________________ [2024-04-20 03:24:33] authn-users-8000 show_stderr : Display stderr order ________________________________________________________________________________ 2024-04-20 03:24:33,566 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/06_authn-users-8000/stderr.txt is small (0 lines), printing all lines: 2024-04-20 03:24:33,566 DEBUG ----- output ----- 2024-04-20 03:24:33,566 DEBUG 2024-04-20 03:24:33,567 INFO ________________________________________________________________________________ [2024-04-20 03:24:33] authn-users-8000 check_rc_and_logs : Check order's outputs ________________________________________________________________________________ PASS: no error found in rc log PASS: no error found in stdout log PASS: no error found in stderr log ________________________________________________________________________________ [2024-04-20 03:24:33] authn-users-8000 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-04-20 03:24:33] authn-users-8000 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped