0 | 0:00 | DEBUG | Using configuration file PurpleWaveAIIDETournament.config.json
0 | 0:00 | DEBUG | Human: false
0 | 0:00 | DEBUG | Ladder: false
0 | 0:00 | DEBUG | Stream: false
0 | 0:00 | DEBUG | Tournament: true
0 | 0:00 | DEBUG | Round-robin: true
0 | 0:00 | DEBUG | Elimination: false
0 | 0:00 | DEBUG | Debugging: false
0 | 0:00 | DEBUG | Loading BWTA for Python 1.1 at (4)Python.scx
0 | 0:00 | DEBUG | Strategery.Selection.Opponents$$anon$1@118dd33 has finished recommended strategy phase in game 148 of 3; will fall back to StrategySelectionGreedy
0 | 0:00 | DEBUG | Game start time:  Sat Oct 17 19:51:41 NDT 2020
0 | 0:00 | DEBUG | OS:               Windows 7 6.1 x86
0 | 0:00 | DEBUG | JRE:              Oracle Corporation - 1.8.0_211
0 | 0:00 | DEBUG | CPUs available:   2
0 | 0:00 | DEBUG | System memory:    2147 MB
0 | 0:00 | DEBUG | JVM Max memory:   1037 MB
0 | 0:00 | DEBUG | JVM Total memory: 1037 MB
0 | 0:00 | DEBUG | JVM Free memory:  705 MB
0 | 0:00 | DEBUG | This copy of PurpleWave was packaged for distribution on Mon, Sep 28, 2020 12:17:44 AM
0 | 0:00 | DEBUG | This copy of PurpleWave came from Git revision 82d99bd1f57d158ab68478e9b35c42d521127e1b
0 | 0:00 | DEBUG | JBWAPI autocontinue: true
0 | 0:00 | DEBUG | JBWAPI debugConnection: false
0 | 0:00 | DEBUG | JBWAPI async: true
0 | 0:00 | DEBUG | JBWAPI async unsafe: true
0 | 0:00 | DEBUG | JBWAPI async frame buffer size: 10
0 | 0:00 | DEBUG | JBWAPI unlimited frame zero: true
0 | 0:00 | DEBUG | JBWAPI max frame duration: 30ms
0 | 0:00 | DEBUG | Strategy	PvEStormNo	WorkersSpread	WorkersUnite	WorkersKill	PvEStormYes	WorkersRaze	PvPRobo	PvP3rdBaseSlow	PvP3GateGoon	PvP2Gate1012Goon	PvP2GateDTExpand	PvPProxy2Gate	PvP1ZealotExpand	PvP3rdBaseFast	PvP2Gate1012DT	PvP4GateGoon
0 | 0:00 | DEBUG | #Games	0.0	0.0	0.0	0.0	0.0	0.0	106.0	141.0	13.0	3.0	14.0	3.0	2.0	7.0	2.0	5.0
0 | 0:00 | DEBUG | #Wtd	0.0	0.0	0.0	0.0	0.0	0.0	46.6	59.7	4.2	0.8	6.2	0.9	0.6	2.6	0.6	2.5
0 | 0:00 | DEBUG | #WtdWins	0.0	0.0	0.0	0.0	0.0	0.0	32.3	38.6	2.5	0.2	3.5	0.3	0.0	1.2	0.0	1.0
0 | 0:00 | DEBUG | WinPct	0%%	0%%	0%%	0%%	0%%	0%%	69%%	64%%	59%%	28%%	57%%	31%%	0%%	45%%	0%%	41%%
0 | 0:00 | DEBUG | WinEst	80%%	80%%	80%%	80%%	80%%	80%%	69%%	65%%	64%%	62%%	61%%	61%%	58%%	57%%	57%%	56%%
0 | 0:00 | DEBUG | Strategy interest
0 | 0:00 | DEBUG | 67%% PvP3rdBaseSlow + PvPRobo
0 | 0:00 | DEBUG | 64%% PvP3GateGoon + PvP3rdBaseSlow
0 | 0:00 | DEBUG | 63%% PvP2Gate1012Goon + PvP3rdBaseSlow
0 | 0:00 | DEBUG | 63%% PvP3rdBaseFast + PvPRobo
0 | 0:00 | DEBUG | 63%% PvP2GateDTExpand + PvP3rdBaseSlow
0 | 0:00 | DEBUG | 61%% PvP2Gate1012DT + PvP3rdBaseSlow
0 | 0:00 | DEBUG | 61%% PvP3GateGoon + PvP3rdBaseFast
0 | 0:00 | DEBUG | 60%% PvP2Gate1012Goon + PvP3rdBaseFast
0 | 0:00 | DEBUG | 59%% PvP2GateDTExpand + PvP3rdBaseFast
0 | 0:00 | DEBUG | 57%% PvP2Gate1012DT + PvP3rdBaseFast
0 | 0:00 | DEBUG | Opponents is BananaBrain
0 | 0:00 | DEBUG | Rush distances is 5152.0, 5600.0, 5216.0, 5280.0
0 | 0:00 | DEBUG | Playbook is Strategery.TournamentPlaybook$@1b7d903
0 | 0:00 | DEBUG | Policy is Strategery.Selection.StrategySelectionTournament$@1aea577
0 | 0:00 | DEBUG | Enemy race is Protoss
0 | 0:00 | DEBUG | Strategy is PvPRobo PvP3rdBaseSlow
0 | 0:00 | DEBUG | Our bases is 0
0 | 0:00 | DEBUG | Enemy bases is 0
0 | 0:00 | DEBUG | Our Factories is 0
0 | 0:00 | DEBUG | Our Barracks is 0
0 | 0:00 | DEBUG | Our Gateways is 0
0 | 0:00 | DEBUG | Our Hatcheries is 0
0 | 0:00 | DEBUG | Enemy Factories is 0
0 | 0:00 | DEBUG | Enemy Barracks is 0
0 | 0:00 | DEBUG | Enemy Gateways is 0
0 | 0:00 | DEBUG | Enemy Hatcheries is 0
0 | 0:00 | DEBUG | Safe at home is true
0 | 0:00 | DEBUG | Safe to move out is true
0 | 0:00 | DEBUG | Should attack is false
0 | 0:00 | DEBUG | Status is PvPRobo
0 | 0:00 | DEBUG | Performance danger is false
1 | 0:00 | DEBUG | Our bases changed from 0 to 1
210 | 0:08 | WARN  | TaskPlanning crossed the 55ms threshold, taking 178ms for 181ms total this frame. 
210 | 0:08 | DEBUG | Task queue took @ 182ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 2ms
TaskBattles: 0ms
TaskSquads: 0ms
TaskPlanning: 178ms
TaskAccounting: 0ms
TaskManners: 0ms
TaskCamera: 0ms
TaskVisualizations: 0ms
648 | 0:27 | WARN  | TaskGeography crossed the 55ms threshold, taking 156ms for 169ms total this frame. 
648 | 0:27 | DEBUG | Task queue took @ 170ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 2ms
TaskBattles: 0ms
TaskSquads: 1ms
TaskPlanning: 4ms
TaskGrids: 2ms
TaskFingerprinting: 3ms
TaskGeography: 156ms
TaskAccounting: 0ms
TaskGathering: 0ms
TaskArchitecture: 3ms
TaskManners: 0ms
TaskCamera: 0ms
TaskVisualizations: 0ms
1188 | 0:49 | WARN  | Microing Probe crossed the 55ms threshold by taking 634ms considering 
1188 | 0:49 | DEBUG | Task queue took @ 636ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 636ms
TaskBattles: 0ms
TaskSquads: 0ms
TaskPlanning: 10ms
TaskGrids: 1ms
TaskGeography: 1ms
TaskAccounting: 0ms
TaskGathering: 0ms
TaskArchitecture: 3ms
TaskManners: 0ms
TaskCamera: 0ms
TaskVisualizations: 0ms
1596 | 1:06 | DEBUG | Discovered novel enemy unit: Probe
1596 | 1:06 | DEBUG | Probe #4 20/20 (20/20) [81, 90] [2605, 2898] projects to arrive in 469 frames at 1:26
1599 | 1:06 | WARN  | TaskGridEnemyRangeAir crossed the 55ms threshold, taking 1935ms for 1942ms total this frame. 
1599 | 1:06 | DEBUG | Task queue took @ 1943ms, crossing the 55ms threshold. Task durations: 
TaskGridUnits: 1ms
TaskGridEnemyDetection: 0ms
TaskGridEnemyRangeAir: 1935ms
1599 | 1:06 | WARN  | TaskGrids crossed the 55ms threshold, taking 1937ms for 1943ms total this frame. 
1599 | 1:06 | DEBUG | Task queue took @ 1943ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 0ms
TaskSquads: 0ms
TaskBattles: 7ms
TaskPlanning: 5ms
TaskGrids: 1937ms
TaskVisualizations: 0ms
1926 | 1:20 | DEBUG | Our Gateways changed from 0 to 1
1991 | 1:22 | WARN  | Microing Probe crossed the 55ms threshold by taking 59ms considering 
1991 | 1:22 | DEBUG | Task queue took @ 61ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 60ms
TaskBattles: 3ms
TaskSquads: 0ms
TaskPlanning: 5ms
TaskGrids: 1ms
TaskFingerprinting: 3ms
TaskGeography: 2ms
TaskAccounting: 0ms
TaskGathering: 0ms
TaskArchitecture: 4ms
TaskVisualizations: 0ms
2019 | 1:24 | DEBUG | Discovered novel enemy unit: Pylon
2019 | 1:24 | DEBUG | Pylon #141 300/300 (300/300) [118, 44] [3776, 1408] is already complete
2034 | 1:24 | DEBUG | Discovered novel enemy unit: Nexus
2034 | 1:24 | DEBUG | Nexus #12 750/750 (750/750) [119, 41] [3808, 1328] is already complete
2035 | 1:24 | DEBUG | Enemy bases changed from 0 to 1
2044 | 1:25 | DEBUG | Enemy Gateways changed from 0 to 1
2044 | 1:25 | DEBUG | Fingerprints is GatewayFirst
2044 | 1:25 | DEBUG | Discovered novel enemy unit: Gateway
2044 | 1:25 | DEBUG | Gateway #147 138/500 (143/500) [112, 40] [3584, 1296] projects to complete in 719 frames at 1:55
2519 | 1:44 | DEBUG | Discovered novel enemy unit: Assimilator
2519 | 1:44 | DEBUG | Assimilator #93 47/450 (47/450) [119, 36] [3808, 1152] projects to complete in -76017 frames at -51:-2
2520 | 1:45 | DEBUG | Fingerprints changed from GatewayFirst to 1GateCore GatewayFirst
3169 | 2:12 | DEBUG | Discovered novel enemy unit: Cybernetics Core
3169 | 2:12 | DEBUG | Cybernetics Core #158 51/500 (51/500) [110, 43] [3536, 1376] projects to complete in 898 frames at 2:49
3170 | 2:12 | DEBUG | Fingerprints changed from 1GateCore GatewayFirst to 1GateCore GatewayFirst CoreBeforeZealot
3923 | 2:43 | DEBUG | Discovered novel enemy unit: Zealot
3923 | 2:43 | DEBUG | Zealot #160 100/100 (60/60) [112, 42] [3598, 1360] projects to arrive in 1312 frames at 3:38
3949 | 2:44 | DEBUG | Our Gateways changed from 1 to 2
5872 | 4:04 | DEBUG | Our Gateways changed from 2 to 3
5982 | 4:09 | DEBUG | Task queue took @ 71ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 70ms
TaskSquads: 2ms
TaskPlanning: 7ms
TaskGrids: 1ms
TaskGeography: 1ms
TaskAccounting: 0ms
TaskGathering: 1ms
TaskArchitecture: 3ms
TaskManners: 0ms
TaskCamera: 0ms
TaskVisualizations: 0ms
6836 | 4:44 | DEBUG | Our upgrades is Singularity Charge = 1
8595 | 5:58 | DEBUG | Enemy upgrades is Singularity Charge = 1
8597 | 5:58 | DEBUG | Discovered novel enemy unit: Dragoon
8597 | 5:58 | DEBUG | Dragoon #168 100/100 (80/80) [75, 98] [2412, 3160] projects to arrive in 372 frames at 6:13
8599 | 5:58 | DEBUG | Fingerprints changed from 1GateCore GatewayFirst CoreBeforeZealot to 1GateCore GatewayFirst DragoonRange CoreBeforeZealot
9537 | 6:37 | DEBUG | Discovered novel enemy unit: Observer
9537 | 6:37 | DEBUG | Observer #221 40/40 (20/20) [69, 115] [2223, 3704] projects to arrive in 260 frames at 6:48
10801 | 7:30 | DEBUG | Our bases changed from 1 to 2
10801 | 7:30 | DEBUG | Should attack changed from false to true
10801 | 7:30 | DEBUG | Status changed from PvPRobo to PvPLateGame
10820 | 7:30 | DEBUG | Task queue took @ 55ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 51ms
TaskBattles: 17ms
TaskVisualizations: 0ms
11487 | 7:58 | DEBUG | Our Gateways changed from 3 to 4
12516 | 8:41 | DEBUG | Discovered novel enemy unit: Scarab
12516 | 8:41 | DEBUG | Scarab #312 20/20 (10/10) [111, 62] [3556, 2000] projects to arrive in 202 frames at 8:49
12516 | 8:41 | DEBUG | Discovered novel enemy unit: Reaver
12516 | 8:41 | DEBUG | Reaver #271 100/100 (80/80) [111, 62] [3575, 2005] projects to arrive in 1816 frames at 9:57
12586 | 8:44 | DEBUG | Enemy bases changed from 1 to 2
12588 | 8:44 | DEBUG | Discovered novel enemy unit: Photon Cannon
12588 | 8:44 | DEBUG | Photon Cannon #302 61/100 (71/100) [116, 65] [3712, 2080] projects to complete in 284 frames at 8:56
12988 | 9:01 | DEBUG | Discovered novel enemy unit: Shuttle
12988 | 9:01 | DEBUG | Shuttle #295 80/80 (60/60) [109, 60] [3495, 1945] projects to arrive in 479 frames at 9:21
14970 | 10:23 | DEBUG | Our Gateways changed from 4 to 5
16720 | 11:36 | DEBUG | Our upgrades changed from Singularity Charge = 1 to Gravitic Drive = 1, Singularity Charge = 1
18347 | 12:44 | DEBUG | Enemy bases changed from 2 to 1
18811 | 13:03 | DEBUG | Discovered novel enemy unit: Robotics Facility
18811 | 13:03 | DEBUG | Robotics Facility #183 500/500 (500/500) [115, 46] [3696, 1472] is already complete
18811 | 13:03 | DEBUG | Discovered novel enemy unit: Observatory
18811 | 13:03 | DEBUG | Observatory #204 250/250 (250/250) [118, 46] [3792, 1472] is already complete
18918 | 13:08 | DEBUG | Discovered novel enemy unit: Citadel of Adun
18918 | 13:08 | DEBUG | Citadel of Adun #424 450/450 (450/450) [109, 47] [3504, 1504] is already complete
19035 | 13:13 | DEBUG | Our bases changed from 2 to 3
19382 | 13:27 | DEBUG | Discovered novel enemy unit: Forge
19382 | 13:27 | DEBUG | Forge #254 550/550 (550/550) [109, 45] [3504, 1440] is already complete
19414 | 13:28 | DEBUG | Discovered novel enemy unit: Robotics Support Bay
19414 | 13:28 | DEBUG | Robotics Support Bay #259 450/450 (450/450) [105, 47] [3376, 1504] is already complete
19415 | 13:28 | DEBUG | Enemy Gateways changed from 1 to 2
19792 | 13:44 | DEBUG | Enemy Gateways changed from 2 to 3
19923 | 13:50 | DEBUG | Enemy Gateways changed from 3 to 0
19924 | 13:50 | DEBUG | Enemy bases changed from 1 to 0
19935 | 13:50 | DEBUG | Game ended in victory
19935 | 13:50 | DEBUG | Cutoff: 	55ms
Task	Last run	 Run %	Seconds	Avg ms	Max (Recent)	Max (All time)	Extended	Disqualifying
Accounting          		 54%%	0	0	1	13	4	0
Architecture        		 38%%	15	1	2	32	51	0
Battles             	X	 56%%	69	8	17	31	73	0
Camera              		 47%%	0	0	0	1	0	0
Fingerprinting      		 50%%	24	0	0	18	37	0
Gathering           		 49%%	7	0	2	13	149	0
Geography           		 51%%	13	1	2	156	337	1
Grids               		 52%%	24	1	2	1937	41	1
Manners             		 47%%	0	0	0	1	0	0
Micro               		 73%%	98	6	18	636	1047	3
Planning            	XXXXXXX	 36%%	60	19	33	178	690	1
Squads              		 61%%	14	0	4	27	33	0
Visualizations      		 100%%	0	0	0	5	38	0
19935 | 13:50 | DEBUG | Cutoff: 	55ms
Task	Last run	 Run %	Seconds	Avg ms	Max (Recent)	Max (All time)	Extended	Disqualifying
Accounting          		 54%%	0	0	1	13	4	0
Architecture        		 38%%	15	1	2	32	51	0
Battles             	X	 56%%	69	8	17	31	73	0
Camera              		 47%%	0	0	0	1	0	0
Fingerprinting      		 50%%	24	0	0	18	37	0
Gathering           		 49%%	7	0	2	13	149	0
Geography           		 51%%	13	1	2	156	337	1
Grids               		 52%%	24	1	2	1937	41	1
Manners             		 47%%	0	0	0	1	0	0
Micro               		 73%%	98	6	18	636	1047	3
Planning            	XXXXXXX	 36%%	60	19	33	178	690	1
Squads              		 61%%	14	0	4	27	33	0
Visualizations      		 100%%	0	0	0	5	38	0
19935 | 13:50 | DEBUG | Game duration (fastest):    13m 50s
19935 | 13:50 | DEBUG | Game duration (wall clock): 7m 53s
19935 | 13:50 | DEBUG | 
Bot frames over 55ms: 9
Bot frames over 1000ms: 2
Bot frames over 10000ms: 0
19935 | 13:50 | DEBUG | The bot believes its performance, if running synchronously, would be good
19935 | 13:50 | DEBUG | Performance metrics:
Frame duration: After receiving 'frame ready' -> before sending 'frame done':
19,935 samples averaging 20 [3.1 - 1,540.5]
>= 5: 19894 samples averaging 20.1
>= 10: 19582 samples averaging 20.2
>= 15: 18044 samples averaging 20.8
>= 20: 11993 samples averaging 22.2
>= 25: 961 samples averaging 31.1
>= 30: 276 samples averaging 42
>= 35: 68 samples averaging 73.1
>= 40: 22 samples averaging 147.8
>= 45: 4 samples averaging 624.1
>= 50: 4 samples averaging 624.1
>= 55: 4 samples averaging 624.1
>= 85: 4 samples averaging 624.1
Frame duration: After receiving 'frame ready' -> after sending 'frame done':
19,935 samples averaging 20.1 [3.1 - 1,542.3]
>= 5: 19895 samples averaging 20.2
>= 10: 19591 samples averaging 20.4
>= 15: 18090 samples averaging 20.9
>= 20: 12204 samples averaging 22.3
>= 25: 1070 samples averaging 31
>= 30: 303 samples averaging 41.7
>= 35: 90 samples averaging 64.9
>= 40: 28 samples averaging 126
>= 45: 6 samples averaging 433
>= 50: 4 samples averaging 626.4
>= 55: 4 samples averaging 626.4
>= 85: 4 samples averaging 626.4
Frame duration: After receiving 'frame ready' -> after sending 'frame done' (Using GetTickCount()):
19,935 samples averaging 20.1 [0 - 1,531]
>= 5: 19537 samples averaging 20.5
>= 10: 19537 samples averaging 20.5
>= 15: 19537 samples averaging 20.5
>= 20: 5929 samples averaging 31.8
>= 25: 5929 samples averaging 31.8
>= 30: 5929 samples averaging 31.8
>= 35: 74 samples averaging 78.1
>= 40: 74 samples averaging 78.1
>= 45: 74 samples averaging 78.1
>= 50: 4 samples averaging 625
>= 55: 4 samples averaging 625
>= 85: 4 samples averaging 625
Frame duration: After receiving 'frame ready' -> receiving next 'frame ready':
19,935 samples averaging 23.1 [4.2 - 1,542.3]
>= 5: 19930 samples averaging 23.1
>= 10: 19745 samples averaging 23.2
>= 15: 19118 samples averaging 23.5
>= 20: 16089 samples averaging 24.6
>= 25: 4445 samples averaging 28.9
>= 30: 890 samples averaging 38.5
>= 35: 316 samples averaging 50.2
>= 40: 114 samples averaging 73.3
>= 45: 41 samples averaging 128.3
>= 50: 16 samples averaging 256
>= 55: 11 samples averaging 348.7
>= 85: 5 samples averaging 694.2
Frame duration: After receiving 'frame ready' -> receiving next 'frame ready' (Using GetTickCount()):
19,935 samples averaging 23.1 [0 - 1,531]
>= 5: 19747 samples averaging 23.3
>= 10: 19747 samples averaging 23.3
>= 15: 19747 samples averaging 23.3
>= 20: 9227 samples averaging 32
>= 25: 9227 samples averaging 32
>= 30: 9227 samples averaging 32
>= 35: 230 samples averaging 61.4
>= 40: 230 samples averaging 61.4
>= 45: 230 samples averaging 61.4
>= 50: 10 samples averaging 381.2
>= 55: 10 samples averaging 381.2
>= 85: 5 samples averaging 693.6
BWAPI duration: Before sending 'frame done' -> After receiving 'frame ready':
19,935 samples averaging 3 [0 - 945.1]
>= 1: 19934 samples averaging 3
>= 3: 6308 samples averaging 4.6
>= 5: 906 samples averaging 10.3
>= 10: 269 samples averaging 19.8
>= 15: 118 samples averaging 29.7
>= 20: 57 samples averaging 42.7
>= 30: 11 samples averaging 119.7
BWAPI duration: Before sending 'frame done' -> After sending 'frame done':
19,935 samples averaging 0.1 [0 - 12.3]
>= 1: 408 samples averaging 2.5
>= 3: 108 samples averaging 3.9
>= 5: 10 samples averaging 6.8
>= 10: 1 samples averaging 12.3
BWAPI duration: Before listening for 'frame ready' -> After receiving 'frame ready':
19,935 samples averaging 2.9 [0 - 945]
>= 1: 19571 samples averaging 2.9
>= 3: 5734 samples averaging 4.6
>= 5: 841 samples averaging 10.5
>= 10: 248 samples averaging 20.4
>= 15: 115 samples averaging 30
>= 20: 57 samples averaging 42.6
>= 30: 11 samples averaging 119.7
Copying frame to buffer:
19,935 samples averaging 1.9 [0.9 - 31.1]
>= 5: 147 samples averaging 9.2
>= 10: 52 samples averaging 13.6
>= 15: 10 samples averaging 19.2
>= 20: 3 samples averaging 25.9
>= 25: 1 samples averaging 31.1
>= 30: 1 samples averaging 31.1
Time holding frame until buffer frees capacity:
1 samples averaging 1,539.3 [1,539.3 - 1,539.3]
>= 0: 1 samples averaging 1,539.3
Frames already buffered when enqueuing a new frame:
19,936 samples averaging 0 [0 - 9]
>= 0: 19936 samples averaging 0
>= 1: 52 samples averaging 1.9
Frames behind real-time when handling events:
19,936 samples averaging 0 [0 - 8]
>= 0: 19936 samples averaging 0
>= 1: 10 samples averaging 4.9
Time flushing side effects:
19,936 samples averaging 0 [0 - 12.2]
>= 1: 4 samples averaging 7.4
>= 3: 3 samples averaging 9.3
>= 5: 2 samples averaging 11.7
Duration of bot event handlers:
19,934 samples averaging 19.6 [0.9 - 1,943.5]
>= 5: 19876 samples averaging 19.6
>= 10: 19541 samples averaging 19.8
>= 15: 17802 samples averaging 20.5
>= 20: 10667 samples averaging 22
>= 25: 620 samples averaging 33.8
>= 30: 175 samples averaging 51.7
>= 35: 72 samples averaging 80.1
>= 40: 33 samples averaging 130.6
>= 45: 18 samples averaging 204.1
>= 50: 11 samples averaging 303.7
>= 55: 8 samples averaging 397.6
>= 85: 4 samples averaging 733.8
Time bot spent idle:
19,936 samples averaging 3.4 [0 - 945.2]
Time client spent waiting for bot:
19,935 samples averaging 17.9 [0 - 614.6]
>= 30: 139 samples averaging 39.8
Excess duration of client sleep:
21,137 samples averaging 0.1 [0 - 585]
>= 1: 190 samples averaging 8.6
>= 5: 63 samples averaging 21.6
>= 10: 20 samples averaging 53
>= 15: 3 samples averaging 288
>= 20: 3 samples averaging 288
>= 25: 3 samples averaging 288
>= 30: 3 samples averaging 288
>= 35: 3 samples averaging 288
>= 40: 3 samples averaging 288
>= 45: 3 samples averaging 288
>= 50: 3 samples averaging 288
>= 55: 3 samples averaging 288
>= 85: 3 samples averaging 288
Positive timer discrepancy compared to BWAPI:
11,393 samples averaging 4.6 [1 - 24]
>= 1: 11393 samples averaging 4.6
>= 2: 10593 samples averaging 4.8
>= 3: 9594 samples averaging 5.1
>= 4: 8148 samples averaging 5.5
>= 5: 5517 samples averaging 6.2
>= 10: 373 samples averaging 11.9
>= 15: 14 samples averaging 15.8
>= 20: 1 samples averaging 24
Negative timer discrepancy compared to BWAPI:
7,702 samples averaging 8.2 [1 - 19]
>= 1: 7702 samples averaging 8.2
>= 2: 6967 samples averaging 8.9
>= 3: 6436 samples averaging 9.5
>= 4: 6064 samples averaging 9.9
>= 5: 5813 samples averaging 10.2
>= 10: 4106 samples averaging 11.3
>= 15: 90 samples averaging 15.3
Number of events received from BWAPI:
19,935 samples averaging 1.3 [0 - 61]
>= 1: 19320 samples averaging 1.4
>= 2: 2009 samples averaging 4.6
>= 3: 1916 samples averaging 4.7
>= 4: 1074 samples averaging 6
>= 5: 569 samples averaging 7.8
>= 6: 280 samples averaging 10.7
>= 8: 131 samples averaging 15.4
>= 10: 82 samples averaging 19.5
>= 15: 46 samples averaging 25.7
>= 20: 28 samples averaging 31.5
Number of events received from BWAPI, multiplied by the receive-to-sent duration of that frame:
19,935 samples averaging 27.1 [0 - 1,542.3]
>= 5: 19282 samples averaging 28
>= 10: 19004 samples averaging 28.3
>= 15: 17629 samples averaging 29.4
>= 20: 12238 samples averaging 34.4
>= 25: 2837 samples averaging 77.6
>= 30: 2239 samples averaging 91.1
>= 35: 2061 samples averaging 96.3
>= 40: 1985 samples averaging 98.5
>= 45: 1905 samples averaging 100.9
>= 50: 1865 samples averaging 102
>= 55: 1813 samples averaging 103.4
>= 85: 819 samples averaging 146.5
Number of events received from BWAPI, multiplied by the receive-to-sent duration of that frame (Using GetTickCount()):
19,935 samples averaging 27 [0 - 1,643]
>= 5: 18939 samples averaging 28.4
>= 10: 18939 samples averaging 28.4
>= 15: 18939 samples averaging 28.4
>= 20: 6965 samples averaging 50.3
>= 25: 6965 samples averaging 50.3
>= 30: 6965 samples averaging 50.3
>= 35: 1986 samples averaging 98.1
>= 40: 1986 samples averaging 98.1
>= 45: 1986 samples averaging 98.1
>= 50: 1416 samples averaging 118.7
>= 55: 1416 samples averaging 118.7
>= 85: 870 samples averaging 150.6