  INFO [Properties.<init>]                           VERSION: 1.3.6
  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 7 6.1 x86
  INFO [Properties.<init>]                           Java Library Path: lib
  INFO [Properties.<init>]                           Max Memory: 266403840
  INFO [Properties.<init>]                           Avaialble Processors: 8
  INFO [PropertiesBase.readFromFile]                 Reading Settings from file settings.txt
  INFO [SubstanceLoader.initLookAndFeel]             Window Skin: Default
  INFO [Main.main]                                   lpSolve: 5.5 Release 0 Build 15
  INFO [SoundPlayer.initialize]                      Initializing Sound System
  INFO [SlickLogSystem.info]                         Initialising sounds..
  INFO [SlickLogSystem.info]                         - Sound works
  INFO [SlickLogSystem.info]                         - 64 OpenAL source available
  INFO [SlickLogSystem.info]                         - Sounds source generated
  INFO [MasterClient.setServerAddress]               MasterClient: Address http://www.planetmule.com/server
  INFO [MasterClient.logSend]                        MasterClient: Sending Login
  INFO [MasterClient.apply]                          MasterClient: Session ID: obn3lq7l690oulj7a0buvrhrc3
  INFO [Login$MasterListener$1.run]                  Logged in as "softwall" (id 101991)
  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.<init>]                    LWJGL Version: 2.4.2
  INFO [MuleGameContainer.<init>]                    Desktop Display Mode: 1600 x 900 x 32 @59Hz
  INFO [MuleGameContainer.<init>]                    Current Display Mode: 1600 x 900 x 32 @59Hz
  INFO [MuleGameContainer.<init>]                    Display Adapter: nvd3dumx,nvwgf2umx,nvwgf2umx
  INFO [MuleGameContainer.<init>]                    Display Driver: null
  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 [MuleGameContainer.<init>]                    GL Vendor: NVIDIA Corporation
  INFO [MuleGameContainer.<init>]                    GL Renderer: GeForce 310M/PCIe/SSE2
  INFO [MuleGameContainer.<init>]                    GL Version: 3.3.0
  INFO [MuleGameContainer.<init>]                    GL Max Texture Size: null
  INFO [SlickLogSystem.info]                         Use Java PNG Loader = true
  INFO [MuleGameContainer.<init>]                    Display finished
  INFO [Main.main]                                   Entering game loop
++++++++ END OF INITIALIZATION +++++++++++++++++++++++++++++++++++++++++++
  INFO [MetaFrame.startGame]                         Starting game number 0
  INFO [MetaFrame.startGame]                         Entering Game - ID: 0, Name: ChuckieBotII-1794, Address: 98.255.118.158, Is Host: false
  INFO [MuleGameContainer.init]                      *** Starting Game ***
  INFO [MuleGameContainer.init]                      Display: Created=true Active=false Visible=true
  INFO [MuleGameContainer.init]                      Making display the current GL context
  INFO [View.<init>]                                 Creating view...
  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: /98.255.118.158:6260 UDP: /98.255.118.158: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 [Client.finishConnect]                        Client finishes connection
  INFO [Client.receiveTCPMessages]                   Client: ServerInfo (0) 35 bytes
  INFO [Client.receiveTCPMessages]                   Client: Join (15) 40 bytes
  INFO [UserController.apply]                        My client id is 1833040a-7ea3-43a6-a428-1dcd73dac6eb
  INFO [Player.<init>]                               Creating (P0)Spectator
  INFO [GameModel.setMyUser]                         (S15)softwall is my user
  INFO [GameModel.setLocalUser]                      (S15)softwall is a local Spectator
  INFO [Client.initUDP]                              Sending UDP initialization message id 1833040a-7ea3-43a6-a428-1dcd73dac6eb
  INFO [Client.receiveTCPMessages]                   Client: Increasing TCP recieve buffer for GameModel (0) 7447 bytes
  INFO [Client.receiveTCPMessages]                   Client: GameModel (0) 7447 bytes
  INFO [GameController.setModel]                     ++++++++ New Model: GAME_LOBBY #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [GameModel.setRemoteUser]                     (S10)CCMuleBot04 is a remote Spectator
  INFO [GameModel.setRemoteUser]                     (P11)mulefox is a remote Player
  INFO [GameModel.setRemoteUser]                     (P13)htman_2000 is a remote Player
  INFO [GameModel.setRemoteUser]                     (P12)mr.earl is a remote Player
  INFO [GameModel.setRemoteUser]                     (P14)speedymule is a remote Player
  INFO [GameModel.setMyUser]                         (S15)softwall is my user
  INFO [GameModel.setLocalUser]                      (S15)softwall is a local Spectator
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (S10)CCMuleBot04 (ID: 100002)
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (S15)softwall (ID: 101991)
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (P12)mr.earl (ID: 25761)
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (P11)mulefox (ID: 100005)
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (P13)htman_2000 (ID: 17861)
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (P14)speedymule (ID: 100006)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (S10)CCMuleBot04 (ID 100002)
  INFO [GameController.apply]                        (S10)CCMuleBot04 chat: Greetings softwall .  This is a chatterbot hosted game.
  INFO [GameController.apply]                        (S10)CCMuleBot04 chat: For a list of commands type "Bot :?"
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (S15)softwall (ID 101991)
  INFO [GameController.apply]                        (S10)CCMuleBot04 chat: Please join our facebook group.
  INFO [GameController.apply]                        (S10)CCMuleBot04 chat: http://www.fb.com/groups/planetmule/
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (P12)mr.earl (ID 25761)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (P11)mulefox (ID 100005)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (P13)htman_2000 (ID 17861)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (P14)speedymule (ID 100006)
  INFO [GameController.apply]                        (S10)CCMuleBot04 chat: === softwall Bot Reputation: Unknown (1) Bot Games: 1
  INFO [GameController.apply]                        (P12)mr.earl chat: ok
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [GameController.apply]                        (P12)mr.earl chat: cool ready when ever
  INFO [GameController.apply]                        (P12)mr.earl chat: jst start'
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [GameLobbyPhase.apply]                        Starting Game - All players want to continue
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P12)mr.earl (P13)htman_2000 (P14)speedymule (P11)mulefox 
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 38
  INFO [GameController.beginNextPhase]               --------- INTRO #0 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.apply]                        (P13)htman_2000 chat: gla
  INFO [GameController.apply]                        (P12)mr.earl chat: ok fine we are off
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- SUMMARY #0 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -6673556838630041788
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 42501120
  INFO [SummaryPhase2.begin]                         (P11)mulefox Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P11)mulefox Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P14)speedymule Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P14)speedymule Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [Shop.buildMules]                             Shop built 0 mules for 0 smithore and now has 14 mules
  INFO [Shop.buildMules]                             A mule now costs $100
  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: 4680
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        (P12)mr.earl chat: gla
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 38
  INFO [GameController.beginNextPhase]               --------- INTRO #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 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 [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 6
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #1 --------------------------------------------------------
  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 3 frames, rountrip 94ms, max 219ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.apply]                        Grace duration 19 frames
  INFO [LandGrantPhase.apply]                        Starting land grant
  INFO [LandGrantPhase.claimPlot]                    (P11)mulefox is granted tile 1: Mountain3 (1,0)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P13)htman_2000 is granted tile 20: Plain (2,2)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P14)speedymule is granted tile 21: Mountain3 (3,2)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 47
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 3
  INFO [LandGrantPhase.claimPlot]                    (P12)mr.earl is granted tile 28: Mountain3 (2,3)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.moveToNextTile]               Land grant ends
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 19
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [PlotSeller.generateNextColonyAuction]        Colony sells plot #1
  INFO [PlotSeller.beginAuction]                     Starting auction set
  INFO [PlotSeller.beginAuction]                     Land auction price: $160
  INFO [AbstractAuctionController.begin]             Begin auction id 1
  INFO [GameController.apply]                        (P12)mr.earl chat: bot:pings
  INFO [GameController.apply]                        (S10)CCMuleBot04 chat: Pings:  Bot: 0ms (0ms) mulefox : 219ms (219ms) htman_2000 : 156ms (156ms) mr.earl : 94ms (94ms) speedymule : 203ms (203ms) <S15> 94ms (94ms) 
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     LandAuctionStart is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 34.25 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [SlickLogSystem.info]                         Local players finished auction
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.0625376 (owner 10)
  INFO [AbstractLandAuctionPhase.update]             Reached final auction state
  INFO [AbstractLandAuctionPhase.buyLand]            (P11)mulefox bought the plot for $972
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [PlotSeller.generateNextColonyAuction]        Colony sells plot #2
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 21
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [PlotSeller.beginAuction]                     Land auction price: $912
  INFO [AbstractAuctionController.begin]             Begin auction id 2
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     LandAuctionStart is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 34.25 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [SlickLogSystem.info]                         Local players finished auction
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (0) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.07706505 (owner 10)
  INFO [AbstractLandAuctionPhase.update]             Reached final auction state
  INFO [AbstractLandAuctionPhase.buyLand]            (P14)speedymule bought the plot for $972
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [PlotSeller.generateNextColonyAuction]        Colony doesn't sell a plot
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 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: Ready (14) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 19
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 915199578080575018
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventGenerator.nextEvent]              No event frist round
  INFO [PlayerEventPhase.begin]                      No player event for (P11)mulefox (rank 1)
  INFO [Player.useFood]                              (P11)mulefox has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11)mulefox
  INFO [Wampus.<init>]                               Wampus has 10 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.05999675 (owner 10)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 126. End Update: 125
  INFO [GameModel.buyAssay]                          (P11)mulefox got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Medium amounts of Crystite
  INFO [GameModel.buyAssay]                          (P11)mulefox got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 1523. End Update: 1522
  INFO [DevelopmentMessenger.showMessage]            mulefox caught the Mountain Wampus and got $100
  INFO [AbstractDevelopmentPhase.apply]              Remote (P11)mulefox finishes on update 2315
  INFO [GameModel.gamble]                            (P11)mulefox gambles $52, max: 47.5, left: 1.7191024, fraction 0.036191627
  INFO [DevelopmentMessenger.showMessage]            mulefox won $52 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  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 (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 15
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 6261929911699684699
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventGenerator.nextEvent]              No event frist round
  INFO [PlayerEventPhase.begin]                      No player event for (P13)htman_2000 (rank 2)
  INFO [Player.useFood]                              (P13)htman_2000 has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 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: (P13)htman_2000
  INFO [Wampus.<init>]                               Wampus has 10 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 [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 445. End Update: 444
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 596. End Update: 595
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Plain (2,2) with Energy factory
  INFO [GameModel.buyAssay]                          (P13)htman_2000 got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [DevelopmentMessenger.showMessage]            htman_2000 caught the Mountain Wampus and got $100
  INFO [GameModel.buyAssay]                          (P13)htman_2000 got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13)htman_2000 finishes on update 1809
  INFO [GameModel.gamble]                            (P13)htman_2000 gambles $68, max: 47.5, left: 11.859184, fraction 0.24966703
  INFO [DevelopmentMessenger.showMessage]            htman_2000 won $68 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 8
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2376604203335982801
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventGenerator.nextEvent]              No event frist round
  INFO [PlayerEventPhase.begin]                      No player event for (P12)mr.earl (rank 3)
  INFO [Player.useFood]                              (P12)mr.earl has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12)mr.earl
  INFO [Wampus.<init>]                               Wampus has 10 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 3.2484531E-6 (owner 10)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 382. End Update: 381
  INFO [GameModel.developLand]                       (P12)mr.earl develops tile Mountain3 (2,3) with Smithore factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 708. End Update: 707
  INFO [GameModel.buyAssay]                          (P12)mr.earl got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found High amounts of Crystite
  INFO [DevelopmentMessenger.showMessage]            mr.earl caught the Mountain Wampus and got $100
  INFO [GameModel.buyAssay]                          (P12)mr.earl got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12)mr.earl finishes on update 2134
  INFO [GameModel.gamble]                            (P12)mr.earl gambles $65, max: 47.5, left: 6.179098, fraction 0.13008627
  INFO [DevelopmentMessenger.showMessage]            mr.earl won $65 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 21
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7653474083630041277
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventGenerator.nextEvent]              No event frist round
  INFO [PlayerEventPhase.begin]                      No player event for (P14)speedymule (rank 4)
  INFO [Player.useFood]                              (P14)speedymule has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 3
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P14)speedymule
  INFO [Wampus.<init>]                               Wampus has 10 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.03999675 (owner 10)
  INFO [GameModel.buyAssay]                          (P14)speedymule got an assay bot
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 194. End Update: 193
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 260. End Update: 259
  INFO [DevelopmentMessenger.showMessage]            Found Low amounts of Crystite
  INFO [GameModel.buyAssay]                          (P14)speedymule got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found High amounts of Crystite
  INFO [DevelopmentMessenger.showMessage]            speedymule caught the Mountain Wampus and got $100
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (7,0) with Food factory
  INFO [AbstractDevelopmentPhase.apply]              Remote (P14)speedymule finishes on update 2257
  INFO [GameModel.gamble]                            (P14)speedymule gambles $61, max: 47.5, left: 2.9191012, fraction 0.06145476
  INFO [DevelopmentMessenger.showMessage]            speedymule won $61 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 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 [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 25
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: SUNSPOT_ACTIVITY
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2788524490776153315
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 1526823653627629667
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P12)mr.earl has 2 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P11)mulefox has 2 energy and needs 0 energy
  INFO [ProductionPhase.finishPower]                 (P13)htman_2000 has 2 energy and needs 0 energy
  INFO [ProductionPhase.finishPower]                 (P14)speedymule has 2 energy and needs 1 energy
  INFO [ProductionPhase.logProduction]               (P12)mr.earl expects 0 food, 0 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox expects 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 expects 0 food, 6 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule expects 2 food, 0 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [ProductionPhase.apply]                       Skipping production
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [ProductionPhase.logProduction]               (P12)mr.earl produced 0 food, 0 energy, 3 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox produced 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 produced 0 food, 5 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule produced 1 food, 0 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 4
  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: -8386019591614293168
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $50
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $-1
  INFO [Shop.printPriceFactor]                       Smithore shop: 8, mules potentially available: 15, mules needed: 7
  INFO [Shop.printPriceFactor]                       Smithore is decreased to 60%
  INFO [Shop.printPriceFactor]                       Smithore buy price $49 sell price $84
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Smithore: 3 critical: 0 surplus: 3 money: $990
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Smithore: 0 critical: 0 surplus: 0 money: $180
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Smithore: 0 critical: 0 surplus: 0 money: $1018
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Smithore: 0 critical: 0 surplus: 0 money: $64
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 6
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 1
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (12) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019994844 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  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: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #1
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [SlickLogSystem.info]                         Transaction #3
  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.03865671 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $84 (3 units for $252)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 8
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -7030005849358503217
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $48
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $64 sell price $204
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Crystite: 0 critical: 0 surplus: 0 money: $738
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Crystite: 0 critical: 0 surplus: 0 money: $180
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Crystite: 0 critical: 0 surplus: 0 money: $1018
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Crystite: 0 critical: 0 surplus: 0 money: $64
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 1
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $64 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -17699164358425919
  INFO [Shop.calcBuySellPrice]                       Current Food price $30
  INFO [Shop.printPriceFactor]                       Food shop: 8, total: 13, needed: 12
  INFO [Shop.printPriceFactor]                       Food is decreased to 94%
  INFO [Shop.printPriceFactor]                       Food buy price $15 sell price $50
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Food: 1 critical: 3 surplus: -2 money: $738
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Food: 1 critical: 3 surplus: -2 money: $180
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Food: 1 critical: 3 surplus: -2 money: $1018
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Food: 2 critical: 3 surplus: -1 money: $64
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 15
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 1
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.039994843 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  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: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #1
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [SlickLogSystem.info]                         Transaction #3
  INFO [SlickLogSystem.info]                         Transaction #4
  INFO [SlickLogSystem.info]                         Transaction #5
  INFO [SlickLogSystem.info]                         Transaction #6
  INFO [SlickLogSystem.info]                         Transaction #7
  INFO [SlickLogSystem.info]                         Transaction #8
  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.034510426 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $50 (8 units for $400)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 7
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -4248553442180372903
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 8, total: 19, needed: 6
  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 [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Energy: 1 critical: 2 surplus: -1 money: $488
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Energy: 2 critical: 1 surplus: 1 money: $180
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Energy: 7 critical: 1 surplus: 6 money: $868
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Energy: 1 critical: 2 surplus: -1 money: $64
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 4
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 1
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (11) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019994844 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P13)htman_2000 
  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 [SlickLogSystem.info]                         Transaction #1
  INFO [Player.increaseAuctionTeleportCount]         (P14)speedymule auction teleport count: 1
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [SlickLogSystem.info]                         Transaction #3
  INFO [SlickLogSystem.info]                         Transaction #4
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #5
  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.06701119 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $45 (5 units for $225)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 8
  INFO [GameController.beginNextPhase]               --------- SUMMARY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 6523949783665647394
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 10459536
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Money: $1093 Plots: 1 Assets: 375 Total: 1968
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Money: $308 Plots: 1 Assets: 1139 Total: 1947
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Food: 6 Energy: 5 Smithore: 6 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)mulefox Money: $180 Plots: 2 Assets: 140 Total: 1320
  INFO [SummaryPhase2.begin]                         (P11)mulefox Food: 1 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P14)speedymule Money: $19 Plots: 2 Assets: 250 Total: 1269
  INFO [SummaryPhase2.begin]                         (P14)speedymule Food: 2 Energy: 2 Smithore: 0 Crystite: 0
  INFO [Shop.buildMules]                             Shop built 2 mules for 4 smithore and now has 13 mules
  INFO [Shop.buildMules]                             A mule now costs $160
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $64
  INFO [SummaryPhase2.begin]                         Shop Smithore: 1 units $84
  INFO [SummaryPhase2.begin]                         Shop Food: 0 units $50
  INFO [SummaryPhase2.begin]                         Shop Energy: 8 units $45
  INFO [SummaryPhase2.begin]                         Shop mules: 13 $160
  INFO [SummaryPhase2.begin]                         Colony total: 6504
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 32
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 13 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.apply]                        Grace duration 19 frames
  INFO [LandGrantPhase.apply]                        Starting land grant
  INFO [LandGrantPhase.claimPlot]                    (P14)speedymule is granted tile 4: Plain (5,0)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P12)mr.earl is granted tile 8: Mountain3 (1,1)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P11)mulefox is granted tile 25: Mountain1 (5,3)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P13)htman_2000 is granted tile 36: Mountain3 (7,4)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.moveToNextTile]               Land grant ends
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 8
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [PlotSeller.generateNextColonyAuction]        Colony doesn't sell a plot
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1753772033797086933
  INFO [Development.setPlayerOrder]                  Normal development order. 13 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.928765
  INFO [PlayerEventPhase.begin]                      No player event for (P13)htman_2000 (rank 1)
  INFO [Player.useFood]                              (P13)htman_2000 has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 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: (P13)htman_2000
  INFO [Wampus.<init>]                               Wampus has 3 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 3.2484531E-6 (owner 10)
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Plain (2,2) with Food factory
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Mountain3 (7,4) with Energy factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 1039. End Update: 1038
  INFO [DevelopmentMessenger.showMessage]            htman_2000 caught the Mountain Wampus and got $100
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13)htman_2000 finishes on update 1669
  INFO [GameModel.gamble]                            (P13)htman_2000 gambles $67, max: 47.5, left: 14.71925, fraction 0.30987895
  INFO [DevelopmentMessenger.showMessage]            htman_2000 won $67 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 16
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -8022750296485693223
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.19605213
  INFO [PlayerEventPhase.begin]                      Event player: (P12)mr.earl (rank 2)
  INFO [PlayerEventPhase.begin]                      Event: HomeWorldPackage
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [PlayerEventPhase$1.finished]                 Event Message: You just received a package from your home-world relatives containing 3 food and 2 energy units
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 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: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Player.useFood]                              (P12)mr.earl has 9 food and needs 3 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12)mr.earl
  INFO [Wampus.<init>]                               Wampus has 3 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 [GameModel.developLand]                       (P12)mr.earl develops tile Mountain3 (1,1) with Smithore factory
  INFO [GameModel.buyAssay]                          (P12)mr.earl got an assay bot
  INFO [DevelopmentMessenger.showMessage]            Found Medium amounts of Crystite
  INFO [DevelopmentMessenger.showMessage]            mr.earl caught the Mountain Wampus and got $100
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12)mr.earl finishes on update 2417
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 8
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1993846537140610810
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.4175828
  INFO [PlayerEventPhase.begin]                      No player event for (P11)mulefox (rank 3)
  INFO [Player.useFood]                              (P11)mulefox has 1 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11)mulefox
  INFO [Wampus.<init>]                               Wampus has 3 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 3.2484531E-6 (owner 10)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 42. End Update: 41
  INFO [AbstractDevelopmentPhase.apply]              Remote (P11)mulefox finishes on update 67
  INFO [GameModel.gamble]                            (P11)mulefox gambles $53, max: 47.5, left: 17.826637, fraction 0.37529764
  INFO [DevelopmentMessenger.showMessage]            mulefox won $53 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  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 [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 6
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2070397955349232937
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.2213974
  INFO [PlayerEventPhase.begin]                      Event player: (P14)speedymule (rank 4)
  INFO [PlayerEventPhase.begin]                      Event: Charity
  INFO [PlayerEventPhase$1.finished]                 Event Message: A charity from your home-world took pity on you and sent $75
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Player.useFood]                              (P14)speedymule has 2 food and needs 3 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P14)speedymule
  INFO [Wampus.<init>]                               Wampus has 3 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.019996751 (owner 10)
  INFO [GameModel.buyAssay]                          (P14)speedymule got an assay bot
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 571. End Update: 570
  INFO [DevelopmentMessenger.showMessage]            Found Medium amounts of Crystite
  INFO [DevelopmentMessenger.showMessage]            speedymule caught the Mountain Wampus and got $100
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (5,0) with Food factory
  INFO [AbstractDevelopmentPhase.apply]              Remote (P14)speedymule finishes on update 1571
  INFO [GameModel.gamble]                            (P14)speedymule gambles $50, max: 47.5, left: 2.5127616, fraction 0.052900244
  INFO [DevelopmentMessenger.showMessage]            speedymule won $50 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 19
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: SUNSPOT_ACTIVITY
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 6994400717372738844
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 5306026688604757922
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [ProductionPhase.finishPower]                 (P12)mr.earl has 7 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P11)mulefox has 2 energy and needs 0 energy
  INFO [ProductionPhase.finishPower]                 (P13)htman_2000 has 2 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P14)speedymule has 2 energy and needs 2 energy
  INFO [ProductionPhase.logProduction]               (P12)mr.earl expects 0 food, 0 energy, 8 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox expects 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 expects 2 food, 4 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule expects 4 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12)mr.earl produced 0 food, 0 energy, 9 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox produced 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 produced 2 food, 5 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule produced 3 food, 0 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  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]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -7047731079980690511
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $84
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $-10
  INFO [Shop.printPriceFactor]                       Smithore shop: 1, mules potentially available: 10, mules needed: 8
  INFO [Shop.printPriceFactor]                       Smithore is decreased to 85%
  INFO [Shop.printPriceFactor]                       Smithore buy price $61 sell price $96
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Smithore: 15 critical: 0 surplus: 15 money: $173
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Smithore: 0 critical: 0 surplus: 0 money: $233
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Smithore: 0 critical: 0 surplus: 0 money: $1075
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Smithore: 0 critical: 0 surplus: 0 money: $59
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 6
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 2
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (12) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019994844 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  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.06643207 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $61 (0 units for $0)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 11
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 9083653568474258940
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $64
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $144 sell price $284
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Crystite: 0 critical: 0 surplus: 0 money: $173
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Crystite: 0 critical: 0 surplus: 0 money: $233
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Crystite: 0 critical: 0 surplus: 0 money: $1075
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Crystite: 0 critical: 0 surplus: 0 money: $59
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 11
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 2
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $144 (0 units for $0)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 5
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -6438519377877509434
  INFO [Shop.calcBuySellPrice]                       Current Food price $50
  INFO [Shop.printPriceFactor]                       Food shop: 0, total: 9, needed: 12
  INFO [Shop.printPriceFactor]                       Food is increased to 125%
  INFO [Shop.printPriceFactor]                       Food buy price $48 sell price $83
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Food: 3 critical: 3 surplus: 0 money: $173
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Food: 0 critical: 3 surplus: -3 money: $233
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Food: 3 critical: 3 surplus: 0 money: $1075
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Food: 3 critical: 3 surplus: 0 money: $59
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 22
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 2
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (14) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 5.155802E-6 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P14)speedymule 
  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 [SlickLogSystem.info]                         Transaction #1
  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 [SlickLogSystem.info]                         Transaction #2
  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.045869015 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $83 (2 units for $166)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 19
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1492509131946375086
  INFO [Shop.calcBuySellPrice]                       Current Energy price $45
  INFO [Shop.printPriceFactor]                       Energy shop: 8, total: 20, needed: 9
  INFO [Shop.printPriceFactor]                       Energy is decreased to 59%
  INFO [Shop.printPriceFactor]                       Energy buy price $11 sell price $46
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Energy: 4 critical: 3 surplus: 1 money: $90
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Energy: 2 critical: 1 surplus: 1 money: $150
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Energy: 6 critical: 2 surplus: 4 money: $1075
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Energy: 0 critical: 3 surplus: -3 money: $225
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 27
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 2
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (12) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (11) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 5.155802E-6 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P13)htman_2000 
  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 [SlickLogSystem.info]                         Transaction #1
  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 [SlickLogSystem.info]                         Transaction #2
  INFO [Player.increaseAuctionTeleportCount]         (P12)mr.earl auction teleport count: 1
  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.03970549 (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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $46 (2 units for $92)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 22
  INFO [GameController.beginNextPhase]               --------- SUMMARY #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 5153632677572768948
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 56178472
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Money: $1121 Plots: 2 Assets: 624 Total: 2745
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Food: 3 Energy: 5 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Money: $44 Plots: 2 Assets: 1697 Total: 2741
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Food: 4 Energy: 5 Smithore: 15 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P14)speedymule Money: $179 Plots: 3 Assets: 249 Total: 1928
  INFO [SummaryPhase2.begin]                         (P14)speedymule Food: 1 Energy: 1 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)mulefox Money: $150 Plots: 3 Assets: 175 Total: 1825
  INFO [SummaryPhase2.begin]                         (P11)mulefox Food: 1 Energy: 2 Smithore: 0 Crystite: 0
  INFO [Shop.buildMules]                             Shop built 0 mules for 0 smithore and now has 10 mules
  INFO [Shop.buildMules]                             A mule now costs $120
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $144
  INFO [SummaryPhase2.begin]                         Shop Smithore: 1 units $61
  INFO [SummaryPhase2.begin]                         Shop Food: 0 units $83
  INFO [SummaryPhase2.begin]                         Shop Energy: 7 units $46
  INFO [SummaryPhase2.begin]                         Shop mules: 10 $120
  INFO [SummaryPhase2.begin]                         Colony total: 9239
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 9
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 10 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.apply]                        Grace duration 19 frames
  INFO [LandGrantPhase.apply]                        Starting land grant
  INFO [LandGrantPhase.claimPlot]                    (P13)htman_2000 is granted tile 7: Plain (2,1)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.claimPlot]                    (P14)speedymule is granted tile 10: Plain (5,1)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P11)mulefox is granted tile 16: Plain (5,2)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 31
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.claimPlot]                    (P12)mr.earl is granted tile 27: Mountain1 (1,4)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.moveToNextTile]               Land grant ends
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 25
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [PlotSeller.generateNextColonyAuction]        Colony sells plot #1
  INFO [PlotSeller.beginAuction]                     Starting auction set
  INFO [PlotSeller.beginAuction]                     Land auction price: $912
  INFO [AbstractAuctionController.begin]             Begin auction id 4
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     LandAuctionStart is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 34.25 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [SlickLogSystem.info]                         Local players finished auction
  INFO [AbstractLandAuctionPhase.update]             Reached final auction state
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (0) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.078251064 (owner 10)
  INFO [AbstractLandAuctionPhase.buyLand]            (P13)htman_2000 bought the plot for $912
  INFO [PlotSeller.generateNextColonyAuction]        Colony doesn't sell a plot
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 18
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -8109028117982006992
  INFO [Development.setPlayerOrder]                  Normal development order. 10 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.35027337
  INFO [PlayerEventPhase.begin]                      No player event for (P13)htman_2000 (rank 1)
  INFO [Player.useFood]                              (P13)htman_2000 has 3 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13)htman_2000
  INFO [Wampus.<init>]                               Wampus has 2 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.019996751 (owner 10)
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Mountain3 (7,4) with Smithore factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 868. End Update: 867
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Plain (2,1) with Energy factory
  INFO [GameModel.developLand]                       (P13)htman_2000 undevelops tile Plain (2,2)
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile River (4,4) with Food factory
  INFO [DevelopmentMessenger.showMessage]            htman_2000 caught the Mountain Wampus and got $100
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 1507. End Update: 1506
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 1728. End Update: 1727
  INFO [GameModel.developLand]                       (P13)htman_2000 undevelops tile Plain (2,1)
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Plain (2,1) with Crystite factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 2398. End Update: 2397
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13)htman_2000 finishes on update 2411
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 29
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1763431966480144762
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.22372401
  INFO [PlayerEventPhase.begin]                      Event player: (P12)mr.earl (rank 2)
  INFO [PlayerEventPhase.begin]                      Event: MuseumBoughtComputer
  INFO [PlayerEventPhase$1.finished]                 Event Message: The museum bought your antique personal computer for $200
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Player.useFood]                              (P12)mr.earl has 4 food and needs 3 food
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 11
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12)mr.earl
  INFO [Wampus.<init>]                               Wampus has 2 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 [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 453. End Update: 452
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 504. End Update: 503
  INFO [GameModel.developLand]                       (P12)mr.earl develops tile Mountain1 (1,4) with Food factory
  INFO [DevelopmentMessenger.showMessage]            mr.earl caught the Mountain Wampus and got $100
  INFO [GameModel.buyAssay]                          (P12)mr.earl got an assay bot
  INFO [DevelopmentMessenger.showMessage]            No Crystite found
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12)mr.earl finishes on update 2405
  INFO [Mule.runAway]                                Mule runs away for (P12)mr.earl
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 40
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 7335633563074126295
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.92899555
  INFO [PlayerEventPhase.begin]                      No player event for (P14)speedymule (rank 3)
  INFO [Player.useFood]                              (P14)speedymule has 1 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 7
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P14)speedymule
  INFO [Wampus.<init>]                               Wampus has 2 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.019996751 (owner 10)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 213. End Update: 212
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (5,1) with Energy factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 624. End Update: 623
  INFO [DevelopmentMessenger.showMessage]            speedymule caught the Mountain Wampus and got $100
  INFO [AbstractDevelopmentPhase.apply]              Remote (P14)speedymule finishes on update 977
  INFO [GameModel.gamble]                            (P14)speedymule gambles $51, max: 47.5, left: 0.46641964, fraction 0.00981936
  INFO [DevelopmentMessenger.showMessage]            speedymule won $51 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 6
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1633457183266731868
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.9171823
  INFO [PlayerEventPhase.begin]                      No player event for (P11)mulefox (rank 4)
  INFO [Player.useFood]                              (P11)mulefox has 1 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 4
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11)mulefox
  INFO [Wampus.<init>]                               Wampus has 2 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 [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 125. End Update: 124
  INFO [GameModel.developLand]                       (P11)mulefox develops tile Plain (5,2) with Food factory
  INFO [DevelopmentMessenger.showMessage]            mulefox caught the Mountain Wampus and got $100
  INFO [AbstractDevelopmentPhase.apply]              Remote (P11)mulefox finishes on update 991
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  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 [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 17
  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: -507686911141376826
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P12)mr.earl has 5 energy and needs 3 energy
  INFO [ProductionPhase.finishPower]                 (P11)mulefox has 2 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P13)htman_2000 has 5 energy and needs 3 energy
  INFO [ProductionPhase.finishPower]                 (P14)speedymule has 1 energy and needs 2 energy
  INFO [ProductionPhase.logProduction]               (P12)mr.earl expects 1 food, 0 energy, 8 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox expects 2 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 expects 4 food, 0 energy, 4 smithore, 2 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule expects 2 food, 3 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [ProductionPhase.logProduction]               (P12)mr.earl produced 2 food, 0 energy, 8 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox produced 3 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 produced 5 food, 0 energy, 3 smithore, 1 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule produced 3 food, 4 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 22
  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: -4902315779449378459
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 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: Ready (14) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 9
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 4887591234125813963
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $61
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $-11
  INFO [Shop.printPriceFactor]                       Smithore shop: 1, mules potentially available: 5, mules needed: 8
  INFO [Shop.printPriceFactor]                       Smithore is increased to 145%
  INFO [Shop.printPriceFactor]                       Smithore buy price $77 sell price $112
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Smithore: 19 critical: 0 surplus: 19 money: $79
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Smithore: 0 critical: 0 surplus: 0 money: $105
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Smithore: 1 critical: 0 surplus: 1 money: $64
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Smithore: 0 critical: 0 surplus: 0 money: $160
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 6
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 3
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (12) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.039994843 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P13)htman_2000 
  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 [SlickLogSystem.info]                         Transaction #1
  INFO [Player.increaseAuctionTeleportCount]         (P12)mr.earl auction teleport count: 1
  INFO [Player.increaseAuctionTeleportCount]         (P13)htman_2000 auction teleport count: 1
  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.068023354 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $77 (1 units for $77)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 7
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3766478884812123417
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $144
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $136 sell price $276
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Crystite: 0 critical: 0 surplus: 0 money: $2
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Crystite: 0 critical: 0 surplus: 0 money: $105
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Crystite: 0 critical: 0 surplus: 0 money: $141
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Crystite: 0 critical: 0 surplus: 0 money: $160
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 3
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $136 (0 units for $0)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 8646248379120891816
  INFO [Shop.calcBuySellPrice]                       Current Food price $83
  INFO [Shop.printPriceFactor]                       Food shop: 0, total: 14, needed: 12
  INFO [Shop.printPriceFactor]                       Food is decreased to 89%
  INFO [Shop.printPriceFactor]                       Food buy price $59 sell price $94
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Food: 3 critical: 3 surplus: 0 money: $2
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Food: 3 critical: 3 surplus: 0 money: $105
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Food: 5 critical: 3 surplus: 2 money: $141
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Food: 3 critical: 3 surplus: 0 money: $160
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 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: Ready (14) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 14
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 3
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (11) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 5.155802E-6 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11)mulefox (P13)htman_2000 
  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 [SlickLogSystem.info]                         Transaction #1
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [Player.increaseAuctionTeleportCount]         (P13)htman_2000 auction teleport count: 1
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #3
  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.061288428 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $59 (4 units for $236)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 16
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 2701097834538690631
  INFO [Shop.calcBuySellPrice]                       Current Energy price $46
  INFO [Shop.printPriceFactor]                       Energy shop: 7, total: 16, needed: 13
  INFO [Shop.printPriceFactor]                       Energy is decreased to 86%
  INFO [Shop.printPriceFactor]                       Energy buy price $25 sell price $60
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Energy: 2 critical: 4 surplus: -2 money: $2
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Energy: 1 critical: 2 surplus: -1 money: $223
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Energy: 2 critical: 4 surplus: -2 money: $259
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Energy: 4 critical: 3 surplus: 1 money: $160
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 7
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 3
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.039994843 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P14)speedymule 
  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 [SlickLogSystem.info]                         Transaction #1
  INFO [Player.increaseAuctionTeleportCount]         (P14)speedymule auction teleport count: 1
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [SlickLogSystem.info]                         Transaction #3
  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.085231885 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $60 (3 units for $180)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 8
  INFO [GameController.beginNextPhase]               --------- SUMMARY #3 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1224543367928905150
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 55314064
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Money: $2 Plots: 3 Assets: 2117 Total: 3619
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Food: 3 Energy: 2 Smithore: 20 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Money: $79 Plots: 4 Assets: 782 Total: 2861
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Food: 3 Energy: 5 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P14)speedymule Money: $220 Plots: 4 Assets: 562 Total: 2782
  INFO [SummaryPhase2.begin]                         (P14)speedymule Food: 3 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)mulefox Money: $223 Plots: 4 Assets: 179 Total: 2402
  INFO [SummaryPhase2.begin]                         (P11)mulefox Food: 1 Energy: 1 Smithore: 0 Crystite: 0
  INFO [Shop.buildMules]                             Shop built 0 mules for 0 smithore and now has 5 mules
  INFO [Shop.buildMules]                             A mule now costs $150
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $136
  INFO [SummaryPhase2.begin]                         Shop Smithore: 1 units $77
  INFO [SummaryPhase2.begin]                         Shop Food: 4 units $59
  INFO [SummaryPhase2.begin]                         Shop Energy: 5 units $60
  INFO [SummaryPhase2.begin]                         Shop mules: 5 $150
  INFO [SummaryPhase2.begin]                         Colony total: 11664
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 28
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [Development.setPlayerOrder]                  Reverse development order. 5 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.apply]                        Grace duration 18 frames
  INFO [LandGrantPhase.apply]                        Starting land grant
  INFO [LandGrantPhase.claimPlot]                    (P14)speedymule is granted tile 4: Plain (6,0)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.claimPlot]                    (P13)htman_2000 is granted tile 13: Plain (1,2)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.claimPlot]                    (P12)mr.earl is granted tile 17: Plain (1,3)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.claimPlot]                    (P11)mulefox is granted tile 20: Plain (6,3)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [LandGrantPhase.moveToNextTile]               Land grant ends
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 16
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [PlotSeller.generateNextColonyAuction]        Colony sells plot #1
  INFO [PlotSeller.beginAuction]                     Starting auction set
  INFO [PlotSeller.beginAuction]                     Land auction price: $852
  INFO [AbstractAuctionController.begin]             Begin auction id 5
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     LandAuctionStart is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 34.25 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [SlickLogSystem.info]                         Local players finished auction
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.18218204 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (0) 16 bytes
  INFO [AbstractLandAuctionPhase.update]             Reached final auction state
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 19
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1118628639813934102
  INFO [Development.setPlayerOrder]                  Reverse development order. 5 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.18294811
  INFO [PlayerEventPhase.begin]                      Event player: (P11)mulefox (rank 4)
  INFO [PlayerEventPhase.begin]                      Event: WormInfestation
  INFO [PlayerEventPhase$1.finished]                 Event Message: The colony awarded you $200 for stopping the Wart Worm infestation
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Player.useFood]                              (P11)mulefox has 1 food and needs 3 food
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11)mulefox
  INFO [Wampus.<init>]                               Wampus has 2 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 [GameModel.developLand]                       (P11)mulefox develops tile Mountain1 (5,3) with Energy factory
  INFO [GameModel.developLand]                       (P11)mulefox develops tile Plain (6,3) with Energy factory
  INFO [AbstractDevelopmentPhase.apply]              Remote (P11)mulefox finishes on update 959
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 13
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3633851725647563771
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.05062443
  INFO [PlayerEventPhase.begin]                      Event player: (P14)speedymule (rank 3)
  INFO [PlayerEventPhase.begin]                      Event: BestBuiltMule
  INFO [PlayerEventPhase$1.finished]                 Event Message: Your M.U.L.E. was judged "Best Built" at the colony fair. You won $100
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 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: Ready (14) 8 bytes
  INFO [Player.useFood]                              (P14)speedymule has 3 food and needs 3 food
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 7
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P14)speedymule
  INFO [Wampus.<init>]                               Wampus has 2 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 [GameModel.developLand]                       (P14)speedymule develops tile Mountain3 (3,2) with Smithore factory
  INFO [DevelopmentMessenger.showMessage]            speedymule caught the Mountain Wampus and got $200
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 1492. End Update: 1491
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (5,0) with Energy factory
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (5,0) with Crystite factory
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (6,0) with Energy factory
  INFO [AbstractDevelopmentPhase.apply]              Remote (P14)speedymule finishes on update 2370
  INFO [GameModel.gamble]                            (P14)speedymule gambles $101, max: 47.5, left: 0.6591034, fraction 0.013875861
  INFO [DevelopmentMessenger.showMessage]            speedymule won $101 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 16
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 5954317486125640214
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.62307024
  INFO [PlayerEventPhase.begin]                      No player event for (P13)htman_2000 (rank 2)
  INFO [Player.useFood]                              (P13)htman_2000 has 3 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P13)htman_2000
  INFO [Wampus.<init>]                               Wampus has 2 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 [GameModel.developLand]                       (P13)htman_2000 undevelops tile Plain (2,1)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 600. End Update: 599
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Plain (2,1) with Energy factory
  INFO [DevelopmentMessenger.showMessage]            htman_2000 caught the Mountain Wampus and got $200
  INFO [GameModel.developLand]                       (P13)htman_2000 develops tile Plain (1,2) with Crystite factory
  INFO [AbstractDevelopmentPhase.apply]              Remote (P13)htman_2000 finishes on update 2067
  INFO [GameModel.gamble]                            (P13)htman_2000 gambles $115, max: 47.5, left: 6.8390975, fraction 0.143981
  INFO [DevelopmentMessenger.showMessage]            htman_2000 won $115 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 23
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 6453745838767788918
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.77917016
  INFO [PlayerEventPhase.begin]                      No player event for (P12)mr.earl (rank 1)
  INFO [Player.useFood]                              (P12)mr.earl has 3 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 11
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12)mr.earl
  INFO [Wampus.<init>]                               Wampus has 2 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.03999675 (owner 10)
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 109. End Update: 108
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 197. End Update: 196
  INFO [GameModel.developLand]                       (P12)mr.earl undevelops tile Mountain1 (1,4)
  INFO [GameModel.developLand]                       (P12)mr.earl develops tile Plain (1,3) with Food factory
  INFO [GameModel.developLand]                       (P12)mr.earl undevelops tile Mountain3 (1,1)
  INFO [GameModel.developLand]                       (P12)mr.earl develops tile Mountain1 (1,4) with Energy factory
  INFO [AvatarCommandStream.update]                  Needs to buffer more frames. Update: 1207. End Update: 1206
  INFO [DevelopmentMessenger.showMessage]            mr.earl caught the Mountain Wampus and got $200
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12)mr.earl finishes on update 1731
  INFO [GameModel.gamble]                            (P12)mr.earl gambles $123, max: 47.5, left: 13.579224, fraction 0.2858784
  INFO [DevelopmentMessenger.showMessage]            mr.earl won $123 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 13
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -5683097217518792567
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [ProductionPhase.finishPower]                 (P12)mr.earl has 2 energy and needs 2 energy
  INFO [ProductionPhase.finishPower]                 (P11)mulefox has 1 energy and needs 1 energy
  INFO [ProductionPhase.finishPower]                 (P13)htman_2000 has 5 energy and needs 3 energy
  INFO [ProductionPhase.finishPower]                 (P14)speedymule has 3 energy and needs 3 energy
  INFO [ProductionPhase.logProduction]               (P12)mr.earl expects 2 food, 1 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox expects 2 food, 6 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 expects 4 food, 3 energy, 4 smithore, 2 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule expects 2 food, 6 energy, 4 smithore, 3 crystite
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [ProductionPhase.apply]                       Skipping production
  INFO [ProductionPhase.logProduction]               (P12)mr.earl produced 1 food, 2 energy, 4 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)mulefox produced 1 food, 4 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)htman_2000 produced 4 food, 2 energy, 5 smithore, 3 crystite
  INFO [ProductionPhase.logProduction]               (P14)speedymule produced 1 food, 5 energy, 5 smithore, 4 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 12
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_B #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: PIRATE_SHIP
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -8317668988227486380
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 7
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 8470933505915143505
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $77
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $11
  INFO [Shop.printPriceFactor]                       Smithore shop: 1, mules potentially available: 0, mules needed: 8
  INFO [Shop.printPriceFactor]                       Smithore is increased to 250%
  INFO [Shop.printPriceFactor]                       Smithore buy price $204 sell price $239
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Smithore: 24 critical: 0 surplus: 24 money: $350
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Smithore: 0 critical: 0 surplus: 0 money: $23
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Smithore: 5 critical: 0 surplus: 5 money: $194
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Smithore: 5 critical: 0 surplus: 5 money: $121
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 4
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019994844 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  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 [SlickLogSystem.info]                         Transaction #1
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [SlickLogSystem.info]                         Transaction #3
  INFO [SlickLogSystem.info]                         Transaction #4
  INFO [SlickLogSystem.info]                         Transaction #5
  INFO [Player.increaseAuctionTeleportCount]         (P14)speedymule auction teleport count: 1
  INFO [Player.increaseAuctionTeleportCount]         (P13)htman_2000 auction teleport count: 1
  INFO [SlickLogSystem.info]                         Transaction #6
  INFO [SlickLogSystem.info]                         Transaction #7
  INFO [SlickLogSystem.info]                         Transaction #8
  INFO [SlickLogSystem.info]                         Transaction #9
  INFO [SlickLogSystem.info]                         Transaction #10
  INFO [SlickLogSystem.info]                         Transaction #11
  INFO [SlickLogSystem.info]                         Transaction #12
  INFO [SlickLogSystem.info]                         Transaction #13
  INFO [SlickLogSystem.info]                         Transaction #14
  INFO [SlickLogSystem.info]                         Transaction #15
  INFO [SlickLogSystem.info]                         Transaction #16
  INFO [SlickLogSystem.info]                         Transaction #17
  INFO [SlickLogSystem.info]                         Transaction #18
  INFO [SlickLogSystem.info]                         Transaction #19
  INFO [SlickLogSystem.info]                         Transaction #20
  INFO [SlickLogSystem.info]                         Transaction #21
  INFO [SlickLogSystem.info]                         Transaction #22
  INFO [SlickLogSystem.info]                         Transaction #23
  INFO [SlickLogSystem.info]                         Transaction #24
  INFO [Player.increaseAuctionTeleportCount]         (P12)mr.earl auction teleport count: 1
  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.06647988 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $204 (34 units for $6936)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 18
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 8798877755302352662
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $136
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $68 sell price $208
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Crystite: 0 critical: 0 surplus: 0 money: $5246
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Crystite: 0 critical: 0 surplus: 0 money: $23
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Crystite: 0 critical: 0 surplus: 0 money: $1214
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Crystite: 0 critical: 0 surplus: 0 money: $1141
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 4
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $68 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -5505511203448434511
  INFO [Shop.calcBuySellPrice]                       Current Food price $59
  INFO [Shop.printPriceFactor]                       Food shop: 4, total: 11, needed: 16
  INFO [Shop.printPriceFactor]                       Food is increased to 134%
  INFO [Shop.printPriceFactor]                       Food buy price $64 sell price $99
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Food: 1 critical: 4 surplus: -3 money: $5246
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Food: 1 critical: 4 surplus: -3 money: $23
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Food: 4 critical: 4 surplus: 0 money: $1214
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Food: 1 critical: 4 surplus: -3 money: $1141
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 8
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 4
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 5.155802E-6 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  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: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #1
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [SlickLogSystem.info]                         Transaction #3
  INFO [SlickLogSystem.info]                         Transaction #4
  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.066005476 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $99 (4 units for $396)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 18
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -4287754654040418851
  INFO [Shop.calcBuySellPrice]                       Current Energy price $60
  INFO [Shop.printPriceFactor]                       Energy shop: 5, total: 20, needed: 13
  INFO [Shop.printPriceFactor]                       Energy is decreased to 74%
  INFO [Shop.printPriceFactor]                       Energy buy price $29 sell price $64
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P12)mr.earl Energy: 2 critical: 3 surplus: -1 money: $5246
  INFO [CollectionPhase.goToNextPhase]               (P11)mulefox Energy: 4 critical: 2 surplus: 2 money: $23
  INFO [CollectionPhase.goToNextPhase]               (P13)htman_2000 Energy: 4 critical: 4 surplus: 0 money: $1214
  INFO [CollectionPhase.goToNextPhase]               (P14)speedymule Energy: 5 critical: 4 surplus: 1 money: $745
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 16
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 4
  INFO [NetworkTimer.start]                          Started "countdown" at 6.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: ChooseDirection (14) 4 bytes
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at -0.019994844 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11)mulefox 
  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 [SlickLogSystem.info]                         Transaction #1
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [SlickLogSystem.info]                         Transaction #3
  INFO [SlickLogSystem.info]                         Transaction #4
  INFO [SlickLogSystem.info]                         Transaction #5
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: StoreClosed (12) 0 bytes
  INFO [AbstractAuctionPhase.storeClosed]            Store closed. Current max tick: 360
  INFO [GameController.apply]                        (P11)mulefox chat: 400
  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 [SlickLogSystem.info]                         Transaction #6
  INFO [SlickLogSystem.info]                         Transaction #7
  INFO [Player.increaseAuctionTeleportCount]         (P11)mulefox auction teleport count: 1
  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.06887669 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $119 (7 units for $834)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 15
  INFO [GameController.beginNextPhase]               --------- SUMMARY #4 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3299979972814105472
  INFO [SummaryPhase2.begin]                         Total Memory: 66715648
  INFO [SummaryPhase2.begin]                         Free Memory: 51422216
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Money: $4732 Plots: 4 Assets: 830 Total: 7562
  INFO [SummaryPhase2.begin]                         (P12)mr.earl Food: 1 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P14)speedymule Money: $425 Plots: 5 Assets: 2160 Total: 5085
  INFO [SummaryPhase2.begin]                         (P14)speedymule Food: 5 Energy: 10 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Money: $1214 Plots: 5 Assets: 1262 Total: 4976
  INFO [SummaryPhase2.begin]                         (P13)htman_2000 Food: 4 Energy: 4 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)mulefox Money: $537 Plots: 5 Assets: 567 Total: 3604
  INFO [SummaryPhase2.begin]                         (P11)mulefox Food: 1 Energy: 2 Smithore: 0 Crystite: 0
  INFO [Shop.buildMules]                             Shop built 14 mules for 28 smithore and now has 14 mules
  INFO [Shop.buildMules]                             A mule now costs $400
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $68
  INFO [SummaryPhase2.begin]                         Shop Smithore: 7 units $204
  INFO [SummaryPhase2.begin]                         Shop Food: 0 units $99
  INFO [SummaryPhase2.begin]                         Shop Energy: 0 units $119
  INFO [SummaryPhase2.begin]                         Shop mules: 14 $400
  INFO [SummaryPhase2.begin]                         Colony total: 21227
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (14) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 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 [MuleGameContainer.logSkippedFrames]          Skipped frames: 12
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #5 --------------------------------------------------------
  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 2 frames, rountrip 109ms, max 203ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 3 frames, rountrip 109ms, max 219ms
  INFO [LandGrantPhase.apply]                        Grace duration 19 frames
  INFO [LandGrantPhase.apply]                        Starting land grant
  INFO [LandGrantPhase.claimPlot]                    (P13)htman_2000 is granted tile 5: Plain (0,1)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 109ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P14)speedymule is granted tile 8: Mountain1 (6,1)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 109ms, max 219ms
  INFO [LandGrantPhase.claimPlot]                    (P12)mr.earl is granted tile 11: Plain (0,2)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 2 frames, rountrip 109ms, max 203ms
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 37
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 1
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.moveToNextTile]               Overtime: 2
  INFO [LandGrantPhase.claimPlot]                    (P11)mulefox is granted tile 22: Plain (5,4)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 3 frames, rountrip 94ms, max 219ms
  INFO [LandGrantPhase.moveToNextTile]               Land grant ends
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 23
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [PlotSeller.generateNextColonyAuction]        Colony sells plot #1
  INFO [PlotSeller.beginAuction]                     Starting auction set
  INFO [PlotSeller.beginAuction]                     Land auction price: $416
  INFO [AbstractAuctionController.begin]             Begin auction id 6
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     LandAuctionStart is delivered in 3 frames, rountrip 94ms, max 203ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)mulefox (P13)htman_2000 (P12)mr.earl (P14)speedymule 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 34.25 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [SlickLogSystem.info]                         Local players finished auction
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BuyLand (0) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -0.06782568 (owner 10)
  INFO [AbstractLandAuctionPhase.update]             Reached final auction state
  INFO [AbstractLandAuctionPhase.buyLand]            (P12)mr.earl bought the plot for $1220
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [PlotSeller.generateNextColonyAuction]        Colony doesn't sell a plot
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 16
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 677509659169500268
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Development.nextPlayer]                      Development moving to next player: 0
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.4592014
  INFO [PlayerEventPhase.begin]                      No player event for (P12)mr.earl (rank 1)
  INFO [Player.useFood]                              (P12)mr.earl has 1 food and needs 4 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  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 (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P12)mr.earl
  INFO [Wampus.<init>]                               Wampus has 1 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 3.2484531E-6 (owner 10)
  INFO [GameModel.developLand]                       (P12)mr.earl develops tile Plain (3,4) with Food factory
  INFO [AbstractDevelopmentPhase.apply]              Remote (P12)mr.earl finishes on update 742
  INFO [GameModel.gamble]                            (P12)mr.earl gambles $100, max: 47.5, left: 0.7848325, fraction 0.01652279
  INFO [DevelopmentMessenger.showMessage]            mr.earl won $100 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 11
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3298999148095412785
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.39156592
  INFO [PlayerEventPhase.begin]                      No player event for (P14)speedymule (rank 2)
  INFO [Player.useFood]                              (P14)speedymule has 5 food and needs 4 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 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: (P14)speedymule
  INFO [Wampus.<init>]                               Wampus has 1 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 [GameModel.developLand]                       (P14)speedymule undevelops tile Plain (5,1)
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Mountain1 (6,1) with Smithore factory
  INFO [GameModel.developLand]                       (P14)speedymule undevelops tile Plain (7,0)
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (5,1) with Food factory
  INFO [DevelopmentMessenger.showMessage]            speedymule caught the Mountain Wampus and got $200
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (6,0) with Crystite factory
  INFO [GameModel.developLand]                       (P14)speedymule develops tile Plain (7,0) with Energy factory
  INFO [AbstractDevelopmentPhase.apply]              Remote (P14)speedymule finishes on update 2002
  INFO [GameModel.gamble]                            (P14)speedymule gambles $133, max: 47.5, left: 8.139099, fraction 0.17134945
  INFO [DevelopmentMessenger.showMessage]            speedymule won $133 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (14) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (15) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 27
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #5 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 94 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2229579480043790223
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventGenerator.nextEvent]              Event random chance: 0.26299107
  INFO [PlayerEventPhase.begin]                      Event player: (P13)htman_2000 (rank 3)
  INFO [PlayerEventPhase.begin]                      Event: WanderingSpaceTraveler
  INFO [PlayerEventPhase$1.finished]                 Event Message: A wandering space traveler repaid your hospitality by leaving two bars of smithore
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [MetaFrame$6.actionPerformed]                 User chooses to disconnect
  INFO [MuleGameContainer.release]                   Closing game.
  INFO [GameController.close]                        -------- CLOSING GAME CONTROLLER ----------------------------------
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
