--Task-- name: Reporting-mixedquery-8000 enabled: True class_name: GatlingResultTask source_name: overseer-0 source_namespace: >default< target_name: overseer-0 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: ['Logs-parse-mixedquery-1000', 'Logs-parse-mixedquery-2000', 'Logs-parse-mixedquery-4000', 'Logs-parse-mixedquery-6000', 'Logs-parse-mixedquery-8000', 'Logs-parse-mixedquery-10000', 'Reporting-mixedquery-1000', 'Reporting-mixedquery-2000', 'Reporting-mixedquery-4000', 'Reporting-mixedquery-6000'] preceding_task: None options: {'task_name': 'mixedquery-8000'} group_name: None Current dir: /mnt/disk1/xslou/workshop/lodestar-fork/pyrock source (overseer-0) is a component 2025-03-28 01:44:11 - INFO: Timeout for this Task has changed to 3h 30m (12600 seconds) 2025-03-28 01:44:11 - INFO: timeout was set to GatlingResultTask default (half of global_duration or 3600 seconds (whatever is higher)), because it was unset Pod stdout file : /results/orders/Reporting-mixedquery-8000/stdout.txt Pod stderr file : /results/orders/Reporting-mixedquery-8000/stderr.txt Pod log : /results/orders/Reporting-mixedquery-8000 ________________________________________________________________________________ [2025-03-28 01:44:11] Reporting-mixedquery-8000 step1 : Write order for overseer to generate the report ________________________________________________________________________________ Order file: /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/order.json { "name": "Reporting-mixedquery-8000", "command": " /lodestar/lodestar.py perf run-gatling --reports-only=\"/results/gatling/mixedquery-8000\" --simulation-jvm-args=\"-XX:+ExitOnOutOfMemoryError -Xmx8G\" --archive-name=\"mixedquery-8000.tar.gz\"", "out-dir": "/results/orders/Reporting-mixedquery-8000" } ________________________________________________________________________________ [2025-03-28 01:44:11] Reporting-mixedquery-8000 step2 : Make sure overseer is ready to accept order (not already busy) ________________________________________________________________________________ 2025-03-28 01:44:11,370 INFO 2025-03-28 01:44:11,370 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 01:44:11,370 INFO [loop_until]: (max_time=120, interval=5, expected_rc=[0] 2025-03-28 01:44:11,585 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 01:44:11,585 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:44:11,585 DEBUG --- stdout --- 2025-03-28 01:44:11,585 DEBUG WAITING 2025-03-28 01:44:11,585 DEBUG --- stderr --- 2025-03-28 01:44:11,585 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2025-03-28 01:44:11] Reporting-mixedquery-8000 step3 : Send order to overseer ________________________________________________________________________________ 2025-03-28 01:44:11,586 INFO 2025-03-28 01:44:11,586 INFO [loop_until]: awk -F" " "{print NF}" <<< `kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm get pods --selector app=overseer-0 --output jsonpath={.items[*].metadata.name}` | grep 1 2025-03-28 01:44:11,586 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 01:44:11,868 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 01:44:11,868 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:44:11,869 DEBUG --- stdout --- 2025-03-28 01:44:11,869 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 01:44:11,869 DEBUG --- stderr --- 2025-03-28 01:44:11,869 DEBUG 2025-03-28 01:44:11,869 INFO 2025-03-28 01:44:11,870 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/08_Verification/12_Reporting-mixedquery-8000/order.json overseer-0-59c948f569-rgrkv:/results/orders/order.json 2025-03-28 01:44:11,870 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 01:44:13,235 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:44:13,235 DEBUG --- stdout --- 2025-03-28 01:44:13,236 DEBUG 2025-03-28 01:44:13,236 DEBUG --- stderr --- 2025-03-28 01:44:13,236 DEBUG Order has been successfully forwarded to overseer ________________________________________________________________________________ [2025-03-28 01:44:13] Reporting-mixedquery-8000 step4 : Wait order is done ________________________________________________________________________________ Workaround for PERF-1966. Sleeping for 5 seconds. 2025-03-28 01:44:18,236 INFO 2025-03-28 01:44:18,236 INFO [loop_until]: curl --insecure https://overseer-0.xlou.iam.xlou-cdm.engineeringpit.com/orders/status.txt | grep "WAITING" 2025-03-28 01:44:18,236 INFO [loop_until]: (max_time=12600, interval=5, expected_rc=[0] 2025-03-28 01:44:18,452 INFO [loop_until]: Function succeeded after 0s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:44:23,667 INFO [loop_until]: Function succeeded after 5s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:44:28,882 INFO [loop_until]: Function succeeded after 10s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:44:34,100 INFO [loop_until]: Function succeeded after 15s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:44:39,315 INFO [loop_until]: Function succeeded after 21s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:44:44,529 INFO [loop_until]: Function succeeded after 26s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:44:49,744 INFO [loop_until]: Function succeeded after 31s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:44:54,959 INFO [loop_until]: Function succeeded after 36s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:00,174 INFO [loop_until]: Function succeeded after 41s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:05,392 INFO [loop_until]: Function succeeded after 47s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:10,661 INFO [loop_until]: Function succeeded after 52s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:15,876 INFO [loop_until]: Function succeeded after 57s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:21,091 INFO [loop_until]: Function succeeded after 1m 02s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:26,306 INFO [loop_until]: Function succeeded after 1m 08s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:31,521 INFO [loop_until]: Function succeeded after 1m 13s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:36,736 INFO [loop_until]: Function succeeded after 1m 18s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:42,005 INFO [loop_until]: Function succeeded after 1m 23s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:47,221 INFO [loop_until]: Function succeeded after 1m 28s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:52,504 INFO [loop_until]: Function succeeded after 1m 34s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:45:57,719 INFO [loop_until]: Function succeeded after 1m 39s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:02,934 INFO [loop_until]: Function succeeded after 1m 44s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:08,149 INFO [loop_until]: Function succeeded after 1m 49s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:13,417 INFO [loop_until]: Function succeeded after 1m 55s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:18,631 INFO [loop_until]: Function succeeded after 2m (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:23,846 INFO [loop_until]: Function succeeded after 2m 05s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:29,061 INFO [loop_until]: Function succeeded after 2m 10s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:34,276 INFO [loop_until]: Function succeeded after 2m 16s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:39,490 INFO [loop_until]: Function succeeded after 2m 21s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:44,708 INFO [loop_until]: Function succeeded after 2m 26s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:49,926 INFO [loop_until]: Function succeeded after 2m 31s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:46:55,141 INFO [loop_until]: Function succeeded after 2m 36s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:00,355 INFO [loop_until]: Function succeeded after 2m 42s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:05,571 INFO [loop_until]: Function succeeded after 2m 47s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:10,786 INFO [loop_until]: Function succeeded after 2m 52s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:16,002 INFO [loop_until]: Function succeeded after 2m 57s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:21,220 INFO [loop_until]: Function succeeded after 3m 02s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:26,435 INFO [loop_until]: Function succeeded after 3m 08s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:31,650 INFO [loop_until]: Function succeeded after 3m 13s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:36,864 INFO [loop_until]: Function succeeded after 3m 18s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:42,079 INFO [loop_until]: Function succeeded after 3m 23s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:47,294 INFO [loop_until]: Function succeeded after 3m 29s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:52,605 INFO [loop_until]: Function succeeded after 3m 34s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:47:57,820 INFO [loop_until]: Function succeeded after 3m 39s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:03,035 INFO [loop_until]: Function succeeded after 3m 44s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:08,250 INFO [loop_until]: Function succeeded after 3m 50s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:13,465 INFO [loop_until]: Function succeeded after 3m 55s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:18,680 INFO [loop_until]: Function succeeded after 4m (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:23,951 INFO [loop_until]: Function succeeded after 4m 05s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:29,165 INFO [loop_until]: Function succeeded after 4m 10s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:34,380 INFO [loop_until]: Function succeeded after 4m 16s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:39,595 INFO [loop_until]: Function succeeded after 4m 21s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:44,814 INFO [loop_until]: Function succeeded after 4m 26s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:50,029 INFO [loop_until]: Function succeeded after 4m 31s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:48:55,288 INFO [loop_until]: Function succeeded after 4m 37s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:00,503 INFO [loop_until]: Function succeeded after 4m 42s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:05,717 INFO [loop_until]: Function succeeded after 4m 47s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:10,934 INFO [loop_until]: Function succeeded after 4m 52s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:16,148 INFO [loop_until]: Function succeeded after 4m 57s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:21,364 INFO [loop_until]: Function succeeded after 5m 03s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:26,632 INFO [loop_until]: Function succeeded after 5m 08s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:31,847 INFO [loop_until]: Function succeeded after 5m 13s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:37,061 INFO [loop_until]: Function succeeded after 5m 18s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:42,276 INFO [loop_until]: Function succeeded after 5m 24s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:47,490 INFO [loop_until]: Function succeeded after 5m 29s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:52,706 INFO [loop_until]: Function succeeded after 5m 34s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:49:57,923 INFO [loop_until]: Function succeeded after 5m 39s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:03,191 INFO [loop_until]: Function succeeded after 5m 44s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:08,406 INFO [loop_until]: Function succeeded after 5m 50s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:13,621 INFO [loop_until]: Function succeeded after 5m 55s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:18,836 INFO [loop_until]: Function succeeded after 6m (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:24,051 INFO [loop_until]: Function succeeded after 6m 05s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:29,265 INFO [loop_until]: Function succeeded after 6m 11s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:34,533 INFO [loop_until]: Function succeeded after 6m 16s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:39,749 INFO [loop_until]: Function succeeded after 6m 21s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:44,964 INFO [loop_until]: Function succeeded after 6m 26s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:50,180 INFO [loop_until]: Function succeeded after 6m 31s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:50:55,464 INFO [loop_until]: Function succeeded after 6m 37s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:00,678 INFO [loop_until]: Function succeeded after 6m 42s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:05,947 INFO [loop_until]: Function succeeded after 6m 47s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:11,161 INFO [loop_until]: Function succeeded after 6m 52s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:16,377 INFO [loop_until]: Function succeeded after 6m 58s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:21,592 INFO [loop_until]: Function succeeded after 7m 03s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:26,806 INFO [loop_until]: Function succeeded after 7m 08s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:32,021 INFO [loop_until]: Function succeeded after 7m 13s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:37,239 INFO [loop_until]: Function succeeded after 7m 19s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:42,523 INFO [loop_until]: Function succeeded after 7m 24s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:47,738 INFO [loop_until]: Function succeeded after 7m 29s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:52,953 INFO [loop_until]: Function succeeded after 7m 34s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:51:58,167 INFO [loop_until]: Function succeeded after 7m 39s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:03,383 INFO [loop_until]: Function succeeded after 7m 45s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:08,601 INFO [loop_until]: Function succeeded after 7m 50s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:13,818 INFO [loop_until]: Function succeeded after 7m 55s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:19,033 INFO [loop_until]: Function succeeded after 8m (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:24,248 INFO [loop_until]: Function succeeded after 8m 06s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:29,463 INFO [loop_until]: Function succeeded after 8m 11s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:34,678 INFO [loop_until]: Function succeeded after 8m 16s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:39,895 INFO [loop_until]: Function succeeded after 8m 21s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:45,178 INFO [loop_until]: Function succeeded after 8m 26s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:50,394 INFO [loop_until]: Function succeeded after 8m 32s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:52:55,608 INFO [loop_until]: Function succeeded after 8m 37s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:00,824 INFO [loop_until]: Function succeeded after 8m 42s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:06,039 INFO [loop_until]: Function succeeded after 8m 47s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:11,254 INFO [loop_until]: Function succeeded after 8m 53s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:16,539 INFO [loop_until]: Function succeeded after 8m 58s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:21,754 INFO [loop_until]: Function succeeded after 9m 03s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:26,969 INFO [loop_until]: Function succeeded after 9m 08s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:32,184 INFO [loop_until]: Function succeeded after 9m 13s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:37,399 INFO [loop_until]: Function succeeded after 9m 19s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:42,613 INFO [loop_until]: Function succeeded after 9m 24s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:47,830 INFO [loop_until]: Function succeeded after 9m 29s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:53,088 INFO [loop_until]: Function succeeded after 9m 34s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:53:58,303 INFO [loop_until]: Function succeeded after 9m 40s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:03,519 INFO [loop_until]: Function succeeded after 9m 45s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:08,734 INFO [loop_until]: Function succeeded after 9m 50s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:13,950 INFO [loop_until]: Function succeeded after 9m 55s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:19,165 INFO [loop_until]: Function succeeded after 10m (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:24,474 INFO [loop_until]: Function succeeded after 10m 06s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:29,690 INFO [loop_until]: Function succeeded after 10m 11s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:34,906 INFO [loop_until]: Function succeeded after 10m 16s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:40,120 INFO [loop_until]: Function succeeded after 10m 21s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:45,335 INFO [loop_until]: Function succeeded after 10m 27s (rc=0) - failed to find expected output: WAITING - retry 2025-03-28 01:54:50,551 INFO [loop_until]: Function succeeded after 10m 32s (rc=0) - expected pattern found 2025-03-28 01:54:50,551 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:50,551 DEBUG --- stdout --- 2025-03-28 01:54:50,551 DEBUG WAITING 2025-03-28 01:54:50,551 DEBUG --- stderr --- 2025-03-28 01:54:50,551 DEBUG % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7 100 7 0 0 33 0 --:--:-- --:--:-- --:--:-- 33 ________________________________________________________________________________ [2025-03-28 01:54:50] Reporting-mixedquery-8000 step5 : Wait until gatling report is generated on overseer ________________________________________________________________________________ 2025-03-28 01:54:50,552 INFO 2025-03-28 01:54:50,552 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 01:54:50,552 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 01:54:50,863 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 01:54:50,863 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:50,863 DEBUG --- stdout --- 2025-03-28 01:54:50,863 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 01:54:50,863 DEBUG --- stderr --- 2025-03-28 01:54:50,863 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 01:54:50,864 INFO 2025-03-28 01:54:50,864 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/gatling/mixedquery-8000/mixedquery-8000.tar.gz" ]; then echo "/results/gatling/mixedquery-8000/mixedquery-8000.tar.gz file found"; exit 0; else echo "/results/gatling/mixedquery-8000/mixedquery-8000.tar.gz file not found"; exit 1; fi' | grep "/results/gatling/mixedquery-8000/mixedquery-8000.tar.gz file found" 2025-03-28 01:54:50,864 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 01:54:51,723 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 01:54:51,724 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:51,724 DEBUG --- stdout --- 2025-03-28 01:54:51,724 DEBUG /results/gatling/mixedquery-8000/mixedquery-8000.tar.gz file found 2025-03-28 01:54:51,724 DEBUG --- stderr --- 2025-03-28 01:54:51,724 DEBUG 2025-03-28 01:54:51,724 INFO 2025-03-28 01:54:51,724 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/gatling/mixedquery-8000/mixedquery-8000.tar.gz 2025-03-28 01:54:52,531 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 01:54:52,531 DEBUG --- stdout --- 2025-03-28 01:54:52,531 DEBUG 320 /results/gatling/mixedquery-8000/mixedquery-8000.tar.gz 2025-03-28 01:54:52,531 DEBUG --- stderr --- 2025-03-28 01:54:52,531 DEBUG 2025-03-28 01:54:52,531 INFO - Download file (size 320k) source : /results/gatling/mixedquery-8000/mixedquery-8000.tar.gz @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/mixedquery-8000.tar.gz 2025-03-28 01:54:52,532 INFO 2025-03-28 01:54:52,532 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/gatling/mixedquery-8000/mixedquery-8000.tar.gz /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/mixedquery-8000.tar.gz 2025-03-28 01:54:52,532 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 01:54:53,527 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:53,527 DEBUG --- stdout --- 2025-03-28 01:54:53,527 DEBUG tar: Removing leading `/' from member names 2025-03-28 01:54:53,527 DEBUG --- stderr --- 2025-03-28 01:54:53,527 DEBUG ________________________________________________________________________________ [2025-03-28 01:54:53] Reporting-mixedquery-8000 step6 : Unzip the result ________________________________________________________________________________ 2025-03-28 01:54:53,527 INFO 2025-03-28 01:54:53,528 INFO [run_command]: tar zxf /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/shared/mixedquery-8000.tar.gz -C /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/05_mixedquery-8000/gatling 2025-03-28 01:54:53,543 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 01:54:53,543 DEBUG --- stdout --- 2025-03-28 01:54:53,543 DEBUG 2025-03-28 01:54:53,543 DEBUG --- stderr --- 2025-03-28 01:54:53,543 DEBUG 2025-03-28 01:54:53,543 INFO ________________________________________________________________________________ [2025-03-28 01:54:53] Reporting-mixedquery-8000 step7 : Print rc order ________________________________________________________________________________ 2025-03-28 01:54:53,544 INFO 2025-03-28 01:54:53,544 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 01:54:53,544 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 01:54:53,821 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 01:54:53,821 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:53,821 DEBUG --- stdout --- 2025-03-28 01:54:53,821 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 01:54:53,821 DEBUG --- stderr --- 2025-03-28 01:54:53,821 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 01:54:53,822 INFO 2025-03-28 01:54:53,822 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/Reporting-mixedquery-8000/rc.txt" ]; then echo "/results/orders/Reporting-mixedquery-8000/rc.txt file found"; exit 0; else echo "/results/orders/Reporting-mixedquery-8000/rc.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-mixedquery-8000/rc.txt file found" 2025-03-28 01:54:53,822 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 01:54:54,616 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 01:54:54,616 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:54,616 DEBUG --- stdout --- 2025-03-28 01:54:54,616 DEBUG /results/orders/Reporting-mixedquery-8000/rc.txt file found 2025-03-28 01:54:54,616 DEBUG --- stderr --- 2025-03-28 01:54:54,616 DEBUG 2025-03-28 01:54:54,617 INFO 2025-03-28 01:54:54,617 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/Reporting-mixedquery-8000/rc.txt 2025-03-28 01:54:55,506 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 01:54:55,506 DEBUG --- stdout --- 2025-03-28 01:54:55,506 DEBUG 4 /results/orders/Reporting-mixedquery-8000/rc.txt 2025-03-28 01:54:55,506 DEBUG --- stderr --- 2025-03-28 01:54:55,506 DEBUG 2025-03-28 01:54:55,506 INFO - Download file (size 4k) source : /results/orders/Reporting-mixedquery-8000/rc.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/rc.txt 2025-03-28 01:54:55,507 INFO 2025-03-28 01:54:55,507 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-mixedquery-8000/rc.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/rc.txt 2025-03-28 01:54:55,507 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 01:54:56,239 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:56,239 DEBUG --- stdout --- 2025-03-28 01:54:56,239 DEBUG tar: Removing leading `/' from member names 2025-03-28 01:54:56,239 DEBUG --- stderr --- 2025-03-28 01:54:56,239 DEBUG 2025-03-28 01:54:56,239 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/rc.txt is small (1 lines), printing all lines: 2025-03-28 01:54:56,239 INFO ----- output ----- CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) ________________________________________________________________________________ [2025-03-28 01:54:56] Reporting-mixedquery-8000 step8 : Check rc log ________________________________________________________________________________ CMD SUCCESS: command returns code 0 (expected [0, -9, 143, 137, -15]) PASS: no error found in rc log ________________________________________________________________________________ [2025-03-28 01:54:56] Reporting-mixedquery-8000 step9 : Print stdout order ________________________________________________________________________________ 2025-03-28 01:54:56,481 INFO 2025-03-28 01:54:56,481 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 01:54:56,481 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 01:54:56,762 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 01:54:56,762 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:56,762 DEBUG --- stdout --- 2025-03-28 01:54:56,762 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 01:54:56,762 DEBUG --- stderr --- 2025-03-28 01:54:56,762 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 01:54:56,763 INFO 2025-03-28 01:54:56,763 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/Reporting-mixedquery-8000/stdout.txt" ]; then echo "/results/orders/Reporting-mixedquery-8000/stdout.txt file found"; exit 0; else echo "/results/orders/Reporting-mixedquery-8000/stdout.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-mixedquery-8000/stdout.txt file found" 2025-03-28 01:54:56,764 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 01:54:57,570 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 01:54:57,570 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:57,570 DEBUG --- stdout --- 2025-03-28 01:54:57,570 DEBUG /results/orders/Reporting-mixedquery-8000/stdout.txt file found 2025-03-28 01:54:57,570 DEBUG --- stderr --- 2025-03-28 01:54:57,570 DEBUG 2025-03-28 01:54:57,570 INFO 2025-03-28 01:54:57,571 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/Reporting-mixedquery-8000/stdout.txt 2025-03-28 01:54:58,375 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 01:54:58,375 DEBUG --- stdout --- 2025-03-28 01:54:58,375 DEBUG 8 /results/orders/Reporting-mixedquery-8000/stdout.txt 2025-03-28 01:54:58,375 DEBUG --- stderr --- 2025-03-28 01:54:58,375 DEBUG 2025-03-28 01:54:58,375 INFO - Download file (size 8k) source : /results/orders/Reporting-mixedquery-8000/stdout.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/stdout.txt 2025-03-28 01:54:58,376 INFO 2025-03-28 01:54:58,376 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-mixedquery-8000/stdout.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/stdout.txt 2025-03-28 01:54:58,376 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 01:54:59,101 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:59,101 DEBUG --- stdout --- 2025-03-28 01:54:59,101 DEBUG tar: Removing leading `/' from member names 2025-03-28 01:54:59,101 DEBUG --- stderr --- 2025-03-28 01:54:59,101 DEBUG 2025-03-28 01:54:59,101 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/stdout.txt is small (93 lines), printing all lines: 2025-03-28 01:54:59,101 INFO ----- output ----- 2025-03-28 01:44:14,194 INFO pom.xml copied from /home/jenkins/lodestar/pyrock/shared/clients/gatling to temporary folder /tmp/tmpo67keutf 2025-03-28 01:44:14,196 INFO Running Gatling simulation with command: mvn gatling:test --batch-mode -Dgatling.reportsOnly="/results/gatling/mixedquery-8000/loadtest-20250328002312276" -Dgatling.jvmArgs="-XX:+ExitOnOutOfMemoryError,-Xmx8G" [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/tmpo67keutf/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] skip non existing resourceDirectory /tmp/tmpo67keutf/src/test/resources [INFO] [INFO] --- compiler:3.13.0:testCompile (default-testCompile) @ pyrock-gatling-simulation --- [INFO] No sources to compile [INFO] [INFO] --- scala:4.9.2:testCompile (default) @ pyrock-gatling-simulation --- [INFO] compile in 0.0 s [INFO] No sources to compile [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 --- 01:44:16,064 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.8 01:44:16,065 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - No custom configurators were discovered as a service. 01:44:16,065 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 01:44:16,066 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 01:44:16,071 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 01:44:16,072 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 01:44:16,079 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 6 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 01:44:16,079 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 01:44:16,079 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 01:44:16,080 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 01:44:16,083 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/home/jenkins/.m2/repository/io/gatling/gatling-maven-plugin/4.9.6/gatling-maven-plugin-4.9.6.jar!/logback.xml] 01:44:16,087 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@240237d2 - URL [jar:file:/home/jenkins/.m2/repository/io/gatling/gatling-maven-plugin/4.9.6/gatling-maven-plugin-4.9.6.jar!/logback.xml] is not of type file 01:44:16,132 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - element is deprecated. Near [level] on line 12 01:44:16,132 |-WARN in ch.qos.logback.classic.joran.action.LevelAction - Please use "level" attribute within or elements instead. 01:44:16,171 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [CONSOLE] 01:44:16,171 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 01:44:16,178 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 01:44:16,199 |-INFO in ch.qos.logback.classic.model.processor.LevelModelHandler - ROOT level set to WARN 01:44:16,199 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [CONSOLE] to Logger[ROOT] 01:44:16,199 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@25a65b77 - End of configuration. 01:44:16,200 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2ed0fbae - Registering current configuration as safe fallback point 01:44:16,200 |-INFO in ch.qos.logback.classic.util.ContextInitializer@12d3a4e9 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 121 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY Parsing log file(s)... Parsing log file(s) done in 629s. Generating reports... ================================================================================ ---- Global Information -------------------------------------------------------- > request count 14278100 (OK=14278089 KO=11 ) > min response time 39 (OK=39 KO=10000 ) > max response time 60000 (OK=13694 KO=60000 ) > mean response time 47 (OK=47 KO=19092 ) > std deviation 46 (OK=39 KO=19284 ) > response time 50th percentile 46 (OK=46 KO=10001 ) > response time 75th percentile 48 (OK=48 KO=10004 ) > response time 95th percentile 51 (OK=51 KO=60000 ) > response time 99th percentile 57 (OK=57 KO=60000 ) > mean requests/sec 7932.28 (OK=7932.27 KO=0.01 ) ---- Response Time Distribution ------------------------------------------------ > t < 800 ms 14272595 ( 99.96%) > 800 ms <= t < 1200 ms 1406 ( 0.01%) > t >= 1200 ms 4088 ( 0.03%) > failed 11 ( 0%) ---- Errors -------------------------------------------------------------------- > i.n.h.s.SslHandshakeTimeoutException: handshake timed out afte 8 (72.73%) r 10000ms > Request timeout to openam-perf-200m.forgeblocks.com/34.107.203 2 (18.18%) .37:443 after 60000 ms > j.i.IOException: Premature close 1 ( 9.09%) ================================================================================ Reports generated, please open the following file: file:///results/gatling/mixedquery-8000/loadtest-20250328002312276/index.html [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 10:31 min [INFO] Finished at: 2025-03-28T01:54:47Z [INFO] ------------------------------------------------------------------------ 2025-03-28 01:54:47,092 INFO Gatling simulation run ended successfully 2025-03-28 01:54:47,093 INFO Creating archive mixedquery-8000.tar.gz with report files 2025-03-28 01:54:47,191 INFO Archive /results/gatling/mixedquery-8000/mixedquery-8000.tar.gz successfully created ________________________________________________________________________________ [2025-03-28 01:54:59] Reporting-mixedquery-8000 step10 : Check stdout log and parse its content ________________________________________________________________________________ PASS: no error found in stdout log ________________________________________________________________________________ [2025-03-28 01:54:59] Reporting-mixedquery-8000 step11 : Print stderr order ________________________________________________________________________________ 2025-03-28 01:54:59,102 INFO 2025-03-28 01:54:59,102 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 01:54:59,102 INFO [loop_until]: (max_time=180, interval=10, expected_rc=[0] 2025-03-28 01:54:59,382 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected number of elements found 2025-03-28 01:54:59,382 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:54:59,382 DEBUG --- stdout --- 2025-03-28 01:54:59,382 DEBUG overseer-0-59c948f569-rgrkv 2025-03-28 01:54:59,382 DEBUG --- stderr --- 2025-03-28 01:54:59,382 DEBUG Checking pod: overseer-0-59c948f569-rgrkv for file exists, if not wait. 2025-03-28 01:54:59,383 INFO 2025-03-28 01:54:59,383 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/Reporting-mixedquery-8000/stderr.txt" ]; then echo "/results/orders/Reporting-mixedquery-8000/stderr.txt file found"; exit 0; else echo "/results/orders/Reporting-mixedquery-8000/stderr.txt file not found"; exit 1; fi' | grep "/results/orders/Reporting-mixedquery-8000/stderr.txt file found" 2025-03-28 01:54:59,383 INFO [loop_until]: (max_time=180, interval=5, expected_rc=[0] 2025-03-28 01:55:00,181 INFO [loop_until]: Function succeeded after 0s (rc=0) - expected pattern found 2025-03-28 01:55:00,181 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:55:00,181 DEBUG --- stdout --- 2025-03-28 01:55:00,181 DEBUG /results/orders/Reporting-mixedquery-8000/stderr.txt file found 2025-03-28 01:55:00,181 DEBUG --- stderr --- 2025-03-28 01:55:00,181 DEBUG 2025-03-28 01:55:00,181 INFO 2025-03-28 01:55:00,182 INFO [run_command]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm exec overseer-0-59c948f569-rgrkv --stdin -- du -k /results/orders/Reporting-mixedquery-8000/stderr.txt 2025-03-28 01:55:00,979 INFO [run_command]: OK (rc = 0 - expected to be in [0]) 2025-03-28 01:55:00,979 DEBUG --- stdout --- 2025-03-28 01:55:00,980 DEBUG 0 /results/orders/Reporting-mixedquery-8000/stderr.txt 2025-03-28 01:55:00,980 DEBUG --- stderr --- 2025-03-28 01:55:00,980 DEBUG 2025-03-28 01:55:00,980 INFO - Download file (size 0k) source : /results/orders/Reporting-mixedquery-8000/stderr.txt @ overseer-0-59c948f569-rgrkv destination : /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/stderr.txt 2025-03-28 01:55:00,980 INFO 2025-03-28 01:55:00,980 INFO [loop_until]: kubectl --namespace=xlou --context=gke_engineeringpit_us-east1-d_xlou-cdm cp --retries=100 overseer-0-59c948f569-rgrkv:/results/orders/Reporting-mixedquery-8000/stderr.txt /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/stderr.txt 2025-03-28 01:55:00,980 INFO [loop_until]: (max_time=-1, interval=5, expected_rc=[0] 2025-03-28 01:55:01,703 INFO [loop_until]: OK (rc = 0) 2025-03-28 01:55:01,703 DEBUG --- stdout --- 2025-03-28 01:55:01,703 DEBUG tar: Removing leading `/' from member names 2025-03-28 01:55:01,703 DEBUG --- stderr --- 2025-03-28 01:55:01,703 DEBUG 2025-03-28 01:55:01,703 DEBUG [print_head_tail]: Input file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/stderr.txt is small (0 lines), printing all lines: 2025-03-28 01:55:01,703 INFO ----- output ----- ________________________________________________________________________________ [2025-03-28 01:55:01] Reporting-mixedquery-8000 step12 : Check stderr log ________________________________________________________________________________ PASS: no error found in stderr log ________________________________________________________________________________ [2025-03-28 01:55:01] Reporting-mixedquery-8000 step13 : Analyze graphs for spikes ________________________________________________________________________________ Analyze Gatling graphs for spikes checking parameters open overall stats JSON file checking simulation request restLoginInitiate checking simulation request restLoginUsernamePasswordCallback checking simulation request Skip 2FA checking simulation request User Authorize PKCE stage checking simulation request User AccessToken PKCE stage checking simulation request ReadManagedUser [warn] responseTimePercentiles was not found in /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/05_mixedquery-8000/gatling/req_readmanageduser--1429285772.html - cannot check for spikes checking simulation request queryFull [warn] responseTimePercentiles was not found in /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/07_Scenario_scenario/05_mixedquery-8000/gatling/req_queryfull--1807283337.html - cannot check for spikes no spikes found ________________________________________________________________________________ [2025-03-28 01:55:01] Reporting-mixedquery-8000 step14 : Collect Gatling simulation data ________________________________________________________________________________ collected stats : { "global": { "name": "All Requests", "numberOfRequests": { "total": 14278100, "ok": 14278089, "ko": 11 }, "minResponseTime": { "total": 39, "ok": 39, "ko": 10000 }, "maxResponseTime": { "total": 60000, "ok": 13694, "ko": 60000 }, "meanResponseTime": { "total": 47, "ok": 47, "ko": 19092 }, "standardDeviation": { "total": 46, "ok": 39, "ko": 19284 }, "percentiles1": { "total": 46, "ok": 46, "ko": 10001 }, "percentiles2": { "total": 48, "ok": 48, "ko": 10004 }, "percentiles3": { "total": 51, "ok": 51, "ko": 60000 }, "percentiles4": { "total": 57, "ok": 57, "ko": 60000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 14272595, "percentage": 99.96144444989179 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 1406, "percentage": 0.009847248583495003 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 4088, "percentage": 0.028631260461826152 }, "group4": { "name": "failed", "htmlName": "failed", "count": 11, "percentage": 7.704106288651851e-05 }, "meanNumberOfRequestsPerSecond": { "total": 7932.277777777777, "ok": 7932.2716666666665, "ko": 0.006111111111111111 } }, "details": [ { "name": "restLoginInitiate", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 69, "ok": 69, "ko": 0 }, "maxResponseTime": { "total": 69, "ok": 69, "ko": 0 }, "meanResponseTime": { "total": 69, "ok": 69, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 69, "ok": 69, "ko": 0 }, "percentiles2": { "total": 69, "ok": 69, "ko": 0 }, "percentiles3": { "total": 69, "ok": 69, "ko": 0 }, "percentiles4": { "total": 69, "ok": 69, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100.0 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0.0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0.0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0005555555555555556, "ok": 0.0005555555555555556, "ko": 0 }, "spikes": [] }, { "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 111, "ok": 111, "ko": 0 }, "maxResponseTime": { "total": 111, "ok": 111, "ko": 0 }, "meanResponseTime": { "total": 111, "ok": 111, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 111, "ok": 111, "ko": 0 }, "percentiles2": { "total": 111, "ok": 111, "ko": 0 }, "percentiles3": { "total": 111, "ok": 111, "ko": 0 }, "percentiles4": { "total": 111, "ok": 111, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100.0 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0.0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0.0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0005555555555555556, "ok": 0.0005555555555555556, "ko": 0 }, "spikes": [] }, { "name": "Skip 2FA", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 70, "ok": 70, "ko": 0 }, "maxResponseTime": { "total": 70, "ok": 70, "ko": 0 }, "meanResponseTime": { "total": 70, "ok": 70, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 70, "ok": 70, "ko": 0 }, "percentiles2": { "total": 70, "ok": 70, "ko": 0 }, "percentiles3": { "total": 70, "ok": 70, "ko": 0 }, "percentiles4": { "total": 70, "ok": 70, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100.0 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0.0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0.0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0005555555555555556, "ok": 0.0005555555555555556, "ko": 0 }, "spikes": [] }, { "name": "User Authorize PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 69, "ok": 69, "ko": 0 }, "maxResponseTime": { "total": 69, "ok": 69, "ko": 0 }, "meanResponseTime": { "total": 69, "ok": 69, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 69, "ok": 69, "ko": 0 }, "percentiles2": { "total": 69, "ok": 69, "ko": 0 }, "percentiles3": { "total": 69, "ok": 69, "ko": 0 }, "percentiles4": { "total": 69, "ok": 69, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100.0 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0.0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0.0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0005555555555555556, "ok": 0.0005555555555555556, "ko": 0 }, "spikes": [] }, { "name": "User AccessToken PKCE stage", "numberOfRequests": { "total": 1, "ok": 1, "ko": 0 }, "minResponseTime": { "total": 53, "ok": 53, "ko": 0 }, "maxResponseTime": { "total": 53, "ok": 53, "ko": 0 }, "meanResponseTime": { "total": 53, "ok": 53, "ko": 0 }, "standardDeviation": { "total": 0, "ok": 0, "ko": 0 }, "percentiles1": { "total": 53, "ok": 53, "ko": 0 }, "percentiles2": { "total": 53, "ok": 53, "ko": 0 }, "percentiles3": { "total": 53, "ok": 53, "ko": 0 }, "percentiles4": { "total": 53, "ok": 53, "ko": 0 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 1, "percentage": 100.0 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 0, "percentage": 0.0 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 0, "percentage": 0.0 }, "group4": { "name": "failed", "htmlName": "failed", "count": 0, "percentage": 0.0 }, "meanNumberOfRequestsPerSecond": { "total": 0.0005555555555555556, "ok": 0.0005555555555555556, "ko": 0 }, "spikes": [] }, { "name": "ReadManagedUser", "numberOfRequests": { "total": 7137671, "ok": 7137667, "ko": 4 }, "minResponseTime": { "total": 39, "ok": 39, "ko": 10000 }, "maxResponseTime": { "total": 60000, "ok": 13694, "ko": 60000 }, "meanResponseTime": { "total": 48, "ok": 47, "ko": 22501 }, "standardDeviation": { "total": 46, "ok": 39, "ko": 21650 }, "percentiles1": { "total": 46, "ok": 46, "ko": 10001 }, "percentiles2": { "total": 48, "ok": 48, "ko": 22501 }, "percentiles3": { "total": 51, "ok": 51, "ko": 52500 }, "percentiles4": { "total": 57, "ok": 57, "ko": 58500 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 7134952, "percentage": 99.96190634171846 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 683, "percentage": 0.009568947630116321 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 2032, "percentage": 0.028468669962512985 }, "group4": { "name": "failed", "htmlName": "failed", "count": 4, "percentage": 5.6040688902584615e-05 }, "meanNumberOfRequestsPerSecond": { "total": 3965.3727777777776, "ok": 3965.3705555555557, "ko": 0.0022222222222222222 }, "spikes": [] }, { "name": "queryFull", "numberOfRequests": { "total": 7140424, "ok": 7140417, "ko": 7 }, "minResponseTime": { "total": 39, "ok": 39, "ko": 10000 }, "maxResponseTime": { "total": 60000, "ok": 13241, "ko": 60000 }, "meanResponseTime": { "total": 47, "ok": 47, "ko": 17144 }, "standardDeviation": { "total": 46, "ok": 39, "ko": 17496 }, "percentiles1": { "total": 46, "ok": 46, "ko": 10001 }, "percentiles2": { "total": 48, "ok": 48, "ko": 10004 }, "percentiles3": { "total": 50, "ok": 50, "ko": 45002 }, "percentiles4": { "total": 57, "ok": 57, "ko": 57000 }, "group1": { "name": "t < 800 ms", "htmlName": "t < 800 ms", "count": 7137638, "percentage": 99.96098270915004 }, "group2": { "name": "800 ms <= t < 1200 ms", "htmlName": "t >= 800 ms
t < 1200 ms", "count": 723, "percentage": 0.010125449132992664 }, "group3": { "name": "t >= 1200 ms", "htmlName": "t >= 1200 ms", "count": 2056, "percentage": 0.0287938083228671 }, "group4": { "name": "failed", "htmlName": "failed", "count": 7, "percentage": 9.803339409536465e-05 }, "meanNumberOfRequestsPerSecond": { "total": 3966.902222222222, "ok": 3966.8983333333335, "ko": 0.0038888888888888888 }, "spikes": [] } ] } { "concurrency": null, "generic_stats": { "avg_num_of_requests_per_second": 7932, "avg_response_time": 47, "max_response_time": 13694, "min_response_time": 39, "num_requests": 14278100, "num_requests_pass": 14278089, "num_requests_percent_pass": 100.0 }, "options": "; testMode:open; testCase:idm.MixedQuery; duration:1800; throughput:8000", "stats": { "details": [ { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100.0 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0.0 }, "maxResponseTime": { "ko": 0, "ok": 69, "total": 69 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0005555555555555556, "total": 0.0005555555555555556 }, "meanResponseTime": { "ko": 0, "ok": 69, "total": 69 }, "minResponseTime": { "ko": 0, "ok": 69, "total": 69 }, "name": "restLoginInitiate", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 69, "total": 69 }, "percentiles2": { "ko": 0, "ok": 69, "total": 69 }, "percentiles3": { "ko": 0, "ok": 69, "total": 69 }, "percentiles4": { "ko": 0, "ok": 69, "total": 69 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100.0 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0.0 }, "maxResponseTime": { "ko": 0, "ok": 111, "total": 111 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0005555555555555556, "total": 0.0005555555555555556 }, "meanResponseTime": { "ko": 0, "ok": 111, "total": 111 }, "minResponseTime": { "ko": 0, "ok": 111, "total": 111 }, "name": "restLoginUsernamePasswordCallback", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 111, "total": 111 }, "percentiles2": { "ko": 0, "ok": 111, "total": 111 }, "percentiles3": { "ko": 0, "ok": 111, "total": 111 }, "percentiles4": { "ko": 0, "ok": 111, "total": 111 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100.0 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0.0 }, "maxResponseTime": { "ko": 0, "ok": 70, "total": 70 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0005555555555555556, "total": 0.0005555555555555556 }, "meanResponseTime": { "ko": 0, "ok": 70, "total": 70 }, "minResponseTime": { "ko": 0, "ok": 70, "total": 70 }, "name": "Skip 2FA", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 70, "total": 70 }, "percentiles2": { "ko": 0, "ok": 70, "total": 70 }, "percentiles3": { "ko": 0, "ok": 70, "total": 70 }, "percentiles4": { "ko": 0, "ok": 70, "total": 70 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100.0 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0.0 }, "maxResponseTime": { "ko": 0, "ok": 69, "total": 69 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0005555555555555556, "total": 0.0005555555555555556 }, "meanResponseTime": { "ko": 0, "ok": 69, "total": 69 }, "minResponseTime": { "ko": 0, "ok": 69, "total": 69 }, "name": "User Authorize PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 69, "total": 69 }, "percentiles2": { "ko": 0, "ok": 69, "total": 69 }, "percentiles3": { "ko": 0, "ok": 69, "total": 69 }, "percentiles4": { "ko": 0, "ok": 69, "total": 69 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 1, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 100.0 }, "group2": { "count": 0, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.0 }, "group3": { "count": 0, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0 }, "group4": { "count": 0, "htmlName": "failed", "name": "failed", "percentage": 0.0 }, "maxResponseTime": { "ko": 0, "ok": 53, "total": 53 }, "meanNumberOfRequestsPerSecond": { "ko": 0, "ok": 0.0005555555555555556, "total": 0.0005555555555555556 }, "meanResponseTime": { "ko": 0, "ok": 53, "total": 53 }, "minResponseTime": { "ko": 0, "ok": 53, "total": 53 }, "name": "User AccessToken PKCE stage", "numberOfRequests": { "ko": 0, "ok": 1, "total": 1 }, "percentiles1": { "ko": 0, "ok": 53, "total": 53 }, "percentiles2": { "ko": 0, "ok": 53, "total": 53 }, "percentiles3": { "ko": 0, "ok": 53, "total": 53 }, "percentiles4": { "ko": 0, "ok": 53, "total": 53 }, "spikes": [], "standardDeviation": { "ko": 0, "ok": 0, "total": 0 } }, { "group1": { "count": 7134952, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.96190634171846 }, "group2": { "count": 683, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.009568947630116321 }, "group3": { "count": 2032, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.028468669962512985 }, "group4": { "count": 4, "htmlName": "failed", "name": "failed", "percentage": 5.6040688902584615e-05 }, "maxResponseTime": { "ko": 60000, "ok": 13694, "total": 60000 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0022222222222222222, "ok": 3965.3705555555557, "total": 3965.3727777777776 }, "meanResponseTime": { "ko": 22501, "ok": 47, "total": 48 }, "minResponseTime": { "ko": 10000, "ok": 39, "total": 39 }, "name": "ReadManagedUser", "numberOfRequests": { "ko": 4, "ok": 7137667, "total": 7137671 }, "percentiles1": { "ko": 10001, "ok": 46, "total": 46 }, "percentiles2": { "ko": 22501, "ok": 48, "total": 48 }, "percentiles3": { "ko": 52500, "ok": 51, "total": 51 }, "percentiles4": { "ko": 58500, "ok": 57, "total": 57 }, "spikes": [], "standardDeviation": { "ko": 21650, "ok": 39, "total": 46 } }, { "group1": { "count": 7137638, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.96098270915004 }, "group2": { "count": 723, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.010125449132992664 }, "group3": { "count": 2056, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.0287938083228671 }, "group4": { "count": 7, "htmlName": "failed", "name": "failed", "percentage": 9.803339409536465e-05 }, "maxResponseTime": { "ko": 60000, "ok": 13241, "total": 60000 }, "meanNumberOfRequestsPerSecond": { "ko": 0.0038888888888888888, "ok": 3966.8983333333335, "total": 3966.902222222222 }, "meanResponseTime": { "ko": 17144, "ok": 47, "total": 47 }, "minResponseTime": { "ko": 10000, "ok": 39, "total": 39 }, "name": "queryFull", "numberOfRequests": { "ko": 7, "ok": 7140417, "total": 7140424 }, "percentiles1": { "ko": 10001, "ok": 46, "total": 46 }, "percentiles2": { "ko": 10004, "ok": 48, "total": 48 }, "percentiles3": { "ko": 45002, "ok": 50, "total": 50 }, "percentiles4": { "ko": 57000, "ok": 57, "total": 57 }, "spikes": [], "standardDeviation": { "ko": 17496, "ok": 39, "total": 46 } } ], "global": { "group1": { "count": 14272595, "htmlName": "t < 800 ms", "name": "t < 800 ms", "percentage": 99.96144444989179 }, "group2": { "count": 1406, "htmlName": "t >= 800 ms
t < 1200 ms", "name": "800 ms <= t < 1200 ms", "percentage": 0.009847248583495003 }, "group3": { "count": 4088, "htmlName": "t >= 1200 ms", "name": "t >= 1200 ms", "percentage": 0.028631260461826152 }, "group4": { "count": 11, "htmlName": "failed", "name": "failed", "percentage": 7.704106288651851e-05 }, "maxResponseTime": { "ko": 60000, "ok": 13694, "total": 60000 }, "meanNumberOfRequestsPerSecond": { "ko": 0.006111111111111111, "ok": 7932.2716666666665, "total": 7932.277777777777 }, "meanResponseTime": { "ko": 19092, "ok": 47, "total": 47 }, "minResponseTime": { "ko": 10000, "ok": 39, "total": 39 }, "name": "All Requests", "numberOfRequests": { "ko": 11, "ok": 14278089, "total": 14278100 }, "percentiles1": { "ko": 10001, "ok": 46, "total": 46 }, "percentiles2": { "ko": 10004, "ok": 48, "total": 48 }, "percentiles3": { "ko": 60000, "ok": 51, "total": 51 }, "percentiles4": { "ko": 60000, "ok": 57, "total": 57 }, "standardDeviation": { "ko": 19284, "ok": 39, "total": 46 } } }, "target_hostname": "openam-perf-200m.forgeblocks.com", "tool_name": "gatling" } ________________________________________________________________________________ [2025-03-28 01:55:01] Reporting-mixedquery-8000 step15 : Update run description in the Gatling HTML report ________________________________________________________________________________ ________________________________________________________________________________ [2025-03-28 01:55:01] Reporting-mixedquery-8000 step16 : Remove gatling task's stdout file ________________________________________________________________________________ Cleanup of Gatling stdout file /mnt/disk1/xslou/workshop/lodestar-fork/results/pyrock/idc_simple_managed_users/08_Verification/12_Reporting-mixedquery-8000/stdout.txt Gatling stdout.txt found, but is small - leave it intact. ________________________________________________________________________________ [2025-03-28 01:55:01] Reporting-mixedquery-8000 post : Check output ________________________________________________________________________________ Setting result to PASS Task has been successfully stopped