--Task-- name: query-7 enabled: True class_name: GatlingTask source_name: overseer-0 source_namespace: >default< target_name: idm target_namespace: >default< start: 0.0 stop: None timeout: not yet initialized for this Task as timeout was not explicitly defined, see updates below loop: False interval: None dependencies: [] wait_for: ['query-8'] preceding_task: query-8 options: {'testMode': 'open', 'testCase': 'idm.ManagedUsersQueryPartial', 'duration': 600, 'throughput': 50, 'java-opts': '-Dcsvfile=/results/idm/user_feeder.csv -Drealm=alpha -DqueryStringLength=7'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock 2025-03-28 19:14:31,834 INFO 2025-03-28 19:14:31,834 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 2025-03-28 19:14:31,834 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:14:32,112 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:14:32,112 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:14:32,112 DEBUG --- stdout --- 2025-03-28 19:14:32,112 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:14:32,112 DEBUG --- stderr --- 2025-03-28 19:14:32,112 DEBUG 2025-03-28 19:14:32,112 INFO Lodestar assumed that full stack is deployed so will set all products host URLs in Gatling system properties 2025-03-28 19:14:32 - INFO: Timeout for this Task has changed to 12m (720 seconds) 2025-03-28 19:14:32 - INFO: timeout was calculated based on simulation duration parameter Pod log file : /results/orders/query-7/stdout.txt Pod log : /results/orders/query-7 ________________________________________________________________________________ [2025-03-28 19:14:32] query-7 print_command : Display the command to be forwarded to overseer as an order ________________________________________________________________________________ /lodestar/lodestar.py perf run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idm.ManagedUsersQueryPartial@perf-200m" --results-folder="/results/gatling/query-7" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx8G" --simulation-system-properties="-Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -DqueryStringLength=7 -Drealm=alpha -DtestCase=idm.ManagedUsersQueryPartial -DtestMode=open -Dthroughput=50 -Duser_password=**** ________________________________________________________________________________ [2025-03-28 19:14:32] query-7 create_order : Create order for overseer with the command to run ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/order.json { "name": "query-7", "command": " /lodestar/lodestar.py perf run-gatling --simulation-class=\"com.forgerock.pyrock.Loadtest\" --run-description=\"idm.ManagedUsersQueryPartial@perf-200m\" --results-folder=\"/results/gatling/query-7\" --no-reports --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx8G\" --simulation-system-properties=\"-Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -DqueryStringLength=7 -Drealm=alpha -DtestCase=idm.ManagedUsersQueryPartial -DtestMode=open -Dthroughput=50 -Duser_password=T35!tr0c-k123\"", "out-dir": "/results/orders/query-7" } ________________________________________________________________________________ [2025-03-28 19:14:32] query-7 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: ________________________________________________________________________________ 2025-03-28 19:14:32,120 INFO 2025-03-28 19:14:32,120 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 19:14:32,120 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 19:14:32,403 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:14:32,403 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:14:32,404 DEBUG --- stdout --- 2025-03-28 19:14:32,404 DEBUG WAITING 2025-03-28 19:14:32,404 DEBUG --- stderr --- 2025-03-28 19:14:32,404 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 25 0 --:--:-- --:--:-- --:--:-- 25 ________________________________________________________________________________ [2025-03-28 19:14:32] query-7 start_order : Send the order to the overseer pod ________________________________________________________________________________ 2025-03-28 19:14:32,405 INFO 2025-03-28 19:14:32,405 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 2025-03-28 19:14:32,405 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:14:32,684 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:14:32,684 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:14:32,684 DEBUG --- stdout --- 2025-03-28 19:14:32,684 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:14:32,684 DEBUG --- stderr --- 2025-03-28 19:14:32,684 DEBUG 2025-03-28 19:14:32,685 INFO 2025-03-28 19:14:32,685 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 19:14:32,685 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:14:34,065 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:14:34,065 DEBUG --- stdout --- 2025-03-28 19:14:34,065 DEBUG 2025-03-28 19:14:34,065 DEBUG --- stderr --- 2025-03-28 19:14:34,065 DEBUG Order has been successfully forwarded to overseer 2025-03-28 19:14:34 - INFO: Check if Gatling simulation started successfully 2025-03-28 19:14:34,066 INFO 2025-03-28 19:14:34,066 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv -- head --lines 5000 /results/orders/query-7/stdout.txt | grep "Simulation com.forgerock.pyrock.Loadtest started..." 2025-03-28 19:14:34,066 INFO [loop_until]: (max_time=300, interval=5, expected_rc=[0] 2025-03-28 19:14:34,791 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 19:14:40,590 INFO [loop_until]: Function succeeded after 6s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 19:14:46,344 INFO [loop_until]: Function succeeded after 12s (rc=0) - failed to find expected output: Simulation com.forgerock.pyrock.Loadtest started... - retry 2025-03-28 19:14:52,075 INFO [loop_until]: Function succeeded after 18s (rc=0) - expected pattern found 2025-03-28 19:14:52,076 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:14:52,076 DEBUG --- stdout --- 2025-03-28 19:14:52,076 DEBUG 2025-03-28 19:14:34,760 DEBUG Creating results folder /results/gatling/query-7 2025-03-28 19:14:34,765 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp_8kcvln_ 2025-03-28 19:14:34,768 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/query-7" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx8G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -DqueryStringLength=7 -Drealm=alpha -DtestCase=idm.ManagedUsersQueryPartial -DtestMode=open -Dthroughput=50 -Duser_password=**** [INFO] Scanning for projects... [INFO] [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- [INFO] Building pyrock-gatling-simulation 3.12.0 [INFO] from pom.xml [INFO] --------------------------------[ jar ]--------------------------------- [INFO] [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> [INFO] [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- [INFO] skip non existing resourceDirectory /tmp/tmp_8kcvln_/src/main/resources [INFO] [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- [INFO] Copying 2 resources from src/test/resources to target/test-classes [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] Nothing to compile - all classes are up to date. [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compiling 38 Scala sources to /tmp/tmp_8kcvln_/target/test-classes ... [INFO] compile in 8.3 s [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- [INFO] Running simulation com.forgerock.pyrock.Loadtest. Gatling 3.13.5 is available! (you're using 3.12.0) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Set idVarName to id Simulation com.forgerock.pyrock.Loadtest started... 2025-03-28 19:14:52,076 DEBUG --- stderr --- 2025-03-28 19:14:52,076 DEBUG ________________________________________________________________________________ [2025-03-28 19:14:52] query-7 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 12m. Waiting for status (curl --fail --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt) == WAITING Order is running since 5s, retry Order is running since 10s, retry Order is running since 15s, retry Order is running since 21s, retry Order is running since 26s, retry Order is running since 31s, retry Order is running since 36s, retry Order is running since 42s, retry Order is running since 47s, retry Order is running since 52s, retry Order is running since 57s, retry Order is running since 1m 02s, retry Order is running since 1m 08s, retry Order is running since 1m 13s, retry Order is running since 1m 18s, retry Order is running since 1m 24s, retry Order is running since 1m 29s, retry Order is running since 1m 34s, retry Order is running since 1m 39s, retry Order is running since 1m 45s, retry Order is running since 1m 50s, retry Order is running since 1m 55s, retry Order is running since 2m, retry Order is running since 2m 06s, retry Order is running since 2m 11s, retry Order is running since 2m 16s, retry Order is running since 2m 21s, retry Order is running since 2m 27s, retry Order is running since 2m 32s, retry Order is running since 2m 37s, retry Order is running since 2m 42s, retry Order is running since 2m 48s, retry Order is running since 2m 53s, retry Order is running since 2m 58s, retry Order is running since 3m 03s, retry Order is running since 3m 08s, retry Order is running since 3m 14s, retry Order is running since 3m 19s, retry Order is running since 3m 24s, retry Order is running since 3m 29s, retry Order is running since 3m 35s, retry Order is running since 3m 40s, retry Order is running since 3m 45s, retry Order is running since 3m 50s, retry Order is running since 3m 56s, retry Order is running since 4m 01s, retry Order is running since 4m 06s, retry Order is running since 4m 11s, retry Order is running since 4m 17s, retry Order is running since 4m 22s, retry Order is running since 4m 27s, retry Order is running since 4m 32s, retry Order is running since 4m 38s, retry Order is running since 4m 43s, retry Order is running since 4m 48s, retry Order is running since 4m 53s, retry Order is running since 4m 59s, retry Order is running since 5m 04s, retry Order is running since 5m 09s, retry Order is running since 5m 14s, retry Order is running since 5m 20s, retry Order is running since 5m 25s, retry Order is running since 5m 30s, retry Order is running since 5m 35s, retry Order is running since 5m 41s, retry Order is running since 5m 46s, retry Order is running since 5m 51s, retry Order is running since 5m 56s, retry Order is running since 6m 02s, retry Order is running since 6m 07s, retry Order is running since 6m 12s, retry Order is running since 6m 17s, retry Order is running since 6m 23s, retry Order is running since 6m 28s, retry Order is running since 6m 33s, retry Order is running since 6m 38s, retry Order is running since 6m 44s, retry Order is running since 6m 49s, retry Order is running since 6m 54s, retry Order is running since 6m 59s, retry Order is running since 7m 05s, retry Order is running since 7m 10s, retry Order is running since 7m 15s, retry Order is running since 7m 20s, retry Order is running since 7m 26s, retry Order is running since 7m 31s, retry Order is running since 7m 36s, retry Order is running since 7m 41s, retry Order is running since 7m 47s, retry Order is running since 7m 52s, retry Order is running since 7m 57s, retry Order is running since 8m 02s, retry Order is running since 8m 08s, retry Order is running since 8m 13s, retry Order is running since 8m 18s, retry Order is running since 8m 23s, retry Order is running since 8m 29s, retry Order is running since 8m 34s, retry Order is running since 8m 39s, retry Order is running since 8m 44s, retry Order is running since 8m 50s, retry Order is running since 8m 55s, retry Order is running since 9m, retry Order is running since 9m 05s, retry Order is running since 9m 10s, retry Order is running since 9m 16s, retry Order is running since 9m 21s, retry Order is running since 9m 26s, retry Order is running since 9m 32s, retry Order is running since 9m 37s, retry Order is running since 9m 42s, retry Order is running since 9m 47s, retry Order is running since 9m 52s, retry PASS : Order stopped by itself after 9m 58s and before timeout (12m) ________________________________________________________________________________ [2025-03-28 19:24:50] query-7 stop_order : Stop the order on overseer pod ________________________________________________________________________________ 2025-03-28 19:24:50,269 INFO 2025-03-28 19:24:50,269 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 2025-03-28 19:24:50,269 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:24:50,573 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:24:50,573 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:50,573 DEBUG --- stdout --- 2025-03-28 19:24:50,573 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:24:50,573 DEBUG --- stderr --- 2025-03-28 19:24:50,573 DEBUG 2025-03-28 19:24:50,573 INFO 2025-03-28 19:24:50,573 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv -- rm -f /results/orders/order.json 2025-03-28 19:24:50,573 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:24:51,355 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:51,355 DEBUG --- stdout --- 2025-03-28 19:24:51,355 DEBUG 2025-03-28 19:24:51,355 DEBUG --- stderr --- 2025-03-28 19:24:51,355 DEBUG Order ran during 10m 17s ________________________________________________________________________________ [2025-03-28 19:24:51] query-7 download_logs : Download individual order files ________________________________________________________________________________ 2025-03-28 19:24:51 - PASS: file already downloaded /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/order.json 2025-03-28 19:24:51,355 INFO 2025-03-28 19:24:51,355 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 19:24:51,355 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:24:51,635 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:24:51,635 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:51,635 DEBUG --- stdout --- 2025-03-28 19:24:51,635 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:24:51,635 DEBUG --- stderr --- 2025-03-28 19:24:51,635 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:24:51,636 INFO 2025-03-28 19:24:51,636 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/query-7/rc.txt" ]; then echo "/results/orders/query-7/rc.txt file found"; exit 0; else echo "/results/orders/query-7/rc.txt file not found"; exit 1; fi' | grep "/results/orders/query-7/rc.txt file found" 2025-03-28 19:24:51,636 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:24:52,434 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:24:52,434 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:52,434 DEBUG --- stdout --- 2025-03-28 19:24:52,434 DEBUG /results/orders/query-7/rc.txt file found 2025-03-28 19:24:52,434 DEBUG --- stderr --- 2025-03-28 19:24:52,434 DEBUG 2025-03-28 19:24:52,434 INFO 2025-03-28 19:24:52,435 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/query-7/rc.txt 2025-03-28 19:24:53,240 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:24:53,240 DEBUG --- stdout --- 2025-03-28 19:24:53,240 DEBUG 4 /results/orders/query-7/rc.txt 2025-03-28 19:24:53,240 DEBUG --- stderr --- 2025-03-28 19:24:53,240 DEBUG 2025-03-28 19:24:53,240 INFO - Download file (size 4k) source : /results/orders/query-7/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/rc.txt 2025-03-28 19:24:53,241 INFO 2025-03-28 19:24:53,241 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/query-7/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/rc.txt 2025-03-28 19:24:53,241 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:24:54,006 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:54,006 DEBUG --- stdout --- 2025-03-28 19:24:54,006 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:24:54,006 DEBUG --- stderr --- 2025-03-28 19:24:54,006 DEBUG 2025-03-28 19:24:54,006 INFO 2025-03-28 19:24:54,006 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 2025-03-28 19:24:54,006 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:24:54,284 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:24:54,284 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:54,284 DEBUG --- stdout --- 2025-03-28 19:24:54,284 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:24:54,284 DEBUG --- stderr --- 2025-03-28 19:24:54,284 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:24:54,285 INFO 2025-03-28 19:24:54,285 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/query-7/stderr.txt" ]; then echo "/results/orders/query-7/stderr.txt file found"; exit 0; else echo "/results/orders/query-7/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/query-7/stderr.txt file found" 2025-03-28 19:24:54,285 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:24:55,086 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:24:55,086 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:55,086 DEBUG --- stdout --- 2025-03-28 19:24:55,086 DEBUG /results/orders/query-7/stderr.txt file found 2025-03-28 19:24:55,086 DEBUG --- stderr --- 2025-03-28 19:24:55,086 DEBUG 2025-03-28 19:24:55,086 INFO 2025-03-28 19:24:55,087 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/query-7/stderr.txt 2025-03-28 19:24:55,955 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:24:55,955 DEBUG --- stdout --- 2025-03-28 19:24:55,955 DEBUG 0 /results/orders/query-7/stderr.txt 2025-03-28 19:24:55,955 DEBUG --- stderr --- 2025-03-28 19:24:55,955 DEBUG 2025-03-28 19:24:55,955 INFO - Download file (size 0k) source : /results/orders/query-7/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/stderr.txt 2025-03-28 19:24:55,956 INFO 2025-03-28 19:24:55,956 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/query-7/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/stderr.txt 2025-03-28 19:24:55,956 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:24:56,680 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:56,680 DEBUG --- stdout --- 2025-03-28 19:24:56,680 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:24:56,680 DEBUG --- stderr --- 2025-03-28 19:24:56,680 DEBUG 2025-03-28 19:24:56,680 INFO 2025-03-28 19:24:56,680 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 2025-03-28 19:24:56,680 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:24:56,962 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:24:56,962 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:56,962 DEBUG --- stdout --- 2025-03-28 19:24:56,962 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:24:56,962 DEBUG --- stderr --- 2025-03-28 19:24:56,962 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:24:56,964 INFO 2025-03-28 19:24:56,964 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/query-7/stdout.txt" ]; then echo "/results/orders/query-7/stdout.txt file found"; exit 0; else echo "/results/orders/query-7/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/query-7/stdout.txt file found" 2025-03-28 19:24:56,964 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:24:57,799 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:24:57,799 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:57,799 DEBUG --- stdout --- 2025-03-28 19:24:57,799 DEBUG /results/orders/query-7/stdout.txt file found 2025-03-28 19:24:57,799 DEBUG --- stderr --- 2025-03-28 19:24:57,799 DEBUG 2025-03-28 19:24:57,799 INFO 2025-03-28 19:24:57,800 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/query-7/stdout.txt 2025-03-28 19:24:58,598 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:24:58,598 DEBUG --- stdout --- 2025-03-28 19:24:58,598 DEBUG 180 /results/orders/query-7/stdout.txt 2025-03-28 19:24:58,598 DEBUG --- stderr --- 2025-03-28 19:24:58,598 DEBUG 2025-03-28 19:24:58,598 INFO - Download file (size 180k) source : /results/orders/query-7/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/stdout.txt 2025-03-28 19:24:58,599 INFO 2025-03-28 19:24:58,599 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/query-7/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/stdout.txt 2025-03-28 19:24:58,599 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:24:59,541 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:59,541 DEBUG --- stdout --- 2025-03-28 19:24:59,541 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:24:59,541 DEBUG --- stderr --- 2025-03-28 19:24:59,541 DEBUG ________________________________________________________________________________ [2025-03-28 19:24:59] query-7 show_cmd : Display order command ________________________________________________________________________________ 2025-03-28 19:24:59,542 INFO 2025-03-28 19:24:59,542 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 2025-03-28 19:24:59,542 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 19:24:59,820 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 19:24:59,820 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:24:59,820 DEBUG --- stdout --- 2025-03-28 19:24:59,820 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 19:24:59,820 DEBUG --- stderr --- 2025-03-28 19:24:59,820 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 19:24:59,821 INFO 2025-03-28 19:24:59,821 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- bash -c 'if [ -f "/results/orders/query-7/cmd.txt" ]; then echo "/results/orders/query-7/cmd.txt file found"; exit 0; else echo "/results/orders/query-7/cmd.txt file not found"; exit 1; fi' | grep "/results/orders/query-7/cmd.txt file found" 2025-03-28 19:24:59,821 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 19:25:00,623 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 19:25:00,623 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:25:00,623 DEBUG --- stdout --- 2025-03-28 19:25:00,623 DEBUG /results/orders/query-7/cmd.txt file found 2025-03-28 19:25:00,624 DEBUG --- stderr --- 2025-03-28 19:25:00,624 DEBUG 2025-03-28 19:25:00,624 INFO 2025-03-28 19:25:00,624 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/query-7/cmd.txt 2025-03-28 19:25:01,516 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 19:25:01,516 DEBUG --- stdout --- 2025-03-28 19:25:01,517 DEBUG 4 /results/orders/query-7/cmd.txt 2025-03-28 19:25:01,517 DEBUG --- stderr --- 2025-03-28 19:25:01,517 DEBUG 2025-03-28 19:25:01,517 INFO - Download file (size 4k) source : /results/orders/query-7/cmd.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/cmd.txt 2025-03-28 19:25:01,518 INFO 2025-03-28 19:25:01,518 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/query-7/cmd.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/cmd.txt 2025-03-28 19:25:01,518 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 19:25:02,236 INFO [loop_until]: OK (rc = 0) 2025-03-28 19:25:02,236 DEBUG --- stdout --- 2025-03-28 19:25:02,236 DEBUG tar: Removing leading `/' from member names 2025-03-28 19:25:02,236 DEBUG --- stderr --- 2025-03-28 19:25:02,236 DEBUG 2025-03-28 19:25:02,236 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/cmd.txt is small (1 lines), printing all lines: 2025-03-28 19:25:02,236 INFO ----- output ----- /lodestar/lodestar.py perf run-gatling --simulation-class="com.forgerock.pyrock.Loadtest" --run-description="idm.ManagedUsersQueryPartial@perf-200m" --results-folder="/results/gatling/query-7" --no-reports --simulation-jvm-args="-XX:+ExitOnOutOfMemoryError -Xmx8G" --simulation-system-properties="-Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=M@ythe4th -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -DqueryStringLength=7 -Drealm=alpha -DtestCase=idm.ManagedUsersQueryPartial -DtestMode=open -Dthroughput=50 -Duser_password=T35!tr0c-k123" ________________________________________________________________________________ [2025-03-28 19:25:02] query-7 show_rc : Display rc order ________________________________________________________________________________ 2025-03-28 19:25:02,236 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/rc.txt is small (1 lines), printing all lines: 2025-03-28 19:25:02,236 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 19:25:02] query-7 show_stdout : Display stdout order ________________________________________________________________________________ 2025-03-28 19:25:02,236 DEBUG [print_head_tail]: Print head (100 lines) and tail (100 lines) of input file (/mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/stdout.txt is 2580 lines): 2025-03-28 19:25:02,237 INFO ----- output ----- 2025-03-28 19:14:34,760 DEBUG Creating results folder /results/gatling/query-7 2025-03-28 19:14:34,765 INFO pom.xml and Gatling Scala files copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmp_8kcvln_ 2025-03-28 19:14:34,768 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.simulationClass="com.forgerock.pyrock.Loadtest" -Dgatling.runDescription="..." -Dgatling.resultsFolder="/results/gatling/query-7" -Dgatling.noReports=true -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx8G" -Dgatling.propagateSystemProperties=true -Dam_host=openam-perf-200m.forgeblocks.com -Dam_oauth2_scope=openid^fr:idm:* -DamadminPassword=**** -DamadminUsername=xiaosong.lou@pingidentity.com -Dcsvfile=/results/idm/user_feeder.csv -Dduration=600 -Didc=true -Didm_host=openam-perf-200m.forgeblocks.com -Dlogin_cookie=15892ffd844ef80 -Dnum_users=50000000 -Doauth2_client_id=idmAdminClient -Doauth2_redirect_uri=/platform/appAuthHelperRedirect.html -DqueryStringLength=7 -Drealm=alpha -DtestCase=idm.ManagedUsersQueryPartial -DtestMode=open -Dthroughput=50 -Duser_password=**** [INFO] Scanning for projects... [INFO] [INFO] -----------< com.forgerock.pyrock:pyrock-gatling-simulation >----------- [INFO] Building pyrock-gatling-simulation 3.12.0 [INFO] from pom.xml [INFO] --------------------------------[ jar ]--------------------------------- [INFO] [INFO] >>> gatling:4.9.6:test (default-cli) > test-compile @ pyrock-gatling-simulation >>> [INFO] [INFO] --- resources:3.3.1:resources (default-resources) @ pyrock-gatling-simulation --- [INFO] skip non existing resourceDirectory /tmp/tmp_8kcvln_/src/main/resources [INFO] [INFO] --- compiler:3.13.0:compile (default-compile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- resources:3.3.1:testResources (default-testResources) @ pyrock-gatling-simulation --- [INFO] Copying 2 resources from src/test/resources to target/test-classes [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] Nothing to compile - all classes are up to date. [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compiling 38 Scala sources to /tmp/tmp_8kcvln_/target/test-classes ... [INFO] compile in 8.3 s [INFO] [INFO] <<< gatling:4.9.6:test (default-cli) < test-compile @ pyrock-gatling-simulation <<< [INFO] [INFO] [INFO] --- gatling:4.9.6:test (default-cli) @ pyrock-gatling-simulation --- [INFO] Running simulation com.forgerock.pyrock.Loadtest. Gatling 3.13.5 is available! (you're using 3.12.0) System property think_time_multiplier not set. No think time emulation will be done in the simulation. Set idVarName to id Simulation com.forgerock.pyrock.Loadtest started... ================================================================================ 2025-03-28 19:14:52 GMT 5s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=25 KO=0 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > queryPartial (OK=20 KO=0 ) ---- idm.ManagedUsersQueryPartial ---------------------------------------------- [ ] 0% waiting: 30486 / active: 0 / done: 20 ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ================================================================================ ================================================================================ 2025-03-28 19:14:57 GMT 10s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=88 KO=0 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > queryPartial (OK=83 KO=0 ) ---- idm.ManagedUsersQueryPartial ---------------------------------------------- [ ] 0% waiting: 30423 / active: 0 / done: 83 ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ================================================================================ ================================================================================ 2025-03-28 19:15:02 GMT 14s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=191 KO=0 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > queryPartial (OK=186 KO=0 ) ---- idm.ManagedUsersQueryPartial ---------------------------------------------- [- ] 0% waiting: 30319 / active: 1 / done: 186 ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ================================================================================ ================================================================================ 2025-03-28 19:15:07 GMT 19s elapsed [...] ---- idm.ManagedUsersQueryPartial ---------------------------------------------- [#####################################################################- ] 94% waiting: 1735 / active: 2 / done: 28769 ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ================================================================================ ================================================================================ 2025-03-28 19:24:47 GMT 599s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=29023 KO=1 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > queryPartial (OK=29018 KO=1 ) ---- Errors -------------------------------------------------------------------- > status.find.in(200), but actually found 503 1 (100.0%) ---- idm.ManagedUsersQueryPartial ---------------------------------------------- [######################################################################- ] 95% waiting: 1485 / active: 2 / done: 29019 ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ================================================================================ ================================================================================ 2025-03-28 19:24:47 GMT 600s elapsed ---- Requests ------------------------------------------------------------------ > Global (OK=29023 KO=1 ) > restLoginInitiate (OK=1 KO=0 ) > restLoginUsernamePasswordCallback (OK=1 KO=0 ) > Skip 2FA (OK=1 KO=0 ) > User Authorize PKCE stage (OK=1 KO=0 ) > User AccessToken PKCE stage (OK=1 KO=0 ) > queryPartial (OK=29018 KO=1 ) ---- Errors -------------------------------------------------------------------- > status.find.in(200), but actually found 503 1 (100.0%) ---- idm.ManagedUsersQueryPartial ---------------------------------------------- [######################################################################- ] 95% waiting: 1485 / active: 2 / done: 29019 ---- getToken ------------------------------------------------------------------ [--------------------------------------------------------------------------] 0% waiting: 0 / active: 1 / done: 0 ================================================================================ 19:24:47.443 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'queryPartial' failed for user 29021: j.i.IOException: Premature close 19:24:47.443 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - Request 'queryPartial' failed for user 29022: j.i.IOException: Premature close 19:24:47.443 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: queryPartial: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersQueryPartial,29022,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTczMzc0MCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJRZGNSN0hFMFktRlF3d0VTOVFfRDhmcnRMOFkiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTg5Mjg3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTg5Mjg3LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxOTI4ODcsImlhdCI6MTc0MzE4OTI4NywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidXdLZGVUSG5Vd2pTalFWbllWbkdPeFR5eTkwIn0.V18LCmDPwxQavM7jYvRFiBUI4VEWIFQvYnrW1J5EWqX3irjVOOWDtMFtjFvzpCSlHthSqyZROjP8PF-2aESu2GJ9i4JjMl8HuyFxlURAJLECf_6X91pfSiCtQWhFYCHvx0WfIvQeO3SCXUxbEuv4ImV7ZRxYgLbINv_RO4gD1f0TLATz3IUP-BKzNOHsxWf-R9BT00fWGa-vVdxhMLGVrJ2qCN_9tEXk4L9CzmUhazV13AuvQH2rofSQhychBiwtoDt8jHcNx9-Xofs56jnR_BN1_OuCjgAeJp4IZAQ7w7Z8m3sk1Bgrkc3QBq-lEdsmhTab7IaiZTM2ZBFC79S7Mg, username -> user.94352785, tokenIdCookieName -> 15892ffd844ef80, QueryFilterValue -> Buwxvva, id -> 0009793c-3a64-40d4-91dd-b1e8fa38bd40, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@5f5128f0, givenname -> Drago, tokenId -> naozoJcjnmmNXxmhVTPRVGhjIm0.*AAJTSQACMDIAAlNLABxSOS9uWEFGajVpUDBiNVdZRzhMOGh6cmtFdTQ9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Felfli, challenge -> ya_y2ydgDmXLczOJgo581HwYac7wh2ONp9Ih4dDk3jE, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.94352785@example.com, verifier -> NzY2NTIzNDk2Nzg1NzM1MzE3MQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@22c48d7b),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$825/0x000079e69869bfd8@10ee0ac4,io.netty.channel.epoll.EpollEventLoop@4f2c9ba6) ========================= HTTP request: GET https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/?_queryFilter=sn+co+%27Buwxvva%27&_fields=*&_pageSize=1000 headers: user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Content-Type: application/json Authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTczMzc0MCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJRZGNSN0hFMFktRlF3d0VTOVFfRDhmcnRMOFkiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTg5Mjg3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTg5Mjg3LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxOTI4ODcsImlhdCI6MTc0MzE4OTI4NywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidXdLZGVUSG5Vd2pTalFWbllWbkdPeFR5eTkwIn0.V18LCmDPwxQavM7jYvRFiBUI4VEWIFQvYnrW1J5EWqX3irjVOOWDtMFtjFvzpCSlHthSqyZROjP8PF-2aESu2GJ9i4JjMl8HuyFxlURAJLECf_6X91pfSiCtQWhFYCHvx0WfIvQeO3SCXUxbEuv4ImV7ZRxYgLbINv_RO4gD1f0TLATz3IUP-BKzNOHsxWf-R9BT00fWGa-vVdxhMLGVrJ2qCN_9tEXk4L9CzmUhazV13AuvQH2rofSQhychBiwtoDt8jHcNx9-Xofs56jnR_BN1_OuCjgAeJp4IZAQ7w7Z8m3sk1Bgrkc3QBq-lEdsmhTab7IaiZTM2ZBFC79S7Mg accept: */* host: openam-perf-200m.forgeblocks.com ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< 19:24:47.443 [DEBUG] i.g.h.e.r.DefaultStatsProcessor - >>>>>>>>>>>>>>>>>>>>>>>>>> Request: queryPartial: KO j.i.IOException: Premature close ========================= Session: Session(idm.ManagedUsersQueryPartial,29021,HashMap(access_token -> eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTczMzc0MCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJRZGNSN0hFMFktRlF3d0VTOVFfRDhmcnRMOFkiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTg5Mjg3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTg5Mjg3LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxOTI4ODcsImlhdCI6MTc0MzE4OTI4NywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidXdLZGVUSG5Vd2pTalFWbllWbkdPeFR5eTkwIn0.V18LCmDPwxQavM7jYvRFiBUI4VEWIFQvYnrW1J5EWqX3irjVOOWDtMFtjFvzpCSlHthSqyZROjP8PF-2aESu2GJ9i4JjMl8HuyFxlURAJLECf_6X91pfSiCtQWhFYCHvx0WfIvQeO3SCXUxbEuv4ImV7ZRxYgLbINv_RO4gD1f0TLATz3IUP-BKzNOHsxWf-R9BT00fWGa-vVdxhMLGVrJ2qCN_9tEXk4L9CzmUhazV13AuvQH2rofSQhychBiwtoDt8jHcNx9-Xofs56jnR_BN1_OuCjgAeJp4IZAQ7w7Z8m3sk1Bgrkc3QBq-lEdsmhTab7IaiZTM2ZBFC79S7Mg, username -> user.46039009, tokenIdCookieName -> 15892ffd844ef80, QueryFilterValue -> Yljwakc, id -> 00097942-65af-43ae-902a-2b0ac0881817, gatling.http.ssl.sslContexts -> io.gatling.http.util.SslContexts@3626d31e, givenname -> Rank, tokenId -> naozoJcjnmmNXxmhVTPRVGhjIm0.*AAJTSQACMDIAAlNLABxSOS9uWEFGajVpUDBiNVdZRzhMOGh6cmtFdTQ9AAR0eXBlAANDVFMAAlMxAAIwMQ..*, familyname -> Tandberg, challenge -> ya_y2ydgDmXLczOJgo581HwYac7wh2ONp9Ih4dDk3jE, gatling.http.cache.baseUrl -> https://openam-perf-200m.forgeblocks.com:443, email -> user.46039009@example.com, verifier -> NzY2NTIzNDk2Nzg1NzM1MzE3MQ, gatling.http.cache.dns -> io.gatling.http.resolver.ShufflingNameResolver@2decc29),KO,List(),io.gatling.core.protocol.ProtocolComponentsRegistry$$Lambda$825/0x000079e69869bfd8@10ee0ac4,io.netty.channel.epoll.EpollEventLoop@1e1d3956) ========================= HTTP request: GET https://openam-perf-200m.forgeblocks.com/openidm/managed/alpha_user/?_queryFilter=sn+co+%27Yljwakc%27&_fields=*&_pageSize=1000 headers: user-agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 12_5_1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Content-Type: application/json Authorization: Bearer eyJ0eXAiOiJKV1QiLCJraWQiOiJ1QVQ1a1VCbnhzUmZLblRwNUw4bDFpNkdyRkU9IiwiYWxnIjoiUlMyNTYifQ.eyJzdWIiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJjdHMiOiJPQVVUSDJfU1RBVEVMRVNTX0dSQU5UIiwiYXV0aF9sZXZlbCI6MCwiYXVkaXRUcmFja2luZ0lkIjoiYjhmYTc4NjgtNjFiZi00NDY3LWE3ZjktMWU4YTIzYzZjN2FmLTczMzc0MCIsInN1Ym5hbWUiOiJjNDI0ZjVmZC0zNjJlLTQzOTctYTg3NC0xYzIzMWU5M2UwZGMiLCJpc3MiOiJodHRwczovL29wZW5hbS1wZXJmLTIwMG0uZm9yZ2VibG9ja3MuY29tOjQ0My9hbS9vYXV0aDIiLCJ0b2tlbk5hbWUiOiJhY2Nlc3NfdG9rZW4iLCJ0b2tlbl90eXBlIjoiQmVhcmVyIiwiYXV0aEdyYW50SWQiOiJRZGNSN0hFMFktRlF3d0VTOVFfRDhmcnRMOFkiLCJub25jZSI6IjEyMzQiLCJjbGllbnRfaWQiOiJpZG1BZG1pbkNsaWVudCIsImF1ZCI6ImlkbUFkbWluQ2xpZW50IiwibmJmIjoxNzQzMTg5Mjg3LCJncmFudF90eXBlIjoiYXV0aG9yaXphdGlvbl9jb2RlIiwic2NvcGUiOlsib3BlbmlkIiwiZnI6aWRtOioiXSwiYXV0aF90aW1lIjoxNzQzMTg5Mjg3LCJyZWFsbSI6Ii8iLCJleHAiOjE3NDMxOTI4ODcsImlhdCI6MTc0MzE4OTI4NywiZXhwaXJlc19pbiI6MzYwMCwianRpIjoidXdLZGVUSG5Vd2pTalFWbllWbkdPeFR5eTkwIn0.V18LCmDPwxQavM7jYvRFiBUI4VEWIFQvYnrW1J5EWqX3irjVOOWDtMFtjFvzpCSlHthSqyZROjP8PF-2aESu2GJ9i4JjMl8HuyFxlURAJLECf_6X91pfSiCtQWhFYCHvx0WfIvQeO3SCXUxbEuv4ImV7ZRxYgLbINv_RO4gD1f0TLATz3IUP-BKzNOHsxWf-R9BT00fWGa-vVdxhMLGVrJ2qCN_9tEXk4L9CzmUhazV13AuvQH2rofSQhychBiwtoDt8jHcNx9-Xofs56jnR_BN1_OuCjgAeJp4IZAQ7w7Z8m3sk1Bgrkc3QBq-lEdsmhTab7IaiZTM2ZBFC79S7Mg accept: */* host: openam-perf-200m.forgeblocks.com ========================= HTTP response: <<<<<<<<<<<<<<<<<<<<<<<<< [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 10:11 min [INFO] Finished at: 2025-03-28T19:24:47Z [INFO] ------------------------------------------------------------------------ 2025-03-28 19:24:47,506 INFO Gatling simulation run ended successfully 2025-03-28 19:24:47,506 DEBUG No archive name provided. No archive will be created ________________________________________________________________________________ [2025-03-28 19:25:02] query-7 show_stderr : Display stderr order ________________________________________________________________________________ 2025-03-28 19:25:02,237 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/04_query-7/stderr.txt is small (0 lines), printing all lines: 2025-03-28 19:25:02,237 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 19:25:02] query-7 check_rc_and_logs : Check order's outputs ________________________________________________________________________________ CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) PASS: no error found in rc log PASS: no error found in stdout log PASS: no error found in stderr log ________________________________________________________________________________ [2025-03-28 19:25:02] query-7 print_overseer_logs : Print overseer logs from the K8s pod ________________________________________________________________________________ Task result is INIT no need to display logs. ________________________________________________________________________________ [2025-03-28 19:25:02] query-7 post : Post ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped