--Task-- name: authn-users-2000 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-1000'] preceding_task: authn-users-1000 options: {'testMode': 'open', 'testCase': 'am.AMAuthN', 'throughput': 2000, 'rampup-duration': 30, 'duration': 3600} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-04-10 01:37:17] authn-users-2000 pre : N/A ________________________________________________________________________________ [2024-04-10 01:37:17] - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) [2024-04-10 01:37:17] - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/authn-users-2000/stdout.txt Pod log : /results/orders/authn-users-2000 2024-04-10 01:37:17,188 INFO 2024-04-10 01:37:17,188 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-10 01:37:17,188 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 01:37:17,499 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 01:37:17,500 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:17,500 DEBUG --- stdout --- 2024-04-10 01:37:17,500 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 01:37:17,500 DEBUG --- stderr --- 2024-04-10 01:37:17,500 DEBUG ________________________________________________________________________________ [2024-04-10 01:37:17] authn-users-2000 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-04-10 01:37:17,500 INFO 2024-04-10 01:37:17,500 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-10 01:37:17,501 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 01:37:17,827 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 01:37:17,827 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:17,827 DEBUG --- stdout --- 2024-04-10 01:37:17,827 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 01:37:17,827 DEBUG --- stderr --- 2024-04-10 01:37:17,827 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-2000 --extra-run-jvm-options "-Xmx4G" --no-reports ________________________________________________________________________________ [2024-04-10 01:37:17] authn-users-2000 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-04-10 01:37:17,828 INFO 2024-04-10 01:37:17,828 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-10 01:37:17,828 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 01:37:18,152 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 01:37:18,152 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:18,152 DEBUG --- stdout --- 2024-04-10 01:37:18,152 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 01:37:18,152 DEBUG --- stderr --- 2024-04-10 01:37:18,152 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/order.json { "name": "authn-users-2000", "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-2000 --extra-run-jvm-options \"-Xmx4G\" --no-reports", "out-dir": "/results/orders/authn-users-2000", "environment": { "JAVA_OPTS": "-Dam_host=xlou.iam.xlou-cdm.engineeringpit.com -DamadminPassword=**** -DamadminUsername=amadmin -Dduration=3600 -Dnum_users=1000000 -Drampup_duration=30 -DtestCase=am.AMAuthN -DtestMode=open -Dthroughput=2000 -Duser_password=T35tr0ck123" } } ________________________________________________________________________________ [2024-04-10 01:37:18] authn-users-2000 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-10 01:37:18,154 INFO 2024-04-10 01:37:18,154 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-04-10 01:37:18,154 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-10 01:37:18,401 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 01:37:18,401 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:18,401 DEBUG --- stdout --- 2024-04-10 01:37:18,401 DEBUG WAITING 2024-04-10 01:37:18,401 DEBUG --- stderr --- 2024-04-10 01:37:18,401 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-10 01:37:18] authn-users-2000 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-04-10 01:37:18,402 INFO 2024-04-10 01:37:18,402 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-10 01:37:18,402 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 01:37:18,751 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 01:37:18,753 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:18,753 DEBUG --- stdout --- 2024-04-10 01:37:18,753 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 01:37:18,753 DEBUG --- stderr --- 2024-04-10 01:37:18,753 DEBUG 2024-04-10 01:37:18,753 INFO 2024-04-10 01:37:18,754 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/04_authn-users-2000/order.json overseer-0-6f8784665d-zq5hb:/results/orders/order.json 2024-04-10 01:37:18,754 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 01:37:20,175 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:20,176 DEBUG --- stdout --- 2024-04-10 01:37:20,176 DEBUG 2024-04-10 01:37:20,176 DEBUG --- stderr --- 2024-04-10 01:37:20,176 DEBUG Order has been successfully forwarded to overseer [2024-04-10 01:37:20] - INFO: Check if Gatling simulation started successfully 2024-04-10 01:37:20,176 INFO 2024-04-10 01:37:20,176 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-10 01:37:20,176 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 01:37:20,491 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 01:37:20,491 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:20,491 DEBUG --- stdout --- 2024-04-10 01:37:20,491 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 01:37:20,491 DEBUG --- stderr --- 2024-04-10 01:37:20,491 DEBUG 2024-04-10 01:37:20,491 INFO 2024-04-10 01:37:20,492 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb -- head -n 25 /results/orders/authn-users-2000/stdout.txt | grep "started..." 2024-04-10 01:37:20,492 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-10 01:37:21,267 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-04-10 01:37:27,047 INFO [loop_until]: Function succeeded after 6s (rc=0) - expected pattern found 2024-04-10 01:37:27,047 INFO [loop_until]: OK (rc = 0) 2024-04-10 01:37:27,047 DEBUG --- stdout --- 2024-04-10 01:37:27,047 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-10 01:37:27,047 DEBUG --- stderr --- 2024-04-10 01:37:27,047 DEBUG ________________________________________________________________________________ [2024-04-10 01:37:27] authn-users-2000 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 03s, retry Order is running since 24m 04s, retry Order is running since 26m 04s, retry Order is running since 28m 04s, 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 06s, retry Order is running since 40m 07s, retry Order is running since 42m 07s, retry Order is running since 44m 07s, retry Order is running since 46m 08s, retry Order is running since 48m 08s, retry Order is running since 50m 08s, retry Order is running since 52m 09s, retry Order is running since 54m 09s, retry Order is running since 56m 09s, 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-10 02:39:37] authn-users-2000 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-04-10 02:39:37,949 INFO 2024-04-10 02:39:37,949 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-10 02:39:37,949 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:38,302 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:38,302 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:38,302 DEBUG --- stdout --- 2024-04-10 02:39:38,303 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:38,303 DEBUG --- stderr --- 2024-04-10 02:39:38,303 DEBUG 2024-04-10 02:39:38,303 INFO 2024-04-10 02:39:38,303 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb -- rm -f /results/orders/order.json 2024-04-10 02:39:38,303 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 02:39:39,121 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:39,121 DEBUG --- stdout --- 2024-04-10 02:39:39,121 DEBUG 2024-04-10 02:39:39,121 DEBUG --- stderr --- 2024-04-10 02:39:39,122 DEBUG Order ran during 1h 02m ________________________________________________________________________________ [2024-04-10 02:39:39] authn-users-2000 download_logs : Download individual order files ________________________________________________________________________________ [2024-04-10 02:39:39] - PASS: file already downloaded /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/order.json 2024-04-10 02:39:39,123 INFO 2024-04-10 02:39:39,123 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-10 02:39:39,123 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:39,456 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:39,457 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:39,457 DEBUG --- stdout --- 2024-04-10 02:39:39,457 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:39,457 DEBUG --- stderr --- 2024-04-10 02:39:39,457 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 02:39:39,457 INFO 2024-04-10 02:39:39,457 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-10 02:39:39,457 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:39,786 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:39,786 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:39,786 DEBUG --- stdout --- 2024-04-10 02:39:39,786 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:39,786 DEBUG --- stderr --- 2024-04-10 02:39:39,786 DEBUG 2024-04-10 02:39:39,787 INFO 2024-04-10 02:39:39,787 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- bash -c 'if [ -f "/results/orders/authn-users-2000/rc.txt" ]; then echo "/results/orders/authn-users-2000/rc.txt file found"; exit 0; else echo "/results/orders/authn-users-2000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-2000/rc.txt file found" 2024-04-10 02:39:39,787 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 02:39:40,628 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 02:39:40,629 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:40,629 DEBUG --- stdout --- 2024-04-10 02:39:40,629 DEBUG /results/orders/authn-users-2000/rc.txt file found 2024-04-10 02:39:40,629 DEBUG --- stderr --- 2024-04-10 02:39:40,629 DEBUG 2024-04-10 02:39:40,630 INFO 2024-04-10 02:39:40,630 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-10 02:39:40,630 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:40,995 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:40,996 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:40,996 DEBUG --- stdout --- 2024-04-10 02:39:40,996 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:40,996 DEBUG --- stderr --- 2024-04-10 02:39:40,996 DEBUG 2024-04-10 02:39:40,996 INFO 2024-04-10 02:39:40,996 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- du -k /results/orders/authn-users-2000/rc.txt 2024-04-10 02:39:41,875 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 02:39:41,875 DEBUG --- stdout --- 2024-04-10 02:39:41,875 DEBUG 4 /results/orders/authn-users-2000/rc.txt 2024-04-10 02:39:41,876 DEBUG --- stderr --- 2024-04-10 02:39:41,876 DEBUG 2024-04-10 02:39:41,876 INFO - Download file (size 4k) 2024-04-10 02:39:41,876 INFO 2024-04-10 02:39:41,876 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-10 02:39:41,876 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:42,229 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:42,231 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:42,231 DEBUG --- stdout --- 2024-04-10 02:39:42,231 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:42,231 DEBUG --- stderr --- 2024-04-10 02:39:42,231 DEBUG source : /results/orders/authn-users-2000/rc.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/rc.txt 2024-04-10 02:39:42,231 INFO 2024-04-10 02:39:42,231 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-10 02:39:42,231 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:42,593 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:42,593 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:42,593 DEBUG --- stdout --- 2024-04-10 02:39:42,593 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:42,593 DEBUG --- stderr --- 2024-04-10 02:39:42,593 DEBUG 2024-04-10 02:39:42,594 INFO 2024-04-10 02:39:42,594 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6f8784665d-zq5hb:/results/orders/authn-users-2000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/rc.txt 2024-04-10 02:39:42,594 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 02:39:43,406 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:43,406 DEBUG --- stdout --- 2024-04-10 02:39:43,406 DEBUG tar: Removing leading `/' from member names 2024-04-10 02:39:43,406 DEBUG --- stderr --- 2024-04-10 02:39:43,406 DEBUG 2024-04-10 02:39:43,407 INFO 2024-04-10 02:39:43,407 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-10 02:39:43,407 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:43,728 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:43,728 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:43,728 DEBUG --- stdout --- 2024-04-10 02:39:43,728 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:43,728 DEBUG --- stderr --- 2024-04-10 02:39:43,728 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 02:39:43,729 INFO 2024-04-10 02:39:43,729 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-10 02:39:43,729 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:44,068 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:44,069 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:44,069 DEBUG --- stdout --- 2024-04-10 02:39:44,069 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:44,069 DEBUG --- stderr --- 2024-04-10 02:39:44,069 DEBUG 2024-04-10 02:39:44,069 INFO 2024-04-10 02:39:44,069 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- bash -c 'if [ -f "/results/orders/authn-users-2000/stderr.txt" ]; then echo "/results/orders/authn-users-2000/stderr.txt file found"; exit 0; else echo "/results/orders/authn-users-2000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-2000/stderr.txt file found" 2024-04-10 02:39:44,070 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 02:39:44,929 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 02:39:44,929 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:44,929 DEBUG --- stdout --- 2024-04-10 02:39:44,930 DEBUG /results/orders/authn-users-2000/stderr.txt file found 2024-04-10 02:39:44,930 DEBUG --- stderr --- 2024-04-10 02:39:44,930 DEBUG 2024-04-10 02:39:44,930 INFO 2024-04-10 02:39:44,930 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-10 02:39:44,930 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:45,239 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:45,239 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:45,239 DEBUG --- stdout --- 2024-04-10 02:39:45,239 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:45,239 DEBUG --- stderr --- 2024-04-10 02:39:45,239 DEBUG 2024-04-10 02:39:45,239 INFO 2024-04-10 02:39:45,240 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- du -k /results/orders/authn-users-2000/stderr.txt 2024-04-10 02:39:46,080 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 02:39:46,080 DEBUG --- stdout --- 2024-04-10 02:39:46,080 DEBUG 0 /results/orders/authn-users-2000/stderr.txt 2024-04-10 02:39:46,080 DEBUG --- stderr --- 2024-04-10 02:39:46,080 DEBUG 2024-04-10 02:39:46,080 INFO - Download file (size 0k) 2024-04-10 02:39:46,081 INFO 2024-04-10 02:39:46,081 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-10 02:39:46,081 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:46,401 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:46,401 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:46,401 DEBUG --- stdout --- 2024-04-10 02:39:46,401 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:46,401 DEBUG --- stderr --- 2024-04-10 02:39:46,401 DEBUG source : /results/orders/authn-users-2000/stderr.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/stderr.txt 2024-04-10 02:39:46,402 INFO 2024-04-10 02:39:46,402 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-10 02:39:46,402 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:46,711 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:46,711 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:46,711 DEBUG --- stdout --- 2024-04-10 02:39:46,711 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:46,711 DEBUG --- stderr --- 2024-04-10 02:39:46,711 DEBUG 2024-04-10 02:39:46,712 INFO 2024-04-10 02:39:46,712 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6f8784665d-zq5hb:/results/orders/authn-users-2000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/stderr.txt 2024-04-10 02:39:46,712 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 02:39:47,510 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:47,510 DEBUG --- stdout --- 2024-04-10 02:39:47,510 DEBUG tar: Removing leading `/' from member names 2024-04-10 02:39:47,510 DEBUG --- stderr --- 2024-04-10 02:39:47,510 DEBUG 2024-04-10 02:39:47,511 INFO 2024-04-10 02:39:47,511 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-10 02:39:47,511 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:47,851 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:47,851 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:47,852 DEBUG --- stdout --- 2024-04-10 02:39:47,852 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:47,852 DEBUG --- stderr --- 2024-04-10 02:39:47,852 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 02:39:47,852 INFO 2024-04-10 02:39:47,852 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-10 02:39:47,852 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:48,241 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:48,241 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:48,241 DEBUG --- stdout --- 2024-04-10 02:39:48,242 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:48,242 DEBUG --- stderr --- 2024-04-10 02:39:48,242 DEBUG 2024-04-10 02:39:48,243 INFO 2024-04-10 02:39:48,243 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- bash -c 'if [ -f "/results/orders/authn-users-2000/stdout.txt" ]; then echo "/results/orders/authn-users-2000/stdout.txt file found"; exit 0; else echo "/results/orders/authn-users-2000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-2000/stdout.txt file found" 2024-04-10 02:39:48,243 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 02:39:49,123 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 02:39:49,123 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:49,123 DEBUG --- stdout --- 2024-04-10 02:39:49,123 DEBUG /results/orders/authn-users-2000/stdout.txt file found 2024-04-10 02:39:49,123 DEBUG --- stderr --- 2024-04-10 02:39:49,123 DEBUG 2024-04-10 02:39:49,123 INFO 2024-04-10 02:39:49,123 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-10 02:39:49,123 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:49,444 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:49,444 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:49,444 DEBUG --- stdout --- 2024-04-10 02:39:49,444 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:49,444 DEBUG --- stderr --- 2024-04-10 02:39:49,444 DEBUG 2024-04-10 02:39:49,445 INFO 2024-04-10 02:39:49,445 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- du -k /results/orders/authn-users-2000/stdout.txt 2024-04-10 02:39:50,286 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 02:39:50,286 DEBUG --- stdout --- 2024-04-10 02:39:50,286 DEBUG 508 /results/orders/authn-users-2000/stdout.txt 2024-04-10 02:39:50,286 DEBUG --- stderr --- 2024-04-10 02:39:50,286 DEBUG 2024-04-10 02:39:50,286 INFO - Download file (size 508k) 2024-04-10 02:39:50,287 INFO 2024-04-10 02:39:50,287 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-10 02:39:50,287 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:50,613 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:50,614 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:50,614 DEBUG --- stdout --- 2024-04-10 02:39:50,614 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:50,614 DEBUG --- stderr --- 2024-04-10 02:39:50,614 DEBUG source : /results/orders/authn-users-2000/stdout.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/stdout.txt 2024-04-10 02:39:50,614 INFO 2024-04-10 02:39:50,614 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-10 02:39:50,614 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:50,945 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:50,945 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:50,945 DEBUG --- stdout --- 2024-04-10 02:39:50,945 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:50,946 DEBUG --- stderr --- 2024-04-10 02:39:50,946 DEBUG 2024-04-10 02:39:50,946 INFO 2024-04-10 02:39:50,946 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6f8784665d-zq5hb:/results/orders/authn-users-2000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/stdout.txt 2024-04-10 02:39:50,946 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 02:39:52,035 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:52,035 DEBUG --- stdout --- 2024-04-10 02:39:52,035 DEBUG tar: Removing leading `/' from member names 2024-04-10 02:39:52,035 DEBUG --- stderr --- 2024-04-10 02:39:52,035 DEBUG ________________________________________________________________________________ [2024-04-10 02:39:52] authn-users-2000 show_cmd : Display order command ________________________________________________________________________________ 2024-04-10 02:39:52,036 INFO 2024-04-10 02:39:52,036 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-10 02:39:52,036 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:52,362 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:52,362 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:52,362 DEBUG --- stdout --- 2024-04-10 02:39:52,362 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:52,362 DEBUG --- stderr --- 2024-04-10 02:39:52,362 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 02:39:52,363 INFO 2024-04-10 02:39:52,363 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-10 02:39:52,363 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:52,677 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:52,677 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:52,678 DEBUG --- stdout --- 2024-04-10 02:39:52,678 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:52,678 DEBUG --- stderr --- 2024-04-10 02:39:52,679 DEBUG 2024-04-10 02:39:52,679 INFO 2024-04-10 02:39:52,680 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- bash -c 'if [ -f "/results/orders/authn-users-2000/cmd.txt" ]; then echo "/results/orders/authn-users-2000/cmd.txt file found"; exit 0; else echo "/results/orders/authn-users-2000/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-2000/cmd.txt file found" 2024-04-10 02:39:52,680 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 02:39:53,541 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 02:39:53,542 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:53,542 DEBUG --- stdout --- 2024-04-10 02:39:53,542 DEBUG /results/orders/authn-users-2000/cmd.txt file found 2024-04-10 02:39:53,542 DEBUG --- stderr --- 2024-04-10 02:39:53,542 DEBUG 2024-04-10 02:39:53,542 INFO 2024-04-10 02:39:53,542 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-10 02:39:53,542 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:53,859 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:53,859 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:53,859 DEBUG --- stdout --- 2024-04-10 02:39:53,859 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:53,859 DEBUG --- stderr --- 2024-04-10 02:39:53,860 DEBUG 2024-04-10 02:39:53,860 INFO 2024-04-10 02:39:53,860 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-6f8784665d-zq5hb --stdin -- du -k /results/orders/authn-users-2000/cmd.txt 2024-04-10 02:39:54,697 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 02:39:54,698 DEBUG --- stdout --- 2024-04-10 02:39:54,698 DEBUG 4 /results/orders/authn-users-2000/cmd.txt 2024-04-10 02:39:54,698 DEBUG --- stderr --- 2024-04-10 02:39:54,698 DEBUG 2024-04-10 02:39:54,698 INFO - Download file (size 4k) 2024-04-10 02:39:54,699 INFO 2024-04-10 02:39:54,699 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-10 02:39:54,699 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:55,051 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:55,051 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:55,051 DEBUG --- stdout --- 2024-04-10 02:39:55,051 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:55,051 DEBUG --- stderr --- 2024-04-10 02:39:55,051 DEBUG source : /results/orders/authn-users-2000/cmd.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/cmd.txt 2024-04-10 02:39:55,051 INFO 2024-04-10 02:39:55,051 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-10 02:39:55,051 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:55,370 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:55,370 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:55,370 DEBUG --- stdout --- 2024-04-10 02:39:55,370 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:55,370 DEBUG --- stderr --- 2024-04-10 02:39:55,370 DEBUG 2024-04-10 02:39:55,371 INFO 2024-04-10 02:39:55,371 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-6f8784665d-zq5hb:/results/orders/authn-users-2000/cmd.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/cmd.txt 2024-04-10 02:39:55,371 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 02:39:56,167 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:56,167 DEBUG --- stdout --- 2024-04-10 02:39:56,167 DEBUG tar: Removing leading `/' from member names 2024-04-10 02:39:56,167 DEBUG --- stderr --- 2024-04-10 02:39:56,167 DEBUG 2024-04-10 02:39:56,168 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/cmd.txt is small (1 lines), printing all lines: 2024-04-10 02:39:56,168 DEBUG ----- output ----- 2024-04-10 02:39:56,168 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-2000 --extra-run-jvm-options "-Xmx4G" --no-reports 2024-04-10 02:39:56,168 INFO ________________________________________________________________________________ [2024-04-10 02:39:56] authn-users-2000 show_rc : Display rc order ________________________________________________________________________________ 2024-04-10 02:39:56,168 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/rc.txt is small (1 lines), printing all lines: 2024-04-10 02:39:56,168 DEBUG ----- output ----- 2024-04-10 02:39:56,168 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-04-10 02:39:56,168 INFO ________________________________________________________________________________ [2024-04-10 02:39:56] authn-users-2000 show_stdout : Display stdout order ________________________________________________________________________________ 2024-04-10 02:39:56,170 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/04_authn-users-2000/stdout.txt is 8746 lines): 2024-04-10 02:39:56,170 DEBUG ----- output ----- 2024-04-10 02:39:56,170 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-04-10 02:39:56,170 INFO Gatling 3.10.5 is available! (you're using 3.9.5) 2024-04-10 02:39:56,170 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-04-10 02:39:56,170 INFO 2024-04-10 02:39:56,170 INFO ================================================================================ 2024-04-10 02:39:56,170 INFO 2024-04-10 02:37:31 5s elapsed 2024-04-10 02:39:56,170 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,170 INFO > Global (OK=832 KO=0 ) 2024-04-10 02:39:56,170 INFO > userRestLogin (OK=832 KO=0 ) 2024-04-10 02:39:56,170 INFO 2024-04-10 02:39:56,170 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,170 INFO [- ] 0% 2024-04-10 02:39:56,170 INFO waiting: 7228378 / active: 4 / done: 832 2024-04-10 02:39:56,170 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:37:36 10s elapsed 2024-04-10 02:39:56,171 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,171 INFO > Global (OK=3332 KO=0 ) 2024-04-10 02:39:56,171 INFO > userRestLogin (OK=3332 KO=0 ) 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,171 INFO [- ] 0% 2024-04-10 02:39:56,171 INFO waiting: 7225876 / active: 7 / done: 3331 2024-04-10 02:39:56,171 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:37:41 15s elapsed 2024-04-10 02:39:56,171 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,171 INFO > Global (OK=7499 KO=0 ) 2024-04-10 02:39:56,171 INFO > userRestLogin (OK=7499 KO=0 ) 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,171 INFO [- ] 0% 2024-04-10 02:39:56,171 INFO waiting: 7221705 / active: 10 / done: 7499 2024-04-10 02:39:56,171 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:37:46 20s elapsed 2024-04-10 02:39:56,171 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,171 INFO > Global (OK=13327 KO=0 ) 2024-04-10 02:39:56,171 INFO > userRestLogin (OK=13327 KO=0 ) 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,171 INFO [- ] 0% 2024-04-10 02:39:56,171 INFO waiting: 7215871 / active: 16 / done: 13327 2024-04-10 02:39:56,171 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO 2024-04-10 02:39:56,171 INFO ================================================================================ 2024-04-10 02:39:56,171 INFO 2024-04-10 02:37:51 25s elapsed 2024-04-10 02:39:56,172 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,172 INFO > Global (OK=20829 KO=0 ) 2024-04-10 02:39:56,172 INFO > userRestLogin (OK=20829 KO=0 ) 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,172 INFO [- ] 0% 2024-04-10 02:39:56,172 INFO waiting: 7208369 / active: 17 / done: 20828 2024-04-10 02:39:56,172 INFO ================================================================================ 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO ================================================================================ 2024-04-10 02:39:56,172 INFO 2024-04-10 02:37:56 30s elapsed 2024-04-10 02:39:56,172 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,172 INFO > Global (OK=29947 KO=0 ) 2024-04-10 02:39:56,172 INFO > userRestLogin (OK=29947 KO=0 ) 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,172 INFO [- ] 0% 2024-04-10 02:39:56,172 INFO waiting: 7199235 / active: 32 / done: 29947 2024-04-10 02:39:56,172 INFO ================================================================================ 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO ================================================================================ 2024-04-10 02:39:56,172 INFO 2024-04-10 02:38:01 35s elapsed 2024-04-10 02:39:56,172 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,172 INFO > Global (OK=39769 KO=0 ) 2024-04-10 02:39:56,172 INFO > userRestLogin (OK=39769 KO=0 ) 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,172 INFO [- ] 0% 2024-04-10 02:39:56,172 INFO waiting: 7189410 / active: 35 / done: 39769 2024-04-10 02:39:56,172 INFO ================================================================================ 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO 2024-04-10 02:39:56,172 INFO ================================================================================ 2024-04-10 02:39:56,172 INFO 2024-04-10 02:38:06 40s elapsed 2024-04-10 02:39:56,172 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,172 INFO > Global (OK=49987 KO=0 ) 2024-04-10 02:39:56,173 INFO > userRestLogin (OK=49987 KO=0 ) 2024-04-10 02:39:56,173 INFO 2024-04-10 02:39:56,173 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,173 INFO [- ] 0% 2024-04-10 02:39:56,173 INFO waiting: 7179198 / active: 30 / done: 49986 2024-04-10 02:39:56,173 INFO ================================================================================ 2024-04-10 02:39:56,173 INFO 2024-04-10 02:39:56,173 INFO 2024-04-10 02:39:56,173 INFO [...] 2024-04-10 02:39:56,175 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,175 INFO > Global (OK=7179218 KO=0 ) 2024-04-10 02:39:56,175 INFO > userRestLogin (OK=7179218 KO=0 ) 2024-04-10 02:39:56,175 INFO 2024-04-10 02:39:56,175 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,175 INFO [#########################################################################-] 99% 2024-04-10 02:39:56,175 INFO waiting: 49965 / active: 32 / done: 7179217 2024-04-10 02:39:56,175 INFO ================================================================================ 2024-04-10 02:39:56,175 INFO 2024-04-10 02:39:56,175 INFO 2024-04-10 02:39:56,175 INFO ================================================================================ 2024-04-10 02:39:56,175 INFO 2024-04-10 03:37:36 3610s elapsed 2024-04-10 02:39:56,175 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,175 INFO > Global (OK=7189137 KO=0 ) 2024-04-10 02:39:56,176 INFO > userRestLogin (OK=7189137 KO=0 ) 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,176 INFO [#########################################################################-] 99% 2024-04-10 02:39:56,176 INFO waiting: 40048 / active: 29 / done: 7189137 2024-04-10 02:39:56,176 INFO ================================================================================ 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO ================================================================================ 2024-04-10 02:39:56,176 INFO 2024-04-10 03:37:41 3615s elapsed 2024-04-10 02:39:56,176 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,176 INFO > Global (OK=7199247 KO=0 ) 2024-04-10 02:39:56,176 INFO > userRestLogin (OK=7199247 KO=0 ) 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,176 INFO [#########################################################################-] 99% 2024-04-10 02:39:56,176 INFO waiting: 29944 / active: 23 / done: 7199247 2024-04-10 02:39:56,176 INFO ================================================================================ 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO ================================================================================ 2024-04-10 02:39:56,176 INFO 2024-04-10 03:37:46 3620s elapsed 2024-04-10 02:39:56,176 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,176 INFO > Global (OK=7209368 KO=0 ) 2024-04-10 02:39:56,176 INFO > userRestLogin (OK=7209368 KO=0 ) 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,176 INFO [#########################################################################-] 99% 2024-04-10 02:39:56,176 INFO waiting: 19820 / active: 26 / done: 7209368 2024-04-10 02:39:56,176 INFO ================================================================================ 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO ================================================================================ 2024-04-10 02:39:56,176 INFO 2024-04-10 03:37:51 3625s elapsed 2024-04-10 02:39:56,176 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,176 INFO > Global (OK=7219251 KO=0 ) 2024-04-10 02:39:56,176 INFO > userRestLogin (OK=7219251 KO=0 ) 2024-04-10 02:39:56,176 INFO 2024-04-10 02:39:56,176 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,176 INFO [#########################################################################-] 99% 2024-04-10 02:39:56,177 INFO waiting: 9918 / active: 45 / done: 7219251 2024-04-10 02:39:56,177 INFO ================================================================================ 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO ================================================================================ 2024-04-10 02:39:56,177 INFO 2024-04-10 03:37:56 3630s elapsed 2024-04-10 02:39:56,177 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,177 INFO > Global (OK=7229202 KO=0 ) 2024-04-10 02:39:56,177 INFO > userRestLogin (OK=7229202 KO=0 ) 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,177 INFO [#########################################################################-] 99% 2024-04-10 02:39:56,177 INFO waiting: 0 / active: 12 / done: 7229202 2024-04-10 02:39:56,177 INFO ================================================================================ 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO ================================================================================ 2024-04-10 02:39:56,177 INFO 2024-04-10 03:37:56 3630s elapsed 2024-04-10 02:39:56,177 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 02:39:56,177 INFO > Global (OK=7229214 KO=0 ) 2024-04-10 02:39:56,177 INFO > userRestLogin (OK=7229214 KO=0 ) 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 02:39:56,177 INFO [##########################################################################]100% 2024-04-10 02:39:56,177 INFO waiting: 0 / active: 0 / done: 7229214 2024-04-10 02:39:56,177 INFO ================================================================================ 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO Simulation com.forgerock.gatling.Loadtest completed in 3630 seconds 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,177 INFO ---------------------- 2024-04-10 02:39:56,177 INFO [10/Apr/2024 03:37:56] Create tar file authn-users-2000.tar.gz 2024-04-10 02:39:56,177 INFO ---------------------- 2024-04-10 02:39:56,177 INFO RESULTS_FOLDER=/results/gatling/ 2024-04-10 02:39:56,177 INFO RESULT_FOLDER=authn-users-2000 2024-04-10 02:39:56,177 INFO SIMULATION_PATH=authn-users-2000/loadtest-20240410013726057 2024-04-10 02:39:56,177 INFO PWD=/results/gatling/authn-users-2000/loadtest-20240410013726057 2024-04-10 02:39:56,177 INFO [cmd] tar -czvf /results/gatling//authn-users-2000.tar.gz --exclude=simulation.log * 2024-04-10 02:39:56,177 INFO /results/gatling 2024-04-10 02:39:56,177 INFO 2024-04-10 02:39:56,178 INFO ---------------------- 2024-04-10 02:39:56,178 INFO [10/Apr/2024 03:37:56] Update /results/gatling//latest 2024-04-10 02:39:56,178 INFO ---------------------- 2024-04-10 02:39:56,178 INFO 2024-04-10 02:39:56,178 INFO ---------------------- 2024-04-10 02:39:56,178 INFO [10/Apr/2024 03:37:56] Update /results/gatling//latest.tar.gz 2024-04-10 02:39:56,178 INFO ---------------------- 2024-04-10 02:39:56,178 INFO ________________________________________________________________________________ [2024-04-10 02:39:56] authn-users-2000 show_stderr : Display stderr order ________________________________________________________________________________ 2024-04-10 02:39:56,178 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/04_authn-users-2000/stderr.txt is small (0 lines), printing all lines: 2024-04-10 02:39:56,178 DEBUG ----- output ----- 2024-04-10 02:39:56,178 DEBUG 2024-04-10 02:39:56,178 INFO ________________________________________________________________________________ [2024-04-10 02:39:56] authn-users-2000 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-10 02:39:56] authn-users-2000 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-04-10 02:39:56] authn-users-2000 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped