--Task-- name: login-tree-300 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: ['login-tree-250'] preceding_task: login-tree-250 options: {'testCase': 'idc.login', 'testMode': 'open', 'throughput': 300, 'rampup-duration': 30, 'duration': 3600, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd -Dlogin_tree=Login'} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-06-24 02:33:18] login-tree-300 pre : N/A ________________________________________________________________________________ 2024-06-24 02:33:18 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2024-06-24 02:33:18 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/login-tree-300/stdout.txt Pod log : /results/orders/login-tree-300 2024-06-24 02:33:18,316 INFO 2024-06-24 02:33:18,316 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-06-24 02:33:18,316 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 02:33:18,629 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 02:33:18,630 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:18,630 DEBUG --- stdout --- 2024-06-24 02:33:18,630 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 02:33:18,630 DEBUG --- stderr --- 2024-06-24 02:33:18,630 DEBUG ________________________________________________________________________________ [2024-06-24 02:33:18] login-tree-300 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-06-24 02:33:18,631 INFO 2024-06-24 02:33:18,631 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-06-24 02:33:18,631 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 02:33:18,948 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 02:33:18,949 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:18,949 DEBUG --- stdout --- 2024-06-24 02:33:18,949 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 02:33:18,949 DEBUG --- stderr --- 2024-06-24 02:33:18,949 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 "idc.login@ema-perf-p1" --results-folder /results/gatling/login-tree-300 --extra-run-jvm-options "-Xmx4G" --no-reports ________________________________________________________________________________ [2024-06-24 02:33:18] login-tree-300 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-06-24 02:33:18,950 INFO 2024-06-24 02:33:18,950 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-24 02:33:18,950 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 02:33:19,268 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 02:33:19,269 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:19,269 DEBUG --- stdout --- 2024-06-24 02:33:19,269 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 02:33:19,269 DEBUG --- stderr --- 2024-06-24 02:33:19,269 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/order.json { "name": "login-tree-300", "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 \"idc.login@ema-perf-p1\" --results-folder /results/gatling/login-tree-300 --extra-run-jvm-options \"-Xmx4G\" --no-reports", "out-dir": "/results/orders/login-tree-300", "environment": { "JAVA_OPTS": "-Dam_host=openam-ema-perf-p1.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@forgerock.com -Dduration=3600 -Didc=true -Dlogin_cookie=69cee86761d9c02 -Dlogin_tree=Login -Dnum_users=1000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -Drampup_duration=30 -Drealm=alpha -DtestCase=idc.login -DtestMode=open -Dthroughput=300 -Duser_password=Pa_ssw0rd" } } ________________________________________________________________________________ [2024-06-24 02:33:19] login-tree-300 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-06-24 02:33:19,271 INFO 2024-06-24 02:33:19,272 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-24 02:33:19,272 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-06-24 02:33:19,530 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 02:33:19,530 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:19,530 DEBUG --- stdout --- 2024-06-24 02:33:19,530 DEBUG WAITING 2024-06-24 02:33:19,530 DEBUG --- stderr --- 2024-06-24 02:33:19,530 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 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 32 0 --:--:-- --:--:-- --:--:-- 31 ________________________________________________________________________________ [2024-06-24 02:33:19] login-tree-300 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-06-24 02:33:19,531 INFO 2024-06-24 02:33:19,531 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-06-24 02:33:19,531 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 02:33:19,849 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 02:33:19,849 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:19,849 DEBUG --- stdout --- 2024-06-24 02:33:19,849 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 02:33:19,849 DEBUG --- stderr --- 2024-06-24 02:33:19,849 DEBUG 2024-06-24 02:33:19,849 INFO 2024-06-24 02:33:19,850 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/order.json overseer-0-5b6f9464fd-slbm8:/results/orders/order.json 2024-06-24 02:33:19,850 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 02:33:21,221 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:21,221 DEBUG --- stdout --- 2024-06-24 02:33:21,221 DEBUG 2024-06-24 02:33:21,221 DEBUG --- stderr --- 2024-06-24 02:33:21,221 DEBUG Order has been successfully forwarded to overseer 2024-06-24 02:33:21 - INFO: Check if Gatling simulation started successfully 2024-06-24 02:33:21,222 INFO 2024-06-24 02:33:21,222 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-06-24 02:33:21,222 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 02:33:21,537 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 02:33:21,537 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:21,537 DEBUG --- stdout --- 2024-06-24 02:33:21,537 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 02:33:21,537 DEBUG --- stderr --- 2024-06-24 02:33:21,537 DEBUG 2024-06-24 02:33:21,537 INFO 2024-06-24 02:33:21,538 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 -- head -n 25 /results/orders/login-tree-300/stdout.txt | grep "started..." 2024-06-24 02:33:21,538 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-06-24 02:33:22,283 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-06-24 02:33:28,037 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: started... - retry 2024-06-24 02:33:33,780 INFO [loop_until]: Function succeeded after 12s (rc=0) - expected pattern found 2024-06-24 02:33:33,780 INFO [loop_until]: OK (rc = 0) 2024-06-24 02:33:33,780 DEBUG --- stdout --- 2024-06-24 02:33:33,780 DEBUG GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 03:33:23.370 [WARN ] i.g.c.ZincCompiler$ - -target is deprecated: Use -release instead to compile against the correct platform API. 03:33:28.185 [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"); ^ 03:33:28.188 [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"); ^ 03:33:29.923 [WARN ] i.g.c.ZincCompiler$ - three warnings found Gatling 3.11.4 is available! (you're using 3.9.5) Simulation com.forgerock.gatling.Loadtest started... 2024-06-24 02:33:33,780 DEBUG --- stderr --- 2024-06-24 02:33:33,780 DEBUG ________________________________________________________________________________ [2024-06-24 02:33:33] login-tree-300 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 01s, 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 03s, 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 06s, retry Order is running since 38m 06s, retry Order is running since 40m 06s, retry Order is running since 42m 06s, retry Order is running since 44m 07s, retry Order is running since 46m 07s, retry Order is running since 48m 07s, retry Order is running since 50m 08s, retry Order is running since 52m 08s, retry Order is running since 54m 08s, 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-06-24 03:35:43] login-tree-300 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-06-24 03:35:43,879 INFO 2024-06-24 03:35:43,879 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-06-24 03:35:43,879 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:44,202 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:44,203 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:44,203 DEBUG --- stdout --- 2024-06-24 03:35:44,203 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:44,203 DEBUG --- stderr --- 2024-06-24 03:35:44,203 DEBUG 2024-06-24 03:35:44,203 INFO 2024-06-24 03:35:44,203 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 -- rm -f /results/orders/order.json 2024-06-24 03:35:44,203 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 03:35:44,989 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:44,989 DEBUG --- stdout --- 2024-06-24 03:35:44,989 DEBUG 2024-06-24 03:35:44,989 DEBUG --- stderr --- 2024-06-24 03:35:44,989 DEBUG Order ran during 1h 02m ________________________________________________________________________________ [2024-06-24 03:35:44] login-tree-300 download_logs : Download individual order files ________________________________________________________________________________ 2024-06-24 03:35:44 - PASS: file already downloaded /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/order.json 2024-06-24 03:35:44,991 INFO 2024-06-24 03:35:44,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-06-24 03:35:44,991 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:45,306 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:45,306 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:45,306 DEBUG --- stdout --- 2024-06-24 03:35:45,306 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:45,306 DEBUG --- stderr --- 2024-06-24 03:35:45,306 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 03:35:45,307 INFO 2024-06-24 03:35:45,307 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-06-24 03:35:45,307 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:45,630 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:45,631 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:45,631 DEBUG --- stdout --- 2024-06-24 03:35:45,631 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:45,631 DEBUG --- stderr --- 2024-06-24 03:35:45,631 DEBUG 2024-06-24 03:35:45,631 INFO 2024-06-24 03:35:45,631 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-300/rc.txt" ]; then echo "/results/orders/login-tree-300/rc.txt file found"; exit 0; else echo "/results/orders/login-tree-300/rc.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-300/rc.txt file found" 2024-06-24 03:35:45,632 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 03:35:46,453 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 03:35:46,453 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:46,453 DEBUG --- stdout --- 2024-06-24 03:35:46,453 DEBUG /results/orders/login-tree-300/rc.txt file found 2024-06-24 03:35:46,453 DEBUG --- stderr --- 2024-06-24 03:35:46,453 DEBUG 2024-06-24 03:35:46,454 INFO 2024-06-24 03:35:46,454 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-24 03:35:46,454 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:46,772 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:46,772 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:46,773 DEBUG --- stdout --- 2024-06-24 03:35:46,773 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:46,773 DEBUG --- stderr --- 2024-06-24 03:35:46,773 DEBUG 2024-06-24 03:35:46,773 INFO 2024-06-24 03:35:46,773 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/login-tree-300/rc.txt 2024-06-24 03:35:47,591 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 03:35:47,591 DEBUG --- stdout --- 2024-06-24 03:35:47,592 DEBUG 4 /results/orders/login-tree-300/rc.txt 2024-06-24 03:35:47,592 DEBUG --- stderr --- 2024-06-24 03:35:47,592 DEBUG 2024-06-24 03:35:47,592 INFO - Download file (size 4k) 2024-06-24 03:35:47,592 INFO 2024-06-24 03:35:47,592 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-06-24 03:35:47,592 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:47,900 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:47,901 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:47,901 DEBUG --- stdout --- 2024-06-24 03:35:47,901 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:47,901 DEBUG --- stderr --- 2024-06-24 03:35:47,901 DEBUG source : /results/orders/login-tree-300/rc.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/rc.txt 2024-06-24 03:35:47,901 INFO 2024-06-24 03:35:47,901 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-06-24 03:35:47,901 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:48,215 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:48,215 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:48,215 DEBUG --- stdout --- 2024-06-24 03:35:48,215 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:48,215 DEBUG --- stderr --- 2024-06-24 03:35:48,215 DEBUG 2024-06-24 03:35:48,216 INFO 2024-06-24 03:35:48,216 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/login-tree-300/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/rc.txt 2024-06-24 03:35:48,216 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 03:35:48,944 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:48,944 DEBUG --- stdout --- 2024-06-24 03:35:48,944 DEBUG tar: Removing leading `/' from member names 2024-06-24 03:35:48,944 DEBUG --- stderr --- 2024-06-24 03:35:48,944 DEBUG 2024-06-24 03:35:48,945 INFO 2024-06-24 03:35:48,945 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-06-24 03:35:48,945 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:49,255 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:49,255 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:49,255 DEBUG --- stdout --- 2024-06-24 03:35:49,255 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:49,255 DEBUG --- stderr --- 2024-06-24 03:35:49,255 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 03:35:49,256 INFO 2024-06-24 03:35:49,256 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-06-24 03:35:49,256 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:49,558 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:49,558 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:49,558 DEBUG --- stdout --- 2024-06-24 03:35:49,558 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:49,558 DEBUG --- stderr --- 2024-06-24 03:35:49,558 DEBUG 2024-06-24 03:35:49,559 INFO 2024-06-24 03:35:49,559 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-300/stderr.txt" ]; then echo "/results/orders/login-tree-300/stderr.txt file found"; exit 0; else echo "/results/orders/login-tree-300/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-300/stderr.txt file found" 2024-06-24 03:35:49,559 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 03:35:50,354 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 03:35:50,355 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:50,355 DEBUG --- stdout --- 2024-06-24 03:35:50,355 DEBUG /results/orders/login-tree-300/stderr.txt file found 2024-06-24 03:35:50,355 DEBUG --- stderr --- 2024-06-24 03:35:50,355 DEBUG 2024-06-24 03:35:50,355 INFO 2024-06-24 03:35:50,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-06-24 03:35:50,355 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:50,672 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:50,672 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:50,672 DEBUG --- stdout --- 2024-06-24 03:35:50,673 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:50,673 DEBUG --- stderr --- 2024-06-24 03:35:50,673 DEBUG 2024-06-24 03:35:50,673 INFO 2024-06-24 03:35:50,673 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/login-tree-300/stderr.txt 2024-06-24 03:35:51,495 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 03:35:51,495 DEBUG --- stdout --- 2024-06-24 03:35:51,495 DEBUG 0 /results/orders/login-tree-300/stderr.txt 2024-06-24 03:35:51,495 DEBUG --- stderr --- 2024-06-24 03:35:51,495 DEBUG 2024-06-24 03:35:51,495 INFO - Download file (size 0k) 2024-06-24 03:35:51,496 INFO 2024-06-24 03:35:51,496 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-06-24 03:35:51,496 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:51,813 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:51,814 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:51,814 DEBUG --- stdout --- 2024-06-24 03:35:51,814 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:51,814 DEBUG --- stderr --- 2024-06-24 03:35:51,814 DEBUG source : /results/orders/login-tree-300/stderr.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/stderr.txt 2024-06-24 03:35:51,814 INFO 2024-06-24 03:35:51,814 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-06-24 03:35:51,814 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:52,132 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:52,132 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:52,132 DEBUG --- stdout --- 2024-06-24 03:35:52,132 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:52,132 DEBUG --- stderr --- 2024-06-24 03:35:52,132 DEBUG 2024-06-24 03:35:52,133 INFO 2024-06-24 03:35:52,133 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/login-tree-300/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/stderr.txt 2024-06-24 03:35:52,133 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 03:35:52,997 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:52,997 DEBUG --- stdout --- 2024-06-24 03:35:52,997 DEBUG tar: Removing leading `/' from member names 2024-06-24 03:35:52,997 DEBUG --- stderr --- 2024-06-24 03:35:52,997 DEBUG 2024-06-24 03:35:52,998 INFO 2024-06-24 03:35:52,998 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-06-24 03:35:52,998 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:53,305 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:53,305 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:53,305 DEBUG --- stdout --- 2024-06-24 03:35:53,305 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:53,305 DEBUG --- stderr --- 2024-06-24 03:35:53,305 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 03:35:53,306 INFO 2024-06-24 03:35:53,306 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-06-24 03:35:53,306 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:53,612 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:53,613 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:53,613 DEBUG --- stdout --- 2024-06-24 03:35:53,613 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:53,613 DEBUG --- stderr --- 2024-06-24 03:35:53,613 DEBUG 2024-06-24 03:35:53,614 INFO 2024-06-24 03:35:53,614 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-300/stdout.txt" ]; then echo "/results/orders/login-tree-300/stdout.txt file found"; exit 0; else echo "/results/orders/login-tree-300/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-300/stdout.txt file found" 2024-06-24 03:35:53,614 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 03:35:54,445 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 03:35:54,445 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:54,447 DEBUG --- stdout --- 2024-06-24 03:35:54,447 DEBUG /results/orders/login-tree-300/stdout.txt file found 2024-06-24 03:35:54,448 DEBUG --- stderr --- 2024-06-24 03:35:54,448 DEBUG 2024-06-24 03:35:54,449 INFO 2024-06-24 03:35:54,449 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-06-24 03:35:54,449 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:54,861 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:54,861 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:54,861 DEBUG --- stdout --- 2024-06-24 03:35:54,861 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:54,861 DEBUG --- stderr --- 2024-06-24 03:35:54,861 DEBUG 2024-06-24 03:35:54,861 INFO 2024-06-24 03:35:54,862 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/login-tree-300/stdout.txt 2024-06-24 03:35:55,725 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 03:35:55,726 DEBUG --- stdout --- 2024-06-24 03:35:55,726 DEBUG 852 /results/orders/login-tree-300/stdout.txt 2024-06-24 03:35:55,726 DEBUG --- stderr --- 2024-06-24 03:35:55,726 DEBUG 2024-06-24 03:35:55,726 INFO - Download file (size 852k) 2024-06-24 03:35:55,727 INFO 2024-06-24 03:35:55,727 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-06-24 03:35:55,727 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:56,050 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:56,050 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:56,050 DEBUG --- stdout --- 2024-06-24 03:35:56,050 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:56,051 DEBUG --- stderr --- 2024-06-24 03:35:56,051 DEBUG source : /results/orders/login-tree-300/stdout.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/stdout.txt 2024-06-24 03:35:56,051 INFO 2024-06-24 03:35:56,051 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-24 03:35:56,051 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:56,376 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:56,377 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:56,377 DEBUG --- stdout --- 2024-06-24 03:35:56,377 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:56,377 DEBUG --- stderr --- 2024-06-24 03:35:56,377 DEBUG 2024-06-24 03:35:56,377 INFO 2024-06-24 03:35:56,377 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/login-tree-300/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/stdout.txt 2024-06-24 03:35:56,377 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 03:35:57,485 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:57,485 DEBUG --- stdout --- 2024-06-24 03:35:57,485 DEBUG tar: Removing leading `/' from member names 2024-06-24 03:35:57,485 DEBUG --- stderr --- 2024-06-24 03:35:57,485 DEBUG ________________________________________________________________________________ [2024-06-24 03:35:57] login-tree-300 show_cmd : Display order command ________________________________________________________________________________ 2024-06-24 03:35:57,486 INFO 2024-06-24 03:35:57,486 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-06-24 03:35:57,486 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:57,805 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:57,806 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:57,806 DEBUG --- stdout --- 2024-06-24 03:35:57,806 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:57,806 DEBUG --- stderr --- 2024-06-24 03:35:57,806 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 03:35:57,806 INFO 2024-06-24 03:35:57,806 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-06-24 03:35:57,806 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:58,178 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:58,179 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:58,179 DEBUG --- stdout --- 2024-06-24 03:35:58,179 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:58,179 DEBUG --- stderr --- 2024-06-24 03:35:58,179 DEBUG 2024-06-24 03:35:58,180 INFO 2024-06-24 03:35:58,180 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-300/cmd.txt" ]; then echo "/results/orders/login-tree-300/cmd.txt file found"; exit 0; else echo "/results/orders/login-tree-300/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-300/cmd.txt file found" 2024-06-24 03:35:58,180 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 03:35:58,999 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 03:35:58,999 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:59,000 DEBUG --- stdout --- 2024-06-24 03:35:59,000 DEBUG /results/orders/login-tree-300/cmd.txt file found 2024-06-24 03:35:59,000 DEBUG --- stderr --- 2024-06-24 03:35:59,000 DEBUG 2024-06-24 03:35:59,000 INFO 2024-06-24 03:35:59,000 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-06-24 03:35:59,000 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:35:59,319 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:35:59,319 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:35:59,319 DEBUG --- stdout --- 2024-06-24 03:35:59,319 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:35:59,319 DEBUG --- stderr --- 2024-06-24 03:35:59,319 DEBUG 2024-06-24 03:35:59,319 INFO 2024-06-24 03:35:59,320 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-5b6f9464fd-slbm8 --stdin -- du -k /results/orders/login-tree-300/cmd.txt 2024-06-24 03:36:00,132 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 03:36:00,133 DEBUG --- stdout --- 2024-06-24 03:36:00,134 DEBUG 4 /results/orders/login-tree-300/cmd.txt 2024-06-24 03:36:00,135 DEBUG --- stderr --- 2024-06-24 03:36:00,135 DEBUG 2024-06-24 03:36:00,135 INFO - Download file (size 4k) 2024-06-24 03:36:00,135 INFO 2024-06-24 03:36:00,136 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-06-24 03:36:00,136 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:36:00,456 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:36:00,456 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:36:00,456 DEBUG --- stdout --- 2024-06-24 03:36:00,456 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:36:00,456 DEBUG --- stderr --- 2024-06-24 03:36:00,456 DEBUG source : /results/orders/login-tree-300/cmd.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/cmd.txt 2024-06-24 03:36:00,456 INFO 2024-06-24 03:36:00,456 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-06-24 03:36:00,457 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 03:36:00,765 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 03:36:00,765 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:36:00,765 DEBUG --- stdout --- 2024-06-24 03:36:00,765 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 03:36:00,765 DEBUG --- stderr --- 2024-06-24 03:36:00,765 DEBUG 2024-06-24 03:36:00,766 INFO 2024-06-24 03:36:00,766 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-5b6f9464fd-slbm8:/results/orders/login-tree-300/cmd.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/cmd.txt 2024-06-24 03:36:00,766 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 03:36:01,504 INFO [loop_until]: OK (rc = 0) 2024-06-24 03:36:01,504 DEBUG --- stdout --- 2024-06-24 03:36:01,504 DEBUG tar: Removing leading `/' from member names 2024-06-24 03:36:01,504 DEBUG --- stderr --- 2024-06-24 03:36:01,504 DEBUG 2024-06-24 03:36:01,505 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/cmd.txt is small (1 lines), printing all lines: 2024-06-24 03:36:01,505 DEBUG ----- output ----- 2024-06-24 03:36:01,505 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 "idc.login@ema-perf-p1" --results-folder /results/gatling/login-tree-300 --extra-run-jvm-options "-Xmx4G" --no-reports 2024-06-24 03:36:01,505 INFO ________________________________________________________________________________ [2024-06-24 03:36:01] login-tree-300 show_rc : Display rc order ________________________________________________________________________________ 2024-06-24 03:36:01,505 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/rc.txt is small (1 lines), printing all lines: 2024-06-24 03:36:01,505 DEBUG ----- output ----- 2024-06-24 03:36:01,505 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-06-24 03:36:01,505 INFO ________________________________________________________________________________ [2024-06-24 03:36:01] login-tree-300 show_stdout : Display stdout order ________________________________________________________________________________ 2024-06-24 03:36:01,508 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input file (/mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/stdout.txt is 12456 lines): 2024-06-24 03:36:01,508 DEBUG ----- output ----- 2024-06-24 03:36:01,508 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-06-24 03:36:01,508 INFO 03:33:23.370 [WARN ] i.g.c.ZincCompiler$ - -target is deprecated: Use -release instead to compile against the correct platform API. 2024-06-24 03:36:01,508 INFO 03:33:28.185 [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-06-24 03:36:01,508 INFO crossSessionVariables.-("poliEvalTokenId"); 2024-06-24 03:36:01,508 INFO ^ 2024-06-24 03:36:01,508 INFO 03:33:28.188 [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-06-24 03:36:01,508 INFO crossSessionVariables.-("poliEvalTokenId"); 2024-06-24 03:36:01,508 INFO ^ 2024-06-24 03:36:01,508 INFO 03:33:29.923 [WARN ] i.g.c.ZincCompiler$ - three warnings found 2024-06-24 03:36:01,508 INFO Gatling 3.11.4 is available! (you're using 3.9.5) 2024-06-24 03:36:01,508 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-06-24 03:36:01,508 INFO 2024-06-24 03:36:01,508 INFO ================================================================================ 2024-06-24 03:36:01,508 INFO 2024-06-24 03:33:37 5s elapsed 2024-06-24 03:36:01,508 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,508 INFO > Global (OK=265 KO=0 ) 2024-06-24 03:36:01,508 INFO > restLoginInitiate (OK=124 KO=0 ) 2024-06-24 03:36:01,508 INFO > restLoginUsernamePasswordCallback (OK=118 KO=0 ) 2024-06-24 03:36:01,508 INFO > restloginProgressiveProfileCallback (OK=23 KO=0 ) 2024-06-24 03:36:01,508 INFO 2024-06-24 03:36:01,508 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,508 INFO [- ] 0% 2024-06-24 03:36:01,508 INFO waiting: 1085572 / active: 10 / done: 116 2024-06-24 03:36:01,508 INFO ================================================================================ 2024-06-24 03:36:01,508 INFO 2024-06-24 03:36:01,508 INFO 2024-06-24 03:36:01,508 INFO ================================================================================ 2024-06-24 03:36:01,509 INFO 2024-06-24 03:33:42 10s elapsed 2024-06-24 03:36:01,509 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,509 INFO > Global (OK=1091 KO=0 ) 2024-06-24 03:36:01,509 INFO > restLoginInitiate (OK=496 KO=0 ) 2024-06-24 03:36:01,509 INFO > restLoginUsernamePasswordCallback (OK=485 KO=0 ) 2024-06-24 03:36:01,509 INFO > restloginProgressiveProfileCallback (OK=110 KO=0 ) 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,509 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,509 INFO [- ] 0% 2024-06-24 03:36:01,509 INFO waiting: 1085196 / active: 19 / done: 483 2024-06-24 03:36:01,509 INFO ================================================================================ 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,509 INFO ================================================================================ 2024-06-24 03:36:01,509 INFO 2024-06-24 03:33:47 15s elapsed 2024-06-24 03:36:01,509 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,509 INFO > Global (OK=2487 KO=0 ) 2024-06-24 03:36:01,509 INFO > restLoginInitiate (OK=1120 KO=0 ) 2024-06-24 03:36:01,509 INFO > restLoginUsernamePasswordCallback (OK=1104 KO=0 ) 2024-06-24 03:36:01,509 INFO > restloginProgressiveProfileCallback (OK=263 KO=0 ) 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,509 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,509 INFO [- ] 0% 2024-06-24 03:36:01,509 INFO waiting: 1084571 / active: 29 / done: 1098 2024-06-24 03:36:01,509 INFO ================================================================================ 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,509 INFO ================================================================================ 2024-06-24 03:36:01,509 INFO 2024-06-24 03:33:52 20s elapsed 2024-06-24 03:36:01,509 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,509 INFO > Global (OK=4444 KO=0 ) 2024-06-24 03:36:01,509 INFO > restLoginInitiate (OK=1993 KO=0 ) 2024-06-24 03:36:01,509 INFO > restLoginUsernamePasswordCallback (OK=1972 KO=0 ) 2024-06-24 03:36:01,509 INFO > restloginProgressiveProfileCallback (OK=479 KO=0 ) 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,509 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,509 INFO [- ] 0% 2024-06-24 03:36:01,509 INFO waiting: 1083695 / active: 35 / done: 1968 2024-06-24 03:36:01,509 INFO ================================================================================ 2024-06-24 03:36:01,509 INFO 2024-06-24 03:36:01,510 INFO 2024-06-24 03:36:01,510 INFO ================================================================================ 2024-06-24 03:36:01,510 INFO 2024-06-24 03:33:57 25s elapsed 2024-06-24 03:36:01,510 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,510 INFO > Global (OK=6942 KO=0 ) 2024-06-24 03:36:01,510 INFO > restLoginInitiate (OK=3114 KO=0 ) 2024-06-24 03:36:01,510 INFO > restLoginUsernamePasswordCallback (OK=3082 KO=0 ) 2024-06-24 03:36:01,510 INFO > restloginProgressiveProfileCallback (OK=746 KO=0 ) 2024-06-24 03:36:01,510 INFO 2024-06-24 03:36:01,510 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,510 INFO [- ] 0% 2024-06-24 03:36:01,510 INFO waiting: 1082570 / active: 53 / done: 3075 2024-06-24 03:36:01,510 INFO ================================================================================ 2024-06-24 03:36:01,510 INFO 2024-06-24 03:36:01,510 INFO 2024-06-24 03:36:01,510 INFO ================================================================================ 2024-06-24 03:36:01,510 INFO 2024-06-24 03:34:02 30s elapsed 2024-06-24 03:36:01,510 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,510 INFO > Global (OK=9981 KO=0 ) 2024-06-24 03:36:01,510 INFO > restLoginInitiate (OK=4486 KO=0 ) 2024-06-24 03:36:01,510 INFO > restLoginUsernamePasswordCallback (OK=4445 KO=0 ) 2024-06-24 03:36:01,510 INFO > restloginProgressiveProfileCallback (OK=1050 KO=0 ) 2024-06-24 03:36:01,510 INFO 2024-06-24 03:36:01,510 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,510 INFO [- ] 0% 2024-06-24 03:36:01,510 INFO waiting: 1081197 / active: 73 / done: 4428 2024-06-24 03:36:01,510 INFO ================================================================================ 2024-06-24 03:36:01,510 INFO 2024-06-24 03:36:01,510 INFO 03:34:07.728 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'restLoginInitiate' failed for user 5939: status.find.is(200), but actually found 502 2024-06-24 03:36:01,510 INFO 03:34:07.735 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-06-24 03:36:01,510 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-06-24 03:36:01,510 INFO Request: 2024-06-24 03:36:01,510 INFO restLoginInitiate: KO status.find.is(200), but actually found 502 2024-06-24 03:36:01,510 INFO [...] 2024-06-24 03:36:01,514 INFO [#########################################################################-] 99% 2024-06-24 03:36:01,514 INFO waiting: 1458 / active: 83 / done: 1084157 2024-06-24 03:36:01,514 INFO ================================================================================ 2024-06-24 03:36:01,514 INFO 2024-06-24 03:36:01,514 INFO 04:34:02.622 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'restLoginUsernamePasswordCallback' failed for user 1085603: status.find.is(200), but actually found 502 2024-06-24 03:36:01,514 INFO 04:34:02.623 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - 2024-06-24 03:36:01,514 INFO >>>>>>>>>>>>>>>>>>>>>>>>>> 2024-06-24 03:36:01,514 INFO Request: 2024-06-24 03:36:01,514 INFO restLoginUsernamePasswordCallback: KO status.find.is(200), but actually found 502 2024-06-24 03:36:01,514 INFO ========================= 2024-06-24 03:36:01,514 INFO Session: 2024-06-24 03:36:01,514 INFO Session(idc.login,1085603,HashMap(gatling.http.cache.baseUrl -> https://openam-ema-perf-p1.forgeblocks.com:443, username -> user.787452, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@4e03cfc, gatling.http.referer -> https://openam-ema-perf-p1.forgeblocks.com/am/json/realms/alpha/authenticate?authIndexType=service&authIndexValue=Login, fake-user-agent -> Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/116.0.0.0 Safari/537.36, c516c55c-e0ee-48ea-a30f-55615477f5f9 -> 0, callbacks -> {"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiJiZGYxZTgwOC1iNjcyLTQ1ZDMtOTBjZi1mZTZkYzU0OWI5NGMiLCJhdXRoSW5kZXhWYWx1ZSI6IkxvZ2luIiwib3RrIjoiNGhuZHV0bDhrNWprdGhsNTJlaWttYW5oMmgiLCJhdXRoSW5kZXhUeXBlIjoic2VydmljZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1dlEwNUhTVkV0UkZwS09IWjVkemRKUWt0UFJ6aDNMbWR1V1haQ05WbEVjMmxNZFc1cmIyVjNaR0pXZDJSMFFUaHVlRmhoWW1rNVprOTVPRFpYWkhCeVJWTTBWeTFSTjNodk5WOVhkV2xGWkhWQ2FFMTVlR0p2UzNaaU4wMXViazVuTTFoU2JGcGpSbUV5ZUdaTFExcG1OSEI0VmxGdmREQnhPR3BpTldvdGRUaGlObmxWTFU1VWVVMVVjemhJYmpoS1RqYzVaazlyVkRndFdISkdRVU5xY0RkM1UwbE5jbHBRZG5CT1lrMW5URzlYTUdsM1JEaFRha05STVZwdWJWWlRNVVZGU0MxNlRqQnhaR3gxUkcxYWJGTTNkV2RwVTBaWFRHMVBibHAxUTNaaWNuUmlUVXR2UVVRNVFWZFVWWGg2Y25GWE1YcE5lRWRCYmxReFVYbHpjRXRuVjIxWlkwMUJUVVUzUm1NMmFXSmZjMDFzUlRnMFEyNDFRa0ZxWTI4eFQyNDROMFJ0TkdsSldsUnNVVnAwUVdKNlRHMUNSV3AwYzBsQ1IyMXpabWxaZFVSaVF6YzRhR2xIVW1kbFV6SmpNWE5yZFdaNmVrWTJlbEJRVW5VMGRsbEZlR1JtU1cwelVHaFlRMVZNU0ZCbWVEaENXVUkxUkdkWWNtUlRXbXRZUmxwNFRYYzNaMGxvVlVKYWFuQkdZbWhqUm5obGQyeGFjRk51UmxkZk5VMW1aV0U0VWtObmFsbzFabE13YkZKUE1XOTFiRGxyYTNsWFNUbEJNVFJKVlc0eWFFRk9haTFVVEhWWlMzUkRjVWx2Tm5OSFh6UTVSVGxDTVRnNGFXdE5hVFIwUTIxWVgxZDZjVUZNYVRSd1RXMHRjbGM1U0haUmJWWXhhR1kyWldwdU5FcFdhRlpYYVVkc1pHaG5XVEZET0VSTVZqQnRlVE5sTUhscGVERmxRVWM0WmpoTWFUTm5SamhNYmkxSWVXUkRiakF6WmxaRWJrMVVaRlY1YmtaVFlVZDBZa1JIVmt0ck4xTkNkRVpNWTFCNGVVVlJNbDlSV0dKbldXWkRVbmw1U3pWc1dWSkVMVXRMTlZSaU5YY3RXSFZsU2tJeE5ERk9hamgyU0ZOM2JuRjNhMmM0ZDBGd1NFNTBUakJxV1c1d2RrUkZjbVF3WWxsQmNsZERkV1ZIVFhoVVVGVm1NMW8wYWtod1JFRlRjRzFvUVVkTFdsVmFSV1pTTlVFMFlVNUtOMlJwT1c1RmNXTlNRVXBDTlVseWRHOXZXbkpxWkVoRGFHTnZNVlJ4VTAxUU1IRjRSM05NVGtac2VraExPWEUwTUZjNFNFMUdiemRGYkdweVoxcGZURWN6YTJZMmFWRnJjVk5LZVRSNFpuaERRVnB0VUM1a2FFRkdjWHBWVlVKcE1pMXphbk00Vkc5Q1MxOVIuS1hNMzhEdm10TjhBUzJBNERYRG41M3c2UHBiUHpUbWNRNk44MFpoYmV4TSIsImV4cCI6MTcxOTIwMDM0MiwiaWF0IjoxNzE5MjAwMDQyfQ.xtnlZQqssO5DMOhB7q--ab3uwmVCeu1JCowComz6Atw","callbacks":[{"type":"NameCallback","output":[{"name":"prompt","value":"User Name"}],"input":[{"name":"IDToken1","value":"user.787452"}],"_id":0},{"type":"PasswordCallback","output":[{"name":"prompt","value":"Password"}],"input":[{"name":"IDToken2","value":"Pa_ssw0rd"}],"_id":1}],"header":"Sign In","description":"New here? Create an account
Forgot username? Forgot password?"}, gatling.http.cookies -> CookieJar(Map(CookieKey(amlbcookie,openam-ema-perf-p1.forgeblocks.com,/) -> StoredCookie(amlbcookie=01, domain=openam-ema-perf-p1.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None,false,false,1719200042585))), password -> Pa_ssw0rd, fake-ip -> 225.253.100.113, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@723613cd),OK,List(TryMaxBlock(c516c55c-e0ee-48ea-a30f-55615477f5f9,tryMax-1-inner,KO)),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$826/0x0000783b9c6e85a8@34000880,io.netty.channel.epoll.EpollEventLoop@6ac4944a) 2024-06-24 03:36:01,514 INFO ========================= 2024-06-24 03:36:01,514 INFO HTTP request: 2024-06-24 03:36:01,514 INFO POST https://openam-ema-perf-p1.forgeblocks.com/am/json/realms/alpha/authenticate?authIndexType=service&authIndexValue=Login 2024-06-24 03:36:01,514 INFO headers: 2024-06-24 03:36:01,514 INFO Accept-API-Version: resource=2.0, protocol=1.0 2024-06-24 03:36:01,514 INFO accept: application/json 2024-06-24 03:36:01,514 INFO content-type: application/json 2024-06-24 03:36:01,514 INFO cookie: amlbcookie=01 2024-06-24 03:36:01,514 INFO host: openam-ema-perf-p1.forgeblocks.com 2024-06-24 03:36:01,514 INFO content-length: 2632 2024-06-24 03:36:01,514 INFO cookies: 2024-06-24 03:36:01,514 INFO amlbcookie=01, domain=openam-ema-perf-p1.forgeblocks.com, path=/, secure, HTTPOnly, SameSite=None 2024-06-24 03:36:01,514 INFO body:StringChunksRequestBody{charset=UTF-8, content={"authId":"eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJ3aGl0ZWxpc3Qtc3RhdGUiOiJiZGYxZTgwOC1iNjcyLTQ1ZDMtOTBjZi1mZTZkYzU0OWI5NGMiLCJhdXRoSW5kZXhWYWx1ZSI6IkxvZ2luIiwib3RrIjoiNGhuZHV0bDhrNWprdGhsNTJlaWttYW5oMmgiLCJhdXRoSW5kZXhUeXBlIjoic2VydmljZSIsInJlYWxtIjoiL2FscGhhIiwic2Vzc2lvbklkIjoiKkFBSlRTUUFDTURJQUJIUjVjR1VBQ0VwWFZGOUJWVlJJQUFKVE1RQUNNREUuKmV5SjBlWEFpT2lKS1YxUWlMQ0pqZEhraU9pSktWMVFpTENKaGJHY2lPaUpJVXpJMU5pSjkuWlhsS01HVllRV2xQYVVwTFZqRlJhVXhEU214aWJVMXBUMmxLUWsxVVNUUlJNRXBFVEZWb1ZFMXFWVEpKYVhkcFdWZDRia2xxYjJsYVIyeDVTVzR3TGk1dlEwNUhTVkV0UkZwS09IWjVkemRKUWt0UFJ6aDNMbWR1V1haQ05WbEVjMmxNZFc1cmIyVjNaR0pXZDJSMFFUaHVlRmhoWW1rNVprOTVPRFpYWkhCeVJWTTBWeTFSTjNodk5WOVhkV2xGWkhWQ2FFMTVlR0p2UzNaaU4wMXViazVuTTFoU2JGcGpSbUV5ZUdaTFExcG1OSEI0VmxGdmREQnhPR3BpTldvdGRUaGlObmxWTFU1VWVVMVVjemhJYmpoS1RqYzVaazlyVkRndFdISkdRVU5xY0RkM1UwbE5jbHBRZG5CT1lrMW5URzlYTUdsM1JEaFRha05STVZwdWJWWlRNVVZGU0MxNlRqQnhaR3gxUkcxYWJGTTNkV2RwVTBaWFRHMVBibHAxUTNaaWNuUmlUVXR2UVVRNVFWZFVWWGg2Y25GWE1YcE5lRWRCYmxReFVYbHpjRXRuVjIxWlkwMUJUVVUzUm1NMmFXSmZjMDFzUlRnMFEyNDFRa0ZxWTI4eFQyNDROMFJ0TkdsSldsUnNVVnAwUVdKNlRHMUNSV3AwYzBsQ1IyMXpabWxaZFVSaVF6YzRhR2xIVW1kbFV6SmpNWE5yZFdaNmVrWTJlbEJRVW5VMGRsbEZlR1JtU1cwelVHaFlRMVZNU0ZCbWVEaENXVUkxUkdkWWNtUlRXbXRZUmxwNFRYYzNaMGxvVlVKYWFuQkdZbWhqUm5obGQyeGFjRk51UmxkZk5VMW1aV0U0VWtObmFsbzFabE13YkZKUE1XOTFiRGxyYTNsWFNUbEJNVFJKVlc0eWFFRk9haTFVVEhWWlMzUkRjVWx2Tm5OSFh6UTVSVGxDTVRnNGFXdE5hVFIwUTIxWVgxZDZjVUZNYVRSd1RXMHRjbGM1U0haUmJWWXhhR1kyWldwdU5FcFdhRlpYYVVkc1pHaG5XVEZET0VSTVZqQnRlVE5sTUhscGVERmxRVWM0WmpoTWFUTm5SamhNYmkxSWVXUkRiakF6WmxaRWJrMVVaRlY1YmtaVFlVZDBZa1JIVmt0ck4xTkNkRVpNWTFCNGVVVlJNbDlSV0dKbldXWkRVbmw1U3pWc1dWSkVMVXRMTlZSaU5YY3RXSFZsU2tJeE5ERk9hamgyU0ZOM2JuRjNhMmM0ZDBGd1NFNTBUakJxV1c1d2RrUkZjbVF3WWxsQmNsZERkV1ZIVFhoVVVGVm1NMW8wYWtod1JFRlRjRzFvUVVkTFdsVmFSV1pTTlVFMFlVNUtOMlJwT1c1RmNXTlNRVXBDTlVseWRHOXZXbkpxWkVoRGFHTnZNVlJ4VTAxUU1IRjRSM05NVGtac2VraExPWEUwTUZjNFNFMUdiemRGYkdweVoxcGZURWN6YTJZMmFWRnJjVk5LZVRSNFpuaERRVnB0VUM1a2FFRkdjWHBWVlVKcE1pMXphbk00Vkc5Q1MxOVIuS1hNMzhEdm10TjhBUzJBNERYRG41M3c2UHBiUHpUbWNRNk44MFpoYmV4TSIsImV4cCI6MTcxOTIwMDM0MiwiaWF0IjoxNzE5MjAwMDQyfQ.xtnlZQqssO5DMOhB7q--ab3uwmVCeu1JCowComz6Atw","callbacks":[{"type":"NameCallback","output":[{"name":"prompt","value":"User Name"}],"input":[{"name":"IDToken1","value":"user.787452"}],"_id":0},{"type":"PasswordCallback","output":[{"name":"prompt","value":"Password"}],"input":[{"name":"IDToken2","value":"Pa_ssw0rd"}],"_id":1}],"header":"Sign In","description":"New here? Create an account
Forgot username? Forgot password?"}} 2024-06-24 03:36:01,514 INFO ========================= 2024-06-24 03:36:01,514 INFO HTTP response: 2024-06-24 03:36:01,515 INFO status: 2024-06-24 03:36:01,515 INFO 502 Bad Gateway 2024-06-24 03:36:01,515 INFO headers: 2024-06-24 03:36:01,515 INFO Content-Type: text/html; charset=UTF-8 2024-06-24 03:36:01,515 INFO Referrer-Policy: no-referrer 2024-06-24 03:36:01,515 INFO Content-Length: 332 2024-06-24 03:36:01,515 INFO Date: Mon, 24 Jun 2024 03:34:02 GMT 2024-06-24 03:36:01,515 INFO Alt-Svc: h3=":443"; ma=2592000,h3-29=":443"; ma=2592000 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO body: 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO 502 Server Error 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO

Error: Server Error

2024-06-24 03:36:01,515 INFO

The server encountered a temporary error and could not complete your request.

Please try again in 30 seconds.

2024-06-24 03:36:01,515 INFO

2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO <<<<<<<<<<<<<<<<<<<<<<<<< 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO ================================================================================ 2024-06-24 03:36:01,515 INFO 2024-06-24 04:34:02 3630s elapsed 2024-06-24 03:36:01,515 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,515 INFO > Global (OK=2404310 KO=18 ) 2024-06-24 03:36:01,515 INFO > restLoginInitiate (OK=1085677 KO=8 ) 2024-06-24 03:36:01,515 INFO > restLoginUsernamePasswordCallback (OK=1085625 KO=6 ) 2024-06-24 03:36:01,515 INFO > restloginProgressiveProfileCallback (OK=233008 KO=4 ) 2024-06-24 03:36:01,515 INFO ---- Errors -------------------------------------------------------------------- 2024-06-24 03:36:01,515 INFO > status.find.is(200), but actually found 502 18 (100.0%) 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,515 INFO [#########################################################################-] 99% 2024-06-24 03:36:01,515 INFO waiting: 0 / active: 68 / done: 1085630 2024-06-24 03:36:01,515 INFO ================================================================================ 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO 2024-06-24 03:36:01,515 INFO ================================================================================ 2024-06-24 03:36:01,516 INFO 2024-06-24 04:34:03 3630s elapsed 2024-06-24 03:36:01,516 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 03:36:01,516 INFO > Global (OK=2404398 KO=18 ) 2024-06-24 03:36:01,516 INFO > restLoginInitiate (OK=1085690 KO=8 ) 2024-06-24 03:36:01,516 INFO > restLoginUsernamePasswordCallback (OK=1085684 KO=6 ) 2024-06-24 03:36:01,516 INFO > restloginProgressiveProfileCallback (OK=233024 KO=4 ) 2024-06-24 03:36:01,516 INFO ---- Errors -------------------------------------------------------------------- 2024-06-24 03:36:01,516 INFO > status.find.is(200), but actually found 502 18 (100.0%) 2024-06-24 03:36:01,516 INFO 2024-06-24 03:36:01,516 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 03:36:01,516 INFO [##########################################################################]100% 2024-06-24 03:36:01,516 INFO waiting: 0 / active: 0 / done: 1085698 2024-06-24 03:36:01,516 INFO ================================================================================ 2024-06-24 03:36:01,516 INFO 2024-06-24 03:36:01,516 INFO Simulation com.forgerock.gatling.Loadtest completed in 3630 seconds 2024-06-24 03:36:01,516 INFO 2024-06-24 03:36:01,516 INFO ---------------------- 2024-06-24 03:36:01,516 INFO [24/Jun/2024 04:34:03] Create tar file login-tree-300.tar.gz 2024-06-24 03:36:01,516 INFO ---------------------- 2024-06-24 03:36:01,516 INFO RESULTS_FOLDER=/results/gatling/ 2024-06-24 03:36:01,516 INFO RESULT_FOLDER=login-tree-300 2024-06-24 03:36:01,516 INFO SIMULATION_PATH=login-tree-300/loadtest-20240624023332023 2024-06-24 03:36:01,516 INFO PWD=/results/gatling/login-tree-300/loadtest-20240624023332023 2024-06-24 03:36:01,516 INFO [cmd] tar -czvf /results/gatling//login-tree-300.tar.gz --exclude=simulation.log * 2024-06-24 03:36:01,516 INFO /results/gatling 2024-06-24 03:36:01,516 INFO 2024-06-24 03:36:01,516 INFO ---------------------- 2024-06-24 03:36:01,516 INFO [24/Jun/2024 04:34:03] Update /results/gatling//latest 2024-06-24 03:36:01,516 INFO ---------------------- 2024-06-24 03:36:01,516 INFO 2024-06-24 03:36:01,516 INFO ---------------------- 2024-06-24 03:36:01,516 INFO [24/Jun/2024 04:34:03] Update /results/gatling//latest.tar.gz 2024-06-24 03:36:01,516 INFO ---------------------- 2024-06-24 03:36:01,516 INFO ________________________________________________________________________________ [2024-06-24 03:36:01] login-tree-300 show_stderr : Display stderr order ________________________________________________________________________________ 2024-06-24 03:36:01,517 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/06_login-tree-300/stderr.txt is small (0 lines), printing all lines: 2024-06-24 03:36:01,517 DEBUG ----- output ----- 2024-06-24 03:36:01,517 DEBUG 2024-06-24 03:36:01,517 INFO ________________________________________________________________________________ [2024-06-24 03:36:01] login-tree-300 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-06-24 03:36:01] login-tree-300 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-06-24 03:36:01] login-tree-300 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped