  INFO [Properties.<init>]                           VERSION: 1.3.7
  INFO [Properties.<init>]                           Classpath: c:\Users\Turborilla\Documents\PM1\MulesAI\build\main;c:\Users\Turborilla\Documents\PM1\MulesAI\lib\jogg-0.0.7.jar;c:\Users\Turborilla\Documents\PM1\MulesAI\lib\jorbis-0.0.15.jar;c:\Users\Turborilla\Documents\PM1\MulesAI\lib\lpsolve55j.jar;c:\Users\Turborilla\Documents\PM1\MulesAI\lib\lwjgl.jar;c:\Users\Turborilla\Documents\PM1\MulesAI\lib\slick.jar;c:\Users\Turborilla\Documents\PM1\MulesAI\lib\substance-lite.jar
  INFO [Properties.<init>]                           Java VM: 11.0.28+6-LTS
  INFO [Properties.<init>]                           Java Runtime: 11.0.28+6-LTS
  INFO [Properties.<init>]                           OS: Windows 10 10.0 amd64
  INFO [Properties.<init>]                           Java Library Path: C:\\Users\\Turborilla\\Documents\\PM1\\MulesAI/lib/natives/windows/data/lib
  INFO [Properties.<init>]                           Max Memory: 8529117184
  INFO [Properties.<init>]                           Avaialble Processors: 16
  INFO [PropertiesBase.readFromFile]                 Reading Settings from file settings.txt
  INFO [SubstanceLoader.initLookAndFeel]             Window Skin: Default
  SEVERE [Main.logError]                             java.nio.file.NoSuchFileException: lpsolve55_64.dll
	 at java.base/sun.nio.fs.WindowsException.translateToIOException(WindowsException.java:85)
	 at java.base/sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:103)
	 at java.base/sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:108)
	 at java.base/sun.nio.fs.WindowsFileCopy.copy(WindowsFileCopy.java:98)
	 at java.base/sun.nio.fs.WindowsFileSystemProvider.copy(WindowsFileSystemProvider.java:283)
	 at java.base/java.nio.file.Files.copy(Files.java:1295)
	 at com.turborilla.mule.Main.main(Main.java:96)
  WARNING [Main.main]                                Disabling Adam's AI
  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: 08deabd0e43ce78af577665f0714c134
  INFO [Login$MasterListener$1.run]                  Logged in as "xitheta" (id 109210)
  INFO [MetaFrame.<init>]                            Creating Meta Frame
  INFO [MapSkinParser.findSkins]                     Found skin "default"
  INFO [MasterClient.logSend]                        MasterClient: Sending Enter Lobby
  INFO [Login.dispose]                               Disposing login
++++++++ END OF INITIALIZATION +++++++++++++++++++++++++++++++++++++++++++
  INFO [MetaFrame.startGame]                         Starting game number 2
  INFO [MetaFrame.startGame]                         Entering Game - ID: 0, Name: BIT-6916, Address: 147.185.221.211:58971, Is Host: false
  INFO [MuleGameContainer.init]                      *** Starting Game ***
  INFO [MuleGameContainer.init]                      Display: Created=true Active=true Visible=true
  INFO [MuleGameContainer.init]                      Making display the current GL context
  INFO [View.<init>]                                 Creating view...
  INFO [View.<init>]                                 Finished creating view
  INFO [Client.connect]                              Client connects...
  INFO [Client.connectUDP]                           Client UDP connects...
  WARNING [Client.connectUDP]                        Client couldn't connect with UDP port 6261 (Address already in use: bind)
  INFO [Client.connectUDP]                           Client UDP local address: 0.0.0.0/0.0.0.0:6262
  INFO [Client.connectUDP]                           Client: Connects UDP:  UDP: /147.185.221.211:58971
  INFO [Client.connectTCP]                           Client TCP connects...
  INFO [Client.connectTCP]                           Client: Connects TCP: /147.185.221.211:58971
  INFO [Client.connectTCP]                           Client: TCP receive buffer: 65536 send buffer: 65536
  INFO [GameController.setModel]                     ++++++++ New Model: CONNECT #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [MuleGameContainer.setWindowedMode]           Setting windowed mode: 640 x 480 x 0 @0Hz
  INFO [Client.finishConnect]                        Client finishes connection
  INFO [ConnectPhase.update]                         my User Number: 11
  INFO [ConnectPhase.update]                         connection token: 890b38c7ce87312f85208185b14b1def3558e638d9e9132a1b99b10d8da6ff2a
  INFO [ConnectPhase.sendRejoin]                     Attempt reconnect join: sent request for user 11
  INFO [Client.receiveTCPMessages]                   Client: ServerInfo (0) 35 bytes
  INFO [Client.receiveTCPMessages]                   Client: ReconnectRejected (0) 16 bytes
  INFO [UserController.apply]                        My client id is 7aabb2a3-e59f-45a1-adcd-288c4303e51e
  INFO [ConnectPhase.sendJoin]                       Attempt join: sent request for user...
  INFO [Client.initUDP]                              Sending UDP initialization message id 7aabb2a3-e59f-45a1-adcd-288c4303e51e
  INFO [Client.receiveTCPMessages]                   Client: ServerInfo (0) 35 bytes
  INFO [Client.receiveTCPMessages]                   Client: Join (11) 39 bytes
  INFO [Client.receiveTCPMessages]                   Client: Increasing TCP recieve buffer for GameModel (0) 7182 bytes
  INFO [Client.receiveTCPMessages]                   Client: GameModel (0) 7182 bytes
  INFO [Client.receiveTCPMessages]                   Client: ReconnectInfo (0) 120 bytes
  INFO [UserController.apply]                        My client id is 7aabb2a3-e59f-45a1-adcd-288c4303e51e
  INFO [Player.<init>]                               Creating (P0)Spectator
  INFO [GameModel.setMyUser]                         (S11)xitheta is my user
  INFO [GameModel.setLocalUser]                      (S11)xitheta is a local Spectator
  INFO [GameModel.setRemoteUser]                     (S10)xitheta4 is a remote Spectator
  INFO [GameModel.setMyUser]                         (S11)xitheta is my user
  INFO [GameModel.setLocalUser]                      (S11)xitheta is a local Spectator
  INFO [GameController.setModel]                     ++++++++ New Model: GAME_LOBBY #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (S10)xitheta4 (ID: 109244)
  INFO [GameLobbyPhase.getMasterUserInfo]            Fetching user info for (S11)xitheta (ID: 109210)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (S10)xitheta4 (ID 109244)
  INFO [GameLobbyPhase$MasterListener.apply]         No statistics available for (S10)xitheta4 (ID 109244)
  INFO [GameLobbyPhase$MasterListener.apply]         Got user info for (S11)xitheta (ID 109210)
  INFO [Client.receiveTCPMessages]                   Client: PlayerJoin (11) 0 bytes
  INFO [UserController.apply]                        (S11)xitheta joins the players
  INFO [Player.<init>]                               Creating (P11)xitheta
  INFO [GameModel.setMyUser]                         (P11)xitheta is my user
  INFO [GameModel.setLocalUser]                      (P11)xitheta is a local Player
  INFO [Client.receiveTCPMessages]                   Client: PlayerJoin (10) 0 bytes
  INFO [UserController.apply]                        (S10)xitheta4 joins the players
  INFO [Player.<init>]                               Creating (P10)xitheta4
  INFO [GameModel.setServerUser]                     (P10)xitheta4 is hosting the server
  INFO [GameModel.setRemoteUser]                     (P10)xitheta4 is a remote Player
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 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 (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 (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: AIJoin (12) 12 bytes
  INFO [Player.<init>]                               Creating (P12)<J.I.M.>
  INFO [UserController.setAiPlayer]                  (P12)<J.I.M.> is an AI player
  INFO [GameModel.setRemoteUser]                     (P12)<J.I.M.> is a remote Player
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: AIJoin (13) 14 bytes
  INFO [Player.<init>]                               Creating (P13)<A.L.A.N.>
  INFO [UserController.setAiPlayer]                  (P13)<A.L.A.N.> is an AI player
  INFO [GameModel.setRemoteUser]                     (P13)<A.L.A.N.> is a remote Player
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [GameLobbyPhase.apply]                        Starting Game - All players want to continue
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P12)<J.I.M.> (P13)<A.L.A.N.> (P11)xitheta (P10)xitheta4 
  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 [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- INTRO #0 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 64 ms
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- SUMMARY #0 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 64 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -189137416115907057
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P13)<A.L.A.N.> (P12)<J.I.M.> (P11)xitheta (P10)xitheta4 
  INFO [SummaryPhase2.begin]                         Total Memory: 50331648
  INFO [SummaryPhase2.begin]                         Free Memory: 21581696
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)xitheta Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P11)xitheta Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 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
  WARNING [Client.initUDP]                           UDP messages timed out. Sending new UDP initialization message id 7aabb2a3-e59f-45a1-adcd-288c4303e51e
  SEVERE [GameController.checkMessageTimeout]        Your network connection timed out
  INFO [Client.connect]                              Client connects...
  INFO [Client.connectUDP]                           Client UDP connects...
  WARNING [Client.connectUDP]                        Client couldn't connect with UDP port 6261 (Address already in use: bind)
  INFO [Client.connectUDP]                           Client UDP local address: 0.0.0.0/0.0.0.0:6262
  INFO [Client.connectUDP]                           Client: Connects UDP:  UDP: /147.185.221.211:58971
  INFO [Client.connectTCP]                           Client TCP connects...
  INFO [Client.connectTCP]                           Client: Connects TCP: /147.185.221.211:58971
  INFO [Client.connectTCP]                           Client: TCP receive buffer: 65536 send buffer: 65536
  INFO [SlickLogSystem.info]                         Too much real time passed since last frame. Breaking sync with real time.
  INFO [Client.finishConnect]                        Client finishes connection
  INFO [ConnectPhase.update]                         my User Number: 11
  INFO [ConnectPhase.update]                         connection token: cf6399a1340cd50255e082b263e933a92e8b849f46a900a121197d063a594ed6
  INFO [ConnectPhase.sendRejoin]                     Attempt reconnect join: sent request for user 11
  INFO [Client.receiveTCPMessages]                   Client: ServerInfo (0) 35 bytes
  INFO [Client.receiveTCPMessages]                   Client: ReconnectJoin (11) 2244 bytes
  INFO [UserController.apply]                        My client id is 8a4568f8-b93b-431b-b8cb-cbf0e06fb2a4
  INFO [UserController.apply]                        (P11)xitheta reconnects.
  INFO [GameController.enterPausePhase]              -GAME PAUSED-
  INFO [Client.receiveTCPMessages]                   Client: Increasing TCP recieve buffer for ReconnectReady (0) 7368 bytes
  INFO [Client.receiveTCPMessages]                   Client: ReconnectReady (0) 7368 bytes
  INFO [GameController.setModel]                     ++++++++ New Model: SUMMARY #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [GameModel.setMyUser]                         (P11)xitheta is my user
  INFO [GameModel.setLocalUser]                      (P11)xitheta is a local Player
  INFO [GameModel.setRemoteUser]                     (P10)xitheta4 is a remote Player
  INFO [GameModel.setRemoteUser]                     (P12)<J.I.M.> is a remote Player
  INFO [GameModel.setRemoteUser]                     (P13)<A.L.A.N.> is a remote Player
  INFO [UserController.setAiPlayer]                  (P12)<J.I.M.> is taken over by an AI player
  INFO [UserController.setAiPlayer]                  (P13)<A.L.A.N.> is taken over by an AI player
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -189137416115907057
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P13)<A.L.A.N.> (P12)<J.I.M.> (P11)xitheta (P10)xitheta4 
  INFO [SummaryPhase2.begin]                         Total Memory: 50331648
  INFO [SummaryPhase2.begin]                         Free Memory: 29166648
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)xitheta Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P11)xitheta Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 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.setModel]                     ++++++++ New Model: SUMMARY #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [Client.initUDP]                              Sending UDP initialization message id 8a4568f8-b93b-431b-b8cb-cbf0e06fb2a4
  SEVERE [GameController.checkMessageTimeout]        Your network connection timed out
  INFO [Client.connect]                              Client connects...
  INFO [Client.connectUDP]                           Client UDP connects...
  WARNING [Client.connectUDP]                        Client couldn't connect with UDP port 6261 (Address already in use: bind)
  INFO [Client.connectUDP]                           Client UDP local address: 0.0.0.0/0.0.0.0:6262
  INFO [Client.connectUDP]                           Client: Connects UDP:  UDP: /147.185.221.211:58971
  INFO [Client.connectTCP]                           Client TCP connects...
  INFO [Client.connectTCP]                           Client: Connects TCP: /147.185.221.211:58971
  INFO [Client.connectTCP]                           Client: TCP receive buffer: 65536 send buffer: 65536
  INFO [SlickLogSystem.info]                         Too much real time passed since last frame. Breaking sync with real time.
  INFO [Client.finishConnect]                        Client finishes connection
  INFO [ConnectPhase.update]                         my User Number: 11
  INFO [ConnectPhase.update]                         connection token: cf6399a1340cd50255e082b263e933a92e8b849f46a900a121197d063a594ed6
  INFO [ConnectPhase.sendRejoin]                     Attempt reconnect join: sent request for user 11
  INFO [Client.receiveTCPMessages]                   Client: ServerInfo (0) 35 bytes
  INFO [Client.receiveTCPMessages]                   Client: ReconnectJoin (11) 2245 bytes
  INFO [UserController.apply]                        My client id is 5e15a0a0-5ad5-4afc-99c0-35409ce9cb38
  INFO [UserController.apply]                        (P11)xitheta reconnects.
  INFO [GameController.enterPausePhase]              -GAME PAUSED-
  INFO [Client.receiveTCPMessages]                   Client: ReconnectReady (0) 7368 bytes
  INFO [GameController.setModel]                     ++++++++ New Model: SUMMARY #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [GameModel.setMyUser]                         (P11)xitheta is my user
  INFO [GameModel.setLocalUser]                      (P11)xitheta is a local Player
  INFO [GameModel.setRemoteUser]                     (P10)xitheta4 is a remote Player
  INFO [GameModel.setRemoteUser]                     (P12)<J.I.M.> is a remote Player
  INFO [GameModel.setRemoteUser]                     (P13)<A.L.A.N.> is a remote Player
  INFO [UserController.setAiPlayer]                  (P12)<J.I.M.> is taken over by an AI player
  INFO [UserController.setAiPlayer]                  (P13)<A.L.A.N.> is taken over by an AI player
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -189137416115907057
  INFO [GameModel.updatePlayerRankOrder]             Random rank order: (P13)<A.L.A.N.> (P12)<J.I.M.> (P11)xitheta (P10)xitheta4 
  INFO [SummaryPhase2.begin]                         Total Memory: 50331648
  INFO [SummaryPhase2.begin]                         Free Memory: 29560744
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)xitheta Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P11)xitheta Food: 4 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 Money: $1000 Plots: 0 Assets: 170 Total: 1170
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 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
  SEVERE [SummaryPainter3.start]                     Player sprites not empty at start of summary animation.
  INFO [GameController.setModel]                     ++++++++ New Model: SUMMARY #0 +++++++++++++++++++++++++++++++++++++++++++
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [SlickLogSystem.info]                         Too much real time passed since last frame. Breaking sync with real time.
  INFO [Client.initUDP]                              Sending UDP initialization message id 5e15a0a0-5ad5-4afc-99c0-35409ce9cb38
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 18
  INFO [GameController.beginNextPhase]               --------- INTRO #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 75 ms
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 75 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 75ms, max 75ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 75ms, max 75ms
  INFO [LandGrantPhase.apply]                        Grace duration 10 frames
  INFO [LandGrantPhase.apply]                        Starting land grant
  INFO [LandGrantPhase.claimPlot]                    (P12)<J.I.M.> is granted tile 22: Plain (5,2)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 75ms, max 75ms
  INFO [LandGrantPhase.claimPlot]                    (P13)<A.L.A.N.> is granted tile 30: River (4,3)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantContinue is delivered in 0 frames, rountrip 75ms, max 75ms
  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 (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- LAND_AUCTION #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 75 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 (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 75 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 4890677531752162596
  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 (P13)<A.L.A.N.> (rank 1)
  INFO [Player.useFood]                              (P13)<A.L.A.N.> has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- FAST_DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 75 ms
  INFO [Wampus.<init>]                               Wampus has 20 mountains, reward is $100
  INFO [Client.receiveTCPMessages]                   Client: FastDevelopment (13) 16 bytes
  INFO [GameModel.developLand]                       (P13)<A.L.A.N.> develops tile River (4,3) with Food factory
  INFO [Client.receiveTCPMessages]                   Client: FastDevelopment (13) 16 bytes
  INFO [GameModel.gamble]                            (P13)<A.L.A.N.> gambles $52, max: 47.5, left: 23.75, fraction 0.5
  INFO [DevelopmentMessenger.showMessage]            <A.L.A.N.> won $52 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 75 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -36614218435944586
  INFO [Development.nextPlayer]                      Development moving to next player: 1
  INFO [PlayerEventGenerator.nextEvent]              No event frist round
  INFO [PlayerEventPhase.begin]                      No player event for (P12)<J.I.M.> (rank 2)
  INFO [Player.useFood]                              (P12)<J.I.M.> has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- FAST_DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 75 ms
  INFO [Wampus.<init>]                               Wampus has 20 mountains, reward is $100
  INFO [Client.receiveTCPMessages]                   Client: FastDevelopment (12) 16 bytes
  INFO [GameModel.developLand]                       (P12)<J.I.M.> develops tile Plain (5,2) with Energy factory
  INFO [Client.receiveTCPMessages]                   Client: FastDevelopment (12) 16 bytes
  INFO [GameModel.gamble]                            (P12)<J.I.M.> gambles $111, max: 47.5, left: 23.75, fraction 0.5
  INFO [DevelopmentMessenger.showMessage]            <J.I.M.> won $111 in the pub
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 74 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -6064685061669564036
  INFO [Development.nextPlayer]                      Development moving to next player: 2
  INFO [PlayerEventGenerator.nextEvent]              No event frist round
  INFO [PlayerEventPhase.begin]                      No player event for (P11)xitheta (rank 3)
  INFO [Player.useFood]                              (P11)xitheta has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 73 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P11)xitheta
  INFO [Wampus.<init>]                               Wampus has 20 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 2.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.08000134 (owner 10)
  INFO [GameModel.sellMule]                          (P11)xitheta sold a mule for $100
  INFO [GameModel.gamble]                            (P11)xitheta gambles $145, max: 47.5, left: 27.83955, fraction 0.5860958
  INFO [DevelopmentMessenger.showMessage]            xitheta won $145 in the pub
  INFO [AbstractDevelopmentPhase.updatePlayer]       My user (P11)xitheta finishes on update 983
  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 [MuleGameContainer.logSkippedFrames]          Skipped frames: 3
  INFO [GameController.beginNextPhase]               --------- PLAYER_EVENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 72 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -1716451093735521039
  INFO [Development.nextPlayer]                      Development moving to next player: 3
  INFO [PlayerEventGenerator.nextEvent]              No event frist round
  INFO [PlayerEventPhase.begin]                      No player event for (P10)xitheta4 (rank 4)
  INFO [Player.useFood]                              (P10)xitheta4 has 4 food and needs 3 food
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- DEVELOPMENT #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 71 ms
  INFO [DevelopmentPhaseSingle.begin]                Developing player: (P10)xitheta4
  INFO [Wampus.<init>]                               Wampus has 20 mountains, reward is $100
  INFO [NetworkTimer.start]                          Started "countdown" at 2.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 1.3411045E-6 (owner 10)
  INFO [AbstractDevelopmentPhase.apply]              Remote (P10)xitheta4 finishes on update 222
  INFO [GameModel.gamble]                            (P10)xitheta4 gambles $102, max: 47.5, left: 43.0599, fraction 0.9065242
  INFO [DevelopmentMessenger.showMessage]            xitheta4 won $102 in the pub
  INFO [AbstractDevelopmentPhase.startOutroIfDone]   Starting outro
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_A #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 71 ms
  INFO [ColonyEventPhase.begin]                      ColonyEvent: ACID_RAIN_STORM
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3547958668145666584
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- PRODUCTION #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 71 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 1891375823140583661
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [ProductionPhase.finishPower]                 (P11)xitheta has 2 energy and needs 0 energy
  INFO [ProductionPhase.finishPower]                 (P10)xitheta4 has 2 energy and needs 0 energy
  INFO [ProductionPhase.finishPower]                 (P12)<J.I.M.> has 2 energy and needs 0 energy
  INFO [ProductionPhase.finishPower]                 (P13)<A.L.A.N.> has 2 energy and needs 1 energy
  INFO [ProductionPhase.logProduction]               (P11)xitheta expects 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10)xitheta4 expects 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12)<J.I.M.> expects 0 food, 1 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)<A.L.A.N.> expects 5 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P11)xitheta produced 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P10)xitheta4 produced 0 food, 0 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P12)<J.I.M.> produced 0 food, 2 energy, 0 smithore, 0 crystite
  INFO [ProductionPhase.logProduction]               (P13)<A.L.A.N.> produced 6 food, 0 energy, 0 smithore, 0 crystite
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- COLONY_EVENT_B #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 71 ms
  INFO [ColonyEventPhase.begin]                      No colony event. Skipping phase.
  INFO [GameController.beginNextPhase]               --------- COLLECTION_SMITHORE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 71 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -7760737345748649917
  INFO [Shop.calcBuySellPrice]                       Current Smithore price $50
  INFO [Shop.calcBuySellPrice]                       Smithore random variation $6
  INFO [Shop.printPriceFactor]                       Smithore shop: 8, mules potentially available: 16, mules needed: 4
  INFO [Shop.printPriceFactor]                       Smithore is decreased to 44%
  INFO [Shop.printPriceFactor]                       Smithore buy price $56 sell price $91
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P11)xitheta Smithore: 0 critical: 0 surplus: 0 money: $1145
  INFO [CollectionPhase.goToNextPhase]               (P10)xitheta4 Smithore: 0 critical: 0 surplus: 0 money: $1102
  INFO [CollectionPhase.goToNextPhase]               (P12)<J.I.M.> Smithore: 0 critical: 0 surplus: 0 money: $961
  INFO [CollectionPhase.goToNextPhase]               (P13)<A.L.A.N.> Smithore: 0 critical: 0 surplus: 0 money: $927
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 71 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: 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 0 frames, rountrip 69ms, max 69ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)xitheta (P10)xitheta4 (P13)<A.L.A.N.> 
  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.26748946 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $56 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 67 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3704058345909549610
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $48
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $56 sell price $196
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11)xitheta Crystite: 0 critical: 0 surplus: 0 money: $1145
  INFO [CollectionPhase.goToNextPhase]               (P10)xitheta4 Crystite: 0 critical: 0 surplus: 0 money: $1102
  INFO [CollectionPhase.goToNextPhase]               (P12)<J.I.M.> Crystite: 0 critical: 0 surplus: 0 money: $961
  INFO [CollectionPhase.goToNextPhase]               (P13)<A.L.A.N.> Crystite: 0 critical: 0 surplus: 0 money: $927
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 67 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 3
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $56 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 67 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 4669038945606582169
  INFO [Shop.calcBuySellPrice]                       Current Food price $30
  INFO [Shop.printPriceFactor]                       Food shop: 8, total: 18, needed: 12
  INFO [Shop.printPriceFactor]                       Food is decreased to 75%
  INFO [Shop.printPriceFactor]                       Food buy price $15 sell price $50
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11)xitheta Food: 1 critical: 3 surplus: -2 money: $1145
  INFO [CollectionPhase.goToNextPhase]               (P10)xitheta4 Food: 1 critical: 3 surplus: -2 money: $1102
  INFO [CollectionPhase.goToNextPhase]               (P12)<J.I.M.> Food: 1 critical: 3 surplus: -2 money: $961
  INFO [CollectionPhase.goToNextPhase]               (P13)<A.L.A.N.> Food: 7 critical: 3 surplus: 4 money: $927
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 67 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: 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 0 frames, rountrip 66ms, max 66ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P11)xitheta (P10)xitheta4 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P13)<A.L.A.N.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #1
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at -1.5550107 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $49 (2 units for $98)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 66 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3238091941992565415
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 8, total: 17, needed: 5
  INFO [Shop.printPriceFactor]                       Energy is decreased to 47%
  INFO [Shop.printPriceFactor]                       Energy buy price $10 sell price $45
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [CollectionPhase.goToNextPhase]               (P11)xitheta Energy: 2 critical: 1 surplus: 1 money: $1145
  INFO [CollectionPhase.goToNextPhase]               (P10)xitheta4 Energy: 2 critical: 1 surplus: 1 money: $1102
  INFO [CollectionPhase.goToNextPhase]               (P12)<J.I.M.> Energy: 4 critical: 1 surplus: 3 money: $863
  INFO [CollectionPhase.goToNextPhase]               (P13)<A.L.A.N.> Energy: 1 critical: 2 surplus: -1 money: $1025
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 66 ms
  INFO [AbstractAuctionController.begin]             Begin auction id 5
  INFO [NetworkTimer.start]                          Started "countdown" at 6.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 5.155802E-6 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 0 frames, rountrip 66ms, max 66ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P13)<A.L.A.N.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P11)xitheta (P10)xitheta4 
  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 [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.034744114 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $28 (2 units for $56)
  INFO [GameController.beginNextPhase]               --------- SUMMARY #1 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 66 ms
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2523218071539825435
  INFO [SummaryPhase2.begin]                         Total Memory: 50331648
  INFO [SummaryPhase2.begin]                         Free Memory: 25379088
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Money: $969 Plots: 1 Assets: 389 Total: 1858
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Food: 5 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Money: $919 Plots: 1 Assets: 288 Total: 1707
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Food: 3 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)xitheta Money: $1145 Plots: 0 Assets: 105 Total: 1250
  INFO [SummaryPhase2.begin]                         (P11)xitheta Food: 1 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 Money: $1102 Plots: 0 Assets: 105 Total: 1207
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 Food: 1 Energy: 2 Smithore: 0 Crystite: 0
  INFO [Shop.buildMules]                             Shop built 2 mules for 4 smithore and now has 14 mules
  INFO [Shop.buildMules]                             A mule now costs $110
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $56
  INFO [SummaryPhase2.begin]                         Shop Smithore: 4 units $56
  INFO [SummaryPhase2.begin]                         Shop Food: 8 units $49
  INFO [SummaryPhase2.begin]                         Shop Energy: 8 units $28
  INFO [SummaryPhase2.begin]                         Shop mules: 14 $110
  INFO [SummaryPhase2.begin]                         Colony total: 6022
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [Client.receiveTCPMessages]                   Client: Continue (12) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Continue (13) 0 bytes
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [SlickLogSystem.info]                         Too much real time passed since last frame. Breaking sync with real time.
  INFO [Client.receiveTCPMessages]                   Client: Continue (10) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 6
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #2 --------------------------------------------------------
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 67 ms
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 0 frames, rountrip 67ms, max 67ms
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 0 frames, rountrip 67ms, max 67ms
  INFO [LandGrantPhase.apply]                        Grace duration 10 frames
  INFO [LandGrantPhase.apply]                        Starting land grant
  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
     Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- AUCTION_SMITHORE #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 12ms (14ms) <P11> 71ms (72ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 12 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8294 bytes
  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: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.0 (owner 10)
  INFO [AbstractAuctionPhase.timerFinished]          Starting auction in 0.93 seconds
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 1 frames, rountrip 11ms, max 69ms
  INFO [AbstractAuctionPhase.calcRoundtripTime]      Auction uses roundtrip: 71ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P10)xitheta4 (P12)<J.I.M.> (P13)<A.L.A.N.> (P11)xitheta 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [AuctionActuator.calcTargetPrice]             AI: <J.I.M.> target price $58
  INFO [AuctionActuator.calcTargetPrice]             AI: <A.L.A.N.> target price $56
  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.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Smithore price set to average $56 (0 units for $0)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- COLLECTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 9ms (12ms) <P11> 67ms (71ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 10 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8290 bytes
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3704058345909549610
  INFO [Shop.calcBuySellPrice]                       Current Crystite price $48
  INFO [Shop.calcBuySellPrice]                       Crystite buy price $56 sell price $196
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P11)xitheta Crystite: 0 critical: 0 surplus: 0 money: $1145
  INFO [CollectionPhase.goToNextPhase]               (P10)xitheta4 Crystite: 0 critical: 0 surplus: 0 money: $1102
  INFO [CollectionPhase.goToNextPhase]               (P12)<J.I.M.> Crystite: 0 critical: 0 surplus: 0 money: $961
  INFO [CollectionPhase.goToNextPhase]               (P13)<A.L.A.N.> Crystite: 0 critical: 0 surplus: 0 money: $927
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_CRYSTITE #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 9ms (12ms) <P11> 67ms (71ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 9 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8305 bytes
  INFO [AbstractAuctionController.begin]             Begin auction id 3
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Crystite price set to average $56 (0 units for $0)
  INFO [GameController.beginNextPhase]               --------- COLLECTION_FOOD #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 9ms (12ms) <P11> 67ms (71ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 9 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8288 bytes
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: 4669038945606582169
  INFO [Shop.calcBuySellPrice]                       Current Food price $30
  INFO [Shop.printPriceFactor]                       Food shop: 8, total: 18, needed: 12
  INFO [Shop.printPriceFactor]                       Food is decreased to 75%
  INFO [Shop.printPriceFactor]                       Food buy price $15 sell price $50
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P11)xitheta Food: 1 critical: 3 surplus: -2 money: $1145
  INFO [CollectionPhase.goToNextPhase]               (P10)xitheta4 Food: 1 critical: 3 surplus: -2 money: $1102
  INFO [CollectionPhase.goToNextPhase]               (P12)<J.I.M.> Food: 1 critical: 3 surplus: -2 money: $961
  INFO [CollectionPhase.goToNextPhase]               (P13)<A.L.A.N.> Food: 7 critical: 3 surplus: 4 money: $927
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_FOOD #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 7ms (10ms) <P11> 67ms (69ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 8 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8290 bytes
  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: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 0 "countdown" at 0.0 (owner 10)
  INFO [AbstractAuctionPhase.timerFinished]          Starting auction in 0.934 seconds
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 1 frames, rountrip 6ms, max 66ms
  INFO [AbstractAuctionPhase.calcRoundtripTime]      Auction uses roundtrip: 67ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P10)xitheta4 (P12)<J.I.M.> (P11)xitheta 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P13)<A.L.A.N.> 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [AuctionActuator.calcTargetPrice]             AI: <J.I.M.> target price $102 ratio 2.5
  INFO [AuctionActuator.calcTargetPrice]             AI: <A.L.A.N.> target price $50 ratio 1.0
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #1
  INFO [AuctionActuator.calcTargetPrice]             AI: <J.I.M.> target price $102 ratio 2.5
  INFO [AuctionActuator.calcTargetPrice]             AI: <A.L.A.N.> target price $50 ratio 1.0
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [AuctionActuator.calcTargetPrice]             AI: <A.L.A.N.> target price $50 ratio 1.0
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [AbstractAuctionPhase.calcRoundtripTime]      Auction uses roundtrip: 67ms
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at 0.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Food price set to average $49 (2 units for $98)
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 2
  INFO [GameController.beginNextPhase]               --------- COLLECTION_ENERGY #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 6ms (8ms) <P11> 66ms (67ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 6 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8315 bytes
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -3238091941992565415
  INFO [Shop.calcBuySellPrice]                       Current Energy price $25
  INFO [Shop.printPriceFactor]                       Energy shop: 8, total: 17, needed: 5
  INFO [Shop.printPriceFactor]                       Energy is decreased to 47%
  INFO [Shop.printPriceFactor]                       Energy buy price $10 sell price $45
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [CollectionPhase.goToNextPhase]               (P11)xitheta Energy: 2 critical: 1 surplus: 1 money: $1145
  INFO [CollectionPhase.goToNextPhase]               (P10)xitheta4 Energy: 2 critical: 1 surplus: 1 money: $1102
  INFO [CollectionPhase.goToNextPhase]               (P12)<J.I.M.> Energy: 4 critical: 1 surplus: 3 money: $863
  INFO [CollectionPhase.goToNextPhase]               (P13)<A.L.A.N.> Energy: 1 critical: 2 surplus: -1 money: $1025
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [GameController.beginNextPhase]               --------- AUCTION_ENERGY #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 5ms (6ms) <P11> 66ms (67ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 6 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8305 bytes
  INFO [AbstractAuctionController.begin]             Begin auction id 5
  INFO [NetworkTimer.start]                          Started "countdown" at 6.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.0 (owner 10)
  INFO [AbstractAuctionPhase.timerFinished]          Starting auction in 0.934 seconds
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 45 bytes
  INFO [DelayedMessageQueue.add]                     StartAuction is delivered in 1 frames, rountrip 4ms, max 66ms
  INFO [AbstractAuctionPhase.calcRoundtripTime]      Auction uses roundtrip: 67ms
  INFO [Auction.setBuyersAndSellers]                 Auction buyers: (P13)<A.L.A.N.> 
  INFO [Auction.setBuyersAndSellers]                 Auction sellers: (P10)xitheta4 (P12)<J.I.M.> (P11)xitheta 
  INFO [NetworkTimer.start]                          Started "phase timer" at 10.0 (owner 10)
  INFO [AuctionActuator.calcTargetPrice]             AI: <J.I.M.> target price $28 ratio 0.54
  INFO [AuctionActuator.calcTargetPrice]             AI: <A.L.A.N.> target price $70 ratio 1.7333333
  INFO [Client.receiveTCPMessages]                   Client: TimerStarted (10) 16 bytes
  INFO [Client.receiveTCPMessages]                   Client: BeginTransaction (0) 0 bytes
  INFO [SlickLogSystem.info]                         Transaction #1
  INFO [AuctionActuator.calcTargetPrice]             AI: <J.I.M.> target price $14 ratio 0.14000002
  INFO [AuctionActuator.calcTargetPrice]             AI: <A.L.A.N.> target price $53 ratio 1.24
  INFO [SlickLogSystem.info]                         Transaction #2
  INFO [Client.receiveTCPMessages]                   Client: EndTransaction (0) 0 bytes
  INFO [AbstractAuctionPhase.calcRoundtripTime]      Auction uses roundtrip: 75ms
  INFO [Client.receiveTCPMessages]                   Client: TimerFinished (10) 16 bytes
  INFO [NetworkTimerManager.apply]                   Finished Timer 1 "phase timer" at 0.0 (owner 10)
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [Shop.setAveragePrice]                        Energy price set to average $28 (2 units for $56)
  INFO [GameController.beginNextPhase]               --------- SUMMARY #1 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 3ms (6ms) <P11> 66ms (75ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 3 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8287 bytes
  INFO [GameController.checkClientSynchronization]   Sending synchonization checksum: -2523218071539825435
  INFO [SummaryPhase2.begin]                         Total Memory: 56623104
  INFO [SummaryPhase2.begin]                         Free Memory: 28255248
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Money: $969 Plots: 1 Assets: 389 Total: 1858
  INFO [SummaryPhase2.begin]                         (P13)<A.L.A.N.> Food: 5 Energy: 3 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Money: $919 Plots: 1 Assets: 288 Total: 1707
  INFO [SummaryPhase2.begin]                         (P12)<J.I.M.> Food: 3 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P11)xitheta Money: $1145 Plots: 0 Assets: 105 Total: 1250
  INFO [SummaryPhase2.begin]                         (P11)xitheta Food: 1 Energy: 2 Smithore: 0 Crystite: 0
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 Money: $1102 Plots: 0 Assets: 105 Total: 1207
  INFO [SummaryPhase2.begin]                         (P10)xitheta4 Food: 1 Energy: 2 Smithore: 0 Crystite: 0
  INFO [Shop.buildMules]                             Shop built 2 mules for 4 smithore and now has 14 mules
  INFO [Shop.buildMules]                             A mule now costs $110
  INFO [SummaryPhase2.begin]                         Shop Crystite: 0 units $56
  INFO [SummaryPhase2.begin]                         Shop Smithore: 4 units $56
  INFO [SummaryPhase2.begin]                         Shop Food: 8 units $49
  INFO [SummaryPhase2.begin]                         Shop Energy: 8 units $28
  INFO [SummaryPhase2.begin]                         Shop mules: 14 $110
  INFO [SummaryPhase2.begin]                         Colony total: 6022
  INFO [MasterClient.logSend]                        MasterClient: Sending Round Results
  INFO [MasterClient.logSend]                        MasterClient: Sending Round Results
  INFO [MasterClient.logSend]                        MasterClient: Sending Round Results
  INFO [MasterClient.logSend]                        MasterClient: Sending Round Results
  INFO [MasterClient.logSend]                        MasterClient: Sending Finish Round
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Chat Log
  INFO [MasterClient.logSend]                        MasterClient: Sending Game Log
  INFO [GameController.apply]                        Client Synchronization OK
  INFO [Client.receiveTCPMessages]                   Client: Continue (11) 0 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (10) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (12) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (13) 8 bytes
  INFO [Client.receiveTCPMessages]                   Client: Ready (11) 8 bytes
  INFO [MuleGameContainer.logSkippedFrames]          Skipped frames: 5
  INFO [GameController.beginNextPhase]               --------- LAND_GRANT #2 --------------------------------------------------------
  INFO [Server.logRoundtrip]                         Roundtrips: <P10 P12 P13> 2ms (3ms) <P11> 67ms (76ms) 
  INFO [Client.logRoundtripTime]                     Client: Roundtrip time is 2 ms
  INFO [GameModelSerializer.serializeModel]          Packed game model to 8303 bytes
  INFO [Development.setPlayerOrder]                  Normal development order. 14 mules.
  INFO [DevelopmentPlanFinder$1.run]                 AI: <J.I.M.> found 4 plans testing 6933 tiles in 42641500ns
  INFO [DevelopmentPlanFinder.logPlans]              AI: <J.I.M.> Plan: River Food <claim> (+4) 2034 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: River Food <claim> (+4) 2802 points
  INFO [DevelopmentPlanFinder.logPlans]              AI: <J.I.M.> Plan: River Food <claim> (+4) 2034 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: River Food <claim> (+4) 2802 points
  INFO [DevelopmentPlanFinder$1.run]                 AI: <A.L.A.N.> found 4 plans testing 6933 tiles in 46539700ns
  INFO [DevelopmentPlanFinder.logPlans]              AI: <J.I.M.> Plan: River Food <claim> (+4) 2034 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: Mountain3 Smithore <claim> (+4) 2732 points
  INFO [DevelopmentPlanFinder.logPlans]              AI: <J.I.M.> Plan: Mountain3 Smithore <claim> (+4) 2002 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: Mountain3 Smithore <claim> (+4) 2573 points
  INFO [LandGrantActuator.update]                    AI: <J.I.M.> wants River (4,1)
  INFO [DevelopmentPlanFinder.logPlans]              AI: <A.L.A.N.> Plan: River Food <claim> (+4) 2154 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: River Food <claim> (+4) 3025 points
  INFO [DevelopmentPlanFinder.logPlans]              AI: <A.L.A.N.> Plan: River Food <claim> (+4) 2056 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: River Food <claim> (+4) 2927 points
  INFO [DevelopmentPlanFinder.logPlans]              AI: <A.L.A.N.> Plan: River Food <claim> (+4) 2056 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: River Food <claim> (+4) 2927 points
  INFO [DevelopmentPlanFinder.logPlans]              AI: <A.L.A.N.> Plan: Mountain3 Smithore <claim> (+4) 2084 points
  INFO [DevelopmentPlanFinder.logPlans]              AI:	Next: Mountain3 Smithore <claim> (+4) 2878 points
  INFO [LandGrantActuator.update]                    AI: <A.L.A.N.> wants River (4,4)
  INFO [LandGrantActuator.agreeOnClaims]             AI: Agrees on tiles to claim.
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 21 bytes
  INFO [DelayedMessageQueue.add]                     Continue is delivered in 1 frames, rountrip 2ms, max 67ms
  INFO [LandGrantPhase$2.finished]                   Grace duration 76ms 10 frames (6 grace frames)
  INFO [Client.receiveTCPMessages]                   Client: Synchronized (0) 25 bytes
  INFO [DelayedMessageQueue.add]                     LandGrantStart is delivered in 1 frames, rountrip 2ms, max 67ms
  INFO [LandGrantPhase.apply]                        Starting land grant
