--Task-- name: authn-users-3000 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-2000'] preceding_task: authn-users-2000 options: {'testMode': 'open', 'testCase': 'am.AMAuthN', 'throughput': 3000, 'rampup-duration': 30, 'duration': 3600} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-04-10 02:39:57] authn-users-3000 pre : N/A ________________________________________________________________________________ [2024-04-10 02:39:57] - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) [2024-04-10 02:39:57] - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/authn-users-3000/stdout.txt Pod log : /results/orders/authn-users-3000 2024-04-10 02:39:57,118 INFO 2024-04-10 02:39:57,118 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:57,118 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:57,450 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:57,450 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:57,450 DEBUG --- stdout --- 2024-04-10 02:39:57,450 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:57,450 DEBUG --- stderr --- 2024-04-10 02:39:57,450 DEBUG ________________________________________________________________________________ [2024-04-10 02:39:57] authn-users-3000 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-04-10 02:39:57,451 INFO 2024-04-10 02:39:57,451 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:57,451 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:57,769 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:57,771 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:57,771 DEBUG --- stdout --- 2024-04-10 02:39:57,771 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:57,771 DEBUG --- stderr --- 2024-04-10 02:39:57,771 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-3000 --extra-run-jvm-options "-Xmx4G" --no-reports ________________________________________________________________________________ [2024-04-10 02:39:57] authn-users-3000 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-04-10 02:39:57,772 INFO 2024-04-10 02:39:57,772 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:57,772 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:58,091 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:58,091 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:58,091 DEBUG --- stdout --- 2024-04-10 02:39:58,091 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:58,091 DEBUG --- stderr --- 2024-04-10 02:39:58,091 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/order.json { "name": "authn-users-3000", "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-3000 --extra-run-jvm-options \"-Xmx4G\" --no-reports", "out-dir": "/results/orders/authn-users-3000", "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=3000 -Duser_password=T35tr0ck123" } } ________________________________________________________________________________ [2024-04-10 02:39:58] authn-users-3000 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 02:39:58,093 INFO 2024-04-10 02:39:58,093 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-04-10 02:39:58,093 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-10 02:39:58,354 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 02:39:58,354 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:58,354 DEBUG --- stdout --- 2024-04-10 02:39:58,354 DEBUG WAITING 2024-04-10 02:39:58,354 DEBUG --- stderr --- 2024-04-10 02:39:58,355 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 32 0 --:--:-- --:--:-- --:--:-- 32 ________________________________________________________________________________ [2024-04-10 02:39:58] authn-users-3000 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-04-10 02:39:58,355 INFO 2024-04-10 02:39:58,355 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:58,355 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:39:58,668 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:39:58,668 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:39:58,668 DEBUG --- stdout --- 2024-04-10 02:39:58,669 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:39:58,669 DEBUG --- stderr --- 2024-04-10 02:39:58,669 DEBUG 2024-04-10 02:39:58,669 INFO 2024-04-10 02:39:58,669 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/05_authn-users-3000/order.json overseer-0-6f8784665d-zq5hb:/results/orders/order.json 2024-04-10 02:39:58,669 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 02:40:00,147 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:40:00,147 DEBUG --- stdout --- 2024-04-10 02:40:00,147 DEBUG 2024-04-10 02:40:00,147 DEBUG --- stderr --- 2024-04-10 02:40:00,147 DEBUG Order has been successfully forwarded to overseer [2024-04-10 02:40:00] - INFO: Check if Gatling simulation started successfully 2024-04-10 02:40:00,148 INFO 2024-04-10 02:40:00,148 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:40:00,148 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 02:40:00,503 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 02:40:00,504 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:40:00,504 DEBUG --- stdout --- 2024-04-10 02:40:00,504 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 02:40:00,504 DEBUG --- stderr --- 2024-04-10 02:40:00,504 DEBUG 2024-04-10 02:40:00,505 INFO 2024-04-10 02:40:00,505 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-3000/stdout.txt | grep "started..." 2024-04-10 02:40:00,505 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-10 02:40:01,284 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-04-10 02:40:07,069 INFO [loop_until]: Function succeeded after 6s (rc=0) - expected pattern found 2024-04-10 02:40:07,070 INFO [loop_until]: OK (rc = 0) 2024-04-10 02:40:07,070 DEBUG --- stdout --- 2024-04-10 02:40:07,070 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 02:40:07,070 DEBUG --- stderr --- 2024-04-10 02:40:07,070 DEBUG ________________________________________________________________________________ [2024-04-10 02:40:07] authn-users-3000 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 04s, retry Order is running since 32m 05s, retry Order is running since 34m 05s, retry Order is running since 36m 05s, retry Order is running since 38m 06s, retry Order is running since 40m 06s, retry Order is running since 42m 07s, retry Order is running since 44m 07s, retry Order is running since 46m 07s, retry Order is running since 48m 08s, retry Order is running since 50m 08s, retry Order is running since 52m 08s, retry Order is running since 54m 09s, retry Order is running since 56m 09s, retry Order is running since 58m 09s, retry Order is running since 1h, retry PASS : Order stopped by itself after 1h 02m and before timeout (1h 12m) ________________________________________________________________________________ [2024-04-10 03:42:17] authn-users-3000 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-04-10 03:42:17,712 INFO 2024-04-10 03:42:17,712 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 03:42:17,712 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:18,070 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:18,070 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:18,070 DEBUG --- stdout --- 2024-04-10 03:42:18,071 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:18,071 DEBUG --- stderr --- 2024-04-10 03:42:18,071 DEBUG 2024-04-10 03:42:18,071 INFO 2024-04-10 03:42:18,071 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 03:42:18,071 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 03:42:18,922 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:18,922 DEBUG --- stdout --- 2024-04-10 03:42:18,923 DEBUG 2024-04-10 03:42:18,923 DEBUG --- stderr --- 2024-04-10 03:42:18,923 DEBUG Order ran during 1h 02m ________________________________________________________________________________ [2024-04-10 03:42:18] authn-users-3000 download_logs : Download individual order files ________________________________________________________________________________ [2024-04-10 03:42:18] - PASS: file already downloaded /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/order.json 2024-04-10 03:42:18,924 INFO 2024-04-10 03:42:18,924 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 03:42:18,924 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:19,256 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:19,257 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:19,257 DEBUG --- stdout --- 2024-04-10 03:42:19,257 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:19,257 DEBUG --- stderr --- 2024-04-10 03:42:19,258 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 03:42:19,258 INFO 2024-04-10 03:42:19,258 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 03:42:19,258 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:19,591 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:19,591 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:19,591 DEBUG --- stdout --- 2024-04-10 03:42:19,591 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:19,591 DEBUG --- stderr --- 2024-04-10 03:42:19,591 DEBUG 2024-04-10 03:42:19,592 INFO 2024-04-10 03:42:19,592 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-3000/rc.txt" ]; then echo "/results/orders/authn-users-3000/rc.txt file found"; exit 0; else echo "/results/orders/authn-users-3000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-3000/rc.txt file found" 2024-04-10 03:42:19,592 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 03:42:20,468 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 03:42:20,468 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:20,468 DEBUG --- stdout --- 2024-04-10 03:42:20,468 DEBUG /results/orders/authn-users-3000/rc.txt file found 2024-04-10 03:42:20,468 DEBUG --- stderr --- 2024-04-10 03:42:20,468 DEBUG 2024-04-10 03:42:20,468 INFO 2024-04-10 03:42:20,468 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 03:42:20,468 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:20,796 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:20,796 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:20,796 DEBUG --- stdout --- 2024-04-10 03:42:20,797 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:20,797 DEBUG --- stderr --- 2024-04-10 03:42:20,797 DEBUG 2024-04-10 03:42:20,797 INFO 2024-04-10 03:42:20,797 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-3000/rc.txt 2024-04-10 03:42:21,642 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 03:42:21,643 DEBUG --- stdout --- 2024-04-10 03:42:21,643 DEBUG 4 /results/orders/authn-users-3000/rc.txt 2024-04-10 03:42:21,643 DEBUG --- stderr --- 2024-04-10 03:42:21,643 DEBUG 2024-04-10 03:42:21,643 INFO - Download file (size 4k) 2024-04-10 03:42:21,643 INFO 2024-04-10 03:42:21,643 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 03:42:21,643 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:21,967 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:21,967 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:21,967 DEBUG --- stdout --- 2024-04-10 03:42:21,967 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:21,967 DEBUG --- stderr --- 2024-04-10 03:42:21,967 DEBUG source : /results/orders/authn-users-3000/rc.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/rc.txt 2024-04-10 03:42:21,968 INFO 2024-04-10 03:42:21,968 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 03:42:21,968 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:22,301 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:22,301 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:22,301 DEBUG --- stdout --- 2024-04-10 03:42:22,301 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:22,301 DEBUG --- stderr --- 2024-04-10 03:42:22,301 DEBUG 2024-04-10 03:42:22,302 INFO 2024-04-10 03:42:22,302 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-3000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/rc.txt 2024-04-10 03:42:22,302 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 03:42:23,067 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:23,068 DEBUG --- stdout --- 2024-04-10 03:42:23,068 DEBUG tar: Removing leading `/' from member names 2024-04-10 03:42:23,068 DEBUG --- stderr --- 2024-04-10 03:42:23,068 DEBUG 2024-04-10 03:42:23,070 INFO 2024-04-10 03:42:23,070 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 03:42:23,070 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:23,431 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:23,432 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:23,432 DEBUG --- stdout --- 2024-04-10 03:42:23,432 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:23,432 DEBUG --- stderr --- 2024-04-10 03:42:23,432 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 03:42:23,432 INFO 2024-04-10 03:42:23,432 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 03:42:23,432 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:23,776 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:23,777 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:23,777 DEBUG --- stdout --- 2024-04-10 03:42:23,777 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:23,777 DEBUG --- stderr --- 2024-04-10 03:42:23,777 DEBUG 2024-04-10 03:42:23,777 INFO 2024-04-10 03:42:23,777 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-3000/stderr.txt" ]; then echo "/results/orders/authn-users-3000/stderr.txt file found"; exit 0; else echo "/results/orders/authn-users-3000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-3000/stderr.txt file found" 2024-04-10 03:42:23,777 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 03:42:24,604 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 03:42:24,606 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:24,606 DEBUG --- stdout --- 2024-04-10 03:42:24,606 DEBUG /results/orders/authn-users-3000/stderr.txt file found 2024-04-10 03:42:24,606 DEBUG --- stderr --- 2024-04-10 03:42:24,606 DEBUG 2024-04-10 03:42:24,607 INFO 2024-04-10 03:42:24,607 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 03:42:24,607 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:24,963 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:24,964 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:24,964 DEBUG --- stdout --- 2024-04-10 03:42:24,964 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:24,964 DEBUG --- stderr --- 2024-04-10 03:42:24,964 DEBUG 2024-04-10 03:42:24,964 INFO 2024-04-10 03:42:24,964 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-3000/stderr.txt 2024-04-10 03:42:25,818 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 03:42:25,818 DEBUG --- stdout --- 2024-04-10 03:42:25,819 DEBUG 0 /results/orders/authn-users-3000/stderr.txt 2024-04-10 03:42:25,819 DEBUG --- stderr --- 2024-04-10 03:42:25,819 DEBUG 2024-04-10 03:42:25,819 INFO - Download file (size 0k) 2024-04-10 03:42:25,819 INFO 2024-04-10 03:42:25,819 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 03:42:25,819 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:26,137 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:26,137 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:26,137 DEBUG --- stdout --- 2024-04-10 03:42:26,138 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:26,138 DEBUG --- stderr --- 2024-04-10 03:42:26,138 DEBUG source : /results/orders/authn-users-3000/stderr.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/stderr.txt 2024-04-10 03:42:26,138 INFO 2024-04-10 03:42:26,138 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 03:42:26,138 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:26,449 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:26,449 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:26,449 DEBUG --- stdout --- 2024-04-10 03:42:26,449 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:26,449 DEBUG --- stderr --- 2024-04-10 03:42:26,449 DEBUG 2024-04-10 03:42:26,450 INFO 2024-04-10 03:42:26,450 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-3000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/stderr.txt 2024-04-10 03:42:26,450 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 03:42:27,199 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:27,199 DEBUG --- stdout --- 2024-04-10 03:42:27,199 DEBUG tar: Removing leading `/' from member names 2024-04-10 03:42:27,199 DEBUG --- stderr --- 2024-04-10 03:42:27,199 DEBUG 2024-04-10 03:42:27,200 INFO 2024-04-10 03:42:27,200 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 03:42:27,200 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:27,515 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:27,515 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:27,515 DEBUG --- stdout --- 2024-04-10 03:42:27,515 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:27,515 DEBUG --- stderr --- 2024-04-10 03:42:27,515 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 03:42:27,516 INFO 2024-04-10 03:42:27,516 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 03:42:27,516 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:27,840 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:27,840 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:27,840 DEBUG --- stdout --- 2024-04-10 03:42:27,840 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:27,840 DEBUG --- stderr --- 2024-04-10 03:42:27,840 DEBUG 2024-04-10 03:42:27,841 INFO 2024-04-10 03:42:27,841 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-3000/stdout.txt" ]; then echo "/results/orders/authn-users-3000/stdout.txt file found"; exit 0; else echo "/results/orders/authn-users-3000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-3000/stdout.txt file found" 2024-04-10 03:42:27,841 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 03:42:28,678 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 03:42:28,678 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:28,678 DEBUG --- stdout --- 2024-04-10 03:42:28,678 DEBUG /results/orders/authn-users-3000/stdout.txt file found 2024-04-10 03:42:28,678 DEBUG --- stderr --- 2024-04-10 03:42:28,678 DEBUG 2024-04-10 03:42:28,678 INFO 2024-04-10 03:42:28,678 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 03:42:28,678 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:29,001 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:29,001 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:29,001 DEBUG --- stdout --- 2024-04-10 03:42:29,002 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:29,002 DEBUG --- stderr --- 2024-04-10 03:42:29,002 DEBUG 2024-04-10 03:42:29,002 INFO 2024-04-10 03:42:29,002 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-3000/stdout.txt 2024-04-10 03:42:29,891 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 03:42:29,893 DEBUG --- stdout --- 2024-04-10 03:42:29,893 DEBUG 508 /results/orders/authn-users-3000/stdout.txt 2024-04-10 03:42:29,893 DEBUG --- stderr --- 2024-04-10 03:42:29,893 DEBUG 2024-04-10 03:42:29,893 INFO - Download file (size 508k) 2024-04-10 03:42:29,893 INFO 2024-04-10 03:42:29,893 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 03:42:29,894 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:30,202 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:30,202 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:30,202 DEBUG --- stdout --- 2024-04-10 03:42:30,202 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:30,202 DEBUG --- stderr --- 2024-04-10 03:42:30,202 DEBUG source : /results/orders/authn-users-3000/stdout.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/stdout.txt 2024-04-10 03:42:30,203 INFO 2024-04-10 03:42:30,203 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 03:42:30,203 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:30,541 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:30,541 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:30,541 DEBUG --- stdout --- 2024-04-10 03:42:30,541 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:30,541 DEBUG --- stderr --- 2024-04-10 03:42:30,541 DEBUG 2024-04-10 03:42:30,541 INFO 2024-04-10 03:42:30,541 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-3000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/stdout.txt 2024-04-10 03:42:30,542 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 03:42:31,681 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:31,681 DEBUG --- stdout --- 2024-04-10 03:42:31,681 DEBUG tar: Removing leading `/' from member names 2024-04-10 03:42:31,681 DEBUG --- stderr --- 2024-04-10 03:42:31,682 DEBUG ________________________________________________________________________________ [2024-04-10 03:42:31] authn-users-3000 show_cmd : Display order command ________________________________________________________________________________ 2024-04-10 03:42:31,682 INFO 2024-04-10 03:42:31,682 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 03:42:31,682 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:31,990 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:31,990 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:31,990 DEBUG --- stdout --- 2024-04-10 03:42:31,990 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:31,990 DEBUG --- stderr --- 2024-04-10 03:42:31,990 DEBUG Checking pod: overseer-0-6f8784665d-zq5hb for file exists, if not wait. 2024-04-10 03:42:31,991 INFO 2024-04-10 03:42:31,991 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 03:42:31,991 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:32,296 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:32,296 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:32,296 DEBUG --- stdout --- 2024-04-10 03:42:32,296 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:32,296 DEBUG --- stderr --- 2024-04-10 03:42:32,296 DEBUG 2024-04-10 03:42:32,297 INFO 2024-04-10 03:42:32,297 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-3000/cmd.txt" ]; then echo "/results/orders/authn-users-3000/cmd.txt file found"; exit 0; else echo "/results/orders/authn-users-3000/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-3000/cmd.txt file found" 2024-04-10 03:42:32,297 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-10 03:42:33,117 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-10 03:42:33,118 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:33,118 DEBUG --- stdout --- 2024-04-10 03:42:33,118 DEBUG /results/orders/authn-users-3000/cmd.txt file found 2024-04-10 03:42:33,118 DEBUG --- stderr --- 2024-04-10 03:42:33,118 DEBUG 2024-04-10 03:42:33,118 INFO 2024-04-10 03:42:33,118 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 03:42:33,118 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:33,425 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:33,425 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:33,425 DEBUG --- stdout --- 2024-04-10 03:42:33,425 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:33,425 DEBUG --- stderr --- 2024-04-10 03:42:33,426 DEBUG 2024-04-10 03:42:33,426 INFO 2024-04-10 03:42:33,426 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-3000/cmd.txt 2024-04-10 03:42:34,252 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-10 03:42:34,252 DEBUG --- stdout --- 2024-04-10 03:42:34,252 DEBUG 4 /results/orders/authn-users-3000/cmd.txt 2024-04-10 03:42:34,252 DEBUG --- stderr --- 2024-04-10 03:42:34,252 DEBUG 2024-04-10 03:42:34,252 INFO - Download file (size 4k) 2024-04-10 03:42:34,253 INFO 2024-04-10 03:42:34,253 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 03:42:34,253 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:34,563 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:34,563 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:34,563 DEBUG --- stdout --- 2024-04-10 03:42:34,563 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:34,563 DEBUG --- stderr --- 2024-04-10 03:42:34,563 DEBUG source : /results/orders/authn-users-3000/cmd.txt @ overseer-0-6f8784665d-zq5hb destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/cmd.txt 2024-04-10 03:42:34,563 INFO 2024-04-10 03:42:34,564 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-10 03:42:34,564 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-10 03:42:34,893 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-10 03:42:34,895 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:34,895 DEBUG --- stdout --- 2024-04-10 03:42:34,895 DEBUG overseer-0-6f8784665d-zq5hb 2024-04-10 03:42:34,895 DEBUG --- stderr --- 2024-04-10 03:42:34,895 DEBUG 2024-04-10 03:42:34,896 INFO 2024-04-10 03:42:34,896 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-3000/cmd.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/cmd.txt 2024-04-10 03:42:34,896 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-10 03:42:35,740 INFO [loop_until]: OK (rc = 0) 2024-04-10 03:42:35,740 DEBUG --- stdout --- 2024-04-10 03:42:35,740 DEBUG tar: Removing leading `/' from member names 2024-04-10 03:42:35,740 DEBUG --- stderr --- 2024-04-10 03:42:35,740 DEBUG 2024-04-10 03:42:35,740 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/cmd.txt is small (1 lines), printing all lines: 2024-04-10 03:42:35,741 DEBUG ----- output ----- 2024-04-10 03:42:35,741 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-3000 --extra-run-jvm-options "-Xmx4G" --no-reports 2024-04-10 03:42:35,741 INFO ________________________________________________________________________________ [2024-04-10 03:42:35] authn-users-3000 show_rc : Display rc order ________________________________________________________________________________ 2024-04-10 03:42:35,741 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/rc.txt is small (1 lines), printing all lines: 2024-04-10 03:42:35,741 DEBUG ----- output ----- 2024-04-10 03:42:35,741 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-04-10 03:42:35,741 INFO ________________________________________________________________________________ [2024-04-10 03:42:35] authn-users-3000 show_stdout : Display stdout order ________________________________________________________________________________ 2024-04-10 03:42:35,743 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/05_authn-users-3000/stdout.txt is 8746 lines): 2024-04-10 03:42:35,743 DEBUG ----- output ----- 2024-04-10 03:42:35,743 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-04-10 03:42:35,743 INFO Gatling 3.10.5 is available! (you're using 3.9.5) 2024-04-10 03:42:35,743 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-04-10 03:42:35,743 INFO 2024-04-10 03:42:35,743 INFO ================================================================================ 2024-04-10 03:42:35,743 INFO 2024-04-10 03:40:11 5s elapsed 2024-04-10 03:42:35,743 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,743 INFO > Global (OK=1247 KO=0 ) 2024-04-10 03:42:35,744 INFO > userRestLogin (OK=1247 KO=0 ) 2024-04-10 03:42:35,744 INFO 2024-04-10 03:42:35,744 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,744 INFO [- ] 0% 2024-04-10 03:42:35,744 INFO waiting: 10850514 / active: 5 / done: 1247 2024-04-10 03:42:35,744 INFO ================================================================================ 2024-04-10 03:42:35,744 INFO 2024-04-10 03:42:35,744 INFO 2024-04-10 03:42:35,744 INFO ================================================================================ 2024-04-10 03:42:35,744 INFO 2024-04-10 03:40:16 10s elapsed 2024-04-10 03:42:35,744 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,744 INFO > Global (OK=4995 KO=0 ) 2024-04-10 03:42:35,744 INFO > userRestLogin (OK=4995 KO=0 ) 2024-04-10 03:42:35,744 INFO 2024-04-10 03:42:35,745 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,745 INFO [- ] 0% 2024-04-10 03:42:35,745 INFO waiting: 10846761 / active: 10 / done: 4995 2024-04-10 03:42:35,745 INFO ================================================================================ 2024-04-10 03:42:35,745 INFO 2024-04-10 03:42:35,745 INFO 2024-04-10 03:42:35,745 INFO ================================================================================ 2024-04-10 03:42:35,745 INFO 2024-04-10 03:40:21 15s elapsed 2024-04-10 03:42:35,745 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,745 INFO > Global (OK=11243 KO=0 ) 2024-04-10 03:42:35,745 INFO > userRestLogin (OK=11243 KO=0 ) 2024-04-10 03:42:35,745 INFO 2024-04-10 03:42:35,745 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,745 INFO [- ] 0% 2024-04-10 03:42:35,745 INFO waiting: 10840505 / active: 18 / done: 11243 2024-04-10 03:42:35,746 INFO ================================================================================ 2024-04-10 03:42:35,746 INFO 2024-04-10 03:42:35,746 INFO 2024-04-10 03:42:35,746 INFO ================================================================================ 2024-04-10 03:42:35,746 INFO 2024-04-10 03:40:26 20s elapsed 2024-04-10 03:42:35,746 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,746 INFO > Global (OK=19986 KO=0 ) 2024-04-10 03:42:35,746 INFO > userRestLogin (OK=19986 KO=0 ) 2024-04-10 03:42:35,746 INFO 2024-04-10 03:42:35,746 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,746 INFO [- ] 0% 2024-04-10 03:42:35,746 INFO waiting: 10831753 / active: 27 / done: 19986 2024-04-10 03:42:35,746 INFO ================================================================================ 2024-04-10 03:42:35,746 INFO 2024-04-10 03:42:35,746 INFO 2024-04-10 03:42:35,746 INFO ================================================================================ 2024-04-10 03:42:35,746 INFO 2024-04-10 03:40:31 25s elapsed 2024-04-10 03:42:35,746 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,746 INFO > Global (OK=31231 KO=0 ) 2024-04-10 03:42:35,747 INFO > userRestLogin (OK=31231 KO=0 ) 2024-04-10 03:42:35,747 INFO 2024-04-10 03:42:35,747 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,747 INFO [- ] 0% 2024-04-10 03:42:35,747 INFO waiting: 10820503 / active: 32 / done: 31231 2024-04-10 03:42:35,747 INFO ================================================================================ 2024-04-10 03:42:35,747 INFO 2024-04-10 03:42:35,747 INFO 2024-04-10 03:42:35,747 INFO ================================================================================ 2024-04-10 03:42:35,747 INFO 2024-04-10 03:40:36 30s elapsed 2024-04-10 03:42:35,747 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,747 INFO > Global (OK=44906 KO=0 ) 2024-04-10 03:42:35,747 INFO > userRestLogin (OK=44906 KO=0 ) 2024-04-10 03:42:35,747 INFO 2024-04-10 03:42:35,747 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,747 INFO [- ] 0% 2024-04-10 03:42:35,747 INFO waiting: 10806806 / active: 54 / done: 44906 2024-04-10 03:42:35,747 INFO ================================================================================ 2024-04-10 03:42:35,747 INFO 2024-04-10 03:42:35,747 INFO 2024-04-10 03:42:35,747 INFO ================================================================================ 2024-04-10 03:42:35,747 INFO 2024-04-10 03:40:41 35s elapsed 2024-04-10 03:42:35,747 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,747 INFO > Global (OK=59961 KO=0 ) 2024-04-10 03:42:35,747 INFO > userRestLogin (OK=59961 KO=0 ) 2024-04-10 03:42:35,748 INFO 2024-04-10 03:42:35,748 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,748 INFO [- ] 0% 2024-04-10 03:42:35,748 INFO waiting: 10791758 / active: 47 / done: 59961 2024-04-10 03:42:35,748 INFO ================================================================================ 2024-04-10 03:42:35,748 INFO 2024-04-10 03:42:35,748 INFO 2024-04-10 03:42:35,748 INFO ================================================================================ 2024-04-10 03:42:35,748 INFO 2024-04-10 03:40:46 40s elapsed 2024-04-10 03:42:35,748 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,748 INFO > Global (OK=74871 KO=0 ) 2024-04-10 03:42:35,748 INFO > userRestLogin (OK=74871 KO=0 ) 2024-04-10 03:42:35,748 INFO 2024-04-10 03:42:35,748 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,748 INFO [- ] 0% 2024-04-10 03:42:35,748 INFO waiting: 10776847 / active: 48 / done: 74871 2024-04-10 03:42:35,748 INFO ================================================================================ 2024-04-10 03:42:35,748 INFO 2024-04-10 03:42:35,748 INFO 2024-04-10 03:42:35,748 INFO [...] 2024-04-10 03:42:35,752 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,752 INFO > Global (OK=10776323 KO=0 ) 2024-04-10 03:42:35,752 INFO > userRestLogin (OK=10776323 KO=0 ) 2024-04-10 03:42:35,752 INFO 2024-04-10 03:42:35,752 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,753 INFO [#########################################################################-] 99% 2024-04-10 03:42:35,753 INFO waiting: 75157 / active: 287 / done: 10776322 2024-04-10 03:42:35,753 INFO ================================================================================ 2024-04-10 03:42:35,753 INFO 2024-04-10 03:42:35,753 INFO 2024-04-10 03:42:35,753 INFO ================================================================================ 2024-04-10 03:42:35,753 INFO 2024-04-10 04:40:16 3610s elapsed 2024-04-10 03:42:35,753 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,753 INFO > Global (OK=10791590 KO=0 ) 2024-04-10 03:42:35,753 INFO > userRestLogin (OK=10791590 KO=0 ) 2024-04-10 03:42:35,753 INFO 2024-04-10 03:42:35,753 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,753 INFO [#########################################################################-] 99% 2024-04-10 03:42:35,753 INFO waiting: 60129 / active: 47 / done: 10791590 2024-04-10 03:42:35,753 INFO ================================================================================ 2024-04-10 03:42:35,753 INFO 2024-04-10 03:42:35,753 INFO 2024-04-10 03:42:35,753 INFO ================================================================================ 2024-04-10 03:42:35,753 INFO 2024-04-10 04:40:21 3615s elapsed 2024-04-10 03:42:35,753 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,753 INFO > Global (OK=10806496 KO=0 ) 2024-04-10 03:42:35,753 INFO > userRestLogin (OK=10806496 KO=0 ) 2024-04-10 03:42:35,753 INFO 2024-04-10 03:42:35,753 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,753 INFO [#########################################################################-] 99% 2024-04-10 03:42:35,753 INFO waiting: 45224 / active: 47 / done: 10806495 2024-04-10 03:42:35,753 INFO ================================================================================ 2024-04-10 03:42:35,754 INFO 2024-04-10 03:42:35,754 INFO 2024-04-10 03:42:35,754 INFO ================================================================================ 2024-04-10 03:42:35,754 INFO 2024-04-10 04:40:26 3620s elapsed 2024-04-10 03:42:35,754 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,754 INFO > Global (OK=10821619 KO=0 ) 2024-04-10 03:42:35,754 INFO > userRestLogin (OK=10821619 KO=0 ) 2024-04-10 03:42:35,754 INFO 2024-04-10 03:42:35,754 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,754 INFO [#########################################################################-] 99% 2024-04-10 03:42:35,754 INFO waiting: 30106 / active: 41 / done: 10821619 2024-04-10 03:42:35,754 INFO ================================================================================ 2024-04-10 03:42:35,754 INFO 2024-04-10 03:42:35,754 INFO 2024-04-10 03:42:35,754 INFO ================================================================================ 2024-04-10 03:42:35,754 INFO 2024-04-10 04:40:31 3625s elapsed 2024-04-10 03:42:35,754 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,754 INFO > Global (OK=10836551 KO=0 ) 2024-04-10 03:42:35,754 INFO > userRestLogin (OK=10836551 KO=0 ) 2024-04-10 03:42:35,754 INFO 2024-04-10 03:42:35,754 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,754 INFO [#########################################################################-] 99% 2024-04-10 03:42:35,754 INFO waiting: 15167 / active: 50 / done: 10836549 2024-04-10 03:42:35,754 INFO ================================================================================ 2024-04-10 03:42:35,755 INFO 2024-04-10 03:42:35,755 INFO 2024-04-10 03:42:35,755 INFO ================================================================================ 2024-04-10 03:42:35,755 INFO 2024-04-10 04:40:36 3630s elapsed 2024-04-10 03:42:35,755 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,755 INFO > Global (OK=10851739 KO=0 ) 2024-04-10 03:42:35,755 INFO > userRestLogin (OK=10851739 KO=0 ) 2024-04-10 03:42:35,755 INFO 2024-04-10 03:42:35,755 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,755 INFO [#########################################################################-] 99% 2024-04-10 03:42:35,755 INFO waiting: 0 / active: 27 / done: 10851739 2024-04-10 03:42:35,755 INFO ================================================================================ 2024-04-10 03:42:35,755 INFO 2024-04-10 03:42:35,755 INFO 2024-04-10 03:42:35,755 INFO ================================================================================ 2024-04-10 03:42:35,755 INFO 2024-04-10 04:40:36 3630s elapsed 2024-04-10 03:42:35,755 INFO ---- Requests ------------------------------------------------------------------ 2024-04-10 03:42:35,755 INFO > Global (OK=10851766 KO=0 ) 2024-04-10 03:42:35,755 INFO > userRestLogin (OK=10851766 KO=0 ) 2024-04-10 03:42:35,755 INFO 2024-04-10 03:42:35,755 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-10 03:42:35,755 INFO [##########################################################################]100% 2024-04-10 03:42:35,755 INFO waiting: 0 / active: 0 / done: 10851766 2024-04-10 03:42:35,755 INFO ================================================================================ 2024-04-10 03:42:35,755 INFO 2024-04-10 03:42:35,755 INFO Simulation com.forgerock.gatling.Loadtest completed in 3630 seconds 2024-04-10 03:42:35,756 INFO 2024-04-10 03:42:35,756 INFO ---------------------- 2024-04-10 03:42:35,756 INFO [10/Apr/2024 04:40:36] Create tar file authn-users-3000.tar.gz 2024-04-10 03:42:35,756 INFO ---------------------- 2024-04-10 03:42:35,756 INFO RESULTS_FOLDER=/results/gatling/ 2024-04-10 03:42:35,756 INFO RESULT_FOLDER=authn-users-3000 2024-04-10 03:42:35,756 INFO SIMULATION_PATH=authn-users-3000/loadtest-20240410024006083 2024-04-10 03:42:35,756 INFO PWD=/results/gatling/authn-users-3000/loadtest-20240410024006083 2024-04-10 03:42:35,756 INFO [cmd] tar -czvf /results/gatling//authn-users-3000.tar.gz --exclude=simulation.log * 2024-04-10 03:42:35,756 INFO /results/gatling 2024-04-10 03:42:35,756 INFO 2024-04-10 03:42:35,756 INFO ---------------------- 2024-04-10 03:42:35,756 INFO [10/Apr/2024 04:40:36] Update /results/gatling//latest 2024-04-10 03:42:35,756 INFO ---------------------- 2024-04-10 03:42:35,756 INFO 2024-04-10 03:42:35,756 INFO ---------------------- 2024-04-10 03:42:35,756 INFO [10/Apr/2024 04:40:36] Update /results/gatling//latest.tar.gz 2024-04-10 03:42:35,756 INFO ---------------------- 2024-04-10 03:42:35,756 INFO ________________________________________________________________________________ [2024-04-10 03:42:35] authn-users-3000 show_stderr : Display stderr order ________________________________________________________________________________ 2024-04-10 03:42:35,757 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/05_authn-users-3000/stderr.txt is small (0 lines), printing all lines: 2024-04-10 03:42:35,757 DEBUG ----- output ----- 2024-04-10 03:42:35,757 DEBUG 2024-04-10 03:42:35,757 INFO ________________________________________________________________________________ [2024-04-10 03:42:35] authn-users-3000 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 03:42:35] authn-users-3000 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-04-10 03:42:35] authn-users-3000 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped