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.StrategySelectionRecommended@ad4df1 has finished recommended strategy phase in game 148 of 5; will fall back to StrategySelectionGreedy
0 | 0:00 | DEBUG | Game start time:  Sat Oct 17 19:50:15 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	PvZ2Gate1012	PvZMidgame5GateGoonReaver	PvZLateGameReaver	PvZ4GateGoon	WorkersUnite	PvZMidgame5GateGoon	WorkersKill	PvZMidgameBisu	PvEStormYes	PvEStormNo	PvZ10Gate	PvZLateGameTemplar	WorkersSpread	PvZMidgameNeoBisu
0 | 0:00 | DEBUG | #Games	148.0	148.0	148.0	148.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0
0 | 0:00 | DEBUG | #Wtd	62.3	62.3	62.3	62.3	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0
0 | 0:00 | DEBUG | #WtdWins	58.9	58.9	58.9	58.9	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0	0.0
0 | 0:00 | DEBUG | WinPct	94%%	94%%	94%%	94%%	0%%	0%%	0%%	0%%	0%%	0%%	0%%	0%%	0%%	0%%
0 | 0:00 | DEBUG | WinEst	94%%	94%%	94%%	94%%	80%%	80%%	80%%	80%%	80%%	80%%	80%%	80%%	80%%	80%%
0 | 0:00 | DEBUG | Strategy interest
0 | 0:00 | DEBUG | 94%% PvZ2Gate1012 + PvZ4GateGoon + PvZLateGameReaver + PvZMidgame5GateGoonReaver
0 | 0:00 | DEBUG | 90%% PvZ10Gate + PvZ4GateGoon + PvZLateGameReaver + PvZMidgame5GateGoonReaver
0 | 0:00 | DEBUG | 86%% PvZ2Gate1012 + PvZ4GateGoon + PvZLateGameTemplar + PvZMidgame5GateGoon
0 | 0:00 | DEBUG | 83%% PvZ10Gate + PvZ4GateGoon + PvZLateGameTemplar + PvZMidgame5GateGoon
0 | 0:00 | DEBUG | Opponents is McRave
0 | 0:00 | DEBUG | Rush distances is 5152.0, 5600.0, 5216.0, 5280.0
0 | 0:00 | DEBUG | Playbook is Strategery.TournamentPlaybook$@5510e0
0 | 0:00 | DEBUG | Policy is Strategery.Selection.StrategySelectionTournament$@16a326f
0 | 0:00 | DEBUG | Enemy race is Zerg
0 | 0:00 | DEBUG | Strategy is PvZ2Gate1012 PvZ4GateGoon PvZMidgame5GateGoonReaver PvZLateGameReaver
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 PvZ2Gate1012, 4-Gate Goons
0 | 0:00 | DEBUG | Performance danger is false
1 | 0:00 | DEBUG | Our bases changed from 0 to 1
461 | 0:19 | WARN  | TaskPlanning crossed the 55ms threshold, taking 155ms for 160ms total this frame. 
461 | 0:19 | DEBUG | Task queue took @ 160ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 3ms
TaskBattles: 1ms
TaskSquads: 0ms
TaskPlanning: 155ms
TaskGrids: 1ms
TaskAccounting: 0ms
TaskManners: 0ms
TaskCamera: 0ms
TaskVisualizations: 0ms
1172 | 0:48 | WARN  | Microing Probe crossed the 55ms threshold by taking 689ms considering 
1172 | 0:48 | DEBUG | Task queue took @ 691ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 691ms
TaskBattles: 1ms
TaskSquads: 0ms
TaskPlanning: 5ms
TaskGrids: 1ms
TaskFingerprinting: 2ms
TaskGeography: 1ms
TaskAccounting: 0ms
TaskGathering: 0ms
TaskArchitecture: 1ms
TaskManners: 0ms
TaskCamera: 0ms
TaskVisualizations: 0ms
1353 | 0:56 | WARN  | TaskGridEnemyDetection crossed the 55ms threshold, taking 1866ms for 1874ms total this frame. 
1353 | 0:56 | DEBUG | Task queue took @ 1874ms, crossing the 55ms threshold. Task durations: 
TaskGridUnits: 0ms
TaskGridEnemyDetection: 1866ms
1353 | 0:56 | WARN  | TaskGrids crossed the 55ms threshold, taking 1866ms for 1874ms total this frame. 
1353 | 0:56 | DEBUG | Task queue took @ 1874ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 2ms
TaskBattles: 24ms
TaskSquads: 0ms
TaskPlanning: 6ms
TaskGrids: 1866ms
TaskVisualizations: 0ms
1353 | 0:56 | DEBUG | Discovered novel enemy unit: Overlord
1353 | 0:56 | DEBUG | Overlord #11 200/200 [19, 96] [631, 3095] projects to arrive in 588 frames at 1:20
1902 | 1:19 | DEBUG | Our Gateways changed from 0 to 1
2515 | 1:44 | DEBUG | Our Gateways changed from 1 to 2
2660 | 1:50 | DEBUG | Discovered novel enemy unit: Drone
2660 | 1:50 | DEBUG | Drone #0 40/40 [12, 75] [407, 2415] projects to arrive in 73 frames at 1:53
2839 | 1:58 | DEBUG | Inferred enemy main from process of elimination.
2840 | 1:58 | DEBUG | Enemy bases changed from 0 to 1
3416 | 2:22 | DEBUG | Enemy Hatcheries changed from 0 to 1
3416 | 2:22 | DEBUG | Discovered novel enemy unit: Hatchery
3416 | 2:22 | DEBUG | Hatchery #9 319/1250 [77, 119] [2464, 3824] projects to complete in 1490 frames at 3:24
3417 | 2:22 | DEBUG | Enemy bases changed from 1 to 2
3626 | 2:31 | DEBUG | Fingerprints is 12Pool
3626 | 2:31 | DEBUG | Discovered novel enemy unit: Spawning Pool
3626 | 2:31 | DEBUG | Spawning Pool #5 750/750 [48, 120] [1552, 3840] is already complete
3657 | 2:32 | DEBUG | Enemy Hatcheries changed from 1 to 2
3658 | 2:32 | DEBUG | Discovered novel enemy unit: Egg
3658 | 2:32 | DEBUG | Egg #158 200/200 [45, 121] [1466, 3877] projects to arrive in 86400 frames at 62:32
3658 | 2:32 | DEBUG | Egg #153 200/200 [45, 120] [1466, 3855] projects to arrive in 86400 frames at 62:32
3658 | 2:32 | DEBUG | Egg #161 200/200 [46, 120] [1476, 3866] projects to arrive in 86400 frames at 62:32
3666 | 2:32 | DEBUG | Fingerprints changed from 12Pool to 9Pool
3666 | 2:32 | DEBUG | Discovered novel enemy unit: Zergling
3666 | 2:32 | DEBUG | Zergling #156 35/35 [46, 121] [1473, 3886] projects to arrive in 920 frames at 3:11
3667 | 2:32 | DEBUG | Safe at home changed from true to false
3667 | 2:32 | DEBUG | Safe to move out changed from true to false
4244 | 2:56 | DEBUG | Discovered novel enemy unit: Larva
4244 | 2:56 | DEBUG | Larva #171 25/25 [45, 120] [1467, 3856] projects to arrive in 86400 frames at 62:56
4379 | 3:02 | DEBUG | Discovered novel enemy unit: Extractor
4379 | 3:02 | DEBUG | Extractor #62 77/750 [44, 115] [1408, 3680] projects to complete in -92732 frames at -61:-21
4850 | 3:22 | DEBUG | Safe at home changed from false to true
4850 | 3:22 | DEBUG | Safe to move out changed from false to true
5768 | 4:00 | DEBUG | Should attack changed from false to true
5850 | 4:03 | DEBUG | Our Gateways changed from 2 to 3
6139 | 4:15 | DEBUG | Our Gateways changed from 3 to 4
6454 | 4:28 | DEBUG | Discovered novel enemy unit: Sunken Colony
6454 | 4:28 | DEBUG | Sunken Colony #10 300/300 [74, 119] [2368, 3808] is already complete
8202 | 5:41 | DEBUG | Our bases changed from 1 to 2
8202 | 5:41 | DEBUG | Status changed from PvZ2Gate1012, 4-Gate Goons to PvZ5GateGoon
9122 | 6:20 | DEBUG | Our upgrades is Singularity Charge = 1
9126 | 6:20 | DEBUG | Discovered novel enemy unit: Creep Colony
9126 | 6:20 | DEBUG | Creep Colony #189 102/400 [74, 121] [2368, 3872] projects to complete in -2352 frames at 4:42
9187 | 6:22 | DEBUG | Enemy upgrades is Metabolic Boost = 1
10188 | 7:04 | DEBUG | Our Gateways changed from 4 to 5
10503 | 7:17 | WARN  | TaskPlanning crossed the 55ms threshold, taking 55ms for 56ms total this frame. The task was overdue to run this frame.
10503 | 7:17 | DEBUG | Task queue took @ 57ms, crossing the 55ms threshold. Task durations: 
TaskPlanning: 55ms
TaskMicro: 11ms
TaskSquads: 0ms
TaskGrids: 3ms
TaskFingerprinting: 0ms
TaskGeography: 1ms
TaskAccounting: 0ms
TaskManners: 0ms
TaskCamera: 0ms
TaskVisualizations: 0ms
10672 | 7:24 | DEBUG | Discovered novel enemy unit: Mutalisk
10672 | 7:24 | DEBUG | Mutalisk #232 120/120 [76, 116] [2447, 3726] projects to arrive in 415 frames at 7:41
10795 | 7:29 | WARN  | Microing Dragoon crossed the 55ms threshold by taking 54ms considering 
10795 | 7:29 | DEBUG | Task queue took @ 71ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 68ms
TaskBattles: 18ms
TaskVisualizations: 0ms
13165 | 9:08 | DEBUG | Enemy Hatcheries changed from 2 to 3
13169 | 9:08 | DEBUG | Discovered novel enemy unit: Lair
13169 | 9:08 | DEBUG | Lair #13 1800/1800 [44, 120] [1408, 3856] is already complete
13224 | 9:11 | WARN  | TaskPlanning crossed the 55ms threshold, taking 54ms for 58ms total this frame. The task was overdue to run this frame.
13224 | 9:11 | DEBUG | Task queue took @ 59ms, crossing the 55ms threshold. Task durations: 
TaskPlanning: 54ms
TaskMicro: 20ms
TaskVisualizations: 0ms
15402 | 10:41 | DEBUG | Our upgrades changed from Singularity Charge = 1 to Singularity Charge = 1, Protoss Air Weapons = 1
15862 | 11:00 | DEBUG | Discovered novel enemy unit: Scourge
15862 | 11:00 | DEBUG | Scourge #330 25/25 [73, 115] [2358, 3684] projects to arrive in 400 frames at 11:17
15862 | 11:00 | DEBUG | Scourge #342 25/25 [74, 114] [2384, 3678] projects to arrive in 403 frames at 11:17
21789 | 15:07 | DEBUG | Enemy Hatcheries changed from 3 to 4
21796 | 15:08 | DEBUG | Enemy bases changed from 2 to 3
21848 | 15:10 | DEBUG | Enemy upgrades changed from Metabolic Boost = 1 to Metabolic Boost = 1, Zerg Flyer Carapace = 1
23564 | 16:21 | DEBUG | Enemy Hatcheries changed from 4 to 5
23569 | 16:22 | DEBUG | Enemy Hatcheries changed from 5 to 6
24144 | 16:46 | WARN  | TaskSquads crossed the 55ms threshold, taking 65ms for 69ms total this frame. 
24144 | 16:46 | DEBUG | Task queue took @ 70ms, crossing the 55ms threshold. Task durations: 
TaskMicro: 1ms
TaskSquads: 65ms
TaskBattles: 16ms
TaskVisualizations: 0ms
25298 | 17:34 | DEBUG | Game ended in victory
25298 | 17:34 | DEBUG | Cutoff: 	55ms
Task	Last run	 Run %	Seconds	Avg ms	Max (Recent)	Max (All time)	Extended	Disqualifying
Accounting          		 49%%	1	0	1	9	1	0
Architecture        		 38%%	12	2	3	24	114	0
Battles             		 39%%	93	14	17	29	158	0
Camera              		 43%%	0	0	0	1	0	0
Fingerprinting      		 51%%	11	0	0	13	37	0
Gathering           		 44%%	10	1	13	13	255	0
Geography           		 44%%	15	2	8	20	326	0
Grids               		 38%%	35	3	10	1866	63	1
Manners             		 43%%	0	0	0	1	0	0
Micro               		 64%%	130	11	23	691	1868	2
Planning            	XXXXXXXXXX	 27%%	65	18	25	155	1217	3
Squads              	XX	 47%%	29	5	15	65	103	1
Visualizations      		 100%%	0	0	1	10	63	0
25298 | 17:34 | DEBUG | Cutoff: 	55ms
Task	Last run	 Run %	Seconds	Avg ms	Max (Recent)	Max (All time)	Extended	Disqualifying
Accounting          		 49%%	1	0	1	9	1	0
Architecture        		 38%%	12	2	3	24	114	0
Battles             		 39%%	93	14	17	29	158	0
Camera              		 43%%	0	0	0	1	0	0
Fingerprinting      		 51%%	11	0	0	13	37	0
Gathering           		 44%%	10	1	13	13	255	0
Geography           		 44%%	15	2	8	20	326	0
Grids               		 38%%	35	3	10	1866	63	1
Manners             		 43%%	0	0	0	1	0	0
Micro               		 64%%	130	11	23	691	1868	2
Planning            	XXXXXXXXXX	 27%%	65	18	25	155	1217	3
Squads              	XX	 47%%	29	5	15	65	103	1
Visualizations      		 100%%	0	0	1	10	63	0
25298 | 17:34 | DEBUG | Game duration (fastest):    17m 34s
25298 | 17:34 | DEBUG | Game duration (wall clock): 11m 27s
25298 | 17:34 | DEBUG | 
Bot frames over 55ms: 14
Bot frames over 1000ms: 2
Bot frames over 10000ms: 0
25298 | 17:34 | DEBUG | The bot believes its performance, if running synchronously, would be good
25298 | 17:34 | DEBUG | Performance metrics:
Frame duration: After receiving 'frame ready' -> before sending 'frame done':
25,298 samples averaging 20.8 [3.8 - 1,437.2]
>= 5: 25275 samples averaging 20.8
>= 10: 24988 samples averaging 21
>= 15: 22038 samples averaging 22
>= 20: 16699 samples averaging 23.4
>= 25: 2828 samples averaging 29.8
>= 30: 836 samples averaging 36.9
>= 35: 250 samples averaging 48.8
>= 40: 75 samples averaging 75.6
>= 45: 25 samples averaging 143.3
>= 50: 14 samples averaging 219.4
>= 55: 11 samples averaging 265
>= 85: 4 samples averaging 614
Frame duration: After receiving 'frame ready' -> after sending 'frame done':
25,298 samples averaging 21 [3.8 - 1,439.1]
>= 5: 25279 samples averaging 21
>= 10: 24998 samples averaging 21.2
>= 15: 22119 samples averaging 22.2
>= 20: 16895 samples averaging 23.6
>= 25: 3130 samples averaging 30.1
>= 30: 983 samples averaging 37.1
>= 35: 329 samples averaging 47.3
>= 40: 116 samples averaging 65.9
>= 45: 41 samples averaging 109.9
>= 50: 22 samples averaging 164.3
>= 55: 17 samples averaging 197.5
>= 85: 6 samples averaging 440.2
Frame duration: After receiving 'frame ready' -> after sending 'frame done' (Using GetTickCount()):
25,298 samples averaging 21 [0 - 1,438]
>= 5: 24731 samples averaging 21.5
>= 10: 24731 samples averaging 21.5
>= 15: 24731 samples averaging 21.5
>= 20: 8904 samples averaging 31.9
>= 25: 8904 samples averaging 31.9
>= 30: 8904 samples averaging 31.9
>= 35: 231 samples averaging 56.7
>= 40: 231 samples averaging 56.7
>= 45: 231 samples averaging 56.7
>= 50: 5 samples averaging 503
>= 55: 5 samples averaging 503
>= 85: 4 samples averaging 613.2
Frame duration: After receiving 'frame ready' -> receiving next 'frame ready':
25,298 samples averaging 26.7 [4.9 - 1,439.1]
>= 5: 25297 samples averaging 26.7
>= 10: 25096 samples averaging 26.8
>= 15: 23900 samples averaging 27.5
>= 20: 20285 samples averaging 29.3
>= 25: 12224 samples averaging 33.3
>= 30: 5866 samples averaging 40.4
>= 35: 3536 samples averaging 45.6
>= 40: 2110 samples averaging 51.4
>= 45: 1272 samples averaging 57.4
>= 50: 761 samples averaging 64.2
>= 55: 450 samples averaging 72.4
>= 85: 30 samples averaging 199.4
Frame duration: After receiving 'frame ready' -> receiving next 'frame ready' (Using GetTickCount()):
25,298 samples averaging 26.6 [0 - 1,438]
>= 5: 25019 samples averaging 26.9
>= 10: 25019 samples averaging 26.9
>= 15: 25019 samples averaging 26.9
>= 20: 14610 samples averaging 34.9
>= 25: 14610 samples averaging 34.9
>= 30: 14610 samples averaging 34.9
>= 35: 2597 samples averaging 51.8
>= 40: 2597 samples averaging 51.8
>= 45: 2597 samples averaging 51.8
>= 50: 484 samples averaging 73.4
>= 55: 484 samples averaging 73.4
>= 85: 27 samples averaging 213
BWAPI duration: Before sending 'frame done' -> After receiving 'frame ready':
25,298 samples averaging 5.8 [0.3 - 1,100.4]
>= 1: 25297 samples averaging 5.8
>= 3: 11805 samples averaging 9.9
>= 5: 6000 samples averaging 16
>= 10: 3851 samples averaging 21
>= 15: 2487 samples averaging 25.7
>= 20: 1553 samples averaging 30.7
>= 30: 571 samples averaging 41.6
BWAPI duration: Before sending 'frame done' -> After sending 'frame done':
25,298 samples averaging 0.2 [0 - 71.9]
>= 1: 932 samples averaging 3.3
>= 3: 314 samples averaging 5.9
>= 5: 105 samples averaging 10.2
>= 10: 28 samples averaging 20.7
>= 15: 11 samples averaging 35.1
>= 20: 9 samples averaging 39.2
>= 30: 5 samples averaging 49.8
BWAPI duration: Before listening for 'frame ready' -> After receiving 'frame ready':
25,298 samples averaging 5.6 [0 - 1,100.4]
>= 1: 24587 samples averaging 5.8
>= 3: 11038 samples averaging 10.2
>= 5: 5820 samples averaging 16.1
>= 10: 3767 samples averaging 20.9
>= 15: 2436 samples averaging 25.6
>= 20: 1508 samples averaging 30.7
>= 30: 551 samples averaging 41.7
Copying frame to buffer:
25,298 samples averaging 1.9 [0.8 - 23.8]
>= 5: 187 samples averaging 9.8
>= 10: 81 samples averaging 13.7
>= 15: 19 samples averaging 17.4
>= 20: 3 samples averaging 22.5
Time holding frame until buffer frees capacity:
1 samples averaging 1,435.9 [1,435.9 - 1,435.9]
>= 0: 1 samples averaging 1,435.9
Frames already buffered when enqueuing a new frame:
25,299 samples averaging 0 [0 - 9]
>= 0: 25299 samples averaging 0
>= 1: 126 samples averaging 1.4
Frames behind real-time when handling events:
25,299 samples averaging 0 [0 - 8]
>= 0: 25299 samples averaging 0
>= 1: 10 samples averaging 5.1
Time flushing side effects:
25,299 samples averaging 0 [0 - 12.9]
>= 1: 9 samples averaging 5.9
>= 3: 5 samples averaging 9.4
>= 5: 4 samples averaging 10.7
Duration of bot event handlers:
25,297 samples averaging 20.3 [1.1 - 1,876.9]
>= 5: 25258 samples averaging 20.3
>= 10: 24939 samples averaging 20.5
>= 15: 21698 samples averaging 21.6
>= 20: 15788 samples averaging 23
>= 25: 1948 samples averaging 30.6
>= 30: 525 samples averaging 40.9
>= 35: 204 samples averaging 55
>= 40: 86 samples averaging 79.1
>= 45: 45 samples averaging 112.6
>= 50: 27 samples averaging 156.3
>= 55: 15 samples averaging 239.5
>= 85: 4 samples averaging 730.3
Time bot spent idle:
25,299 samples averaging 6.3 [0 - 1,102.3]
Time client spent waiting for bot:
25,298 samples averaging 18.7 [0 - 675.1]
>= 30: 437 samples averaging 36.6
Excess duration of client sleep:
27,091 samples averaging 0.1 [0 - 646]
>= 1: 590 samples averaging 6.5
>= 5: 238 samples averaging 12.9
>= 10: 69 samples averaging 27.7
>= 15: 21 samples averaging 65
>= 20: 13 samples averaging 95.1
>= 25: 10 samples averaging 117.2
>= 30: 6 samples averaging 177.3
>= 35: 6 samples averaging 177.3
>= 40: 6 samples averaging 177.3
>= 45: 5 samples averaging 204.2
>= 50: 4 samples averaging 244
>= 55: 3 samples averaging 308.7
>= 85: 3 samples averaging 308.7
Positive timer discrepancy compared to BWAPI:
12,598 samples averaging 5.4 [1 - 59]
>= 1: 12598 samples averaging 5.4
>= 2: 11668 samples averaging 5.7
>= 3: 10764 samples averaging 6.1
>= 4: 9783 samples averaging 6.4
>= 5: 8135 samples averaging 6.9
>= 10: 856 samples averaging 12.3
>= 15: 66 samples averaging 21.8
>= 20: 36 samples averaging 26.8
>= 25: 14 samples averaging 34.3
>= 30: 8 samples averaging 39.5
>= 35: 5 samples averaging 44.4
>= 40: 4 samples averaging 46
>= 45: 1 samples averaging 59
>= 50: 1 samples averaging 59
>= 55: 1 samples averaging 59
Negative timer discrepancy compared to BWAPI:
11,698 samples averaging 7 [1 - 27]
>= 1: 11698 samples averaging 7
>= 2: 10582 samples averaging 7.7
>= 3: 9516 samples averaging 8.3
>= 4: 8662 samples averaging 8.8
>= 5: 7978 samples averaging 9.2
>= 10: 3761 samples averaging 11.1
>= 15: 101 samples averaging 15.5
>= 20: 2 samples averaging 25
>= 25: 1 samples averaging 27
Number of events received from BWAPI:
25,298 samples averaging 1.6 [0 - 59]
>= 1: 24375 samples averaging 1.6
>= 2: 3823 samples averaging 4.9
>= 3: 3632 samples averaging 5.1
>= 4: 1631 samples averaging 7.6
>= 5: 1224 samples averaging 8.8
>= 6: 730 samples averaging 11.3
>= 8: 438 samples averaging 14.3
>= 10: 270 samples averaging 17.7
>= 15: 149 samples averaging 22.6
>= 20: 74 samples averaging 28.6
Number of events received from BWAPI, multiplied by the receive-to-sent duration of that frame:
25,298 samples averaging 33.6 [0 - 2,379.9]
>= 5: 24358 samples averaging 34.9
>= 10: 24106 samples averaging 35.1
>= 15: 21433 samples averaging 37.9
>= 20: 16919 samples averaging 43.2
>= 25: 6025 samples averaging 81.5
>= 30: 4480 samples averaging 100.4
>= 35: 3999 samples averaging 108.6
>= 40: 3817 samples averaging 112
>= 45: 3640 samples averaging 115.4
>= 50: 3498 samples averaging 118.1
>= 55: 3370 samples averaging 120.6
>= 85: 1587 samples averaging 179.8
Number of events received from BWAPI, multiplied by the receive-to-sent duration of that frame (Using GetTickCount()):
25,298 samples averaging 33.3 [0 - 1,457]
>= 5: 23836 samples averaging 35.4
>= 10: 23836 samples averaging 35.4
>= 15: 23836 samples averaging 35.4
>= 20: 10595 samples averaging 60
>= 25: 10595 samples averaging 60
>= 30: 10595 samples averaging 60
>= 35: 3831 samples averaging 110.8
>= 40: 3831 samples averaging 110.8
>= 45: 3831 samples averaging 110.8
>= 50: 2487 samples averaging 145.3
>= 55: 2487 samples averaging 145.3
>= 85: 1916 samples averaging 167.7