--Task-- name: login-tree-200 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-150'] preceding_task: login-tree-150 options: {'testCase': 'idc.login', 'testMode': 'open', 'throughput': 200, '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 00:28:02] login-tree-200 pre : N/A ________________________________________________________________________________ 2024-06-24 00:28:02 - INFO: Timeout for this Task has changed to 1h 12m (4320 seconds) 2024-06-24 00:28:02 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/login-tree-200/stdout.txt Pod log : /results/orders/login-tree-200 2024-06-24 00:28:02,246 INFO 2024-06-24 00:28:02,246 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 00:28:02,246 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 00:28:02,557 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 00:28:02,557 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:02,557 DEBUG --- stdout --- 2024-06-24 00:28:02,557 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 00:28:02,558 DEBUG --- stderr --- 2024-06-24 00:28:02,558 DEBUG ________________________________________________________________________________ [2024-06-24 00:28:02] login-tree-200 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ 2024-06-24 00:28:02,558 INFO 2024-06-24 00:28:02,558 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 00:28:02,558 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 00:28:02,881 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 00:28:02,881 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:02,881 DEBUG --- stdout --- 2024-06-24 00:28:02,882 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 00:28:02,882 DEBUG --- stderr --- 2024-06-24 00:28:02,882 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-200 --extra-run-jvm-options "-Xmx4G" --no-reports ________________________________________________________________________________ [2024-06-24 00:28:02] login-tree-200 create_order : Create order for overseer with the command to run ________________________________________________________________________________ 2024-06-24 00:28:02,882 INFO 2024-06-24 00:28:02,883 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 00:28:02,883 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 00:28:03,201 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 00:28:03,202 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:03,202 DEBUG --- stdout --- 2024-06-24 00:28:03,202 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 00:28:03,202 DEBUG --- stderr --- 2024-06-24 00:28:03,202 DEBUG Order file: /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/order.json { "name": "login-tree-200", "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-200 --extra-run-jvm-options \"-Xmx4G\" --no-reports", "out-dir": "/results/orders/login-tree-200", "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=200 -Duser_password=Pa_ssw0rd" } } ________________________________________________________________________________ [2024-06-24 00:28:03] login-tree-200 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 00:28:03,204 INFO 2024-06-24 00:28:03,204 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2024-06-24 00:28:03,204 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-06-24 00:28:03,449 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 00:28:03,449 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:03,449 DEBUG --- stdout --- 2024-06-24 00:28:03,449 DEBUG WAITING 2024-06-24 00:28:03,449 DEBUG --- stderr --- 2024-06-24 00:28:03,449 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 --:--:-- --:--:-- --:--:-- 32 ________________________________________________________________________________ [2024-06-24 00:28:03] login-tree-200 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2024-06-24 00:28:03,450 INFO 2024-06-24 00:28:03,450 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 00:28:03,450 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 00:28:03,756 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 00:28:03,757 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:03,757 DEBUG --- stdout --- 2024-06-24 00:28:03,757 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 00:28:03,757 DEBUG --- stderr --- 2024-06-24 00:28:03,757 DEBUG 2024-06-24 00:28:03,757 INFO 2024-06-24 00:28:03,757 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/04_login-tree-200/order.json overseer-0-5b6f9464fd-slbm8:/results/orders/order.json 2024-06-24 00:28:03,757 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 00:28:05,147 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:05,147 DEBUG --- stdout --- 2024-06-24 00:28:05,147 DEBUG 2024-06-24 00:28:05,147 DEBUG --- stderr --- 2024-06-24 00:28:05,147 DEBUG Order has been successfully forwarded to overseer 2024-06-24 00:28:05 - INFO: Check if Gatling simulation started successfully 2024-06-24 00:28:05,148 INFO 2024-06-24 00:28:05,148 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-24 00:28:05,148 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 00:28:05,469 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 00:28:05,469 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:05,469 DEBUG --- stdout --- 2024-06-24 00:28:05,469 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 00:28:05,469 DEBUG --- stderr --- 2024-06-24 00:28:05,469 DEBUG 2024-06-24 00:28:05,470 INFO 2024-06-24 00:28:05,470 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-200/stdout.txt | grep "started..." 2024-06-24 00:28:05,470 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2024-06-24 00:28:06,202 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: started... - retry 2024-06-24 00:28:11,946 INFO [loop_until]: Function succeeded after 6s (rc=0) - expected pattern found 2024-06-24 00:28:11,946 INFO [loop_until]: OK (rc = 0) 2024-06-24 00:28:11,946 DEBUG --- stdout --- 2024-06-24 00:28:11,946 DEBUG GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling Gatling 3.11.4 is available! (you're using 3.9.5) Simulation com.forgerock.gatling.Loadtest started... 2024-06-24 00:28:11,947 DEBUG --- stderr --- 2024-06-24 00:28:11,947 DEBUG ________________________________________________________________________________ [2024-06-24 00:28:11] login-tree-200 wait_stop_by_itself : Wait for the order to stop by itself ________________________________________________________________________________ Task may stop by itself (no stop defined in configuration file), wait until overseer ends the order - timeout is 1h 12m Waiting for status (curl --fail --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt) == WAITING Order is running since 2m, retry Order is running since 4m, retry Order is running since 6m, retry Order is running since 8m 01s, retry Order is running since 10m 01s, retry Order is running since 12m 01s, retry Order is running since 14m 02s, retry Order is running since 16m 02s, retry Order is running since 18m 02s, 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 05s, retry Order is running since 38m 05s, retry Order is running since 40m 06s, retry Order is running since 42m 06s, retry Order is running since 44m 06s, retry Order is running since 46m 07s, retry Order is running since 48m 07s, retry Order is running since 50m 07s, retry Order is running since 52m 08s, retry Order is running since 54m 08s, retry Order is running since 56m 08s, retry Order is running since 58m 08s, retry Order is running since 1h, retry PASS : Order stopped by itself after 1h 02m and before timeout (1h 12m) ________________________________________________________________________________ [2024-06-24 01:30:21] login-tree-200 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2024-06-24 01:30:21,631 INFO 2024-06-24 01:30:21,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 01:30:21,631 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:21,960 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:21,960 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:21,960 DEBUG --- stdout --- 2024-06-24 01:30:21,960 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:21,960 DEBUG --- stderr --- 2024-06-24 01:30:21,960 DEBUG 2024-06-24 01:30:21,960 INFO 2024-06-24 01:30:21,960 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 01:30:21,960 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 01:30:22,781 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:22,782 DEBUG --- stdout --- 2024-06-24 01:30:22,782 DEBUG 2024-06-24 01:30:22,782 DEBUG --- stderr --- 2024-06-24 01:30:22,782 DEBUG Order ran during 1h 02m ________________________________________________________________________________ [2024-06-24 01:30:22] login-tree-200 download_logs : Download individual order files ________________________________________________________________________________ 2024-06-24 01:30:22 - PASS: file already downloaded /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/order.json 2024-06-24 01:30:22,783 INFO 2024-06-24 01:30:22,783 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 01:30:22,783 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:23,107 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:23,107 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:23,108 DEBUG --- stdout --- 2024-06-24 01:30:23,108 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:23,108 DEBUG --- stderr --- 2024-06-24 01:30:23,108 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 01:30:23,108 INFO 2024-06-24 01:30:23,108 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 01:30:23,108 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:23,414 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:23,414 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:23,414 DEBUG --- stdout --- 2024-06-24 01:30:23,414 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:23,414 DEBUG --- stderr --- 2024-06-24 01:30:23,414 DEBUG 2024-06-24 01:30:23,415 INFO 2024-06-24 01:30:23,415 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-200/rc.txt" ]; then echo "/results/orders/login-tree-200/rc.txt file found"; exit 0; else echo "/results/orders/login-tree-200/rc.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-200/rc.txt file found" 2024-06-24 01:30:23,415 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 01:30:24,219 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 01:30:24,219 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:24,219 DEBUG --- stdout --- 2024-06-24 01:30:24,219 DEBUG /results/orders/login-tree-200/rc.txt file found 2024-06-24 01:30:24,220 DEBUG --- stderr --- 2024-06-24 01:30:24,220 DEBUG 2024-06-24 01:30:24,220 INFO 2024-06-24 01:30:24,220 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 01:30:24,220 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:24,519 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:24,519 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:24,519 DEBUG --- stdout --- 2024-06-24 01:30:24,519 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:24,519 DEBUG --- stderr --- 2024-06-24 01:30:24,519 DEBUG 2024-06-24 01:30:24,520 INFO 2024-06-24 01:30:24,520 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-200/rc.txt 2024-06-24 01:30:25,318 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 01:30:25,318 DEBUG --- stdout --- 2024-06-24 01:30:25,318 DEBUG 4 /results/orders/login-tree-200/rc.txt 2024-06-24 01:30:25,319 DEBUG --- stderr --- 2024-06-24 01:30:25,319 DEBUG 2024-06-24 01:30:25,319 INFO - Download file (size 4k) 2024-06-24 01:30:25,319 INFO 2024-06-24 01:30:25,319 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 01:30:25,319 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:25,674 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:25,674 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:25,675 DEBUG --- stdout --- 2024-06-24 01:30:25,675 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:25,675 DEBUG --- stderr --- 2024-06-24 01:30:25,675 DEBUG source : /results/orders/login-tree-200/rc.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/rc.txt 2024-06-24 01:30:25,675 INFO 2024-06-24 01:30:25,676 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 01:30:25,676 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:26,025 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:26,026 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:26,026 DEBUG --- stdout --- 2024-06-24 01:30:26,026 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:26,026 DEBUG --- stderr --- 2024-06-24 01:30:26,026 DEBUG 2024-06-24 01:30:26,027 INFO 2024-06-24 01:30:26,027 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-200/rc.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/rc.txt 2024-06-24 01:30:26,027 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 01:30:26,786 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:26,787 DEBUG --- stdout --- 2024-06-24 01:30:26,787 DEBUG tar: Removing leading `/' from member names 2024-06-24 01:30:26,787 DEBUG --- stderr --- 2024-06-24 01:30:26,787 DEBUG 2024-06-24 01:30:26,787 INFO 2024-06-24 01:30:26,788 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 01:30:26,788 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:27,100 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:27,100 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:27,100 DEBUG --- stdout --- 2024-06-24 01:30:27,101 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:27,101 DEBUG --- stderr --- 2024-06-24 01:30:27,101 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 01:30:27,101 INFO 2024-06-24 01:30:27,101 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 01:30:27,101 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:27,417 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:27,418 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:27,418 DEBUG --- stdout --- 2024-06-24 01:30:27,418 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:27,418 DEBUG --- stderr --- 2024-06-24 01:30:27,418 DEBUG 2024-06-24 01:30:27,419 INFO 2024-06-24 01:30:27,419 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-200/stderr.txt" ]; then echo "/results/orders/login-tree-200/stderr.txt file found"; exit 0; else echo "/results/orders/login-tree-200/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-200/stderr.txt file found" 2024-06-24 01:30:27,419 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 01:30:28,246 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 01:30:28,246 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:28,247 DEBUG --- stdout --- 2024-06-24 01:30:28,247 DEBUG /results/orders/login-tree-200/stderr.txt file found 2024-06-24 01:30:28,247 DEBUG --- stderr --- 2024-06-24 01:30:28,247 DEBUG 2024-06-24 01:30:28,247 INFO 2024-06-24 01:30:28,247 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 01:30:28,247 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:28,569 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:28,569 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:28,569 DEBUG --- stdout --- 2024-06-24 01:30:28,569 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:28,570 DEBUG --- stderr --- 2024-06-24 01:30:28,570 DEBUG 2024-06-24 01:30:28,570 INFO 2024-06-24 01:30:28,570 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-200/stderr.txt 2024-06-24 01:30:29,385 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 01:30:29,385 DEBUG --- stdout --- 2024-06-24 01:30:29,385 DEBUG 0 /results/orders/login-tree-200/stderr.txt 2024-06-24 01:30:29,385 DEBUG --- stderr --- 2024-06-24 01:30:29,385 DEBUG 2024-06-24 01:30:29,385 INFO - Download file (size 0k) 2024-06-24 01:30:29,386 INFO 2024-06-24 01:30:29,386 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 01:30:29,386 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:29,700 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:29,700 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:29,700 DEBUG --- stdout --- 2024-06-24 01:30:29,700 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:29,700 DEBUG --- stderr --- 2024-06-24 01:30:29,700 DEBUG source : /results/orders/login-tree-200/stderr.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/stderr.txt 2024-06-24 01:30:29,700 INFO 2024-06-24 01:30:29,700 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 01:30:29,700 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:30,008 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:30,008 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:30,008 DEBUG --- stdout --- 2024-06-24 01:30:30,008 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:30,008 DEBUG --- stderr --- 2024-06-24 01:30:30,008 DEBUG 2024-06-24 01:30:30,009 INFO 2024-06-24 01:30:30,009 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-200/stderr.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/stderr.txt 2024-06-24 01:30:30,009 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 01:30:30,739 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:30,739 DEBUG --- stdout --- 2024-06-24 01:30:30,739 DEBUG tar: Removing leading `/' from member names 2024-06-24 01:30:30,739 DEBUG --- stderr --- 2024-06-24 01:30:30,739 DEBUG 2024-06-24 01:30:30,740 INFO 2024-06-24 01:30:30,740 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2024-06-24 01:30:30,740 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:31,043 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:31,043 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:31,043 DEBUG --- stdout --- 2024-06-24 01:30:31,044 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:31,044 DEBUG --- stderr --- 2024-06-24 01:30:31,044 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 01:30:31,044 INFO 2024-06-24 01:30:31,044 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 01:30:31,044 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:31,352 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:31,352 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:31,352 DEBUG --- stdout --- 2024-06-24 01:30:31,352 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:31,352 DEBUG --- stderr --- 2024-06-24 01:30:31,352 DEBUG 2024-06-24 01:30:31,353 INFO 2024-06-24 01:30:31,353 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-200/stdout.txt" ]; then echo "/results/orders/login-tree-200/stdout.txt file found"; exit 0; else echo "/results/orders/login-tree-200/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-200/stdout.txt file found" 2024-06-24 01:30:31,353 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 01:30:32,175 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 01:30:32,176 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:32,177 DEBUG --- stdout --- 2024-06-24 01:30:32,177 DEBUG /results/orders/login-tree-200/stdout.txt file found 2024-06-24 01:30:32,177 DEBUG --- stderr --- 2024-06-24 01:30:32,177 DEBUG 2024-06-24 01:30:32,178 INFO 2024-06-24 01:30:32,178 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 01:30:32,178 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:32,523 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:32,524 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:32,524 DEBUG --- stdout --- 2024-06-24 01:30:32,524 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:32,524 DEBUG --- stderr --- 2024-06-24 01:30:32,524 DEBUG 2024-06-24 01:30:32,524 INFO 2024-06-24 01:30:32,524 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-200/stdout.txt 2024-06-24 01:30:33,346 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 01:30:33,346 DEBUG --- stdout --- 2024-06-24 01:30:33,347 DEBUG 864 /results/orders/login-tree-200/stdout.txt 2024-06-24 01:30:33,347 DEBUG --- stderr --- 2024-06-24 01:30:33,347 DEBUG 2024-06-24 01:30:33,347 INFO - Download file (size 864k) 2024-06-24 01:30:33,347 INFO 2024-06-24 01:30:33,347 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 01:30:33,347 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:33,654 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:33,654 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:33,654 DEBUG --- stdout --- 2024-06-24 01:30:33,654 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:33,654 DEBUG --- stderr --- 2024-06-24 01:30:33,654 DEBUG source : /results/orders/login-tree-200/stdout.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/stdout.txt 2024-06-24 01:30:33,655 INFO 2024-06-24 01:30:33,655 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 01:30:33,655 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:33,959 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:33,959 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:33,959 DEBUG --- stdout --- 2024-06-24 01:30:33,959 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:33,959 DEBUG --- stderr --- 2024-06-24 01:30:33,959 DEBUG 2024-06-24 01:30:33,959 INFO 2024-06-24 01:30:33,959 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-200/stdout.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/stdout.txt 2024-06-24 01:30:33,960 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 01:30:35,065 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:35,065 DEBUG --- stdout --- 2024-06-24 01:30:35,065 DEBUG tar: Removing leading `/' from member names 2024-06-24 01:30:35,065 DEBUG --- stderr --- 2024-06-24 01:30:35,065 DEBUG ________________________________________________________________________________ [2024-06-24 01:30:35] login-tree-200 show_cmd : Display order command ________________________________________________________________________________ 2024-06-24 01:30:35,066 INFO 2024-06-24 01:30:35,066 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 01:30:35,066 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:35,377 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:35,377 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:35,377 DEBUG --- stdout --- 2024-06-24 01:30:35,377 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:35,377 DEBUG --- stderr --- 2024-06-24 01:30:35,377 DEBUG Checking pod: overseer-0-5b6f9464fd-slbm8 for file exists, if not wait. 2024-06-24 01:30:35,378 INFO 2024-06-24 01:30:35,378 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 01:30:35,378 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:35,685 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:35,685 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:35,685 DEBUG --- stdout --- 2024-06-24 01:30:35,685 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:35,685 DEBUG --- stderr --- 2024-06-24 01:30:35,685 DEBUG 2024-06-24 01:30:35,686 INFO 2024-06-24 01:30:35,686 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-200/cmd.txt" ]; then echo "/results/orders/login-tree-200/cmd.txt file found"; exit 0; else echo "/results/orders/login-tree-200/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/login-tree-200/cmd.txt file found" 2024-06-24 01:30:35,686 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2024-06-24 01:30:36,489 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2024-06-24 01:30:36,490 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:36,490 DEBUG --- stdout --- 2024-06-24 01:30:36,490 DEBUG /results/orders/login-tree-200/cmd.txt file found 2024-06-24 01:30:36,490 DEBUG --- stderr --- 2024-06-24 01:30:36,490 DEBUG 2024-06-24 01:30:36,490 INFO 2024-06-24 01:30:36,491 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 01:30:36,491 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:36,811 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:36,811 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:36,811 DEBUG --- stdout --- 2024-06-24 01:30:36,811 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:36,811 DEBUG --- stderr --- 2024-06-24 01:30:36,811 DEBUG 2024-06-24 01:30:36,812 INFO 2024-06-24 01:30:36,812 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-200/cmd.txt 2024-06-24 01:30:37,734 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2024-06-24 01:30:37,735 DEBUG --- stdout --- 2024-06-24 01:30:37,735 DEBUG 4 /results/orders/login-tree-200/cmd.txt 2024-06-24 01:30:37,735 DEBUG --- stderr --- 2024-06-24 01:30:37,735 DEBUG 2024-06-24 01:30:37,735 INFO - Download file (size 4k) 2024-06-24 01:30:37,735 INFO 2024-06-24 01:30:37,735 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 01:30:37,735 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:38,056 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:38,057 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:38,057 DEBUG --- stdout --- 2024-06-24 01:30:38,057 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:38,057 DEBUG --- stderr --- 2024-06-24 01:30:38,057 DEBUG source : /results/orders/login-tree-200/cmd.txt @ overseer-0-5b6f9464fd-slbm8 destination : /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/cmd.txt 2024-06-24 01:30:38,057 INFO 2024-06-24 01:30:38,057 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 01:30:38,057 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2024-06-24 01:30:38,383 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2024-06-24 01:30:38,383 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:38,383 DEBUG --- stdout --- 2024-06-24 01:30:38,383 DEBUG overseer-0-5b6f9464fd-slbm8 2024-06-24 01:30:38,383 DEBUG --- stderr --- 2024-06-24 01:30:38,383 DEBUG 2024-06-24 01:30:38,384 INFO 2024-06-24 01:30:38,384 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-200/cmd.txt /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/cmd.txt 2024-06-24 01:30:38,384 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2024-06-24 01:30:39,187 INFO [loop_until]: OK (rc = 0) 2024-06-24 01:30:39,188 DEBUG --- stdout --- 2024-06-24 01:30:39,188 DEBUG tar: Removing leading `/' from member names 2024-06-24 01:30:39,188 DEBUG --- stderr --- 2024-06-24 01:30:39,188 DEBUG 2024-06-24 01:30:39,188 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/cmd.txt is small (1 lines), printing all lines: 2024-06-24 01:30:39,188 DEBUG ----- output ----- 2024-06-24 01:30:39,188 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-200 --extra-run-jvm-options "-Xmx4G" --no-reports 2024-06-24 01:30:39,188 INFO ________________________________________________________________________________ [2024-06-24 01:30:39] login-tree-200 show_rc : Display rc order ________________________________________________________________________________ 2024-06-24 01:30:39,189 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/rc.txt is small (1 lines), printing all lines: 2024-06-24 01:30:39,189 DEBUG ----- output ----- 2024-06-24 01:30:39,189 DEBUG CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) 2024-06-24 01:30:39,189 INFO ________________________________________________________________________________ [2024-06-24 01:30:39] login-tree-200 show_stdout : Display stdout order ________________________________________________________________________________ 2024-06-24 01:30:39,191 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/04_login-tree-200/stdout.txt is 12526 lines): 2024-06-24 01:30:39,191 DEBUG ----- output ----- 2024-06-24 01:30:39,191 INFO GATLING_HOME is set to /home/jenkins/lodestar/clients/gatling 2024-06-24 01:30:39,191 INFO Gatling 3.11.4 is available! (you're using 3.9.5) 2024-06-24 01:30:39,191 INFO Simulation com.forgerock.gatling.Loadtest started... 2024-06-24 01:30:39,191 INFO 2024-06-24 01:30:39,191 INFO ================================================================================ 2024-06-24 01:30:39,191 INFO 2024-06-24 01:28:14 5s elapsed 2024-06-24 01:30:39,191 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,191 INFO > Global (OK=175 KO=0 ) 2024-06-24 01:30:39,191 INFO > restLoginInitiate (OK=82 KO=0 ) 2024-06-24 01:30:39,191 INFO > restLoginUsernamePasswordCallback (OK=79 KO=0 ) 2024-06-24 01:30:39,191 INFO > restloginProgressiveProfileCallback (OK=14 KO=0 ) 2024-06-24 01:30:39,191 INFO 2024-06-24 01:30:39,191 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,191 INFO [- ] 0% 2024-06-24 01:30:39,192 INFO waiting: 723624 / active: 6 / done: 78 2024-06-24 01:30:39,192 INFO ================================================================================ 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO ================================================================================ 2024-06-24 01:30:39,192 INFO 2024-06-24 01:28:19 10s elapsed 2024-06-24 01:30:39,192 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,192 INFO > Global (OK=719 KO=0 ) 2024-06-24 01:30:39,192 INFO > restLoginInitiate (OK=331 KO=0 ) 2024-06-24 01:30:39,192 INFO > restLoginUsernamePasswordCallback (OK=324 KO=0 ) 2024-06-24 01:30:39,192 INFO > restloginProgressiveProfileCallback (OK=64 KO=0 ) 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,192 INFO [- ] 0% 2024-06-24 01:30:39,192 INFO waiting: 723374 / active: 11 / done: 323 2024-06-24 01:30:39,192 INFO ================================================================================ 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO ================================================================================ 2024-06-24 01:30:39,192 INFO 2024-06-24 01:28:24 15s elapsed 2024-06-24 01:30:39,192 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,192 INFO > Global (OK=1632 KO=0 ) 2024-06-24 01:30:39,192 INFO > restLoginInitiate (OK=747 KO=0 ) 2024-06-24 01:30:39,192 INFO > restLoginUsernamePasswordCallback (OK=736 KO=0 ) 2024-06-24 01:30:39,192 INFO > restloginProgressiveProfileCallback (OK=149 KO=0 ) 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,192 INFO [- ] 0% 2024-06-24 01:30:39,192 INFO waiting: 722956 / active: 19 / done: 733 2024-06-24 01:30:39,192 INFO ================================================================================ 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO 2024-06-24 01:30:39,192 INFO ================================================================================ 2024-06-24 01:30:39,192 INFO 2024-06-24 01:28:29 20s elapsed 2024-06-24 01:30:39,192 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,192 INFO > Global (OK=2889 KO=0 ) 2024-06-24 01:30:39,192 INFO > restLoginInitiate (OK=1329 KO=0 ) 2024-06-24 01:30:39,193 INFO > restLoginUsernamePasswordCallback (OK=1314 KO=0 ) 2024-06-24 01:30:39,193 INFO > restloginProgressiveProfileCallback (OK=246 KO=0 ) 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,193 INFO [- ] 0% 2024-06-24 01:30:39,193 INFO waiting: 722373 / active: 25 / done: 1310 2024-06-24 01:30:39,193 INFO ================================================================================ 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO ================================================================================ 2024-06-24 01:30:39,193 INFO 2024-06-24 01:28:34 25s elapsed 2024-06-24 01:30:39,193 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,193 INFO > Global (OK=4525 KO=0 ) 2024-06-24 01:30:39,193 INFO > restLoginInitiate (OK=2076 KO=0 ) 2024-06-24 01:30:39,193 INFO > restLoginUsernamePasswordCallback (OK=2058 KO=0 ) 2024-06-24 01:30:39,193 INFO > restloginProgressiveProfileCallback (OK=391 KO=0 ) 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,193 INFO [- ] 0% 2024-06-24 01:30:39,193 INFO waiting: 721623 / active: 30 / done: 2055 2024-06-24 01:30:39,193 INFO ================================================================================ 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO ================================================================================ 2024-06-24 01:30:39,193 INFO 2024-06-24 01:28:39 30s elapsed 2024-06-24 01:30:39,193 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,193 INFO > Global (OK=6494 KO=0 ) 2024-06-24 01:30:39,193 INFO > restLoginInitiate (OK=2992 KO=0 ) 2024-06-24 01:30:39,193 INFO > restLoginUsernamePasswordCallback (OK=2964 KO=0 ) 2024-06-24 01:30:39,193 INFO > restloginProgressiveProfileCallback (OK=538 KO=0 ) 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,193 INFO [- ] 0% 2024-06-24 01:30:39,193 INFO waiting: 720705 / active: 46 / done: 2957 2024-06-24 01:30:39,193 INFO ================================================================================ 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO 2024-06-24 01:30:39,193 INFO ================================================================================ 2024-06-24 01:30:39,193 INFO 2024-06-24 01:28:44 35s elapsed 2024-06-24 01:30:39,194 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,194 INFO > Global (OK=8673 KO=0 ) 2024-06-24 01:30:39,194 INFO > restLoginInitiate (OK=3987 KO=0 ) 2024-06-24 01:30:39,194 INFO > restLoginUsernamePasswordCallback (OK=3969 KO=0 ) 2024-06-24 01:30:39,194 INFO > restloginProgressiveProfileCallback (OK=717 KO=0 ) 2024-06-24 01:30:39,194 INFO 2024-06-24 01:30:39,194 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,194 INFO [- ] 0% 2024-06-24 01:30:39,194 INFO waiting: 719709 / active: 34 / done: 3965 2024-06-24 01:30:39,194 INFO ================================================================================ 2024-06-24 01:30:39,194 INFO [...] 2024-06-24 01:30:39,197 INFO 2024-06-24 01:30:39,197 INFO 2024-06-24 01:30:39,197 INFO ================================================================================ 2024-06-24 01:30:39,197 INFO 2024-06-24 02:28:24 3615s elapsed 2024-06-24 01:30:39,197 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,197 INFO > Global (OK=1604164 KO=20 ) 2024-06-24 01:30:39,197 INFO > restLoginInitiate (OK=720676 KO=6 ) 2024-06-24 01:30:39,197 INFO > restLoginUsernamePasswordCallback (OK=720647 KO=12 ) 2024-06-24 01:30:39,197 INFO > restloginProgressiveProfileCallback (OK=162841 KO=2 ) 2024-06-24 01:30:39,197 INFO ---- Errors -------------------------------------------------------------------- 2024-06-24 01:30:39,197 INFO > status.find.is(200), but actually found 502 20 (100.0%) 2024-06-24 01:30:39,198 INFO 2024-06-24 01:30:39,198 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,198 INFO [#########################################################################-] 99% 2024-06-24 01:30:39,198 INFO waiting: 3014 / active: 36 / done: 720658 2024-06-24 01:30:39,198 INFO ================================================================================ 2024-06-24 01:30:39,198 INFO 2024-06-24 01:30:39,198 INFO 2024-06-24 01:30:39,198 INFO ================================================================================ 2024-06-24 01:30:39,198 INFO 2024-06-24 02:28:29 3620s elapsed 2024-06-24 01:30:39,198 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,198 INFO > Global (OK=1606454 KO=20 ) 2024-06-24 01:30:39,198 INFO > restLoginInitiate (OK=721696 KO=6 ) 2024-06-24 01:30:39,198 INFO > restLoginUsernamePasswordCallback (OK=721658 KO=12 ) 2024-06-24 01:30:39,198 INFO > restloginProgressiveProfileCallback (OK=163100 KO=2 ) 2024-06-24 01:30:39,198 INFO ---- Errors -------------------------------------------------------------------- 2024-06-24 01:30:39,198 INFO > status.find.is(200), but actually found 502 20 (100.0%) 2024-06-24 01:30:39,198 INFO 2024-06-24 01:30:39,198 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,198 INFO [#########################################################################-] 99% 2024-06-24 01:30:39,198 INFO waiting: 1991 / active: 49 / done: 721668 2024-06-24 01:30:39,198 INFO ================================================================================ 2024-06-24 01:30:39,198 INFO 2024-06-24 01:30:39,198 INFO 2024-06-24 01:30:39,198 INFO ================================================================================ 2024-06-24 01:30:39,198 INFO 2024-06-24 02:28:34 3625s elapsed 2024-06-24 01:30:39,198 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,198 INFO > Global (OK=1608700 KO=20 ) 2024-06-24 01:30:39,198 INFO > restLoginInitiate (OK=722683 KO=6 ) 2024-06-24 01:30:39,198 INFO > restLoginUsernamePasswordCallback (OK=722642 KO=12 ) 2024-06-24 01:30:39,198 INFO > restloginProgressiveProfileCallback (OK=163375 KO=2 ) 2024-06-24 01:30:39,198 INFO ---- Errors -------------------------------------------------------------------- 2024-06-24 01:30:39,198 INFO > status.find.is(200), but actually found 502 20 (100.0%) 2024-06-24 01:30:39,198 INFO 2024-06-24 01:30:39,198 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,198 INFO [#########################################################################-] 99% 2024-06-24 01:30:39,199 INFO waiting: 1006 / active: 51 / done: 722651 2024-06-24 01:30:39,199 INFO ================================================================================ 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO ================================================================================ 2024-06-24 01:30:39,199 INFO 2024-06-24 02:28:39 3630s elapsed 2024-06-24 01:30:39,199 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,199 INFO > Global (OK=1610997 KO=20 ) 2024-06-24 01:30:39,199 INFO > restLoginInitiate (OK=723693 KO=6 ) 2024-06-24 01:30:39,199 INFO > restLoginUsernamePasswordCallback (OK=723658 KO=12 ) 2024-06-24 01:30:39,199 INFO > restloginProgressiveProfileCallback (OK=163646 KO=2 ) 2024-06-24 01:30:39,199 INFO ---- Errors -------------------------------------------------------------------- 2024-06-24 01:30:39,199 INFO > status.find.is(200), but actually found 502 20 (100.0%) 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,199 INFO [#########################################################################-] 99% 2024-06-24 01:30:39,199 INFO waiting: 0 / active: 40 / done: 723668 2024-06-24 01:30:39,199 INFO ================================================================================ 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO ================================================================================ 2024-06-24 01:30:39,199 INFO 2024-06-24 02:28:39 3630s elapsed 2024-06-24 01:30:39,199 INFO ---- Requests ------------------------------------------------------------------ 2024-06-24 01:30:39,199 INFO > Global (OK=1611050 KO=20 ) 2024-06-24 01:30:39,199 INFO > restLoginInitiate (OK=723702 KO=6 ) 2024-06-24 01:30:39,199 INFO > restLoginUsernamePasswordCallback (OK=723690 KO=12 ) 2024-06-24 01:30:39,199 INFO > restloginProgressiveProfileCallback (OK=163658 KO=2 ) 2024-06-24 01:30:39,199 INFO ---- Errors -------------------------------------------------------------------- 2024-06-24 01:30:39,199 INFO > status.find.is(200), but actually found 502 20 (100.0%) 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO ---- idc.login ----------------------------------------------------------------- 2024-06-24 01:30:39,199 INFO [##########################################################################]100% 2024-06-24 01:30:39,199 INFO waiting: 0 / active: 0 / done: 723708 2024-06-24 01:30:39,199 INFO ================================================================================ 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO Simulation com.forgerock.gatling.Loadtest completed in 3630 seconds 2024-06-24 01:30:39,199 INFO 2024-06-24 01:30:39,199 INFO ---------------------- 2024-06-24 01:30:39,199 INFO [24/Jun/2024 02:28:39] Create tar file login-tree-200.tar.gz 2024-06-24 01:30:39,199 INFO ---------------------- 2024-06-24 01:30:39,200 INFO RESULTS_FOLDER=/results/gatling/ 2024-06-24 01:30:39,200 INFO RESULT_FOLDER=login-tree-200 2024-06-24 01:30:39,200 INFO SIMULATION_PATH=login-tree-200/loadtest-20240624002808654 2024-06-24 01:30:39,200 INFO PWD=/results/gatling/login-tree-200/loadtest-20240624002808654 2024-06-24 01:30:39,200 INFO [cmd] tar -czvf /results/gatling//login-tree-200.tar.gz --exclude=simulation.log * 2024-06-24 01:30:39,200 INFO /results/gatling 2024-06-24 01:30:39,200 INFO 2024-06-24 01:30:39,200 INFO ---------------------- 2024-06-24 01:30:39,200 INFO [24/Jun/2024 02:28:39] Update /results/gatling//latest 2024-06-24 01:30:39,200 INFO ---------------------- 2024-06-24 01:30:39,200 INFO 2024-06-24 01:30:39,200 INFO ---------------------- 2024-06-24 01:30:39,200 INFO [24/Jun/2024 02:28:39] Update /results/gatling//latest.tar.gz 2024-06-24 01:30:39,200 INFO ---------------------- 2024-06-24 01:30:39,200 INFO ________________________________________________________________________________ [2024-06-24 01:30:39] login-tree-200 show_stderr : Display stderr order ________________________________________________________________________________ 2024-06-24 01:30:39,200 DEBUG [print_head_tail]: Input file /mnt/disks/data/xslou/lodestar-fork/results/pyrock/idc_login_tree/07_Scenario_scenario/04_login-tree-200/stderr.txt is small (0 lines), printing all lines: 2024-06-24 01:30:39,200 DEBUG ----- output ----- 2024-06-24 01:30:39,200 DEBUG 2024-06-24 01:30:39,200 INFO ________________________________________________________________________________ [2024-06-24 01:30:39] login-tree-200 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 01:30:39] login-tree-200 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2024-06-24 01:30:39] login-tree-200 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped