  INFO [Properties.<init>]                           VERSION: 1.2.0
  INFO [Properties.<init>]                           Classpath: data.jar
  INFO [Properties.<init>]                           Java VM: 14.0-b16
  INFO [Properties.<init>]                           Java Runtime: 1.6.0_14-b08
  INFO [Properties.<init>]                           OS: Windows XP 5.1 x86
  INFO [Properties.<init>]                           Java Library Path: lib
  INFO [Properties.<init>]                           Max Memory: 266403840
  INFO [Properties.<init>]                           Avaialble Processors: 2
  INFO [PropertiesBase.readFromFile]                 Reading Settings from file settings.txt
  INFO [Settings.<init>]                             Settings file not found: settings.txt (The system cannot find the file specified)
  INFO [MasterClient.setServerAddress]               MasterClient: Address http://www.planetmule.com/server
  INFO [MasterClient.logSend]                        MasterClient: Sending Login
  INFO [MasterClient.apply]                          MasterClient: Session ID: e7b332c7140e339d687f131131aee250
  INFO [Login$MasterListener$1.run]                  Logged in as "andrewcaveman" (id 7678)
  INFO [MetaFrame.<init>]                            Creating Meta Frame
  INFO [MapSkinParser.findSkins]                     No extra skins found
  INFO [MasterClient.logSend]                        MasterClient: Sending Enter Lobby
  INFO [Login.dispose]                               Disposing login
  INFO [Main.main]                                   Creating game container
  INFO [MuleGameContainer.create]                    LWJGL Version: 2.2.1
  INFO [MuleGameContainer.create]                    Desktop Display Mode: 1920 x 1200 x 32 @60Hz
  INFO [MuleGameContainer.create]                    Current Display Mode: 1920 x 1200 x 32 @60Hz
  INFO [MuleGameContainer.create]                    Display Adapter: nv4_disp
  INFO [MuleGameContainer.create]                    Display Driver: 6.14.11.9562
  INFO [SlickLogSystem.info]                         Slick Build #269
  INFO [MuleGameContainer.<init>]                    TargetDisplayMode: 640 x 480 x 0 @0Hz
  INFO [MuleGameContainer.setVSync]                  Setting vsync: true
  INFO [MuleGameContainer.<init>]                    Setting pixel format
  INFO [MuleGameContainer$1.run]                     Pixel format: Samples=0 Alpha=0 Depth=8 Stencil=0
  INFO [SlickLogSystem.info]                         Starting display 640x480
  INFO [SlickLogSystem.info]                         Use Java PNG Loader = true
  INFO [MuleGameContainer.<init>]                    Input controllers not available
  INFO [MuleGameContainer.setVSync]                  Setting vsync: true
  INFO [MuleGameContainer.<init>]                    Display finished
  INFO [SettingsDialog.applySettings]                Changing map skin to default
  INFO [Main.main]                                   Entering game loop
  INFO [MetaFrame$MasterListener$1.run]              Entered master server game lobby
  INFO [MuleGameContainer.init]                      *** Starting Game ***
  INFO [MuleGameContainer.init]                      Display Created: true, Active: true, Visible:true
  INFO [MuleGameContainer.init]                      Making display the current GL context
  INFO [MuleGameContainer.setWindowedMode]           Setting windowed mode: 640 x 480 x 0 @0Hz
  INFO [View.<init>]                                 Creating view...
  INFO [SlickLogSystem.info]                         Initialising sounds..
  INFO [SlickLogSystem.info]                         - Sound works
  INFO [SlickLogSystem.info]                         - 64 OpenAL source available
  INFO [SlickLogSystem.info]                         - Sounds source generated
  INFO [View.<init>]                                 Finished creating view
  INFO [GameController.setModel]                     ++++++++ New Model: CONNECT #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [Client.connect]                              Client connects...
  INFO [Client.connect]                              Client UDP local address: 0.0.0.0/0.0.0.0:6261
  INFO [Client.connect]                              Client: Connects TCP: /96.235.0.124:6260 UDP: /96.235.0.124:6260
  INFO [Client.connect]                              Client: TCP receive buffer: 8192 send buffer: 8192
  INFO [MuleGameContainer.setWindowedMode]           Setting windowed mode: 640 x 480 x 0 @0Hz
  INFO [MuleGameContainer.setWindowedMode]           Setting windowed mode: 640 x 480 x 0 @0Hz
  INFO [Client.finishConnect]                        Client finishes connection
  INFO [Client.receiveTCPMessages]                   Client: ServerInfo (0) 35 bytes
  INFO [Client.receiveTCPMessages]                   Client: Join (11) 45 bytes
  INFO [UserController.apply]                        My client id is 65a1e21e-67f7-4463-82bf-1988eaa3d725
  INFO [Player.<init>]                               Creating (P0) spectator
  INFO [GameModel.setMyUser]                         (S11) andrewcaveman is my user
  INFO [GameModel.setLocalUser]                      (S11) andrewcaveman is a local Spectator
  INFO [Client.initUDP]                              Sending UDP initialization message id 65a1e21e-67f7-4463-82bf-1988eaa3d725
  INFO [Client.receiveTCPMessages]                   Client: Increasing TCP recieve buffer for GameModel (0) 7130 bytes
  INFO [Client.receiveTCPMessages]                   Client: GameModel (0) 7130 bytes
  INFO [GameController.setModel]                     ++++++++ New Model: GAME_LOBBY #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [GameModel.setRemoteUser]                     (S10) icm520 is a remote Spectator
  INFO [GameModel.setMyUser]                         (S11) andrewcaveman is my user
  INFO [GameModel.setLocalUser]                      (S11) andrewcaveman is a local Spectator
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (S10) icm520 (ID: 7703)
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (S11) andrewcaveman (ID: 7678)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (S10) icm520 (ID 7703)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (S11) andrewcaveman (ID 7678)
  INFO [Client.receiveTCPMessages]                   Client: PlayerJoin (11) 0 bytes
  INFO [UserController.apply]                        (S11) andrewcaveman joins the players
  INFO [Player.<init>]                               Creating (P11) andrewcaveman
  INFO [GameModel.setMyUser]                         (P11) andrewcaveman is my user
  INFO [GameModel.setLocalUser]                      (P11) andrewcaveman is a local Player
  INFO [Client.receiveTCPMessages]                   Client: PlayerJoin (10) 0 bytes
  INFO [UserController.apply]                        (S10) icm520 joins the players
  INFO [Player.<init>]                               Creating (P10) icm520
  INFO [GameModel.setServerUser]                     (P10) icm520 is hosting the server
  INFO [GameModel.setRemoteUser]                     (P10) icm520 is a remote Player
  INFO [Client.receiveTCPMessages]                   Client: AIJoin (12) 12 bytes
  INFO [Player.<init>]                               Creating (P12) <D.A.N.>
  INFO [UserController.setAiPlayer]                  (P12) <D.A.N.> is an AI player
  INFO [GameModel.setRemoteUser]                     (P12) <D.A.N.> is a remote Player
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: AIJoin (13) 14 bytes
  INFO [Player.<init>]                               Creating (P13) <B.I.L.L.>
  INFO [UserController.setAiPlayer]                  (P13) <B.I.L.L.> is an AI player
  INFO [GameModel.setRemoteUser]                     (P13) <B.I.L.L.> is a remote Player
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [GameLobbyPhase.apply]                        Starting Game - All users want to continue
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P13) <B.I.L.L.> (P10) icm520 (P12) <D.A.N.> (P11) andrewcaveman 
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- INTRO #0 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 172 ms
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- SUMMARY #0 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -4034808078357998798
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P13) <B.I.L.L.> (P12) <D.A.N.> (P10) icm520 (P11) andrewcaveman 
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 33292096
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Money: $1000 Plots: 0 Assets: 220 Total: 1220
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Money: $1000 Plots: 0 Assets: 220 Total: 1220
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10) icm520 Money: $1000 Plots: 0 Assets: 220 Total: 1220
  INFO [SummaryPhase2.begin]                         (P10) icm520 Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Money: $1000 Plots: 0 Assets: 220 Total: 1220
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $48
  INFO [SummaryPhase2.begin]                         Shop Smithore: 8 units $50
  INFO [SummaryPhase2.begin]                         Shop Food: 8 units $30
  INFO [SummaryPhase2.begin]                         Shop Energy: 8 units $25
  INFO [SummaryPhase2.begin]                         Shop mules: 14 $100
  INFO [SummaryPhase2.begin]                         Colony total: 4880
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.buildMules]                             Shop built 0 mules for 0 smithore and now has 14 mules
  INFO [Shop.buildMules]                             A mule now costs $100
  INFO [GameController.beginNextPhase]               --------- INTRO #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 109 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 9
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 93ms, max 93ms
  INFO [LandGrantPhase.apply]                        (P10) icm520 is granted tile 13: River (4,1)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 5
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P13) <B.I.L.L.> is granted tile 21: Plain (3,2)
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P12) <D.A.N.> is granted tile 22: Plain (5,2)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 65
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.update]                       Sending claim tile 28
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P11) andrewcaveman is granted tile 28: Mountain3 (2,3)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [LandAuction.generateColonyAuctions]          Generated 0 colony land auction
  INFO [AbstractLandAuctionPhase.begin]              Land Auctions Player: 0 Colony: 0
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 1427108546574015509
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventPhase.begin]                      No player event for (P13) <B.I.L.L.> (rank 1)
  INFO [Player.useFood]                              (P13) <B.I.L.L.> has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13) <B.I.L.L.>
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.060003247 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 13 timer" at 47.5 (owner 13)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (13) 16 bytes
  INFO [GameModel.developLand]                       (P13) <B.I.L.L.> develops tile Plain (3,2) with Energy factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (13) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 5 "player 13 timer" at 34.4397 (owner 13)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13) <B.I.L.L.> finishes on update 665
  INFO [GameModel.gamble]                            (P13) <B.I.L.L.> gambles $175, max: 47.5, left: 34.22, fraction 0.7204211
  INFO [DevelopmentMessenger.showMessage]            <B.I.L.L.> won $175 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7184217980364608656
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventPhase.begin]                      No player event for (P12) <D.A.N.> (rank 2)
  INFO [Player.useFood]                              (P12) <D.A.N.> has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12) <D.A.N.>
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (12) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.11999674 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 12 timer" at 47.5 (owner 12)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [GameModel.developLand]                       (P12) <D.A.N.> develops tile Plain (5,2) with Energy factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [DevelopmentMessenger.showMessage]            <D.A.N.> caught the Mountain Wampus and got $100
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (12) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 4 "player 12 timer" at 26.49952 (owner 12)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12) <D.A.N.> finishes on update 1059
  INFO [GameModel.gamble]                            (P12) <D.A.N.> gambles $94, max: 47.5, left: 26.34, fraction 0.5545263
  INFO [DevelopmentMessenger.showMessage]            <D.A.N.> won $94 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2843777357023434590
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventPhase.begin]                      No player event for (P10) icm520 (rank 3)
  INFO [Player.useFood]                              (P10) icm520 has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P10) icm520
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.10000324 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 10 timer" at 47.5 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameModel.developLand]                       (P10) icm520 develops tile River (4,1) with Food factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 3 "player 10 timer" at 32.319653 (owner 10)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P10) icm520 finishes on update 753
  INFO [GameModel.gamble]                            (P10) icm520 gambles $183, max: 47.5, left: 32.46, fraction 0.6833684
  INFO [DevelopmentMessenger.showMessage]            icm520 won $183 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -6017008698585420259
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventPhase.begin]                      No player event for (P11) andrewcaveman (rank 4)
  INFO [Player.useFood]                              (P11) andrewcaveman has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11) andrewcaveman
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 3.2484531E-6 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 11 timer" at 47.5 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (11) 16 bytes
  INFO [GameModel.developLand]                       (P11) andrewcaveman develops tile Mountain3 (2,3) with Smithore factory
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman caught the Mountain Wampus and got $100
  INFO [GameModel.buyAssay]                          (P11) andrewcaveman got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [GameModel.gamble]                            (P11) andrewcaveman gambles $53, max: 47.5, left: 11.52, fraction 0.24252632
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman won $53 in the pub
  INFO [AbstractDevelopmentPhase.updatePlayer]       My user (P11) andrewcaveman finishes on update 1800
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (11) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 2 "player 11 timer" at 0.0 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: ACID_RAIN_STORM
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -321771585065492687
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3681832537244473048
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P11) andrewcaveman has 4 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P10) icm520 has 4 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P12) <D.A.N.> has 4 energy and needs 0 energy
  INFO [ProductionPhase.finishPower]                 (P13) <B.I.L.L.> has 4 energy and needs 0 energy
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman expects 0 food, 0 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 expects 8 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> expects 0 food, 2 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> expects 0 food, 2 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman produced 0 food, 0 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 produced 8 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> produced 0 food, 1 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> produced 0 food, 3 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_B #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 8535033256109381553
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $50
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $0
  INFO [Shop.printPriceFactor]                       Smithore shop: 8, mules potentially available: 14, mules needed: 4
  INFO [Shop.printPriceFactor]                       Smithore is decreased to 46%
  INFO [Shop.printPriceFactor]                       Smithore buy price $50 sell price $85
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Smithore: 4 critical: 0 surplus: 4
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Smithore: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 1
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 1
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 1
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 1
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.04000611 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.006757659 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $50 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3846216289647754344
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $48
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $100 sell price $240
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Crystite: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 2
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 2
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 2
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 2
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $100 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3246807357720951553
  INFO [Shop.calcBuySellPrice]                       Current Food price $30
  INFO [Shop.printPriceFactor]                       Food shop: 8, total: 20, needed: 12
  INFO [Shop.printPriceFactor]                       Food is decreased to 70%
  INFO [Shop.printPriceFactor]                       Food buy price $15 sell price $50
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Food: 1 critical: 3 surplus: -2
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Food: 9 critical: 3 surplus: 6
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Food: 1 critical: 3 surplus: -2
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Food: 1 critical: 3 surplus: -2
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 3
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 3
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 3
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 3
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.04000611 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P10) icm520 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 4
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.008569334 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $50 (8 units for $400)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -8640201881516286159
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 8, total: 24, needed: 6
  INFO [Shop.printPriceFactor]                       Energy is decreased to 44%
  INFO [Shop.printPriceFactor]                       Energy buy price $10 sell price $45
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Energy: 3 critical: 2 surplus: 1
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Energy: 3 critical: 2 surplus: 1
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Energy: 4 critical: 1 surplus: 3
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Energy: 6 critical: 1 surplus: 5
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 4
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 5
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 4
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 4
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 6.109476E-6 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.03109906 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $25 (6 units for $62)
  INFO [GameController.beginNextPhase]               --------- SUMMARY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 4197325328091756411
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 52907192
  INFO [SummaryPhase2.begin]                         (P10) icm520 Money: $1358 Plots: 1 Assets: 285 Total: 2143
  INFO [SummaryPhase2.begin]                         (P10) icm520 Food: 3 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Money: $746 Plots: 1 Assets: 710 Total: 1956
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Food: 5 Energy: 6 Smithore: 4 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Money: $966 Plots: 1 Assets: 285 Total: 1751
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Food: 3 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Money: $965 Plots: 1 Assets: 285 Total: 1750
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Food: 3 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $100
  INFO [SummaryPhase2.begin]                         Shop Smithore: 8 units $50
  INFO [SummaryPhase2.begin]                         Shop Food: 6 units $50
  INFO [SummaryPhase2.begin]                         Shop Energy: 11 units $25
  INFO [SummaryPhase2.begin]                         Shop mules: 10 $100
  INFO [SummaryPhase2.begin]                         Colony total: 7600
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.buildMules]                             Shop built 4 mules for 8 smithore and now has 14 mules
  INFO [Shop.buildMules]                             A mule now costs $100
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 5
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 7
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 5
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [LandGrantPhase.apply]                        (P10) icm520 is granted tile 12: Plain (3,1)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 9
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 6
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 5
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 7
  INFO [LandGrantPhase.update]                       Sending claim tile 26
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P13) <B.I.L.L.> is granted tile 26: River (4,3)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 55
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 12
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        Land granted for later tile 35, my current 34. Skipping ahead.
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 7
  INFO [LandGrantPhase.apply]                        (P12) <D.A.N.> is granted tile 35: River (4,4)
  INFO [LandGrantPhase.update]                       Sending claim tile 36
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P11) andrewcaveman is granted tile 36: Plain (5,4)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [LandAuction.generateColonyAuctions]          Generated 1 colony land auction
  INFO [AbstractLandAuctionPhase.begin]              Land Auctions Player: 0 Colony: 1
  INFO [LandAuction.beginAuction]                    Land auction price: $160
  INFO [AbstractLandAuctionPhase.begin]              Starting land auction
  INFO [NetworkTimer.start]                          Started "countdown" at 5.0 (owner 10)
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 5
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 6
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 5
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 5
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.20000418 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 8.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.09029162 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7753952550037143624
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventPhase.begin]                      Event player: (P10) icm520 (rank 1)
  INFO [PlayerEventPhase.begin]                      Event: LostPlot
  INFO [PlayerEventPhase$1.finished]                 Event Message: You lost a plot of land because the claim was not recorded
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Player.useFood]                              (P10) icm520 has 3 food and needs 3 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P10) icm520
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.05999675 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 10 timer" at 47.5 (owner 10)
  INFO [GameModel.buyAssay]                          (P10) icm520 got an assay bot
  INFO [DevelopmentMessenger.showMessage]            No Crystite found
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 3 "player 10 timer" at 28.519566 (owner 10)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P10) icm520 finishes on update 953
  INFO [GameModel.gamble]                            (P10) icm520 gambles $125, max: 47.5, left: 28.460001, fraction 0.5991579
  INFO [DevelopmentMessenger.showMessage]            icm520 won $125 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 664711758611980715
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventPhase.begin]                      No player event for (P11) andrewcaveman (rank 2)
  INFO [Player.useFood]                              (P11) andrewcaveman has 5 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11) andrewcaveman
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.07999675 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 11 timer" at 47.5 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (11) 16 bytes
  INFO [GameModel.developLand]                       (P11) andrewcaveman develops tile Plain (5,4) with Food factory
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman caught the Mountain Wampus and got $100
  INFO [GameModel.gamble]                            (P11) andrewcaveman gambles $62, max: 47.5, left: 8.600002, fraction 0.18105268
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman won $62 in the pub
  INFO [AbstractDevelopmentPhase.updatePlayer]       My user (P11) andrewcaveman finishes on update 1946
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (11) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 2 "player 11 timer" at 0.0 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 110 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2088156034931478780
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventPhase.begin]                      No player event for (P12) <D.A.N.> (rank 3)
  INFO [Player.useFood]                              (P12) <D.A.N.> has 3 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 110 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12) <D.A.N.>
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.060003247 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 12 timer" at 47.5 (owner 12)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (12) 16 bytes
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [GameModel.developLand]                       (P12) <D.A.N.> develops tile River (4,4) with Food factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (12) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 4 "player 12 timer" at 35.059715 (owner 12)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12) <D.A.N.> finishes on update 622
  INFO [GameModel.gamble]                            (P12) <D.A.N.> gambles $177, max: 47.5, left: 35.08, fraction 0.73852634
  INFO [DevelopmentMessenger.showMessage]            <D.A.N.> won $177 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7332019702909790686
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventPhase.begin]                      Event player: (P13) <B.I.L.L.> (rank 4)
  INFO [PlayerEventPhase.begin]                      Event: Charity
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [PlayerEventPhase$1.finished]                 Event Message: A charity from your home-world took pity on you and sent $75
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Player.useFood]                              (P13) <B.I.L.L.> has 3 food and needs 3 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13) <B.I.L.L.>
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.020003248 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 13 timer" at 47.5 (owner 13)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (13) 16 bytes
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [GameModel.developLand]                       (P13) <B.I.L.L.> develops tile River (4,3) with Food factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (13) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 5 "player 13 timer" at 36.699753 (owner 13)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13) <B.I.L.L.> finishes on update 554
  INFO [GameModel.gamble]                            (P13) <B.I.L.L.> gambles $192, max: 47.5, left: 36.440002, fraction 0.767158
  INFO [DevelopmentMessenger.showMessage]            <B.I.L.L.> won $192 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 9153635847587571311
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P11) andrewcaveman has 6 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P10) icm520 has 3 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P12) <D.A.N.> has 2 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P13) <B.I.L.L.> has 2 energy and needs 1 energy
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman expects 2 food, 0 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 expects 4 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> expects 4 food, 3 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> expects 4 food, 3 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman produced 2 food, 0 energy, 5 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 produced 3 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> produced 3 food, 2 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> produced 5 food, 2 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_B #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: FIRE_IN_STORE
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2160933806255785810
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3540514022773119040
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $50
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $3
  INFO [Shop.printPriceFactor]                       Smithore shop: 0, mules potentially available: 11, mules needed: 4
  INFO [Shop.printPriceFactor]                       Smithore is decreased to 52%
  INFO [Shop.printPriceFactor]                       Smithore buy price $53 sell price $88
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Smithore: 9 critical: 0 surplus: 9
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Smithore: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 6
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 7
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 6
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 6
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.04000611 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $53 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3807713210122681349
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $100
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $60 sell price $200
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Crystite: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 7
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 8
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 7
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 7
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $60 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7843005169427956155
  INFO [Shop.calcBuySellPrice]                       Current Food price $50
  INFO [Shop.printPriceFactor]                       Food shop: 0, total: 14, needed: 12
  INFO [Shop.printPriceFactor]                       Food is decreased to 89%
  INFO [Shop.printPriceFactor]                       Food buy price $30 sell price $65
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Food: 3 critical: 3 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Food: 3 critical: 3 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Food: 3 critical: 3 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Food: 5 critical: 3 surplus: 2
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 8
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 9
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 8
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 8
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 6.109476E-6 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P10) icm520 (P12) <D.A.N.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.060897555 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $45 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2730237081077829079
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 0, total: 11, needed: 9
  INFO [Shop.printPriceFactor]                       Energy is decreased to 86%
  INFO [Shop.printPriceFactor]                       Energy buy price $10 sell price $45
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Energy: 3 critical: 3 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Energy: 2 critical: 2 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Energy: 3 critical: 2 surplus: 1
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Energy: 3 critical: 2 surplus: 1
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (12) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (13) 4 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 9
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 10
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 9
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 9
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.04000611 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $25 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- SUMMARY #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -8303606822038898096
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 55723776
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Money: $783 Plots: 2 Assets: 857 Total: 2640
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Food: 3 Energy: 3 Smithore: 9 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Money: $1107 Plots: 2 Assets: 445 Total: 2552
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Food: 5 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Money: $1018 Plots: 2 Assets: 355 Total: 2373
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Food: 3 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10) icm520 Money: $1483 Plots: 1 Assets: 245 Total: 2228
  INFO [SummaryPhase2.begin]                         (P10) icm520 Food: 3 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $60
  INFO [SummaryPhase2.begin]                         Shop Smithore: 0 units $53
  INFO [SummaryPhase2.begin]                         Shop Food: 0 units $45
  INFO [SummaryPhase2.begin]                         Shop Energy: 0 units $25
  INFO [SummaryPhase2.begin]                         Shop mules: 11 $100
  INFO [SummaryPhase2.begin]                         Colony total: 9793
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.buildMules]                             Shop built 0 mules for 0 smithore and now has 11 mules
  INFO [Shop.buildMules]                             A mule now costs $100
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 11 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 93ms, max 93ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P12) <D.A.N.> is granted tile 4: River (4,0)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P10) icm520 is granted tile 12: Plain (3,1)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 3
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.update]                       Sending claim tile 19
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [LandGrantPhase.apply]                        (P11) andrewcaveman is granted tile 19: Plain (2,2)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P13) <B.I.L.L.> is granted tile 25: Plain (3,3)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [LandAuction.generateColonyAuctions]          Generated 1 colony land auction
  INFO [AbstractLandAuctionPhase.begin]              Land Auctions Player: 0 Colony: 1
  INFO [LandAuction.beginAuction]                    Land auction price: $80
  INFO [AbstractLandAuctionPhase.begin]              Starting land auction
  INFO [NetworkTimer.start]                          Started "countdown" at 5.0 (owner 10)
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 10
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 11
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 10
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 10
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019995797 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 8.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.077882886 (owner 10)
  INFO [AbstractLandAuctionPhase.apply]              (P10) icm520 bought the plot for $632
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -6775800265909081512
  INFO [Development.setPlayerOrder]                  Normal development order. 11 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventPhase.begin]                      Event player: (P11) andrewcaveman (rank 1)
  INFO [PlayerEventPhase.begin]                      Event: MuleLostBolt
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [PlayerEventPhase$1.finished]                 Event Message: One of your M.U.L.E.s lost a bolt. Repairs cost you $75
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Player.useFood]                              (P11) andrewcaveman has 3 food and needs 3 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11) andrewcaveman
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.10000324 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 11 timer" at 47.5 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (11) 16 bytes
  INFO [GameModel.developLand]                       (P11) andrewcaveman develops tile Plain (2,2) with Energy factory
  INFO [GameModel.buyAssay]                          (P11) andrewcaveman got an assay bot
  INFO [DevelopmentMessenger.showMessage]            No Crystite found
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman caught the Mountain Wampus and got $100
  INFO [GameModel.gamble]                            (P11) andrewcaveman gambles $74, max: 47.5, left: 10.82, fraction 0.22778946
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman won $74 in the pub
  INFO [AbstractDevelopmentPhase.updatePlayer]       My user (P11) andrewcaveman finishes on update 1835
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (11) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 2 "player 11 timer" at 0.0 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2034544564639524579
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventPhase.begin]                      No player event for (P13) <B.I.L.L.> (rank 2)
  INFO [Player.useFood]                              (P13) <B.I.L.L.> has 5 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13) <B.I.L.L.>
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.040003248 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 13 timer" at 47.5 (owner 13)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (13) 16 bytes
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [GameModel.developLand]                       (P13) <B.I.L.L.> develops tile Plain (3,3) with Energy factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (13) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 5 "player 13 timer" at 34.139694 (owner 13)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13) <B.I.L.L.> finishes on update 672
  INFO [GameModel.gamble]                            (P13) <B.I.L.L.> gambles $138, max: 47.5, left: 34.08, fraction 0.71747375
  INFO [DevelopmentMessenger.showMessage]            <B.I.L.L.> won $138 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 244623454121285948
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventPhase.begin]                      No player event for (P12) <D.A.N.> (rank 3)
  INFO [Player.useFood]                              (P12) <D.A.N.> has 3 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12) <D.A.N.>
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 3.2484531E-6 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 12 timer" at 47.5 (owner 12)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (12) 16 bytes
  INFO [GameModel.developLand]                       (P12) <D.A.N.> develops tile River (4,0) with Food factory
  INFO [DevelopmentMessenger.showMessage]            <D.A.N.> caught the Mountain Wampus and got $100
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (12) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 4 "player 12 timer" at 21.799412 (owner 12)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12) <D.A.N.> finishes on update 1289
  INFO [GameModel.gamble]                            (P12) <D.A.N.> gambles $64, max: 47.5, left: 21.74, fraction 0.45768422
  INFO [DevelopmentMessenger.showMessage]            <D.A.N.> won $64 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2223101532004906811
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventPhase.begin]                      No player event for (P10) icm520 (rank 4)
  INFO [Player.useFood]                              (P10) icm520 has 3 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P10) icm520
  INFO [Wampus.<init>]                               Wumpus has 17 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019996751 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 10 timer" at 47.5 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameModel.developLand]                       (P10) icm520 develops tile Plain (0,0) with Energy factory
  INFO [GameModel.developLand]                       (P10) icm520 develops tile Plain (3,1) with Food factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 3 "player 10 timer" at 12.239193 (owner 10)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P10) icm520 finishes on update 1771
  INFO [GameModel.gamble]                            (P10) icm520 gambles $54, max: 47.5, left: 12.100002, fraction 0.2547369
  INFO [DevelopmentMessenger.showMessage]            icm520 won $54 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1180317221064065910
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P11) andrewcaveman has 3 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P10) icm520 has 2 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P12) <D.A.N.> has 3 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P13) <B.I.L.L.> has 3 energy and needs 1 energy
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman expects 2 food, 3 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 expects 8 food, 3 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> expects 8 food, 3 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> expects 4 food, 8 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman produced 4 food, 2 energy, 3 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 produced 10 food, 2 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> produced 8 food, 4 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> produced 3 food, 7 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_B #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: PLANET_QUAKE
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -5624378448988030760
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1155288759211336534
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $53
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $-7
  INFO [Shop.printPriceFactor]                       Smithore shop: 0, mules potentially available: 6, mules needed: 4
  INFO [Shop.printPriceFactor]                       Smithore is decreased to 75%
  INFO [Shop.printPriceFactor]                       Smithore buy price $43 sell price $78
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Smithore: 10 critical: 0 surplus: 10
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Smithore: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 11
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 12
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 11
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 11
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.020006109 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $43 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -7172947955166578900
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $60
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $108 sell price $248
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Crystite: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 12
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 13
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 12
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 12
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $108 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 1142805677867132915
  INFO [Shop.calcBuySellPrice]                       Current Food price $45
  INFO [Shop.printPriceFactor]                       Food shop: 0, total: 26, needed: 12
  INFO [Shop.printPriceFactor]                       Food is decreased to 60%
  INFO [Shop.printPriceFactor]                       Food buy price $15 sell price $50
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Food: 4 critical: 3 surplus: 1
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Food: 10 critical: 3 surplus: 7
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Food: 8 critical: 3 surplus: 5
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Food: 4 critical: 3 surplus: 1
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 13
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 14
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 13
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 13
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.020006109 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 14
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 14
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.016186884 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $30 (11 units for $165)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -7734866210867717539
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 0, total: 19, needed: 11
  INFO [Shop.printPriceFactor]                       Energy is decreased to 68%
  INFO [Shop.printPriceFactor]                       Energy buy price $10 sell price $45
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Energy: 3 critical: 3 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Energy: 2 critical: 3 surplus: -1
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Energy: 5 critical: 3 surplus: 2
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Energy: 9 critical: 2 surplus: 7
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 79 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 14
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 15
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 15
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 15
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.01999389 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P10) icm520 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.053130146 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $25 (7 units for $73)
  INFO [GameController.beginNextPhase]               --------- SUMMARY #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2391886930909049515
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 58382816
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Money: $702 Plots: 3 Assets: 955 Total: 3157
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Food: 4 Energy: 6 Smithore: 10 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Money: $1173 Plots: 3 Assets: 395 Total: 3068
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Food: 3 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Money: $1142 Plots: 3 Assets: 395 Total: 3037
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Food: 3 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10) icm520 Money: $692 Plots: 3 Assets: 430 Total: 2622
  INFO [SummaryPhase2.begin]                         (P10) icm520 Food: 5 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $108
  INFO [SummaryPhase2.begin]                         Shop Smithore: 0 units $43
  INFO [SummaryPhase2.begin]                         Shop Food: 11 units $30
  INFO [SummaryPhase2.begin]                         Shop Energy: 3 units $25
  INFO [SummaryPhase2.begin]                         Shop mules: 6 $100
  INFO [SummaryPhase2.begin]                         Colony total: 11884
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.buildMules]                             Shop built 0 mules for 0 smithore and now has 6 mules
  INFO [Shop.buildMules]                             A mule now costs $80
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [Development.setPlayerOrder]                  Reverse development order. 6 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P12) <D.A.N.> is granted tile 16: Plain (6,2)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P10) icm520 is granted tile 27: Mountain3 (2,4)
  INFO [LandGrantPhase.update]                       Sending claim tile 28
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P11) andrewcaveman is granted tile 28: Plain (3,4)
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P13) <B.I.L.L.> is granted tile 29: Mountain1 (6,4)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [LandAuction.generateColonyAuctions]          Generated 2 colony land auction
  INFO [AbstractLandAuctionPhase.begin]              Land Auctions Player: 0 Colony: 2
  INFO [LandAuction.beginAuction]                    Land auction price: $572
  INFO [AbstractLandAuctionPhase.begin]              Starting land auction
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [NetworkTimer.start]                          Started "countdown" at 5.0 (owner 10)
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 15
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 16
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 16
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 16
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.100004196 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 8.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.045757167 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (10) 16 bytes
  INFO [AbstractLandAuctionPhase.apply]              (P12) <D.A.N.> bought the plot for $576
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [AbstractLandAuctionPhase.begin]              Land Auctions Player: 0 Colony: 1
  INFO [LandAuction.beginAuction]                    Land auction price: $516
  INFO [AbstractLandAuctionPhase.begin]              Starting land auction
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [NetworkTimer.start]                          Started "countdown" at 5.0 (owner 10)
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 16
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 17
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 17
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 17
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 4.2021275E-6 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 8.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.061953597 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 4158200846075206748
  INFO [Development.setPlayerOrder]                  Reverse development order. 6 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventPhase.begin]                      No player event for (P10) icm520 (rank 4)
  INFO [Player.useFood]                              (P10) icm520 has 5 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P10) icm520
  INFO [Wampus.<init>]                               Wumpus has 13 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 3.2484531E-6 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 10 timer" at 47.5 (owner 10)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [GameModel.developLand]                       (P10) icm520 develops tile Mountain3 (2,4) with Smithore factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 3 "player 10 timer" at 28.539566 (owner 10)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P10) icm520 finishes on update 949
  INFO [GameModel.gamble]                            (P10) icm520 gambles $186, max: 47.5, left: 28.54, fraction 0.6008421
  INFO [DevelopmentMessenger.showMessage]            icm520 won $186 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -6680520925219080153
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventPhase.begin]                      No player event for (P12) <D.A.N.> (rank 3)
  INFO [Player.useFood]                              (P12) <D.A.N.> has 3 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12) <D.A.N.>
  INFO [Wampus.<init>]                               Wumpus has 13 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.020003248 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 12 timer" at 47.5 (owner 12)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (12) 16 bytes
  INFO [GameModel.developLand]                       (P12) <D.A.N.> develops tile Plain (0,4) with Energy factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [GameModel.developLand]                       (P12) <D.A.N.> develops tile Plain (6,2) with Energy factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (12) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 4 "player 12 timer" at 18.059326 (owner 12)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12) <D.A.N.> finishes on update 1475
  INFO [GameModel.gamble]                            (P12) <D.A.N.> gambles $121, max: 47.5, left: 18.02, fraction 0.37936842
  INFO [DevelopmentMessenger.showMessage]            <D.A.N.> won $121 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7428822757708828604
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventPhase.begin]                      Event player: (P13) <B.I.L.L.> (rank 2)
  INFO [PlayerEventPhase.begin]                      Event: DirtySolarCollectors
  INFO [PlayerEventPhase$1.finished]                 Event Message: The Solar Collectors on your energy M.U.L.E.s are dirty. Cleaning cost you $100 each for a total of $200
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Player.useFood]                              (P13) <B.I.L.L.> has 3 food and needs 3 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13) <B.I.L.L.>
  INFO [Wampus.<init>]                               Wumpus has 13 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019996751 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 13 timer" at 47.5 (owner 13)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (13) 16 bytes
  INFO [GameModel.developLand]                       (P13) <B.I.L.L.> develops tile Mountain1 (6,4) with Energy factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (13) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 5 "player 13 timer" at 33.319675 (owner 13)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13) <B.I.L.L.> finishes on update 709
  INFO [GameModel.gamble]                            (P13) <B.I.L.L.> gambles $197, max: 47.5, left: 33.34, fraction 0.70189476
  INFO [DevelopmentMessenger.showMessage]            <B.I.L.L.> won $197 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -5856044604930749081
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventPhase.begin]                      No player event for (P11) andrewcaveman (rank 1)
  INFO [Player.useFood]                              (P11) andrewcaveman has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11) andrewcaveman
  INFO [Wampus.<init>]                               Wumpus has 13 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.060003247 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 11 timer" at 47.5 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (11) 16 bytes
  INFO [GameModel.buyAssay]                          (P11) andrewcaveman got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [GameModel.developLand]                       (P11) andrewcaveman develops tile Plain (3,4) with Crystite factory
  INFO [GameModel.gamble]                            (P11) andrewcaveman gambles $103, max: 47.5, left: 3.4799995, fraction 0.073263146
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman won $103 in the pub
  INFO [AbstractDevelopmentPhase.updatePlayer]       My user (P11) andrewcaveman finishes on update 2202
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (11) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 2 "player 11 timer" at 0.0 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: METEORITE_STRIKE
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 9084393766817676001
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -8547980066877458310
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P11) andrewcaveman has 6 energy and needs 3 energy
  INFO [ProductionPhase.finishPower]                 (P10) icm520 has 3 energy and needs 3 energy
  INFO [ProductionPhase.finishPower]                 (P12) <D.A.N.> has 4 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P13) <B.I.L.L.> has 3 energy and needs 1 energy
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman expects 2 food, 3 energy, 4 smithore, 1 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 expects 8 food, 3 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> expects 8 food, 14 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> expects 4 food, 4 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman produced 2 food, 3 energy, 5 smithore, 1 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 produced 10 food, 3 energy, 3 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> produced 8 food, 12 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> produced 5 food, 3 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_B #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7564992392574532239
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $43
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $2
  INFO [Shop.printPriceFactor]                       Smithore shop: 0, mules potentially available: 1, mules needed: 5
  INFO [Shop.printPriceFactor]                       Smithore is increased to 250%
  INFO [Shop.printPriceFactor]                       Smithore buy price $110 sell price $145
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Smithore: 15 critical: 0 surplus: 15
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Smithore: 3 critical: 0 surplus: 3
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Smithore: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 17
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 18
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 18
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 18
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.01999389 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11) andrewcaveman (P10) icm520 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.029688744 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $110 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 1100997946284824411
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $108
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $96 sell price $236
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Crystite: 1 critical: 0 surplus: 1
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Crystite: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 18
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 19
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 19
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 19
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.8200059 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11) andrewcaveman 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 19
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.052962076 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $96 (1 units for $96)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -6880711605009004341
  INFO [Shop.calcBuySellPrice]                       Current Food price $30
  INFO [Shop.printPriceFactor]                       Food shop: 11, total: 38, needed: 16
  INFO [Shop.printPriceFactor]                       Food is decreased to 57%
  INFO [Shop.printPriceFactor]                       Food buy price $15 sell price $50
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Food: 3 critical: 4 surplus: -1
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Food: 11 critical: 4 surplus: 7
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Food: 8 critical: 4 surplus: 4
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Food: 5 critical: 4 surplus: 1
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 20
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 20
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 20
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 20
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 6.109476E-6 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P10) icm520 (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 21
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 21
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 21
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.03056892 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $30 (12 units for $180)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 6614064561651637118
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 3, total: 31, needed: 13
  INFO [Shop.printPriceFactor]                       Energy is decreased to 56%
  INFO [Shop.printPriceFactor]                       Energy buy price $10 sell price $45
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Energy: 6 critical: 4 surplus: 2
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Energy: 3 critical: 4 surplus: -1
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Energy: 14 critical: 3 surplus: 11
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Energy: 5 critical: 2 surplus: 3
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 21
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 22
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 22
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 22
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.060006108 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P10) icm520 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11) andrewcaveman (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.04511314 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $25 (12 units for $126)
  INFO [GameController.beginNextPhase]               --------- SUMMARY #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 4606370631041731846
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 57250240
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Money: $676 Plots: 4 Assets: 2370 Total: 5046
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Food: 6 Energy: 6 Smithore: 15 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10) icm520 Money: $802 Plots: 4 Assets: 890 Total: 3692
  INFO [SummaryPhase2.begin]                         (P10) icm520 Food: 4 Energy: 5 Smithore: 3 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Money: $593 Plots: 5 Assets: 595 Total: 3688
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Money: $1075 Plots: 4 Assets: 425 Total: 3500
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Food: 4 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $96
  INFO [SummaryPhase2.begin]                         Shop Smithore: 0 units $110
  INFO [SummaryPhase2.begin]                         Shop Food: 20 units $30
  INFO [SummaryPhase2.begin]                         Shop Energy: 13 units $25
  INFO [SummaryPhase2.begin]                         Shop mules: 1 $80
  INFO [SummaryPhase2.begin]                         Colony total: 15926
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.buildMules]                             Shop built 0 mules for 0 smithore and now has 1 mules
  INFO [Shop.buildMules]                             A mule now costs $220
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [Development.setPlayerOrder]                  Reverse development order. 1 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 3
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P12) <D.A.N.> is granted tile 11: Mountain2 (6,1)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 3
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P10) icm520 is granted tile 17: Mountain2 (8,2)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 5
  INFO [LandGrantPhase.update]                       Sending claim tile 19
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P11) andrewcaveman is granted tile 19: Plain (1,3)
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 78ms, max 78ms
  INFO [LandGrantPhase.apply]                        (P13) <B.I.L.L.> is granted tile 20: Mountain1 (5,3)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [LandAuction.generateColonyAuctions]          Generated 0 colony land auction
  INFO [AbstractLandAuctionPhase.begin]              Land Auctions Player: 0 Colony: 0
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 5873646272218275631
  INFO [Development.setPlayerOrder]                  Reverse development order. 1 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventPhase.begin]                      Event player: (P13) <B.I.L.L.> (rank 4)
  INFO [PlayerEventPhase.begin]                      Event: MuseumBoughtComputer
  INFO [PlayerEventPhase$1.finished]                 Event Message: The museum bought your antique personal computer for $400
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Player.useFood]                              (P13) <B.I.L.L.> has 4 food and needs 4 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 78 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13) <B.I.L.L.>
  INFO [Wampus.<init>]                               Wumpus has 8 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.020003248 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 13 timer" at 47.5 (owner 13)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (13) 16 bytes
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [GameModel.developLand]                       (P13) <B.I.L.L.> develops tile Crater (3,3) with Crystite factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (13) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 5 "player 13 timer" at 34.059692 (owner 13)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13) <B.I.L.L.> finishes on update 672
  INFO [GameModel.gamble]                            (P13) <B.I.L.L.> gambles $112, max: 47.5, left: 34.08, fraction 0.71747375
  INFO [DevelopmentMessenger.showMessage]            <B.I.L.L.> won $112 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 6424331386503261587
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventPhase.begin]                      No player event for (P12) <D.A.N.> (rank 3)
  INFO [Player.useFood]                              (P12) <D.A.N.> has 4 food and needs 4 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12) <D.A.N.>
  INFO [Wampus.<init>]                               Wumpus has 8 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.060003247 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 12 timer" at 47.5 (owner 12)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (12) 16 bytes
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (12) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 4 "player 12 timer" at 46.19997 (owner 12)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12) <D.A.N.> finishes on update 60
  INFO [GameModel.gamble]                            (P12) <D.A.N.> gambles $154, max: 47.5, left: 46.32, fraction 0.9751579
  INFO [DevelopmentMessenger.showMessage]            <D.A.N.> won $154 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3940446225036960200
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventPhase.begin]                      Event player: (P10) icm520 (rank 2)
  INFO [PlayerEventPhase.begin]                      Event: RelativeDied
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [PlayerEventPhase$1.finished]                 Event Message: A distant relative died and left you a vast fortune. But after taxes you only got $200
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Player.useFood]                              (P10) icm520 has 4 food and needs 4 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P10) icm520
  INFO [Wampus.<init>]                               Wumpus has 8 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019996751 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 10 timer" at 47.5 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameModel.buyAssay]                          (P10) icm520 got an assay bot
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 3 "player 10 timer" at 31.099625 (owner 10)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P10) icm520 finishes on update 831
  INFO [GameModel.gamble]                            (P10) icm520 gambles $123, max: 47.5, left: 30.9, fraction 0.6505263
  INFO [DevelopmentMessenger.showMessage]            icm520 won $123 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3512800983707243161
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventPhase.begin]                      No player event for (P11) andrewcaveman (rank 1)
  INFO [Player.useFood]                              (P11) andrewcaveman has 6 food and needs 4 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11) andrewcaveman
  INFO [Wampus.<init>]                               Wumpus has 8 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019996751 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 11 timer" at 47.5 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (11) 16 bytes
  INFO [GameModel.buyAssay]                          (P11) andrewcaveman got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman caught the Mountain Wampus and got $200
  INFO [GameModel.gamble]                            (P11) andrewcaveman gambles $156, max: 47.5, left: 22.82, fraction 0.48042104
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman won $156 in the pub
  INFO [AbstractDevelopmentPhase.updatePlayer]       My user (P11) andrewcaveman finishes on update 1235
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (11) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 2 "player 11 timer" at 0.0 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -5613372309484794641
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P11) andrewcaveman has 6 energy and needs 3 energy
  INFO [ProductionPhase.finishPower]                 (P10) icm520 has 5 energy and needs 3 energy
  INFO [ProductionPhase.finishPower]                 (P12) <D.A.N.> has 4 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P13) <B.I.L.L.> has 3 energy and needs 2 energy
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman expects 2 food, 3 energy, 4 smithore, 1 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 expects 8 food, 3 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> expects 8 food, 14 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> expects 4 food, 4 energy, 0 smithore, 4 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [ProductionPhase.logProduction]               (P11) andrewcaveman produced 3 food, 3 energy, 2 smithore, 2 crystite
  INFO [ProductionPhase.logProduction]               (P10) icm520 produced 7 food, 2 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12) <D.A.N.> produced 6 food, 14 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13) <B.I.L.L.> produced 3 food, 4 energy, 0 smithore, 5 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_B #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: PEST_ATTACK
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2973190046758996069
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 8942005424176077997
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $110
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $10
  INFO [Shop.printPriceFactor]                       Smithore shop: 0, mules potentially available: 0, mules needed: 8
  INFO [Shop.printPriceFactor]                       Smithore is increased to 250%
  INFO [Shop.printPriceFactor]                       Smithore buy price $230 sell price $265
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Smithore: 17 critical: 0 surplus: 17
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Smithore: 7 critical: 0 surplus: 7
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Smithore: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Smithore: 0 critical: 0 surplus: 0
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 22
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 23
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 23
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 23
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.03999389 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11) andrewcaveman (P10) icm520 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 24
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 23
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.027355174 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $230 (24 units for $5520)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3211619310989299925
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $96
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $116 sell price $256
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Crystite: 2 critical: 0 surplus: 2
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Crystite: 0 critical: 0 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Crystite: 5 critical: 0 surplus: 5
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 24
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 25
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 24
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 24
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.08000611 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P10) icm520 (P12) <D.A.N.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11) andrewcaveman (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 25
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 25
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.058308933 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $116 (7 units for $812)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 8802979433118572453
  INFO [Shop.calcBuySellPrice]                       Current Food price $30
  INFO [Shop.printPriceFactor]                       Food shop: 20, total: 37, needed: 16
  INFO [Shop.printPriceFactor]                       Food is decreased to 57%
  INFO [Shop.printPriceFactor]                       Food buy price $15 sell price $50
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Food: 1 critical: 4 surplus: -3
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Food: 7 critical: 4 surplus: 3
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Food: 6 critical: 4 surplus: 2
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Food: 3 critical: 4 surplus: -1
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 26
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 26
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 25
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 26
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 6.109476E-6 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11) andrewcaveman (P13) <B.I.L.L.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P10) icm520 (P12) <D.A.N.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 27
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 26
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.098593146 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $40 (10 units for $405)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2041668685991881238
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 13, total: 44, needed: 14
  INFO [Shop.printPriceFactor]                       Energy is decreased to 49%
  INFO [Shop.printPriceFactor]                       Energy buy price $10 sell price $45
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P11) andrewcaveman Energy: 6 critical: 4 surplus: 2
  INFO [CollectionPhase.goToNextPhase]               (P10) icm520 Energy: 4 critical: 4 surplus: 0
  INFO [CollectionPhase.goToNextPhase]               (P12) <D.A.N.> Energy: 16 critical: 3 surplus: 13
  INFO [CollectionPhase.goToNextPhase]               (P13) <B.I.L.L.> Energy: 5 critical: 3 surplus: 2
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 93 ms
  INFO [Player.increaseAuctionTeleportCount]         (P11) andrewcaveman auction teleport count: 27
  INFO [Player.increaseAuctionTeleportCount]         (P10) icm520 auction teleport count: 28
  INFO [Player.increaseAuctionTeleportCount]         (P12) <D.A.N.> auction teleport count: 27
  INFO [Player.increaseAuctionTeleportCount]         (P13) <B.I.L.L.> auction teleport count: 27
  INFO [NetworkTimer.start]                          Started "countdown" at 7.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.020006109 (owner 10)
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P10) icm520 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11) andrewcaveman (P12) <D.A.N.> (P13) <B.I.L.L.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 20 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Transaction (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.098969474 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $25 (13 units for $130)
  INFO [GameController.beginNextPhase]               --------- SUMMARY #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7892009898721118132
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 56369168
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Money: $4801 Plots: 5 Assets: 940 Total: 8241
  INFO [SummaryPhase2.begin]                         (P11) andrewcaveman Food: 10 Energy: 6 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10) icm520 Money: $2831 Plots: 5 Assets: 575 Total: 5906
  INFO [SummaryPhase2.begin]                         (P10) icm520 Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Money: $1825 Plots: 5 Assets: 625 Total: 4950
  INFO [SummaryPhase2.begin]                         (P13) <B.I.L.L.> Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Money: $926 Plots: 6 Assets: 635 Total: 4561
  INFO [SummaryPhase2.begin]                         (P12) <D.A.N.> Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $116
  INFO [SummaryPhase2.begin]                         Shop Smithore: 24 units $230
  INFO [SummaryPhase2.begin]                         Shop Food: 15 units $40
  INFO [SummaryPhase2.begin]                         Shop Energy: 26 units $25
  INFO [SummaryPhase2.begin]                         Shop mules: 0 $220
  INFO [SummaryPhase2.begin]                         Colony total: 23658
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Shop.buildMules]                             Shop built 8 mules for 16 smithore and now has 8 mules
  INFO [Shop.buildMules]                             A mule now costs $460
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 8 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P10) icm520 is granted tile 7: Plain (0,1)
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P12) <D.A.N.> is granted tile 9: Mountain2 (2,1)
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P13) <B.I.L.L.> is granted tile 13: Mountain2 (0,2)
  INFO [LandGrantPhase.update]                       Sending claim tile 14
  INFO [Client.receiveTCPMessages]                   Client: LandGranted (0) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 94ms, max 94ms
  INFO [LandGrantPhase.apply]                        (P11) andrewcaveman is granted tile 14: Plain (1,2)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [LandAuction.generateColonyAuctions]          Generated 0 colony land auction
  INFO [AbstractLandAuctionPhase.begin]              Land Auctions Player: 0 Colony: 0
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 3051169208205921065
  INFO [Development.setPlayerOrder]                  Normal development order. 8 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventPhase.begin]                      No player event for (P11) andrewcaveman (rank 1)
  INFO [Player.useFood]                              (P11) andrewcaveman has 10 food and needs 4 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11) andrewcaveman
  INFO [Wampus.<init>]                               Wumpus has 4 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.060003247 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 11 timer" at 47.5 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (11) 16 bytes
  INFO [GameModel.buyAssay]                          (P11) andrewcaveman got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Medium amounts of Crystite
  INFO [GameModel.developLand]                       (P11) andrewcaveman develops tile Plain (1,3) with Crystite factory
  INFO [GameModel.developLand]                       (P11) andrewcaveman develops tile Plain (1,2) with Energy factory
  INFO [GameModel.gamble]                            (P11) andrewcaveman gambles $100, max: 47.5, left: -0.0399971, fraction -8.4204425E-4
  INFO [DevelopmentMessenger.showMessage]            andrewcaveman won $100 in the pub
  INFO [AbstractDevelopmentPhase.updatePlayer]       My user (P11) andrewcaveman finishes on update 2378
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (11) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 2 "player 11 timer" at 0.0 (owner 11)
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2867870502116304721
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventPhase.begin]                      No player event for (P10) icm520 (rank 2)
  INFO [Player.useFood]                              (P10) icm520 has 4 food and needs 4 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P10) icm520
  INFO [Wampus.<init>]                               Wumpus has 4 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.08000325 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 10 timer" at 47.5 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [GameModel.developLand]                       (P10) icm520 develops tile Plain (0,1) with Energy factory
  INFO [GameModel.developLand]                       (P10) icm520 develops tile Mountain2 (8,2) with Crystite factory
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 3 "player 10 timer" at 8.839115 (owner 10)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P10) icm520 finishes on update 1944
  INFO [GameModel.gamble]                            (P10) icm520 gambles $118, max: 47.5, left: 8.639999, fraction 0.18189472
  INFO [DevelopmentMessenger.showMessage]            icm520 won $118 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2950853421098349053
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventPhase.begin]                      No player event for (P13) <B.I.L.L.> (rank 3)
  INFO [Player.useFood]                              (P13) <B.I.L.L.> has 4 food and needs 4 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #6 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13) <B.I.L.L.>
  INFO [Wampus.<init>]                               Wumpus has 4 mountains, reward is $200
  INFO [NetworkTimer.start]                          Started "countdown" at 4.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (13) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.03999675 (owner 10)
  INFO [NetworkTimer.start]                          Started "player 13 timer" at 47.5 (owner 13)
  INFO [GameModel.developLand]                       (P13) <B.I.L.L.> develops tile Mountain2 (0,2) with Smithore factory
  INFO [GameModel.developLand]                       (P13) <B.I.L.L.> develops tile Mountain1 (5,3) with Smithore factory
  INFO [DevelopmentMessenger.showMessage]            <B.I.L.L.> caught the Mountain Wampus and got $200
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (13) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 5 "player 13 timer" at 9.279125 (owner 13)
  INFO [GameModel.gamble]                            (P13) <B.I.L.L.> gambles $121, max: 47.5, left: 9.040001, fraction 0.19031581
  INFO [DevelopmentMessenger.showMessage]            <B.I.L.L.> won $121 in the pub
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13) <B.I.L.L.> finishes on update 1924
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [GameController.apply]                        (P11) andrewcaveman chat: Benny
  INFO [GameController.apply]                        (P11) andrewcaveman chat: Benny
  INFO [MetaFrame$5.actionPerformed]                 User chooses to disconnect
  INFO [MuleGameContainer.release]                   Closing game.
  INFO [GameController.close]                        -------- CLOSING GAME CONTROLLER ----------------------------------
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
