--Task-- name: authn-users-6000 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: [] preceding_task: None options: {'testMode': 'open', 'testCase': 'am.AMAuthN', 'throughput': 6000, 'duration': 1800} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-04-16 21:10:56] authn-users-6000 pre : N/A ________________________________________________________________________________ [2024-04-16 21:10:56] - INFO: Timeout for this Task has changed to 36m (2160 seconds) [2024-04-16 21:10:56] - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/authn-users-6000/stdout.txt Pod log : /results/orders/authn-users-6000 2024-04-16 21:10:56,622 INFO 2024-04-16 21:10:56,622 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-16 21:10:56,623 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:10:56,944 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:10:56,944 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:10:56,944 DEBUG --- stdout --- 2024-04-16 21:10:56,945 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:10:56,945 DEBUG --- stderr --- 2024-04-16 21:10:56,945 DEBUG [2024-04-16 21:10:56] - INFO: Get overseer pod resources requests memory 2024-04-16 21:10:56,945 INFO 2024-04-16 21:10:56,945 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods overseer-0-7c9b667974-9mr2s --output jsonpath={.spec.containers[].resources.requests.memory} 2024-04-16 21:10:56,945 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-16 21:10:57,273 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:10:57,274 DEBUG --- stdout --- 2024-04-16 21:10:57,274 DEBUG 4Gi 2024-04-16 21:10:57,274 DEBUG --- stderr --- 2024-04-16 21:10:57,274 DEBUG ________________________________________________________________________________ [2024-04-16 21:10:57] authn-users-6000 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-04-16 21:10:57,274 INFO 2024-04-16 21:10:57,275 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-16 21:10:57,275 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:10:57,585 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:10:57,585 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:10:57,585 DEBUG --- stdout --- 2024-04-16 21:10:57,585 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:10:57,585 DEBUG --- stderr --- 2024-04-16 21:10:57,585 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-6000 --extra-run-jvm-options "-Xmx4G" --no-reports ________________________________________________________________________________ [2024-04-16 21:10:57] authn-users-6000 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-04-16 21:10:57,586 INFO 2024-04-16 21:10:57,586 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-16 21:10:57,586 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:10:57,884 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:10:57,885 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:10:57,885 DEBUG --- stdout --- 2024-04-16 21:10:57,885 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:10:57,885 DEBUG --- stderr --- 2024-04-16 21:10:57,885 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/order.json { "name": "authn-users-6000", "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-6000 --extra-run-jvm-options \"-Xmx4G\" --no-reports", "out-dir": "/results/orders/authn-users-6000", "environment": { "JAVA_OPTS": "-Dam_host=xlou.iam.xlou-cdm.engineeringpit.com -DamadminPassword=**** -DamadminUsername=amadmin -Dduration=1800 -Dnum_users=1000000 -DtestCase=am.AMAuthN -DtestMode=open -Dthroughput=6000 -Duser_password=T35tr0ck123" } } ________________________________________________________________________________ [2024-04-16 21:10:57] authn-users-6000 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-16 21:10:57,886 INFO 2024-04-16 21:10:57,886 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-04-16 21:10:57,886 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-16 21:10:58,166 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-16 21:10:58,166 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:10:58,166 DEBUG --- stdout --- 2024-04-16 21:10:58,166 DEBUG WAITING 2024-04-16 21:10:58,167 DEBUG --- stderr --- 2024-04-16 21:10:58,167 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 27 0 --:--:-- --:--:-- --:--:-- 27 ________________________________________________________________________________ [2024-04-16 21:10:58] authn-users-6000 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-04-16 21:10:58,167 INFO 2024-04-16 21:10:58,167 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-16 21:10:58,167 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:10:58,468 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:10:58,468 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:10:58,468 DEBUG --- stdout --- 2024-04-16 21:10:58,468 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:10:58,468 DEBUG --- stderr --- 2024-04-16 21:10:58,468 DEBUG 2024-04-16 21:10:58,468 INFO 2024-04-16 21:10:58,468 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/01_authn-users-6000/order.json overseer-0-7c9b667974-9mr2s:/results/orders/order.json 2024-04-16 21:10:58,469 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-16 21:10:59,889 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:10:59,889 DEBUG --- stdout --- 2024-04-16 21:10:59,889 DEBUG 2024-04-16 21:10:59,889 DEBUG --- stderr --- 2024-04-16 21:10:59,889 DEBUG Order has been successfully forwarded to overseer [2024-04-16 21:10:59] - INFO: Check if Gatling simulation started successfully 2024-04-16 21:10:59,890 INFO 2024-04-16 21:10:59,890 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-16 21:10:59,890 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:11:00,209 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:11:00,209 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:11:00,210 DEBUG --- stdout --- 2024-04-16 21:11:00,210 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:11:00,210 DEBUG --- stderr --- 2024-04-16 21:11:00,210 DEBUG 2024-04-16 21:11:00,210 INFO 2024-04-16 21:11:00,210 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s -- head -n 25 /results/orders/authn-users-6000/stdout.txt | grep "started..." 2024-04-16 21:11:00,210 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-04-16 21:11:00,961 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-04-16 21:11:06,755 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: started... - retry 2024-04-16 21:11:12,544 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: started... - retry 2024-04-16 21:11:18,341 INFO [loop_until]: Function succeeded after 18s (rc=0) - expected pattern found 2024-04-16 21:11:18,342 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:11:18,342 DEBUG --- stdout --- 2024-04-16 21:11:18,342 DEBUG GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 22:11:02.527 [WARN ] i.g.c.ZincCompiler$ - -target is deprecated: Use -release instead to compile against the correct platform API. 22:11:08.377 [WARN ] i.g.c.ZincCompiler$ - /lodestar/pyrock/shared/clients/gatling-open/benchmark/Testcase.scala:122:35: method - in trait MapOps is deprecated (since 2.13.0): Use - or remove on an immutable Map crossSessionVariables.-("poliEvalTokenId"); ^ 22:11:08.379 [WARN ] i.g.c.ZincCompiler$ - /lodestar/pyrock/shared/clients/gatling-open/benchmark/Testcase.scala:225:35: method - in trait MapOps is deprecated (since 2.13.0): Use - or remove on an immutable Map crossSessionVariables.-("poliEvalTokenId"); ^ 22:11:10.649 [WARN ] i.g.c.ZincCompiler$ - three warnings found Gatling 3.10.5 is available! (you're using 3.9.5) Simulation com.forgerock.gatling.Loadtest started... 2024-04-16 21:11:18,342 DEBUG --- stderr --- 2024-04-16 21:11:18,343 DEBUG ________________________________________________________________________________ [2024-04-16 21:11:18] authn-users-6000 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 36m Waiting for status (curl --fail --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt) == WAITING Order is running since 5s, retry Order is running since 10s, retry Order is running since 15s, retry Order is running since 20s, retry Order is running since 26s, retry Order is running since 31s, retry Order is running since 36s, retry Order is running since 41s, retry Order is running since 47s, retry Order is running since 52s, retry Order is running since 57s, retry Order is running since 1m 02s, retry Order is running since 1m 07s, retry Order is running since 1m 13s, retry Order is running since 1m 18s, retry Order is running since 1m 23s, retry Order is running since 1m 28s, retry Order is running since 1m 33s, retry Order is running since 1m 39s, retry Order is running since 1m 44s, retry Order is running since 1m 49s, retry Order is running since 1m 54s, retry Order is running since 2m, retry Order is running since 2m 05s, retry Order is running since 2m 10s, retry Order is running since 2m 15s, retry Order is running since 2m 20s, retry Order is running since 2m 26s, retry Order is running since 2m 31s, retry Order is running since 2m 36s, retry Order is running since 2m 41s, retry Order is running since 2m 47s, retry Order is running since 2m 52s, retry Order is running since 2m 57s, retry Order is running since 3m 02s, retry Order is running since 3m 08s, retry Order is running since 3m 13s, retry Order is running since 3m 18s, retry Order is running since 3m 23s, retry Order is running since 3m 28s, retry Order is running since 3m 34s, retry Order is running since 3m 39s, retry Order is running since 3m 44s, retry Order is running since 3m 49s, retry Order is running since 3m 54s, retry Order is running since 4m, retry Order is running since 4m 05s, retry Order is running since 4m 10s, retry Order is running since 4m 15s, retry Order is running since 4m 21s, retry Order is running since 4m 26s, retry Order is running since 4m 31s, retry Order is running since 4m 36s, retry Order is running since 4m 42s, retry Order is running since 4m 47s, retry Order is running since 4m 52s, retry Order is running since 4m 57s, retry Order is running since 5m 02s, retry Order is running since 5m 08s, retry Order is running since 5m 13s, retry Order is running since 5m 18s, retry Order is running since 5m 23s, retry Order is running since 5m 28s, retry Order is running since 5m 34s, retry Order is running since 5m 39s, retry Order is running since 5m 44s, retry Order is running since 5m 49s, retry Order is running since 5m 55s, retry Order is running since 6m, retry Order is running since 6m 05s, retry Order is running since 6m 10s, retry Order is running since 6m 15s, retry Order is running since 6m 21s, retry Order is running since 6m 26s, retry Order is running since 6m 31s, retry Order is running since 6m 36s, retry Order is running since 6m 42s, retry Order is running since 6m 47s, retry Order is running since 6m 52s, retry Order is running since 6m 57s, retry Order is running since 7m 02s, retry Order is running since 7m 08s, retry Order is running since 7m 13s, retry Order is running since 7m 18s, retry Order is running since 7m 23s, retry Order is running since 7m 29s, retry Order is running since 7m 34s, retry Order is running since 7m 39s, retry Order is running since 7m 44s, retry Order is running since 7m 49s, retry Order is running since 7m 55s, retry Order is running since 8m, retry Order is running since 8m 05s, retry Order is running since 8m 10s, retry Order is running since 8m 16s, retry Order is running since 8m 21s, retry Order is running since 8m 26s, retry Order is running since 8m 31s, retry Order is running since 8m 36s, retry Order is running since 8m 42s, retry Order is running since 8m 47s, retry Order is running since 8m 52s, retry Order is running since 8m 57s, retry Order is running since 9m 03s, retry Order is running since 9m 08s, retry Order is running since 9m 13s, retry Order is running since 9m 18s, retry Order is running since 9m 23s, retry Order is running since 9m 29s, retry Order is running since 9m 34s, retry Order is running since 9m 39s, retry Order is running since 9m 44s, retry Order is running since 9m 50s, retry Order is running since 9m 55s, retry Order is running since 10m, retry Order is running since 10m 05s, retry Order is running since 10m 10s, retry Order is running since 10m 16s, retry Order is running since 10m 21s, retry Order is running since 10m 26s, retry Order is running since 10m 31s, retry Order is running since 10m 37s, retry Order is running since 10m 42s, retry Order is running since 10m 47s, retry Order is running since 10m 52s, retry Order is running since 10m 57s, retry Order is running since 11m 03s, retry Order is running since 11m 08s, retry Order is running since 11m 13s, retry Order is running since 11m 18s, retry Order is running since 11m 23s, retry Order is running since 11m 29s, retry Order is running since 11m 34s, retry Order is running since 11m 39s, retry Order is running since 11m 44s, retry Order is running since 11m 50s, retry Order is running since 11m 55s, retry Order is running since 12m, retry Order is running since 12m 05s, retry Order is running since 12m 10s, retry Order is running since 12m 16s, retry Order is running since 12m 21s, retry Order is running since 12m 26s, retry Order is running since 12m 31s, retry Order is running since 12m 36s, retry Order is running since 12m 42s, retry Order is running since 12m 47s, retry Order is running since 12m 52s, retry Order is running since 12m 57s, retry Order is running since 13m 03s, retry Order is running since 13m 08s, retry Order is running since 13m 13s, retry Order is running since 13m 18s, retry Order is running since 13m 23s, retry Order is running since 13m 29s, retry Order is running since 13m 34s, retry Order is running since 13m 39s, retry Order is running since 13m 44s, retry Order is running since 13m 50s, retry Order is running since 13m 55s, retry Order is running since 14m, retry Order is running since 14m 05s, retry Order is running since 14m 10s, retry Order is running since 14m 16s, retry Order is running since 14m 21s, retry Order is running since 14m 26s, retry Order is running since 14m 31s, retry Order is running since 14m 37s, retry Order is running since 14m 42s, retry Order is running since 14m 47s, retry Order is running since 14m 52s, retry Order is running since 14m 58s, retry Order is running since 15m 03s, retry Order is running since 15m 08s, retry Order is running since 15m 13s, retry Order is running since 15m 18s, retry Order is running since 15m 24s, retry Order is running since 15m 29s, retry Order is running since 15m 34s, retry Order is running since 15m 39s, retry Order is running since 15m 44s, retry Order is running since 15m 50s, retry Order is running since 15m 55s, retry Order is running since 16m, retry Order is running since 16m 05s, retry Order is running since 16m 11s, retry Order is running since 16m 16s, retry Order is running since 16m 21s, retry Order is running since 16m 26s, retry Order is running since 16m 31s, retry Order is running since 16m 37s, retry Order is running since 16m 42s, retry Order is running since 16m 47s, retry Order is running since 16m 52s, retry Order is running since 16m 58s, retry Order is running since 17m 03s, retry Order is running since 17m 08s, retry Order is running since 17m 13s, retry Order is running since 17m 18s, retry Order is running since 17m 24s, retry Order is running since 17m 29s, retry Order is running since 17m 34s, retry Order is running since 17m 39s, retry Order is running since 17m 44s, retry Order is running since 17m 50s, retry Order is running since 17m 55s, retry Order is running since 18m, retry Order is running since 18m 05s, retry Order is running since 18m 11s, retry Order is running since 18m 16s, retry Order is running since 18m 21s, retry Order is running since 18m 26s, retry Order is running since 18m 31s, retry Order is running since 18m 37s, retry Order is running since 18m 42s, retry Order is running since 18m 47s, retry Order is running since 18m 52s, retry Order is running since 18m 58s, retry Order is running since 19m 03s, retry Order is running since 19m 08s, retry Order is running since 19m 13s, retry Order is running since 19m 18s, retry Order is running since 19m 24s, retry Order is running since 19m 29s, retry Order is running since 19m 34s, retry Order is running since 19m 39s, retry Order is running since 19m 45s, retry Order is running since 19m 50s, retry Order is running since 19m 55s, retry Order is running since 20m, retry Order is running since 20m 05s, retry Order is running since 20m 11s, retry Order is running since 20m 16s, retry Order is running since 20m 21s, retry Order is running since 20m 26s, retry Order is running since 20m 32s, retry Order is running since 20m 37s, retry Order is running since 20m 42s, retry Order is running since 20m 47s, retry Order is running since 20m 52s, retry Order is running since 20m 58s, retry Order is running since 21m 03s, retry Order is running since 21m 08s, retry Order is running since 21m 13s, retry Order is running since 21m 19s, retry Order is running since 21m 24s, retry Order is running since 21m 29s, retry Order is running since 21m 34s, retry Order is running since 21m 39s, retry Order is running since 21m 45s, retry Order is running since 21m 50s, retry Order is running since 21m 55s, retry Order is running since 22m, retry Order is running since 22m 06s, retry Order is running since 22m 11s, retry Order is running since 22m 16s, retry Order is running since 22m 21s, retry Order is running since 22m 26s, retry Order is running since 22m 32s, retry Order is running since 22m 37s, retry Order is running since 22m 42s, retry Order is running since 22m 47s, retry Order is running since 22m 53s, retry Order is running since 22m 58s, retry Order is running since 23m 03s, retry Order is running since 23m 08s, retry Order is running since 23m 13s, retry Order is running since 23m 19s, retry Order is running since 23m 24s, retry Order is running since 23m 29s, retry Order is running since 23m 34s, retry Order is running since 23m 39s, retry Order is running since 23m 45s, retry Order is running since 23m 50s, retry Order is running since 23m 55s, retry Order is running since 24m, retry Order is running since 24m 06s, retry Order is running since 24m 11s, retry Order is running since 24m 16s, retry Order is running since 24m 21s, retry Order is running since 24m 27s, retry Order is running since 24m 32s, retry Order is running since 24m 37s, retry Order is running since 24m 42s, retry Order is running since 24m 47s, retry Order is running since 24m 53s, retry Order is running since 24m 58s, retry Order is running since 25m 03s, retry Order is running since 25m 08s, retry Order is running since 25m 14s, retry Order is running since 25m 19s, retry Order is running since 25m 24s, retry Order is running since 25m 29s, retry Order is running since 25m 34s, retry Order is running since 25m 40s, retry Order is running since 25m 45s, retry Order is running since 25m 50s, retry Order is running since 25m 55s, retry Order is running since 26m, retry Order is running since 26m 06s, retry Order is running since 26m 11s, retry Order is running since 26m 16s, retry Order is running since 26m 21s, retry Order is running since 26m 27s, retry Order is running since 26m 32s, retry Order is running since 26m 37s, retry Order is running since 26m 42s, retry Order is running since 26m 47s, retry Order is running since 26m 53s, retry Order is running since 26m 58s, retry Order is running since 27m 03s, retry Order is running since 27m 08s, retry Order is running since 27m 14s, retry Order is running since 27m 19s, retry Order is running since 27m 24s, retry Order is running since 27m 29s, retry Order is running since 27m 34s, retry Order is running since 27m 40s, retry Order is running since 27m 45s, retry Order is running since 27m 50s, retry Order is running since 27m 55s, retry Order is running since 28m 01s, retry Order is running since 28m 06s, retry Order is running since 28m 11s, retry Order is running since 28m 16s, retry Order is running since 28m 21s, retry Order is running since 28m 27s, retry Order is running since 28m 32s, retry Order is running since 28m 37s, retry Order is running since 28m 42s, retry Order is running since 28m 48s, retry Order is running since 28m 53s, retry Order is running since 28m 58s, retry Order is running since 29m 03s, retry Order is running since 29m 08s, retry Order is running since 29m 14s, retry Order is running since 29m 19s, retry Order is running since 29m 24s, retry Order is running since 29m 29s, retry Order is running since 29m 34s, retry Order is running since 29m 40s, retry Order is running since 29m 45s, retry Order is running since 29m 50s, retry Order is running since 29m 55s, retry Order is running since 30m 01s, retry Order is running since 30m 06s, retry Order is running since 30m 11s, retry Order is running since 30m 16s, retry Order is running since 30m 21s, retry Order is running since 30m 27s, retry PASS : Order stopped by itself after 30m 32s and before timeout (36m) ________________________________________________________________________________ [2024-04-16 21:41:50] authn-users-6000 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-04-16 21:41:50,739 INFO 2024-04-16 21:41:50,740 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-16 21:41:50,740 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:51,095 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:51,095 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:51,095 DEBUG --- stdout --- 2024-04-16 21:41:51,095 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:51,096 DEBUG --- stderr --- 2024-04-16 21:41:51,096 DEBUG 2024-04-16 21:41:51,096 INFO 2024-04-16 21:41:51,096 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s -- rm -f /results/orders/order.json 2024-04-16 21:41:51,096 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-16 21:41:51,913 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:51,913 DEBUG --- stdout --- 2024-04-16 21:41:51,913 DEBUG 2024-04-16 21:41:51,914 DEBUG --- stderr --- 2024-04-16 21:41:51,914 DEBUG Order ran during 30m 52s ________________________________________________________________________________ [2024-04-16 21:41:51] authn-users-6000 download_logs : Download individual order files ________________________________________________________________________________ [2024-04-16 21:41:51] - PASS: file already downloaded /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/order.json 2024-04-16 21:41:51,914 INFO 2024-04-16 21:41:51,914 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-16 21:41:51,914 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:52,224 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:52,224 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:52,224 DEBUG --- stdout --- 2024-04-16 21:41:52,224 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:52,224 DEBUG --- stderr --- 2024-04-16 21:41:52,224 DEBUG Checking pod: overseer-0-7c9b667974-9mr2s for file exists, if not wait. 2024-04-16 21:41:52,225 INFO 2024-04-16 21:41:52,225 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-16 21:41:52,225 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:52,531 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:52,531 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:52,531 DEBUG --- stdout --- 2024-04-16 21:41:52,531 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:52,531 DEBUG --- stderr --- 2024-04-16 21:41:52,531 DEBUG 2024-04-16 21:41:52,532 INFO 2024-04-16 21:41:52,532 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- bash -c 'if [ -f "/results/orders/authn-users-6000/rc.txt" ]; then echo "/results/orders/authn-users-6000/rc.txt file found"; exit 0; else echo "/results/orders/authn-users-6000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-6000/rc.txt file found" 2024-04-16 21:41:52,532 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-16 21:41:53,364 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-16 21:41:53,364 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:53,364 DEBUG --- stdout --- 2024-04-16 21:41:53,364 DEBUG /results/orders/authn-users-6000/rc.txt file found 2024-04-16 21:41:53,364 DEBUG --- stderr --- 2024-04-16 21:41:53,364 DEBUG 2024-04-16 21:41:53,365 INFO 2024-04-16 21:41:53,365 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-16 21:41:53,365 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:53,672 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:53,673 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:53,673 DEBUG --- stdout --- 2024-04-16 21:41:53,673 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:53,673 DEBUG --- stderr --- 2024-04-16 21:41:53,673 DEBUG 2024-04-16 21:41:53,673 INFO 2024-04-16 21:41:53,673 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- du -k /results/orders/authn-users-6000/rc.txt 2024-04-16 21:41:54,497 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-16 21:41:54,498 DEBUG --- stdout --- 2024-04-16 21:41:54,498 DEBUG 4 /results/orders/authn-users-6000/rc.txt 2024-04-16 21:41:54,498 DEBUG --- stderr --- 2024-04-16 21:41:54,498 DEBUG 2024-04-16 21:41:54,499 INFO - Download file (size 4k) 2024-04-16 21:41:54,499 INFO 2024-04-16 21:41:54,499 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-16 21:41:54,499 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:54,844 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:54,845 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:54,845 DEBUG --- stdout --- 2024-04-16 21:41:54,845 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:54,845 DEBUG --- stderr --- 2024-04-16 21:41:54,845 DEBUG source : /results/orders/authn-users-6000/rc.txt @ overseer-0-7c9b667974-9mr2s destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/rc.txt 2024-04-16 21:41:54,845 INFO 2024-04-16 21:41:54,845 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-16 21:41:54,845 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:55,143 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:55,143 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:55,143 DEBUG --- stdout --- 2024-04-16 21:41:55,143 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:55,143 DEBUG --- stderr --- 2024-04-16 21:41:55,143 DEBUG 2024-04-16 21:41:55,143 INFO 2024-04-16 21:41:55,144 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-7c9b667974-9mr2s:/results/orders/authn-users-6000/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/rc.txt 2024-04-16 21:41:55,144 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-16 21:41:55,884 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:55,885 DEBUG --- stdout --- 2024-04-16 21:41:55,885 DEBUG tar: Removing leading `/' from member names 2024-04-16 21:41:55,885 DEBUG --- stderr --- 2024-04-16 21:41:55,885 DEBUG 2024-04-16 21:41:55,885 INFO 2024-04-16 21:41:55,885 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-16 21:41:55,885 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:56,189 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:56,189 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:56,189 DEBUG --- stdout --- 2024-04-16 21:41:56,189 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:56,189 DEBUG --- stderr --- 2024-04-16 21:41:56,189 DEBUG Checking pod: overseer-0-7c9b667974-9mr2s for file exists, if not wait. 2024-04-16 21:41:56,190 INFO 2024-04-16 21:41:56,190 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-16 21:41:56,190 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:56,491 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:56,491 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:56,491 DEBUG --- stdout --- 2024-04-16 21:41:56,491 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:56,491 DEBUG --- stderr --- 2024-04-16 21:41:56,491 DEBUG 2024-04-16 21:41:56,492 INFO 2024-04-16 21:41:56,492 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- bash -c 'if [ -f "/results/orders/authn-users-6000/stderr.txt" ]; then echo "/results/orders/authn-users-6000/stderr.txt file found"; exit 0; else echo "/results/orders/authn-users-6000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-6000/stderr.txt file found" 2024-04-16 21:41:56,492 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-16 21:41:57,301 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-16 21:41:57,301 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:57,302 DEBUG --- stdout --- 2024-04-16 21:41:57,302 DEBUG /results/orders/authn-users-6000/stderr.txt file found 2024-04-16 21:41:57,302 DEBUG --- stderr --- 2024-04-16 21:41:57,302 DEBUG 2024-04-16 21:41:57,302 INFO 2024-04-16 21:41:57,302 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-16 21:41:57,302 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:57,613 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:57,613 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:57,613 DEBUG --- stdout --- 2024-04-16 21:41:57,613 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:57,613 DEBUG --- stderr --- 2024-04-16 21:41:57,613 DEBUG 2024-04-16 21:41:57,613 INFO 2024-04-16 21:41:57,613 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- du -k /results/orders/authn-users-6000/stderr.txt 2024-04-16 21:41:58,435 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-16 21:41:58,435 DEBUG --- stdout --- 2024-04-16 21:41:58,436 DEBUG 0 /results/orders/authn-users-6000/stderr.txt 2024-04-16 21:41:58,436 DEBUG --- stderr --- 2024-04-16 21:41:58,436 DEBUG 2024-04-16 21:41:58,436 INFO - Download file (size 0k) 2024-04-16 21:41:58,436 INFO 2024-04-16 21:41:58,436 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-16 21:41:58,436 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:58,786 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:58,786 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:58,786 DEBUG --- stdout --- 2024-04-16 21:41:58,786 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:58,786 DEBUG --- stderr --- 2024-04-16 21:41:58,786 DEBUG source : /results/orders/authn-users-6000/stderr.txt @ overseer-0-7c9b667974-9mr2s destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/stderr.txt 2024-04-16 21:41:58,787 INFO 2024-04-16 21:41:58,787 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-16 21:41:58,787 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:41:59,106 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:41:59,106 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:59,106 DEBUG --- stdout --- 2024-04-16 21:41:59,107 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:41:59,107 DEBUG --- stderr --- 2024-04-16 21:41:59,107 DEBUG 2024-04-16 21:41:59,107 INFO 2024-04-16 21:41:59,107 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-7c9b667974-9mr2s:/results/orders/authn-users-6000/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/stderr.txt 2024-04-16 21:41:59,107 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-16 21:41:59,850 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:41:59,850 DEBUG --- stdout --- 2024-04-16 21:41:59,850 DEBUG tar: Removing leading `/' from member names 2024-04-16 21:41:59,850 DEBUG --- stderr --- 2024-04-16 21:41:59,850 DEBUG 2024-04-16 21:41:59,851 INFO 2024-04-16 21:41:59,851 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-16 21:41:59,851 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:00,153 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:00,153 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:00,153 DEBUG --- stdout --- 2024-04-16 21:42:00,153 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:00,153 DEBUG --- stderr --- 2024-04-16 21:42:00,154 DEBUG Checking pod: overseer-0-7c9b667974-9mr2s for file exists, if not wait. 2024-04-16 21:42:00,154 INFO 2024-04-16 21:42:00,154 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-16 21:42:00,154 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:00,455 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:00,455 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:00,455 DEBUG --- stdout --- 2024-04-16 21:42:00,455 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:00,455 DEBUG --- stderr --- 2024-04-16 21:42:00,455 DEBUG 2024-04-16 21:42:00,456 INFO 2024-04-16 21:42:00,456 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- bash -c 'if [ -f "/results/orders/authn-users-6000/stdout.txt" ]; then echo "/results/orders/authn-users-6000/stdout.txt file found"; exit 0; else echo "/results/orders/authn-users-6000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-6000/stdout.txt file found" 2024-04-16 21:42:00,456 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-16 21:42:01,270 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-16 21:42:01,270 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:01,270 DEBUG --- stdout --- 2024-04-16 21:42:01,270 DEBUG /results/orders/authn-users-6000/stdout.txt file found 2024-04-16 21:42:01,270 DEBUG --- stderr --- 2024-04-16 21:42:01,270 DEBUG 2024-04-16 21:42:01,270 INFO 2024-04-16 21:42:01,270 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-04-16 21:42:01,270 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:01,574 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:01,574 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:01,574 DEBUG --- stdout --- 2024-04-16 21:42:01,574 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:01,574 DEBUG --- stderr --- 2024-04-16 21:42:01,574 DEBUG 2024-04-16 21:42:01,574 INFO 2024-04-16 21:42:01,575 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- du -k /results/orders/authn-users-6000/stdout.txt 2024-04-16 21:42:02,390 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-16 21:42:02,390 DEBUG --- stdout --- 2024-04-16 21:42:02,390 DEBUG 260 /results/orders/authn-users-6000/stdout.txt 2024-04-16 21:42:02,390 DEBUG --- stderr --- 2024-04-16 21:42:02,390 DEBUG 2024-04-16 21:42:02,390 INFO - Download file (size 260k) 2024-04-16 21:42:02,391 INFO 2024-04-16 21:42:02,391 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-16 21:42:02,391 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:02,696 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:02,696 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:02,696 DEBUG --- stdout --- 2024-04-16 21:42:02,696 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:02,696 DEBUG --- stderr --- 2024-04-16 21:42:02,696 DEBUG source : /results/orders/authn-users-6000/stdout.txt @ overseer-0-7c9b667974-9mr2s destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/stdout.txt 2024-04-16 21:42:02,696 INFO 2024-04-16 21:42:02,696 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-16 21:42:02,696 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:02,997 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:02,997 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:02,997 DEBUG --- stdout --- 2024-04-16 21:42:02,997 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:02,997 DEBUG --- stderr --- 2024-04-16 21:42:02,997 DEBUG 2024-04-16 21:42:02,997 INFO 2024-04-16 21:42:02,997 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-7c9b667974-9mr2s:/results/orders/authn-users-6000/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/stdout.txt 2024-04-16 21:42:02,997 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-16 21:42:03,994 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:03,994 DEBUG --- stdout --- 2024-04-16 21:42:03,994 DEBUG tar: Removing leading `/' from member names 2024-04-16 21:42:03,994 DEBUG --- stderr --- 2024-04-16 21:42:03,994 DEBUG ________________________________________________________________________________ [2024-04-16 21:42:03] authn-users-6000 show_cmd : Display order command ________________________________________________________________________________ 2024-04-16 21:42:03,995 INFO 2024-04-16 21:42:03,995 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-16 21:42:03,995 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:04,331 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:04,331 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:04,331 DEBUG --- stdout --- 2024-04-16 21:42:04,331 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:04,331 DEBUG --- stderr --- 2024-04-16 21:42:04,331 DEBUG Checking pod: overseer-0-7c9b667974-9mr2s for file exists, if not wait. 2024-04-16 21:42:04,332 INFO 2024-04-16 21:42:04,332 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-16 21:42:04,332 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:04,677 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:04,677 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:04,677 DEBUG --- stdout --- 2024-04-16 21:42:04,677 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:04,677 DEBUG --- stderr --- 2024-04-16 21:42:04,677 DEBUG 2024-04-16 21:42:04,678 INFO 2024-04-16 21:42:04,678 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- bash -c 'if [ -f "/results/orders/authn-users-6000/cmd.txt" ]; then echo "/results/orders/authn-users-6000/cmd.txt file found"; exit 0; else echo "/results/orders/authn-users-6000/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/authn-users-6000/cmd.txt file found" 2024-04-16 21:42:04,678 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-04-16 21:42:05,516 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-04-16 21:42:05,517 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:05,517 DEBUG --- stdout --- 2024-04-16 21:42:05,517 DEBUG /results/orders/authn-users-6000/cmd.txt file found 2024-04-16 21:42:05,517 DEBUG --- stderr --- 2024-04-16 21:42:05,518 DEBUG 2024-04-16 21:42:05,518 INFO 2024-04-16 21:42:05,518 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-16 21:42:05,518 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:05,875 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:05,875 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:05,876 DEBUG --- stdout --- 2024-04-16 21:42:05,876 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:05,876 DEBUG --- stderr --- 2024-04-16 21:42:05,876 DEBUG 2024-04-16 21:42:05,876 INFO 2024-04-16 21:42:05,876 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-7c9b667974-9mr2s --stdin -- du -k /results/orders/authn-users-6000/cmd.txt 2024-04-16 21:42:06,743 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-04-16 21:42:06,744 DEBUG --- stdout --- 2024-04-16 21:42:06,744 DEBUG 4 /results/orders/authn-users-6000/cmd.txt 2024-04-16 21:42:06,744 DEBUG --- stderr --- 2024-04-16 21:42:06,744 DEBUG 2024-04-16 21:42:06,744 INFO - Download file (size 4k) 2024-04-16 21:42:06,744 INFO 2024-04-16 21:42:06,744 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-16 21:42:06,744 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:07,048 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:07,048 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:07,048 DEBUG --- stdout --- 2024-04-16 21:42:07,048 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:07,048 DEBUG --- stderr --- 2024-04-16 21:42:07,048 DEBUG source : /results/orders/authn-users-6000/cmd.txt @ overseer-0-7c9b667974-9mr2s destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/cmd.txt 2024-04-16 21:42:07,048 INFO 2024-04-16 21:42:07,048 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-16 21:42:07,048 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-04-16 21:42:07,348 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-04-16 21:42:07,348 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:07,348 DEBUG --- stdout --- 2024-04-16 21:42:07,348 DEBUG overseer-0-7c9b667974-9mr2s 2024-04-16 21:42:07,348 DEBUG --- stderr --- 2024-04-16 21:42:07,349 DEBUG 2024-04-16 21:42:07,349 INFO 2024-04-16 21:42:07,349 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-7c9b667974-9mr2s:/results/orders/authn-users-6000/cmd.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/cmd.txt 2024-04-16 21:42:07,349 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-04-16 21:42:08,113 INFO [loop_until]: OK (rc = 0) 2024-04-16 21:42:08,114 DEBUG --- stdout --- 2024-04-16 21:42:08,114 DEBUG tar: Removing leading `/' from member names 2024-04-16 21:42:08,114 DEBUG --- stderr --- 2024-04-16 21:42:08,114 DEBUG 2024-04-16 21:42:08,114 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/cmd.txt is small (1 lines), printing all lines: 2024-04-16 21:42:08,114 DEBUG ----- output ----- 2024-04-16 21:42:08,114 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-6000 --extra-run-jvm-options "-Xmx4G" --no-reports 2024-04-16 21:42:08,114 INFO ________________________________________________________________________________ [2024-04-16 21:42:08] authn-users-6000 show_rc : Display rc order ________________________________________________________________________________ 2024-04-16 21:42:08,115 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/rc.txt is small (1 lines), printing all lines: 2024-04-16 21:42:08,115 DEBUG ----- output ----- 2024-04-16 21:42:08,115 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-04-16 21:42:08,115 INFO ________________________________________________________________________________ [2024-04-16 21:42:08] authn-users-6000 show_stdout : Display stdout order ________________________________________________________________________________ 2024-04-16 21:42:08,116 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/01_authn-users-6000/stdout.txt is 4434 lines): 2024-04-16 21:42:08,116 DEBUG ----- output ----- 2024-04-16 21:42:08,116 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-04-16 21:42:08,116 INFO 22:11:02.527 [WARN ] i.g.c.ZincCompiler$ - -target is deprecated: Use -release instead to compile against the correct platform API. 2024-04-16 21:42:08,116 INFO 22:11:08.377 [WARN ] i.g.c.ZincCompiler$ - /lodestar/pyrock/shared/clients/gatling-open/benchmark/Testcase.scala:122:35: method - in trait MapOps is deprecated (since 2.13.0): Use - or remove on an immutable Map 2024-04-16 21:42:08,116 INFO crossSessionVariables.-("poliEvalTokenId"); 2024-04-16 21:42:08,116 INFO ^ 2024-04-16 21:42:08,116 INFO 22:11:08.379 [WARN ] i.g.c.ZincCompiler$ - /lodestar/pyrock/shared/clients/gatling-open/benchmark/Testcase.scala:225:35: method - in trait MapOps is deprecated (since 2.13.0): Use - or remove on an immutable Map 2024-04-16 21:42:08,116 INFO crossSessionVariables.-("poliEvalTokenId"); 2024-04-16 21:42:08,116 INFO ^ 2024-04-16 21:42:08,116 INFO 22:11:10.649 [WARN ] i.g.c.ZincCompiler$ - three warnings found 2024-04-16 21:42:08,116 INFO Gatling 3.10.5 is available! (you're using 3.9.5) 2024-04-16 21:42:08,116 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-04-16 21:42:08,116 INFO 2024-04-16 21:42:08,116 INFO ================================================================================ 2024-04-16 21:42:08,116 INFO 2024-04-16 22:11:20 5s elapsed 2024-04-16 21:42:08,116 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,116 INFO > Global (OK=2500 KO=0 ) 2024-04-16 21:42:08,116 INFO > userRestLogin (OK=2500 KO=0 ) 2024-04-16 21:42:08,116 INFO 2024-04-16 21:42:08,116 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,116 INFO [- ] 0% 2024-04-16 21:42:08,116 INFO waiting: 10882100 / active: 13 / done: 2500 2024-04-16 21:42:08,116 INFO ================================================================================ 2024-04-16 21:42:08,116 INFO 2024-04-16 21:42:08,116 INFO 2024-04-16 21:42:08,116 INFO ================================================================================ 2024-04-16 21:42:08,116 INFO 2024-04-16 22:11:25 10s elapsed 2024-04-16 21:42:08,116 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,116 INFO > Global (OK=10004 KO=0 ) 2024-04-16 21:42:08,116 INFO > userRestLogin (OK=10004 KO=0 ) 2024-04-16 21:42:08,116 INFO 2024-04-16 21:42:08,116 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,116 INFO [- ] 0% 2024-04-16 21:42:08,117 INFO waiting: 10874589 / active: 21 / done: 10003 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,117 INFO 2024-04-16 22:11:30 15s elapsed 2024-04-16 21:42:08,117 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,117 INFO > Global (OK=22507 KO=0 ) 2024-04-16 21:42:08,117 INFO > userRestLogin (OK=22507 KO=0 ) 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,117 INFO [- ] 0% 2024-04-16 21:42:08,117 INFO waiting: 10862078 / active: 28 / done: 22507 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,117 INFO 2024-04-16 22:11:35 20s elapsed 2024-04-16 21:42:08,117 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,117 INFO > Global (OK=40007 KO=0 ) 2024-04-16 21:42:08,117 INFO > userRestLogin (OK=40007 KO=0 ) 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,117 INFO [- ] 0% 2024-04-16 21:42:08,117 INFO waiting: 10844567 / active: 39 / done: 40007 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,117 INFO 2024-04-16 22:11:40 25s elapsed 2024-04-16 21:42:08,117 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,117 INFO > Global (OK=62508 KO=0 ) 2024-04-16 21:42:08,117 INFO > userRestLogin (OK=62508 KO=0 ) 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,117 INFO [- ] 0% 2024-04-16 21:42:08,117 INFO waiting: 10822056 / active: 49 / done: 62508 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO 2024-04-16 21:42:08,117 INFO ================================================================================ 2024-04-16 21:42:08,118 INFO 2024-04-16 22:11:45 30s elapsed 2024-04-16 21:42:08,118 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,118 INFO > Global (OK=89829 KO=0 ) 2024-04-16 21:42:08,118 INFO > userRestLogin (OK=89829 KO=0 ) 2024-04-16 21:42:08,118 INFO 2024-04-16 21:42:08,118 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,118 INFO [- ] 0% 2024-04-16 21:42:08,118 INFO waiting: 10794715 / active: 69 / done: 89829 2024-04-16 21:42:08,118 INFO ================================================================================ 2024-04-16 21:42:08,118 INFO 2024-04-16 21:42:08,118 INFO 2024-04-16 21:42:08,118 INFO ================================================================================ 2024-04-16 21:42:08,118 INFO 2024-04-16 22:11:50 35s elapsed 2024-04-16 21:42:08,118 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,118 INFO > Global (OK=120066 KO=0 ) 2024-04-16 21:42:08,118 INFO > userRestLogin (OK=120066 KO=0 ) 2024-04-16 21:42:08,118 INFO 2024-04-16 21:42:08,118 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,118 INFO [- ] 1% 2024-04-16 21:42:08,118 INFO waiting: 10764431 / active: 117 / done: 120065 2024-04-16 21:42:08,118 INFO ================================================================================ 2024-04-16 21:42:08,118 INFO 2024-04-16 21:42:08,119 INFO 2024-04-16 21:42:08,119 INFO ================================================================================ 2024-04-16 21:42:08,119 INFO 2024-04-16 22:11:55 40s elapsed 2024-04-16 21:42:08,119 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,119 INFO > Global (OK=150328 KO=0 ) 2024-04-16 21:42:08,119 INFO [...] 2024-04-16 21:42:08,120 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,120 INFO > Global (OK=10734899 KO=0 ) 2024-04-16 21:42:08,120 INFO > userRestLogin (OK=10734899 KO=0 ) 2024-04-16 21:42:08,120 INFO 2024-04-16 21:42:08,120 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,120 INFO [########################################################################- ] 98% 2024-04-16 21:42:08,120 INFO waiting: 149645 / active: 70 / done: 10734898 2024-04-16 21:42:08,120 INFO ================================================================================ 2024-04-16 21:42:08,120 INFO 2024-04-16 21:42:08,120 INFO 2024-04-16 21:42:08,120 INFO ================================================================================ 2024-04-16 21:42:08,120 INFO 2024-04-16 22:41:25 1810s elapsed 2024-04-16 21:42:08,120 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,120 INFO > Global (OK=10764637 KO=0 ) 2024-04-16 21:42:08,120 INFO > userRestLogin (OK=10764637 KO=0 ) 2024-04-16 21:42:08,120 INFO 2024-04-16 21:42:08,120 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,120 INFO [#########################################################################-] 98% 2024-04-16 21:42:08,120 INFO waiting: 119928 / active: 49 / done: 10764636 2024-04-16 21:42:08,120 INFO ================================================================================ 2024-04-16 21:42:08,120 INFO 2024-04-16 21:42:08,120 INFO 2024-04-16 21:42:08,121 INFO ================================================================================ 2024-04-16 21:42:08,121 INFO 2024-04-16 22:41:30 1815s elapsed 2024-04-16 21:42:08,121 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,121 INFO > Global (OK=10794675 KO=0 ) 2024-04-16 21:42:08,121 INFO > userRestLogin (OK=10794675 KO=0 ) 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,121 INFO [#########################################################################-] 99% 2024-04-16 21:42:08,121 INFO waiting: 89875 / active: 66 / done: 10794672 2024-04-16 21:42:08,121 INFO ================================================================================ 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO ================================================================================ 2024-04-16 21:42:08,121 INFO 2024-04-16 22:41:35 1820s elapsed 2024-04-16 21:42:08,121 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,121 INFO > Global (OK=10824713 KO=0 ) 2024-04-16 21:42:08,121 INFO > userRestLogin (OK=10824713 KO=0 ) 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,121 INFO [#########################################################################-] 99% 2024-04-16 21:42:08,121 INFO waiting: 59812 / active: 88 / done: 10824713 2024-04-16 21:42:08,121 INFO ================================================================================ 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO ================================================================================ 2024-04-16 21:42:08,121 INFO 2024-04-16 22:41:40 1825s elapsed 2024-04-16 21:42:08,121 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,121 INFO > Global (OK=10854695 KO=0 ) 2024-04-16 21:42:08,121 INFO > userRestLogin (OK=10854695 KO=0 ) 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,121 INFO [#########################################################################-] 99% 2024-04-16 21:42:08,121 INFO waiting: 29714 / active: 205 / done: 10854694 2024-04-16 21:42:08,121 INFO ================================================================================ 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO 2024-04-16 21:42:08,121 INFO ================================================================================ 2024-04-16 21:42:08,121 INFO 2024-04-16 22:41:45 1830s elapsed 2024-04-16 21:42:08,122 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,122 INFO > Global (OK=10884583 KO=0 ) 2024-04-16 21:42:08,122 INFO > userRestLogin (OK=10884583 KO=0 ) 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,122 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,122 INFO [#########################################################################-] 99% 2024-04-16 21:42:08,122 INFO waiting: 0 / active: 30 / done: 10884583 2024-04-16 21:42:08,122 INFO ================================================================================ 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,122 INFO ================================================================================ 2024-04-16 21:42:08,122 INFO 2024-04-16 22:41:45 1830s elapsed 2024-04-16 21:42:08,122 INFO ---- Requests ------------------------------------------------------------------ 2024-04-16 21:42:08,122 INFO > Global (OK=10884613 KO=0 ) 2024-04-16 21:42:08,122 INFO > userRestLogin (OK=10884613 KO=0 ) 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,122 INFO ---- am.AMAuthN ---------------------------------------------------------------- 2024-04-16 21:42:08,122 INFO [##########################################################################]100% 2024-04-16 21:42:08,122 INFO waiting: 0 / active: 0 / done: 10884613 2024-04-16 21:42:08,122 INFO ================================================================================ 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,122 INFO Simulation com.forgerock.gatling.Loadtest completed in 1830 seconds 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,122 INFO ---------------------- 2024-04-16 21:42:08,122 INFO [16/Apr/2024 22:41:45] Create tar file authn-users-6000.tar.gz 2024-04-16 21:42:08,122 INFO ---------------------- 2024-04-16 21:42:08,122 INFO RESULTS_FOLDER=/results/gatling/ 2024-04-16 21:42:08,122 INFO RESULT_FOLDER=authn-users-6000 2024-04-16 21:42:08,122 INFO SIMULATION_PATH=authn-users-6000/loadtest-20240416211114724 2024-04-16 21:42:08,122 INFO PWD=/results/gatling/authn-users-6000/loadtest-20240416211114724 2024-04-16 21:42:08,122 INFO [cmd] tar -czvf /results/gatling//authn-users-6000.tar.gz --exclude=simulation.log * 2024-04-16 21:42:08,122 INFO /results/gatling 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,122 INFO ---------------------- 2024-04-16 21:42:08,122 INFO [16/Apr/2024 22:41:45] Update /results/gatling//latest 2024-04-16 21:42:08,122 INFO ---------------------- 2024-04-16 21:42:08,122 INFO 2024-04-16 21:42:08,123 INFO ---------------------- 2024-04-16 21:42:08,123 INFO [16/Apr/2024 22:41:45] Update /results/gatling//latest.tar.gz 2024-04-16 21:42:08,123 INFO ---------------------- 2024-04-16 21:42:08,123 INFO ________________________________________________________________________________ [2024-04-16 21:42:08] authn-users-6000 show_stderr : Display stderr order ________________________________________________________________________________ 2024-04-16 21:42:08,123 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/authn_rest/07_Scenario_AuthN/01_authn-users-6000/stderr.txt is small (0 lines), printing all lines: 2024-04-16 21:42:08,123 DEBUG ----- output ----- 2024-04-16 21:42:08,123 DEBUG 2024-04-16 21:42:08,123 INFO ________________________________________________________________________________ [2024-04-16 21:42:08] authn-users-6000 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-16 21:42:08] authn-users-6000 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-04-16 21:42:08] authn-users-6000 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped