Implemented Logging in issue major problem

Discussion in 'Monster' started by Spot1, Apr 12, 2014.

  1. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    This is the error I get on the console any idea's

    2014-04-12 18:37:09 [INFO] [NEIAddons] Registered subset Extra Bees.Machines.Alveary: [1372]
    2014-04-12 18:37:09 [INFO] [NEIAddons|Forestry] Loaded Extra Bees comb item: binnie.extrabees.products.ItemHoneyComb@3b72eecd (8776)
    2014-04-12 18:37:09 [INFO] [NEIAddons|Forestry] Loaded TB comb item: magicbees.item.ItemComb@5b97b833
    2014-04-12 18:37:09 [INFO] [NEIAddons|Forestry] Loaded Magic Bees comb item: magicbees.item.ItemComb@5b97b833 (26090)
    2014-04-12 18:37:09 [INFO] [STDOUT] Loaded net.bdew.neiaddons.NEIAddonsConfig
    2014-04-12 18:37:09 [WARNING] [ForgeModLoader] Could not retrieve Forestry item identified by: biomeFinder
    2014-04-12 18:37:09 [INFO] [STDOUT] Loaded mods.neiplugins.NEIPluginsConfig
    2014-04-12 18:37:32 [INFO] [STDOUT] Inserted super call into axm.c
    2014-04-12 18:37:32 [INFO] [STDOUT] computercraft: Searching for RedPowerWorld...
    2014-04-12 18:37:32 [INFO] [STDOUT] computercraft: RedPowerWorld not found.
    2014-04-12 18:37:33 [INFO] [STDERR] NEI: Omitting #31308:0 ItemHealCrystal
    2014-04-12 18:37:33 [INFO] [STDERR] java.lang.ArrayIndexOutOfBoundsException: 31308
    2014-04-12 18:37:33 [INFO] [STDERR] at net.minecraft.item.ItemBlock.func_77617_a(ItemBlock.java:52)
    2014-04-12 18:37:33 [INFO] [STDERR] at net.minecraft.item.Item.func_77650_f(Item.java:310)
    2014-04-12 18:37:33 [INFO] [STDERR] at codechicken.nei.ItemList$ThreadLoadItems.run(ItemList.java:366)
    2014-04-12 18:38:10 [INFO] [STDERR] java.net.SocketTimeoutException: Read timed out
    2014-04-12 18:38:10 [INFO] [STDERR] at java.net.SocketInputStream.socketRead0(Native Method)
    2014-04-12 18:38:10 [INFO] [STDERR] at java.net.SocketInputStream.read(Unknown Source)
    2014-04-12 18:38:10 [INFO] [STDERR] at java.net.SocketInputStream.read(Unknown Source)
    2014-04-12 18:38:10 [INFO] [STDERR] at java.io.FilterInputStream.read(Unknown Source)
    2014-04-12 18:38:10 [INFO] [STDERR] at org.bouncycastle.crypto.io.CipherInputStream.nextChunk(Unknown Source)
    2014-04-12 18:38:10 [INFO] [STDERR] at org.bouncycastle.crypto.io.CipherInputStream.read(Unknown Source)
    2014-04-12 18:38:10 [INFO] [STDERR] at java.io.DataInputStream.readFully(Unknown Source)
    2014-04-12 18:38:10 [INFO] [STDERR] at net.minecraft.network.packet.Packet56MapChunks.func_73267_a(Packet56MapChunks.java:112)
    2014-04-12 18:38:10 [INFO] [STDERR] at net.minecraft.network.packet.Packet.func_73272_a(Packet.java:166)
    2014-04-12 18:38:10 [INFO] [STDERR] at net.minecraft.network.TcpConnection.func_74447_i(TcpConnection.java:325)
    2014-04-12 18:38:10 [INFO] [STDERR] at net.minecraft.network.TcpConnection.func_74450_c(TcpConnection.java:549)
    2014-04-12 18:38:10 [INFO] [STDERR] at net.minecraft.network.TcpReaderThread.run(SourceFile:94)
    2014-04-12 18:38:11 [INFO] [Remote IO] Restoring client configs
    2014-04-12 18:38:11 [INFO] [MapWriter] connection closed
    2014-04-12 18:38:11 [INFO] [MapWriter] waiting for 72 tasks to finish...
    2014-04-12 18:38:11 [INFO] [MapWriter] done

    I have added a complete log in the attached file's.
    can someone plz help its been a nightmare.
     

    Attached Files:

    • log.txt
      File size:
      784 KB
      Views:
      712
  2. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    what is the problem? are you getting kicked back to the lobby, is the game crashing, are you getting disconnected, are you even able to join?
    and where you on the server before?

    unfortunately this log shows nothing, as everyone is getting the arrayindexoutofbounds from the heal crystal as far as I know, but I will verify this.
     
  3. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    straight off with this
    Conncetion lost
    Intenral Exception: java.net.sockettimeoutexception: read time out

    I start off in the lobby
    it loads a little of the map then I get that error.
     
  4. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    ok, thanks. I need to look if it is chunk related or player file (inventory) related. might take some time as I need to restart the modpack multiple times.[DOUBLEPOST=1397294143,1397294073][/DOUBLEPOST]
    on which monster server?
     
  5. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    monster.mineyourmind.net

    but if ur talking about when im in the lobby its the middle 1
     
  6. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    ok thanks. just a note: I recommend you to use monster-new.mineyourmind.net to connect directly and bypass the lobby.
     
  7. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    I tried to log into the server u told me and this is what I got

    java.net.SocketTimeoutException: Read timed out

    This happens everyday at 3PM on the dot.


    2014-04-12 19:46:12 [INFO] [Minecraft-Client] [CHAT] Aroma1997Core failed to do VersionChecking. Either there is something wrong with your network connection or with my server.
    2014-04-12 19:46:42 [INFO] [STDOUT] Inserted super call into axm.c
    2014-04-12 19:46:42 [INFO] [STDOUT] computercraft: Searching for RedPowerWorld...
    2014-04-12 19:46:42 [INFO] [STDOUT] computercraft: RedPowerWorld not found.
    2014-04-12 19:46:43 [INFO] [STDERR] NEI: Omitting #31308:0 ItemHealCrystal
    2014-04-12 19:46:43 [INFO] [STDERR] java.lang.ArrayIndexOutOfBoundsException: 31308
    2014-04-12 19:46:43 [INFO] [STDERR] at net.minecraft.item.ItemBlock.func_77617_a(ItemBlock.java:52)
    2014-04-12 19:46:43 [INFO] [STDERR] at net.minecraft.item.Item.func_77650_f(Item.java:310)
    2014-04-12 19:46:43 [INFO] [STDERR] at codechicken.nei.ItemList$ThreadLoadItems.run(ItemList.java:366)
    2014-04-12 19:46:47 [INFO] [STDOUT] Pipelining texture from Reika.RotaryCraft.RotaryCraft to Textures/Items/items.png
    2014-04-12 19:46:58 [INFO] [STDERR] java.net.SocketTimeoutException: Read timed out
    2014-04-12 19:46:58 [INFO] [STDERR] at java.net.SocketInputStream.socketRead0(Native Method)
    2014-04-12 19:46:58 [INFO] [STDERR] at java.net.SocketInputStream.read(Unknown Source)
    2014-04-12 19:46:58 [INFO] [STDERR] at java.net.SocketInputStream.read(Unknown Source)
    2014-04-12 19:46:58 [INFO] [STDERR] at java.io.FilterInputStream.read(Unknown Source)
    2014-04-12 19:46:58 [INFO] [STDERR] at org.bouncycastle.crypto.io.CipherInputStream.nextChunk(Unknown Source)
    2014-04-12 19:46:58 [INFO] [STDERR] at org.bouncycastle.crypto.io.CipherInputStream.read(Unknown Source)
    2014-04-12 19:46:58 [INFO] [STDERR] at java.io.DataInputStream.readFully(Unknown Source)
    2014-04-12 19:46:58 [INFO] [STDERR] at net.minecraft.network.packet.Packet56MapChunks.func_73267_a(Packet56MapChunks.java:112)
    2014-04-12 19:46:58 [INFO] [STDERR] at net.minecraft.network.packet.Packet.func_73272_a(Packet.java:166)
    2014-04-12 19:46:58 [INFO] [STDERR] at net.minecraft.network.TcpConnection.func_74447_i(TcpConnection.java:325)
    2014-04-12 19:46:58 [INFO] [STDERR] at net.minecraft.network.TcpConnection.func_74450_c(TcpConnection.java:549)
    2014-04-12 19:46:58 [INFO] [STDERR] at net.minecraft.network.TcpReaderThread.run(SourceFile:94)
    2014-04-12 19:46:59 [INFO] [Remote IO] Restoring client configs
    2014-04-12 19:46:59 [INFO] [MapWriter] connection closed
    2014-04-12 19:46:59 [INFO] [MapWriter] waiting for 2 tasks to finish...
    2014-04-12 19:46:59 [INFO] [MapWriter] done
     
  8. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    the location you are is fine so I deleted the player.dat and put all items into a chest, please try to login[DOUBLEPOST=1397296496,1397296388][/DOUBLEPOST]
    well, if you have a windows computer, could you please run winmtr at that time on the servers ip?
    Let it run for 10-20 min. and than press copy as text and post it here.
     
  9. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    did u want me to try and log into the server at the same time or just run that by itself[DOUBLEPOST=1397297779,1397297388][/DOUBLEPOST]Also TY slind14 for helping me out.
     
  10. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    as it looks like it is not related to the server, more to the connection to the server. Winmtr will ping our server every second and monitor that over the time. This way we can see if there is a problem and where. You don't need to try to login at that time, but you can if you want to verify that the problem exists during the time winmtr runs.
     
  11. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    This was done at 12PM - 1AM
    this looked better on my note pad lol.
    |------------------------------------------------------------------------------------------|
    | WinMTR statistics |
    | Host - % | Sent | Recv | Best | Avrg | Wrst | Last |
    |------------------------------------------------|------|------|------|------|------|------|
    | lns02.sydnmtc.syd.iprimus.net.au - 1 | 1392 | 1391 | 54 | 56 | 94 | 55 |
    |49.72-134-203.static.sydnmtc.iprimus.net.au - 0 | 1396 | 1396 | 54 | 58 | 150 | 56 |
    | xe-0-3-0.bsr01.sjc.iprimus.net.au - 0 | 1396 | 1396 | 191 | 196 | 297 | 192 |
    | xe-5-3-0.sjc12.ip4.tinet.net - 0 | 1396 | 1396 | 191 | 196 | 287 | 193 |
    | et-10-1-0.ams20.ip4.tinet.net - 0 | 1396 | 1396 | 340 | 342 | 381 | 341 |
    | init7-gw.ip4.tinet.net - 1 | 1392 | 1391 | 349 | 356 | 447 | 360 |
    | r1nue2.core.init7.net - 0 | 1395 | 1395 | 367 | 370 | 441 | 369 |
    | r1nue1.core.init7.net - 0 | 1396 | 1396 | 366 | 370 | 406 | 369 |
    | gw-hetzner.init7.net - 0 | 1396 | 1396 | 363 | 368 | 464 | 364 |
    | core11.hetzner.de - 3 | 1257 | 1222 | 0 | 365 | 422 | 364 |
    | core21.hetzner.de - 0 | 1396 | 1396 | 366 | 368 | 405 | 368 |
    | juniper4.rz20.hetzner.de - 0 | 1396 | 1396 | 366 | 371 | 622 | 368 |
    | hos-tr3.ex3k14.rz20.hetzner.de - 0 | 1395 | 1395 | 367 | 369 | 408 | 369 |
    |static.198.3.63.178.clients.your-server.de - 0 | 1396 | 1396 | 366 | 368 | 412 | 367 |
    |________________________________________________|______|______|______|______|______|______|
    WinMTR v0.92 GPL V2 by Appnor MSP - Fully Managed Hosting & Cloud Provider

    This was done from 1AM - 2AM

    |------------------------------------------------------------------------------------------|
    | WinMTR statistics |
    | Host - % | Sent | Recv | Best | Avrg | Wrst | Last |
    |------------------------------------------------|------|------|------|------|------|------|
    | lns02.sydnmtc.syd.iprimus.net.au - 1 | 3354 | 3351 | 54 | 55 | 93 | 56 |
    |49.72-134-203.static.sydnmtc.iprimus.net.au - 0 | 3365 | 3365 | 54 | 57 | 145 | 55 |
    | xe-0-3-0.bsr01.sjc.iprimus.net.au - 1 | 3361 | 3360 | 191 | 196 | 300 | 192 |
    | xe-5-3-0.sjc12.ip4.tinet.net - 0 | 3365 | 3365 | 191 | 196 | 337 | 193 |
    | et-10-1-0.ams20.ip4.tinet.net - 0 | 3366 | 3366 | 340 | 342 | 387 | 342 |
    | init7-gw.ip4.tinet.net - 0 | 3365 | 3365 | 350 | 355 | 399 | 357 |
    | r1nue2.core.init7.net - 0 | 3362 | 3362 | 367 | 370 | 386 | 378 |
    | r1nue1.core.init7.net - 0 | 3365 | 3365 | 366 | 369 | 404 | 367 |
    | gw-hetzner.init7.net - 1 | 3357 | 3355 | 363 | 368 | 449 | 366 |
    | core11.hetzner.de - 5 | 2880 | 2758 | 363 | 365 | 395 | 366 |
    | core21.hetzner.de - 0 | 3365 | 3365 | 366 | 368 | 420 | 369 |
    | juniper4.rz20.hetzner.de - 1 | 3361 | 3360 | 366 | 370 | 564 | 391 |
    | hos-tr3.ex3k14.rz20.hetzner.de - 0 | 3364 | 3364 | 367 | 368 | 390 | 368 |
    |static.198.3.63.178.clients.your-server.de - 1 | 3361 | 3360 | 366 | 367 | 445 | 368 |
    |________________________________________________|______|______|______|______|______|______|
    WinMTR v0.92 GPL V2 by Appnor MSP - Fully Managed Hosting & Cloud Provider

    I put it in a txt doc just incase it does not look right.[DOUBLEPOST=1397319451,1397318676][/DOUBLEPOST]at 2AM I was able to log in no problems.
     

    Attached Files:

  12. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    thanks for the extra doc, as it is hard to read on the forums without the spaces.

    the packet loss is fine but the ping is kinda high (avrg). I'm not sure if a ping of 360 can already cause connection issues. Where you able to login during both tests, none, or only one?

    If it is always at 3pm, could you please run one more at 3pm?
     
  13. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    I could only log in after 2AM
    I wont be be able to do the 3PM test till Tuesday as I have work through the week.
     
  14. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    ok, does that mean, between 12PM - 1AM you could not login and between 1AM - 2AM the login worked?
     
  15. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    nope only after 2AM was I able to log in
     
  16. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    ok, so we don't have winmtr stats from that time. could you let it run about 5-10 min during the time your are able to login for comprehension?
     
  17. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    okay I have just put it in the note pad lol
     

    Attached Files:

  18. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    as you see for your self, it looks kinda the same and that doesn't make any sense. I hope @Xfel11 or @knoxz have more ideas what it could be.
     
  19. Spot1

    Spot1 Active Member

    Messages:
    24
    Likes Received:
    1
    Local Time:
    3:42 PM
    so I have been messing around with my comp and I got a new error

    -04-17 22:19:08 [INFO] [ForgeModLoader] InvTweaks: net.minecraft.client.gui.GuiTextField
    2014-04-17 22:19:08 [INFO] [ForgeModLoader] InvTweaks: successfully transformed setFocused/func_73796_b
    2014-04-17 22:19:08 [INFO] [Minecraft-Client] [CHAT] Aroma1997Core failed to do VersionChecking. Either there is something wrong with your network connection or with my server.
    2014-04-17 22:19:25 [INFO] [STDOUT] Setting up custom skins
    2014-04-17 22:19:56 [INFO] [STDERR] java.net.SocketTimeoutException: Read timed out
    2014-04-17 22:19:56 [INFO] [STDERR] at java.net.SocketInputStream.socketRead0(Native Method)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.net.SocketInputStream.read(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.net.SocketInputStream.read(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.io.FilterInputStream.read(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at org.bouncycastle.crypto.io.CipherInputStream.nextChunk(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at org.bouncycastle.crypto.io.CipherInputStream.read(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.io.DataInputStream.readFully(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at net.minecraft.network.packet.Packet56MapChunks.func_73267_a(Packet56MapChunks.java:112)
    2014-04-17 22:19:56 [INFO] [STDERR] at net.minecraft.network.packet.Packet.func_73272_a(Packet.java:166)
    2014-04-17 22:19:56 [INFO] [STDERR] at net.minecraft.network.TcpConnection.func_74447_i(TcpConnection.java:325)
    2014-04-17 22:19:56 [INFO] [STDERR] at net.minecraft.network.TcpConnection.func_74450_c(TcpConnection.java:549)
    2014-04-17 22:19:56 [INFO] [STDERR] at net.minecraft.network.TcpReaderThread.run(SourceFile:94)
    2014-04-17 22:19:56 [INFO] [STDERR] java.net.SocketException: Socket closed
    2014-04-17 22:19:56 [INFO] [STDERR] at java.net.SocketOutputStream.socketWrite(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.net.SocketOutputStream.write(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at org.bouncycastle.crypto.io.CipherOutputStream.write(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.io.BufferedOutputStream.flushBuffer(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.io.BufferedOutputStream.flush(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at java.io.DataOutputStream.flush(Unknown Source)
    2014-04-17 22:19:56 [INFO] [STDERR] at net.minecraft.network.TcpWriterThread.run(SourceFile:121)
     
  20. Slind

    Slind Founder

    Messages:
    8,332
    Likes Received:
    3,018
    Local Time:
    6:42 AM
    that only tells us that the responstime between server and client and or the other way around is too long. But if we look at winmtr it is the same. So I really don't know what it could be. @Xfel11 and @knoxz could you take a look?
     

Share This Page