--Task-- name: login-tree-400 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-300'] preceding_task: login-tree-300 options: {'duration': 3600, 'java-opts': '-Drealm=alpha -Duser_password=Pa_ssw0rd', 'rampup-duration': 30, 'testCase': 'idc.login', 'testMode': 'open', 'throughput': 400} group_name: None Current dir: /mnt/disks/data/xslou/lodestar-fork/pyrock ________________________________________________________________________________ [2024-05-25 00:04:26] login-tree-400 pre : N/A ________________________________________________________________________________ [2024-05-25 00:04:26] - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) [2024-05-25 00:04:26] - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/login-tree-400/stdout.txt Pod log : /results/orders/login-tree-400 2024-05-25 00:04:26,784 INFO 2024-05-25 00:04:26,784 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-05-25 00:04:26,785 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 00:04:27,099 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 00:04:27,100 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:27,100 DEBUG --- stdout --- 2024-05-25 00:04:27,100 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 00:04:27,100 DEBUG --- stderr --- 2024-05-25 00:04:27,100 DEBUG ________________________________________________________________________________ [2024-05-25 00:04:27] login-tree-400 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-05-25 00:04:27,100 INFO 2024-05-25 00:04:27,100 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-05-25 00:04:27,101 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 00:04:27,409 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 00:04:27,409 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:27,409 DEBUG --- stdout --- 2024-05-25 00:04:27,409 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 00:04:27,409 DEBUG --- stderr --- 2024-05-25 00:04:27,409 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-3580" --results-folder /results/gatling/login-tree-400 --extra-run-jvm-options "-Xmx12G" --no-reports ________________________________________________________________________________ [2024-05-25 00:04:27] login-tree-400 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-05-25 00:04:27,410 INFO 2024-05-25 00:04:27,410 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-05-25 00:04:27,410 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 00:04:27,717 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 00:04:27,717 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:27,717 DEBUG --- stdout --- 2024-05-25 00:04:27,717 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 00:04:27,717 DEBUG --- stderr --- 2024-05-25 00:04:27,717 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/order.json { "name": "login-tree-400", "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-3580\" --results-folder /results/gatling/login-tree-400 --extra-run-jvm-options \"-Xmx12G\" --no-reports", "out-dir": "/results/orders/login-tree-400", "environment": { "JAVA_OPTS": "-Dam_host=openam-ema-perf-3580.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@forgerock.com -Dduration=3600 -Didc=true -Dlogin_cookie=9537f3c44bdb077 -Dnum_users=1000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -Drampup_duration=30 -Drealm=alpha -DtestCase=idc.login -DtestMode=open -Dthroughput=400 -Duser_password=Pa_ssw0rd" } } ________________________________________________________________________________ [2024-05-25 00:04:27] login-tree-400 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-05-25 00:04:27,720 INFO 2024-05-25 00:04:27,720 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-05-25 00:04:27,720 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-05-25 00:04:27,968 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-05-25 00:04:27,968 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:27,968 DEBUG --- stdout --- 2024-05-25 00:04:27,968 DEBUG WAITING 2024-05-25 00:04:27,968 DEBUG --- stderr --- 2024-05-25 00:04:27,968 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 32 0 --:--:-- --:--:-- --:--:-- 32 ________________________________________________________________________________ [2024-05-25 00:04:27] login-tree-400 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-05-25 00:04:27,969 INFO 2024-05-25 00:04:27,969 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-05-25 00:04:27,969 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 00:04:28,282 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 00:04:28,282 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:28,282 DEBUG --- stdout --- 2024-05-25 00:04:28,282 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 00:04:28,282 DEBUG --- stderr --- 2024-05-25 00:04:28,282 DEBUG 2024-05-25 00:04:28,283 INFO 2024-05-25 00:04:28,283 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/05_login-tree-400/order.json overseer-0-dfd5985cb-fzzf7:/results/orders/order.json 2024-05-25 00:04:28,283 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-05-25 00:04:29,649 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:29,650 DEBUG --- stdout --- 2024-05-25 00:04:29,651 DEBUG 2024-05-25 00:04:29,651 DEBUG --- stderr --- 2024-05-25 00:04:29,651 DEBUG Order has been successfully forwarded to overseer [2024-05-25 00:04:29] - INFO: Check if Gatling simulation started successfully 2024-05-25 00:04:29,651 INFO 2024-05-25 00:04:29,651 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-05-25 00:04:29,651 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 00:04:29,963 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 00:04:29,963 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:29,963 DEBUG --- stdout --- 2024-05-25 00:04:29,963 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 00:04:29,964 DEBUG --- stderr --- 2024-05-25 00:04:29,964 DEBUG 2024-05-25 00:04:29,964 INFO 2024-05-25 00:04:29,964 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 -- head -n 25 /results/orders/login-tree-400/stdout.txt | grep "started..." 2024-05-25 00:04:29,964 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-05-25 00:04:30,714 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-05-25 00:04:36,447 INFO [loop_until]: Function succeeded after 6s (rc=0) - expected pattern found 2024-05-25 00:04:36,447 INFO [loop_until]: OK (rc = 0) 2024-05-25 00:04:36,447 DEBUG --- stdout --- 2024-05-25 00:04:36,447 DEBUG GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling Simulation com.forgerock.gatling.Loadtest started... 2024-05-25 00:04:36,447 DEBUG --- stderr --- 2024-05-25 00:04:36,447 DEBUG ________________________________________________________________________________ [2024-05-25 00:04:36] login-tree-400 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 01s, 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 05s, 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 07s, retry Order is running since 44m 07s, retry Order is running since 46m 07s, retry Order is running since 48m 08s, retry Order is running since 50m 08s, retry Order is running since 52m 08s, retry Order is running since 54m 09s, retry Order is running since 56m 09s, retry Order is running since 58m 09s, retry Order is running since 1h, retry PASS : Order stopped by itself after 1h 02m and before timeout (1h 12m) ________________________________________________________________________________ [2024-05-25 01:06:46] login-tree-400 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-05-25 01:06:46,758 INFO 2024-05-25 01:06:46,759 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-05-25 01:06:46,759 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:47,092 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:47,092 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:47,092 DEBUG --- stdout --- 2024-05-25 01:06:47,093 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:47,093 DEBUG --- stderr --- 2024-05-25 01:06:47,093 DEBUG 2024-05-25 01:06:47,093 INFO 2024-05-25 01:06:47,093 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 -- rm -f /results/orders/order.json 2024-05-25 01:06:47,093 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-05-25 01:06:47,885 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:47,885 DEBUG --- stdout --- 2024-05-25 01:06:47,886 DEBUG 2024-05-25 01:06:47,886 DEBUG --- stderr --- 2024-05-25 01:06:47,886 DEBUG Order ran during 1h 02m ________________________________________________________________________________ [2024-05-25 01:06:47] login-tree-400 download_logs : Download individual order files ________________________________________________________________________________ [2024-05-25 01:06:47] - PASS: file already downloaded /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/order.json 2024-05-25 01:06:47,887 INFO 2024-05-25 01:06:47,887 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-05-25 01:06:47,887 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:48,205 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:48,205 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:48,205 DEBUG --- stdout --- 2024-05-25 01:06:48,205 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:48,205 DEBUG --- stderr --- 2024-05-25 01:06:48,205 DEBUG Checking pod: overseer-0-dfd5985cb-fzzf7 for file exists, if not wait. 2024-05-25 01:06:48,205 INFO 2024-05-25 01:06:48,205 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-05-25 01:06:48,205 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:48,505 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:48,506 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:48,506 DEBUG --- stdout --- 2024-05-25 01:06:48,506 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:48,506 DEBUG --- stderr --- 2024-05-25 01:06:48,506 DEBUG 2024-05-25 01:06:48,507 INFO 2024-05-25 01:06:48,507 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-400/rc.txt" ]; then echo "/results/orders/login-tree-400/rc.txt file found"; exit 0; else echo "/results/orders/login-tree-400/rc.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-400/rc.txt file found" 2024-05-25 01:06:48,507 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-05-25 01:06:49,321 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-05-25 01:06:49,321 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:49,321 DEBUG --- stdout --- 2024-05-25 01:06:49,321 DEBUG /results/orders/login-tree-400/rc.txt file found 2024-05-25 01:06:49,321 DEBUG --- stderr --- 2024-05-25 01:06:49,321 DEBUG 2024-05-25 01:06:49,322 INFO 2024-05-25 01:06:49,322 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-05-25 01:06:49,322 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:49,628 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:49,628 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:49,628 DEBUG --- stdout --- 2024-05-25 01:06:49,628 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:49,628 DEBUG --- stderr --- 2024-05-25 01:06:49,628 DEBUG 2024-05-25 01:06:49,628 INFO 2024-05-25 01:06:49,629 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- du -k /results/orders/login-tree-400/rc.txt 2024-05-25 01:06:50,431 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-05-25 01:06:50,431 DEBUG --- stdout --- 2024-05-25 01:06:50,431 DEBUG 4 /results/orders/login-tree-400/rc.txt 2024-05-25 01:06:50,431 DEBUG --- stderr --- 2024-05-25 01:06:50,431 DEBUG 2024-05-25 01:06:50,431 INFO - Download file (size 4k) 2024-05-25 01:06:50,432 INFO 2024-05-25 01:06:50,432 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-05-25 01:06:50,432 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:50,741 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:50,741 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:50,741 DEBUG --- stdout --- 2024-05-25 01:06:50,741 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:50,741 DEBUG --- stderr --- 2024-05-25 01:06:50,741 DEBUG source : /results/orders/login-tree-400/rc.txt @ overseer-0-dfd5985cb-fzzf7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/rc.txt 2024-05-25 01:06:50,742 INFO 2024-05-25 01:06:50,742 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-05-25 01:06:50,742 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:51,048 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:51,049 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:51,049 DEBUG --- stdout --- 2024-05-25 01:06:51,049 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:51,049 DEBUG --- stderr --- 2024-05-25 01:06:51,049 DEBUG 2024-05-25 01:06:51,049 INFO 2024-05-25 01:06:51,049 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-dfd5985cb-fzzf7:/results/orders/login-tree-400/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/rc.txt 2024-05-25 01:06:51,049 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-05-25 01:06:51,779 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:51,779 DEBUG --- stdout --- 2024-05-25 01:06:51,779 DEBUG tar: Removing leading `/' from member names 2024-05-25 01:06:51,779 DEBUG --- stderr --- 2024-05-25 01:06:51,779 DEBUG 2024-05-25 01:06:51,780 INFO 2024-05-25 01:06:51,780 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-05-25 01:06:51,780 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:52,088 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:52,089 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:52,089 DEBUG --- stdout --- 2024-05-25 01:06:52,089 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:52,089 DEBUG --- stderr --- 2024-05-25 01:06:52,089 DEBUG Checking pod: overseer-0-dfd5985cb-fzzf7 for file exists, if not wait. 2024-05-25 01:06:52,089 INFO 2024-05-25 01:06:52,089 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-05-25 01:06:52,089 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:52,400 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:52,400 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:52,400 DEBUG --- stdout --- 2024-05-25 01:06:52,400 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:52,400 DEBUG --- stderr --- 2024-05-25 01:06:52,400 DEBUG 2024-05-25 01:06:52,401 INFO 2024-05-25 01:06:52,401 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-400/stderr.txt" ]; then echo "/results/orders/login-tree-400/stderr.txt file found"; exit 0; else echo "/results/orders/login-tree-400/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-400/stderr.txt file found" 2024-05-25 01:06:52,401 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-05-25 01:06:53,285 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-05-25 01:06:53,286 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:53,286 DEBUG --- stdout --- 2024-05-25 01:06:53,286 DEBUG /results/orders/login-tree-400/stderr.txt file found 2024-05-25 01:06:53,286 DEBUG --- stderr --- 2024-05-25 01:06:53,286 DEBUG 2024-05-25 01:06:53,286 INFO 2024-05-25 01:06:53,286 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-05-25 01:06:53,286 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:53,601 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:53,601 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:53,601 DEBUG --- stdout --- 2024-05-25 01:06:53,601 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:53,601 DEBUG --- stderr --- 2024-05-25 01:06:53,601 DEBUG 2024-05-25 01:06:53,601 INFO 2024-05-25 01:06:53,602 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- du -k /results/orders/login-tree-400/stderr.txt 2024-05-25 01:06:54,413 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-05-25 01:06:54,413 DEBUG --- stdout --- 2024-05-25 01:06:54,413 DEBUG 0 /results/orders/login-tree-400/stderr.txt 2024-05-25 01:06:54,413 DEBUG --- stderr --- 2024-05-25 01:06:54,413 DEBUG 2024-05-25 01:06:54,413 INFO - Download file (size 0k) 2024-05-25 01:06:54,414 INFO 2024-05-25 01:06:54,414 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-05-25 01:06:54,414 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:54,731 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:54,731 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:54,731 DEBUG --- stdout --- 2024-05-25 01:06:54,731 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:54,731 DEBUG --- stderr --- 2024-05-25 01:06:54,731 DEBUG source : /results/orders/login-tree-400/stderr.txt @ overseer-0-dfd5985cb-fzzf7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/stderr.txt 2024-05-25 01:06:54,731 INFO 2024-05-25 01:06:54,731 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-05-25 01:06:54,732 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:55,037 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:55,037 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:55,037 DEBUG --- stdout --- 2024-05-25 01:06:55,037 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:55,037 DEBUG --- stderr --- 2024-05-25 01:06:55,037 DEBUG 2024-05-25 01:06:55,037 INFO 2024-05-25 01:06:55,038 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-dfd5985cb-fzzf7:/results/orders/login-tree-400/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/stderr.txt 2024-05-25 01:06:55,038 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-05-25 01:06:55,764 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:55,765 DEBUG --- stdout --- 2024-05-25 01:06:55,765 DEBUG tar: Removing leading `/' from member names 2024-05-25 01:06:55,765 DEBUG --- stderr --- 2024-05-25 01:06:55,765 DEBUG 2024-05-25 01:06:55,765 INFO 2024-05-25 01:06:55,765 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-05-25 01:06:55,765 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:56,068 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:56,068 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:56,068 DEBUG --- stdout --- 2024-05-25 01:06:56,068 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:56,068 DEBUG --- stderr --- 2024-05-25 01:06:56,068 DEBUG Checking pod: overseer-0-dfd5985cb-fzzf7 for file exists, if not wait. 2024-05-25 01:06:56,068 INFO 2024-05-25 01:06:56,068 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-05-25 01:06:56,069 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:56,370 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:56,370 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:56,370 DEBUG --- stdout --- 2024-05-25 01:06:56,370 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:56,371 DEBUG --- stderr --- 2024-05-25 01:06:56,371 DEBUG 2024-05-25 01:06:56,371 INFO 2024-05-25 01:06:56,371 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-400/stdout.txt" ]; then echo "/results/orders/login-tree-400/stdout.txt file found"; exit 0; else echo "/results/orders/login-tree-400/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-400/stdout.txt file found" 2024-05-25 01:06:56,371 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-05-25 01:06:57,203 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-05-25 01:06:57,204 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:57,204 DEBUG --- stdout --- 2024-05-25 01:06:57,204 DEBUG /results/orders/login-tree-400/stdout.txt file found 2024-05-25 01:06:57,204 DEBUG --- stderr --- 2024-05-25 01:06:57,204 DEBUG 2024-05-25 01:06:57,205 INFO 2024-05-25 01:06:57,205 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-05-25 01:06:57,205 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:57,513 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:57,513 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:57,513 DEBUG --- stdout --- 2024-05-25 01:06:57,514 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:57,514 DEBUG --- stderr --- 2024-05-25 01:06:57,514 DEBUG 2024-05-25 01:06:57,514 INFO 2024-05-25 01:06:57,514 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- du -k /results/orders/login-tree-400/stdout.txt 2024-05-25 01:06:58,371 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-05-25 01:06:58,371 DEBUG --- stdout --- 2024-05-25 01:06:58,371 DEBUG 564 /results/orders/login-tree-400/stdout.txt 2024-05-25 01:06:58,372 DEBUG --- stderr --- 2024-05-25 01:06:58,372 DEBUG 2024-05-25 01:06:58,372 INFO - Download file (size 564k) 2024-05-25 01:06:58,372 INFO 2024-05-25 01:06:58,372 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-05-25 01:06:58,372 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:58,677 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:58,677 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:58,677 DEBUG --- stdout --- 2024-05-25 01:06:58,677 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:58,677 DEBUG --- stderr --- 2024-05-25 01:06:58,677 DEBUG source : /results/orders/login-tree-400/stdout.txt @ overseer-0-dfd5985cb-fzzf7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/stdout.txt 2024-05-25 01:06:58,678 INFO 2024-05-25 01:06:58,678 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-05-25 01:06:58,678 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:06:58,985 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:06:58,985 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:06:58,985 DEBUG --- stdout --- 2024-05-25 01:06:58,985 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:06:58,986 DEBUG --- stderr --- 2024-05-25 01:06:58,986 DEBUG 2024-05-25 01:06:58,986 INFO 2024-05-25 01:06:58,986 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-dfd5985cb-fzzf7:/results/orders/login-tree-400/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/stdout.txt 2024-05-25 01:06:58,986 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-05-25 01:07:00,037 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:00,037 DEBUG --- stdout --- 2024-05-25 01:07:00,037 DEBUG tar: Removing leading `/' from member names 2024-05-25 01:07:00,037 DEBUG --- stderr --- 2024-05-25 01:07:00,037 DEBUG ________________________________________________________________________________ [2024-05-25 01:07:00] login-tree-400 show_cmd : Display order command ________________________________________________________________________________ 2024-05-25 01:07:00,038 INFO 2024-05-25 01:07:00,038 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-05-25 01:07:00,038 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:07:00,343 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:07:00,343 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:00,343 DEBUG --- stdout --- 2024-05-25 01:07:00,343 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:07:00,343 DEBUG --- stderr --- 2024-05-25 01:07:00,343 DEBUG Checking pod: overseer-0-dfd5985cb-fzzf7 for file exists, if not wait. 2024-05-25 01:07:00,344 INFO 2024-05-25 01:07:00,344 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-05-25 01:07:00,344 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:07:00,653 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:07:00,654 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:00,654 DEBUG --- stdout --- 2024-05-25 01:07:00,654 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:07:00,654 DEBUG --- stderr --- 2024-05-25 01:07:00,654 DEBUG 2024-05-25 01:07:00,654 INFO 2024-05-25 01:07:00,654 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- bash -c 'if [ -f "/results/orders/login-tree-400/cmd.txt" ]; then echo "/results/orders/login-tree-400/cmd.txt file found"; exit 0; else echo "/results/orders/login-tree-400/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-400/cmd.txt file found" 2024-05-25 01:07:00,654 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-05-25 01:07:01,464 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-05-25 01:07:01,464 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:01,464 DEBUG --- stdout --- 2024-05-25 01:07:01,464 DEBUG /results/orders/login-tree-400/cmd.txt file found 2024-05-25 01:07:01,464 DEBUG --- stderr --- 2024-05-25 01:07:01,464 DEBUG 2024-05-25 01:07:01,465 INFO 2024-05-25 01:07:01,465 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-05-25 01:07:01,465 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:07:01,780 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:07:01,780 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:01,780 DEBUG --- stdout --- 2024-05-25 01:07:01,780 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:07:01,780 DEBUG --- stderr --- 2024-05-25 01:07:01,780 DEBUG 2024-05-25 01:07:01,780 INFO 2024-05-25 01:07:01,780 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-dfd5985cb-fzzf7 --stdin -- du -k /results/orders/login-tree-400/cmd.txt 2024-05-25 01:07:02,577 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-05-25 01:07:02,577 DEBUG --- stdout --- 2024-05-25 01:07:02,577 DEBUG 4 /results/orders/login-tree-400/cmd.txt 2024-05-25 01:07:02,577 DEBUG --- stderr --- 2024-05-25 01:07:02,577 DEBUG 2024-05-25 01:07:02,577 INFO - Download file (size 4k) 2024-05-25 01:07:02,577 INFO 2024-05-25 01:07:02,577 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-05-25 01:07:02,577 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:07:02,878 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:07:02,878 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:02,878 DEBUG --- stdout --- 2024-05-25 01:07:02,878 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:07:02,878 DEBUG --- stderr --- 2024-05-25 01:07:02,878 DEBUG source : /results/orders/login-tree-400/cmd.txt @ overseer-0-dfd5985cb-fzzf7 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/cmd.txt 2024-05-25 01:07:02,878 INFO 2024-05-25 01:07:02,878 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-05-25 01:07:02,879 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-05-25 01:07:03,184 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-05-25 01:07:03,185 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:03,185 DEBUG --- stdout --- 2024-05-25 01:07:03,185 DEBUG overseer-0-dfd5985cb-fzzf7 2024-05-25 01:07:03,185 DEBUG --- stderr --- 2024-05-25 01:07:03,185 DEBUG 2024-05-25 01:07:03,185 INFO 2024-05-25 01:07:03,185 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-dfd5985cb-fzzf7:/results/orders/login-tree-400/cmd.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/cmd.txt 2024-05-25 01:07:03,185 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-05-25 01:07:03,917 INFO [loop_until]: OK (rc = 0) 2024-05-25 01:07:03,917 DEBUG --- stdout --- 2024-05-25 01:07:03,917 DEBUG tar: Removing leading `/' from member names 2024-05-25 01:07:03,917 DEBUG --- stderr --- 2024-05-25 01:07:03,917 DEBUG 2024-05-25 01:07:03,918 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/cmd.txt is small (1 lines), printing all lines: 2024-05-25 01:07:03,918 DEBUG ----- output ----- 2024-05-25 01:07:03,918 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-3580" --results-folder /results/gatling/login-tree-400 --extra-run-jvm-options "-Xmx12G" --no-reports 2024-05-25 01:07:03,918 INFO ________________________________________________________________________________ [2024-05-25 01:07:03] login-tree-400 show_rc : Display rc order ________________________________________________________________________________ 2024-05-25 01:07:03,918 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/rc.txt is small (1 lines), printing all lines: 2024-05-25 01:07:03,918 DEBUG ----- output ----- 2024-05-25 01:07:03,918 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-05-25 01:07:03,918 INFO ________________________________________________________________________________ [2024-05-25 01:07:03] login-tree-400 show_stdout : Display stdout order ________________________________________________________________________________ 2024-05-25 01:07:03,920 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/05_login-tree-400/stdout.txt is 9472 lines): 2024-05-25 01:07:03,920 DEBUG ----- output ----- 2024-05-25 01:07:03,920 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-05-25 01:07:03,920 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-05-25 01:07:03,920 INFO 2024-05-25 01:07:03,920 INFO ================================================================================ 2024-05-25 01:07:03,920 INFO 2024-05-25 01:04:38 5s elapsed 2024-05-25 01:07:03,920 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,920 INFO > Global (OK=332 KO=0 ) 2024-05-25 01:07:03,920 INFO > restLoginInitiate (OK=167 KO=0 ) 2024-05-25 01:07:03,920 INFO > restLoginUsernamePasswordCallback (OK=165 KO=0 ) 2024-05-25 01:07:03,920 INFO 2024-05-25 01:07:03,920 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,920 INFO [- ] 0% 2024-05-25 01:07:03,921 INFO waiting: 1447237 / active: 2 / done: 165 2024-05-25 01:07:03,921 INFO ================================================================================ 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO ================================================================================ 2024-05-25 01:07:03,921 INFO 2024-05-25 01:04:43 10s elapsed 2024-05-25 01:07:03,921 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,921 INFO > Global (OK=1330 KO=0 ) 2024-05-25 01:07:03,921 INFO > restLoginInitiate (OK=667 KO=0 ) 2024-05-25 01:07:03,921 INFO > restLoginUsernamePasswordCallback (OK=663 KO=0 ) 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,921 INFO [- ] 0% 2024-05-25 01:07:03,921 INFO waiting: 1446736 / active: 5 / done: 663 2024-05-25 01:07:03,921 INFO ================================================================================ 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO ================================================================================ 2024-05-25 01:07:03,921 INFO 2024-05-25 01:04:48 15s elapsed 2024-05-25 01:07:03,921 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,921 INFO > Global (OK=2997 KO=0 ) 2024-05-25 01:07:03,921 INFO > restLoginInitiate (OK=1501 KO=0 ) 2024-05-25 01:07:03,921 INFO > restLoginUsernamePasswordCallback (OK=1496 KO=0 ) 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,921 INFO [- ] 0% 2024-05-25 01:07:03,921 INFO waiting: 1445901 / active: 7 / done: 1496 2024-05-25 01:07:03,921 INFO ================================================================================ 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO 2024-05-25 01:07:03,921 INFO ================================================================================ 2024-05-25 01:07:03,921 INFO 2024-05-25 01:04:53 20s elapsed 2024-05-25 01:07:03,921 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,921 INFO > Global (OK=5328 KO=0 ) 2024-05-25 01:07:03,922 INFO > restLoginInitiate (OK=2667 KO=0 ) 2024-05-25 01:07:03,922 INFO > restLoginUsernamePasswordCallback (OK=2661 KO=0 ) 2024-05-25 01:07:03,922 INFO 2024-05-25 01:07:03,922 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,922 INFO [- ] 0% 2024-05-25 01:07:03,922 INFO waiting: 1444734 / active: 9 / done: 2661 2024-05-25 01:07:03,922 INFO ================================================================================ 2024-05-25 01:07:03,922 INFO 2024-05-25 01:07:03,922 INFO 2024-05-25 01:07:03,922 INFO ================================================================================ 2024-05-25 01:07:03,922 INFO 2024-05-25 01:04:58 25s elapsed 2024-05-25 01:07:03,922 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,922 INFO > Global (OK=8321 KO=0 ) 2024-05-25 01:07:03,922 INFO > restLoginInitiate (OK=4167 KO=0 ) 2024-05-25 01:07:03,922 INFO > restLoginUsernamePasswordCallback (OK=4154 KO=0 ) 2024-05-25 01:07:03,922 INFO 2024-05-25 01:07:03,922 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,922 INFO [- ] 0% 2024-05-25 01:07:03,922 INFO waiting: 1443234 / active: 16 / done: 4154 2024-05-25 01:07:03,922 INFO ================================================================================ 2024-05-25 01:07:03,922 INFO 2024-05-25 01:07:03,922 INFO 2024-05-25 01:07:03,922 INFO ================================================================================ 2024-05-25 01:07:03,922 INFO 2024-05-25 01:05:03 30s elapsed 2024-05-25 01:07:03,922 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,922 INFO > Global (OK=11986 KO=0 ) 2024-05-25 01:07:03,922 INFO > restLoginInitiate (OK=5996 KO=0 ) 2024-05-25 01:07:03,922 INFO > restLoginUsernamePasswordCallback (OK=5990 KO=0 ) 2024-05-25 01:07:03,922 INFO 2024-05-25 01:07:03,922 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,922 INFO [- ] 0% 2024-05-25 01:07:03,922 INFO waiting: 1441401 / active: 13 / done: 5990 2024-05-25 01:07:03,923 INFO ================================================================================ 2024-05-25 01:07:03,923 INFO 2024-05-25 01:07:03,923 INFO 2024-05-25 01:07:03,923 INFO ================================================================================ 2024-05-25 01:07:03,923 INFO 2024-05-25 01:05:08 35s elapsed 2024-05-25 01:07:03,923 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,923 INFO > Global (OK=15925 KO=0 ) 2024-05-25 01:07:03,923 INFO > restLoginInitiate (OK=7970 KO=0 ) 2024-05-25 01:07:03,923 INFO > restLoginUsernamePasswordCallback (OK=7955 KO=0 ) 2024-05-25 01:07:03,923 INFO 2024-05-25 01:07:03,923 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,923 INFO [- ] 0% 2024-05-25 01:07:03,923 INFO waiting: 1439433 / active: 16 / done: 7955 2024-05-25 01:07:03,923 INFO ================================================================================ 2024-05-25 01:07:03,923 INFO 2024-05-25 01:07:03,923 INFO 2024-05-25 01:07:03,923 INFO ================================================================================ 2024-05-25 01:07:03,923 INFO 2024-05-25 01:05:13 40s elapsed 2024-05-25 01:07:03,923 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,923 INFO > Global (OK=20001 KO=0 ) 2024-05-25 01:07:03,923 INFO > restLoginInitiate (OK=10005 KO=0 ) 2024-05-25 01:07:03,923 INFO > restLoginUsernamePasswordCallback (OK=9996 KO=0 ) 2024-05-25 01:07:03,923 INFO [...] 2024-05-25 01:07:03,926 INFO waiting: 10152 / active: 14 / done: 1437238 2024-05-25 01:07:03,926 INFO ================================================================================ 2024-05-25 01:07:03,926 INFO 2024-05-25 01:07:03,926 INFO 2024-05-25 01:07:03,926 INFO ================================================================================ 2024-05-25 01:07:03,926 INFO 2024-05-25 02:04:43 3610s elapsed 2024-05-25 01:07:03,926 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,926 INFO > Global (OK=2878490 KO=0 ) 2024-05-25 01:07:03,926 INFO > restLoginInitiate (OK=1439249 KO=0 ) 2024-05-25 01:07:03,926 INFO > restLoginUsernamePasswordCallback (OK=1439241 KO=0 ) 2024-05-25 01:07:03,926 INFO 2024-05-25 01:07:03,926 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,926 INFO [#########################################################################-] 99% 2024-05-25 01:07:03,926 INFO waiting: 8151 / active: 12 / done: 1439241 2024-05-25 01:07:03,926 INFO ================================================================================ 2024-05-25 01:07:03,926 INFO 2024-05-25 01:07:03,926 INFO 2024-05-25 01:07:03,926 INFO ================================================================================ 2024-05-25 01:07:03,926 INFO 2024-05-25 02:04:48 3615s elapsed 2024-05-25 01:07:03,926 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,926 INFO > Global (OK=2882526 KO=0 ) 2024-05-25 01:07:03,926 INFO > restLoginInitiate (OK=1441267 KO=0 ) 2024-05-25 01:07:03,926 INFO > restLoginUsernamePasswordCallback (OK=1441259 KO=0 ) 2024-05-25 01:07:03,926 INFO 2024-05-25 01:07:03,926 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,927 INFO [#########################################################################-] 99% 2024-05-25 01:07:03,927 INFO waiting: 6133 / active: 12 / done: 1441259 2024-05-25 01:07:03,927 INFO ================================================================================ 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO ================================================================================ 2024-05-25 01:07:03,927 INFO 2024-05-25 02:04:53 3620s elapsed 2024-05-25 01:07:03,927 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,927 INFO > Global (OK=2886619 KO=0 ) 2024-05-25 01:07:03,927 INFO > restLoginInitiate (OK=1443315 KO=0 ) 2024-05-25 01:07:03,927 INFO > restLoginUsernamePasswordCallback (OK=1443304 KO=0 ) 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,927 INFO [#########################################################################-] 99% 2024-05-25 01:07:03,927 INFO waiting: 4086 / active: 14 / done: 1443304 2024-05-25 01:07:03,927 INFO ================================================================================ 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO ================================================================================ 2024-05-25 01:07:03,927 INFO 2024-05-25 02:04:58 3625s elapsed 2024-05-25 01:07:03,927 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,927 INFO > Global (OK=2890731 KO=0 ) 2024-05-25 01:07:03,927 INFO > restLoginInitiate (OK=1445374 KO=0 ) 2024-05-25 01:07:03,927 INFO > restLoginUsernamePasswordCallback (OK=1445357 KO=0 ) 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,927 INFO [#########################################################################-] 99% 2024-05-25 01:07:03,927 INFO waiting: 2028 / active: 19 / done: 1445357 2024-05-25 01:07:03,927 INFO ================================================================================ 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO 2024-05-25 01:07:03,927 INFO ================================================================================ 2024-05-25 01:07:03,927 INFO 2024-05-25 02:05:03 3630s elapsed 2024-05-25 01:07:03,928 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,928 INFO > Global (OK=2894801 KO=0 ) 2024-05-25 01:07:03,928 INFO > restLoginInitiate (OK=1447404 KO=0 ) 2024-05-25 01:07:03,928 INFO > restLoginUsernamePasswordCallback (OK=1447397 KO=0 ) 2024-05-25 01:07:03,928 INFO 2024-05-25 01:07:03,928 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,928 INFO [#########################################################################-] 99% 2024-05-25 01:07:03,928 INFO waiting: 0 / active: 8 / done: 1447396 2024-05-25 01:07:03,928 INFO ================================================================================ 2024-05-25 01:07:03,928 INFO 2024-05-25 01:07:03,928 INFO 2024-05-25 01:07:03,928 INFO ================================================================================ 2024-05-25 01:07:03,928 INFO 2024-05-25 02:05:03 3630s elapsed 2024-05-25 01:07:03,928 INFO ---- Requests ------------------------------------------------------------------ 2024-05-25 01:07:03,928 INFO > Global (OK=2894808 KO=0 ) 2024-05-25 01:07:03,928 INFO > restLoginInitiate (OK=1447404 KO=0 ) 2024-05-25 01:07:03,928 INFO > restLoginUsernamePasswordCallback (OK=1447404 KO=0 ) 2024-05-25 01:07:03,928 INFO 2024-05-25 01:07:03,928 INFO ---- idc.login ----------------------------------------------------------------- 2024-05-25 01:07:03,928 INFO [##########################################################################]100% 2024-05-25 01:07:03,928 INFO waiting: 0 / active: 0 / done: 1447404 2024-05-25 01:07:03,928 INFO ================================================================================ 2024-05-25 01:07:03,928 INFO 2024-05-25 01:07:03,928 INFO Simulation com.forgerock.gatling.Loadtest completed in 3630 seconds 2024-05-25 01:07:03,928 INFO 2024-05-25 01:07:03,928 INFO ---------------------- 2024-05-25 01:07:03,928 INFO [25/May/2024 02:05:03] Create tar file login-tree-400.tar.gz 2024-05-25 01:07:03,928 INFO ---------------------- 2024-05-25 01:07:03,928 INFO RESULTS_FOLDER=/results/gatling/ 2024-05-25 01:07:03,928 INFO RESULT_FOLDER=login-tree-400 2024-05-25 01:07:03,928 INFO SIMULATION_PATH=login-tree-400/loadtest-20240525000432958 2024-05-25 01:07:03,928 INFO PWD=/results/gatling/login-tree-400/loadtest-20240525000432958 2024-05-25 01:07:03,928 INFO [cmd] tar -czvf /results/gatling//login-tree-400.tar.gz --exclude=simulation.log * 2024-05-25 01:07:03,928 INFO /results/gatling 2024-05-25 01:07:03,929 INFO 2024-05-25 01:07:03,929 INFO ---------------------- 2024-05-25 01:07:03,929 INFO [25/May/2024 02:05:03] Update /results/gatling//latest 2024-05-25 01:07:03,929 INFO ---------------------- 2024-05-25 01:07:03,929 INFO 2024-05-25 01:07:03,929 INFO ---------------------- 2024-05-25 01:07:03,929 INFO [25/May/2024 02:05:03] Update /results/gatling//latest.tar.gz 2024-05-25 01:07:03,929 INFO ---------------------- 2024-05-25 01:07:03,929 INFO ________________________________________________________________________________ [2024-05-25 01:07:03] login-tree-400 show_stderr : Display stderr order ________________________________________________________________________________ 2024-05-25 01:07:03,929 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/05_login-tree-400/stderr.txt is small (0 lines), printing all lines: 2024-05-25 01:07:03,929 DEBUG ----- output ----- 2024-05-25 01:07:03,929 DEBUG 2024-05-25 01:07:03,929 INFO ________________________________________________________________________________ [2024-05-25 01:07:03] login-tree-400 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-05-25 01:07:03] login-tree-400 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-05-25 01:07:03] login-tree-400 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped