Bogus IP Header Length Packet Sniff

[towbes]

I am currently in Asia and have always had issues connecting here during working hours. This is mostly due to a terrible internet connection. In order to determine if my connection has been dropped from the server, I run wireshark to watch the IP traffic. Since the patch earlier today there has been a change in the traffic flow and new behavior in the client. After pressing Play Everquest from the server select screen, the loading icon appears on the cursor but the screen never changes. Wireshark spams the traffic pictured below. Eventually the client returns to login screen. I will try back later outside of working hours when my connection improves to see if the same results occur. This was enough of a deviance from the baseline that I wanted to share. It would be great to get a collection of packet logs from people who have similar connection issues (blank server select, crashing on zone, timeout at login, failure to load from char select) so we could compare.

Update: Was able to login after a few more tries, still curious to know what could have changed to see that new message though. Have not seen that occur in over a month of sniffing when I log in

[Vandy]

Most likely a change relating to this patch note.

Rogean: Possible improvements to zoning reliability (EQEmu Community).

[Wisteso]

Yep. They implemented an enhancement from EQEmu to improve reliability of zoning.

Your client will attempt to connect many times now instead of only getting one try.

Unfortunately your connection seems too unreliable to work even with that improvement in place.

[demonstar55]

If you post your Logs/dbg.txt (or just a snippet of connection failing) I can take a guess if it's the client giving up or not.

[towbes]

Interesting. My login issues seem to have gotten worse since this patch but haven't had long enough to really determine. I will start collecting the dbgs for crashes, I currently only have ones from before the patch was implemented.

Edit: Haven't done enough zoning to reliably tell if there is a difference in performance. Once I get connected my network meter sits at 100% / 375ish ms

[towbes]

dbg.txt from getting to char select, pressing enter world with a character and character never loading, have to close window


2015-06-13 10:14:08 Initializing precipitation system.
2015-06-13 10:14:08 World initialized: clz
2015-06-13 10:14:08 load done.
2015-06-13 10:14:08
2015-06-13 10:14:08 Starting char select.
2015-06-13 10:14:08
2015-06-13 10:14:08 Clearing display buffers.
2015-06-13 10:14:08
2015-06-13 10:14:08 Display buffers cleared.
2015-06-13 10:14:08
2015-06-13 10:14:08 Initializing character select UI.
2015-06-13 10:14:08 Resetting game UI.
2015-06-13 10:14:18 Item done, MSG_WEATHER_EVENT received.
2015-06-13 10:14:18
2015-06-13 10:14:48 Item done, MSG_WEATHER_EVENT received.
2015-06-13 10:14:49
2015-06-13 10:15:06 Item done, MSG_WEATHER_EVENT received.
2015-06-13 10:15:06
2015-06-13 10:15:37 Item done, MSG_WEATHER_EVENT received.
2015-06-13 10:15:37
2015-06-13 10:15:44 D3DXCreateTextureFromFileEx() failed to create texture spelma.png for particle system.
2015-06-13 10:15:44 D3DXCreateTextureFromFileEx() failed to create texture spelma.png for particle system.
2015-06-13 10:15:54 D3DXCreateTextureFromFileEx() failed to create texture spelma.png for particle system.
2015-06-13 10:15:54 D3DXCreateTextureFromFileEx() failed to create texture spelma.png for particle system.
2015-06-13 10:15:54 D3DXCreateTextureFromFileEx() failed to create texture spelma.png for particle system.
2015-06-13 10:16:04 D3DXCreateTextureFromFileEx() failed to create texture spelja.png for particle system.

[towbes]

First a successful zone into steamfont mountains. From here I was ported to West Commons and disconnected on zone and had to close window:

2015-06-13 11:11:25
2015-06-13 11:11:25 Initializing zone.
2015-06-13 11:11:25 Initializing world.
2015-06-13 11:11:25 Attempting to load steamfont.EQG.
2015-06-13 11:11:25 Verifying world files.
2015-06-13 11:11:25 Loading zone specific files.
2015-06-13 11:11:25 Loading steamfont_obj2
2015-06-13 11:11:25 Loading steamfont_obj
2015-06-13 11:11:25 Loading steamfont_chr2
2015-06-13 11:11:25 Loading steamfont_chr
2015-06-13 11:11:25 Loaded cst.EQG.
2015-06-13 11:11:25 Loaded NPC with code cst from cst.s3d
2015-06-13 11:11:25
2015-06-13 11:11:25 Loading brc_chr
2015-06-13 11:11:25 Failed to open C:\Program Files (x86)\Sony\EverQuest\brc_chr.s3d.
2015-06-13 11:11:25
2015-06-13 11:11:25 Loaded NPC with code brc from brc_chr.s3d
2015-06-13 11:11:25
2015-06-13 11:11:25 Loading ccd_chr
2015-06-13 11:11:25 Failed to open C:\Program Files (x86)\Sony\EverQuest\ccd_chr.s3d.
2015-06-13 11:11:25
2015-06-13 11:11:25 Loaded NPC with code ccd from ccd_chr.s3d
2015-06-13 11:11:25
2015-06-13 11:11:25 Loading dru_chr
2015-06-13 11:11:25 Failed to open C:\Program Files (x86)\Sony\EverQuest\dru_chr.s3d.
2015-06-13 11:11:25
2015-06-13 11:11:25 Loaded NPC with code dru from dru_chr.s3d
2015-06-13 11:11:25
2015-06-13 11:11:25 Loading trk_chr
2015-06-13 11:11:25 Loaded NPC with code trk from trk_chr.s3d
2015-06-13 11:11:25
2015-06-13 11:11:25 Load NPC point 1 (qeynos_chr, qcm)
2015-06-13 11:11:25
2015-06-13 11:11:25 Load world point 3 (C:\Program Files (x86)\Sony\EverQuest\qeynos_chr.s3d)
2015-06-13 11:11:25
2015-06-13 11:11:25 Load NPC point 5 (1aa09d30, qeynos_chr.wld, qcm).
2015-06-13 11:11:25
2015-06-13 11:11:25 Successful read of NPC.
2015-06-13 11:11:26
2015-06-13 11:11:26 Load NPC end (1).
2015-06-13 11:11:26
2015-06-13 11:11:26 Loaded NPC with code qcm from qeynos_chr.s3d
2015-06-13 11:11:26
2015-06-13 11:11:26 Load NPC point 1 (unrest_chr, zom)
2015-06-13 11:11:26
2015-06-13 11:11:26 Load world point 3 (C:\Program Files (x86)\Sony\EverQuest\unrest_chr.s3d)
2015-06-13 11:11:26
2015-06-13 11:11:26 Load NPC point 5 (1aa09d30, unrest_chr.wld, zom).
2015-06-13 11:11:26
2015-06-13 11:11:26 Successful read of NPC.
2015-06-13 11:11:26
2015-06-13 11:11:26 Load NPC end (1).
2015-06-13 11:11:26
2015-06-13 11:11:26 Loaded NPC with code zom from unrest_chr.s3d
2015-06-13 11:11:26
2015-06-13 11:11:26 Load NPC point 1 (unrest_chr, zof)
2015-06-13 11:11:26
2015-06-13 11:11:26 Load world point 3 (C:\Program Files (x86)\Sony\EverQuest\unrest_chr.s3d)
2015-06-13 11:11:26
2015-06-13 11:11:26 Load NPC point 5 (1aa09d30, unrest_chr.wld, zof).
2015-06-13 11:11:26
2015-06-13 11:11:26 Successful read of NPC.
2015-06-13 11:11:26
2015-06-13 11:11:26 Load NPC end (1).
2015-06-13 11:11:26
2015-06-13 11:11:26 Loaded NPC with code zof from unrest_chr.s3d
2015-06-13 11:11:26
2015-06-13 11:11:26 Loaded tar.EQG.
2015-06-13 11:11:26 Loaded NPC with code tar from tar.s3d
2015-06-13 11:11:26
2015-06-13 11:11:26 Loaded dke.EQG.
2015-06-13 11:11:26 Loaded NPC with code dke from dke.s3d
2015-06-13 11:11:26
2015-06-13 11:11:26 Loaded rtn.EQG.
2015-06-13 11:11:26 Loaded NPC with code rtn from rtn.s3d
2015-06-13 11:11:26
2015-06-13 11:11:26 Loading steamfont
2015-06-13 11:11:27 Loading objects
2015-06-13 11:11:27 Loading lights
2015-06-13 11:11:27 Initializing cameras.
2015-06-13 11:11:27 Initializing lights.
2015-06-13 11:11:27 Initializing visual effects.
2015-06-13 11:11:27 Initializing target indicator.
2015-06-13 11:11:27 Initializing player path.
2015-06-13 11:11:27 Performing post-load operations.
2015-06-13 11:11:27 Initializing precipitation system.
2015-06-13 11:11:27 World initialized: steamfont
2015-06-13 11:11:27 Requesting zone data.
2015-06-13 11:11:27 Resetting cameras.
2015-06-13 11:11:27 Resetting vision.
2015-06-13 11:11:27 Resetting overlays.
2015-06-13 11:11:27 Zone initialized.
2015-06-13 11:11:27 Creating INI files.
2015-06-13 11:11:27 Requesting AA data.
2015-06-13 11:11:27 Requesting Skill rank data.
2015-06-13 11:11:27 Entering main loop.
2015-06-13 11:11:27 Loading game sounds.
2015-06-13 11:11:27 Requesting initialization data.
2015-06-13 11:11:27 DoMainLoop: just before first while(!ReadyEnterWorld).
2015-06-13 11:11:27 Zone Connect -- Received MSG_READY_ENTER_WORLD
2015-06-13 11:11:28 DoMainLoop: complete after first while(!ReadyEnterWorld).
2015-06-13 11:11:28 DoMainLoop: just before second while(!ReadyEnterWorld).
2015-06-13 11:11:28 Zone Connect -- Sending out a MSG_READY_ENTER_WORLD.
2015-06-13 11:11:28 Zone Connect -- Received MSG_READY_ENTER_WORLD
2015-06-13 11:11:28 DoMainLoop: completed second while(!ReadyEnterWorld).
2015-06-13 11:11:28 Setting up models.
2015-06-13 11:11:28 Setting up character.
2015-06-13 11:11:28 Activating music.
2015-06-13 11:11:28 Initialization complete.
2015-06-13 11:11:28 Entering main loop.
2015-06-13 11:11:29 Item done, MSG_WEATHER_EVENT received.
2015-06-13 11:11:29
2015-06-13 11:11:33 Item done, MSG_WEATHER_EVENT received.
2015-06-13 11:11:33
2015-06-13 11:13:31 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:13:31 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:13:35 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:13:35 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:14:03 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:03 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:06 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:06 D3DXCreateTextureFromFileEx() failed to create texture gena20.bmp for particle system.
2015-06-13 11:14:39 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:14:39 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:14:39 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:55 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:55 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:56 Networking: Connection Closed [0] with 0 pending bytes.
2015-06-13 11:14:56 Stopping world display.
2015-06-13 11:14:56 Attempt to send message 30546 on a void connection.
2015-06-13 11:14:56 Beginning EnterZone block.
2015-06-13 11:14:56
2015-06-13 11:14:56 Calling WorldAuthenticate. Countdown is 4
2015-06-13 11:14:56
2015-06-13 11:14:56 Networking: using port [53481].
2015-06-13 11:14:56 Networking: Connection Established [1]
2015-06-13 11:14:56 WorldAuthenticate: Initiating Login.
2015-06-13 11:15:26 Networking: Connection Closed [0] with 0 pending bytes.
2015-06-13 11:15:26 *** ERROR: WorldAuthenticate. My message arrival was NULL, the net has been shutdown.
2015-06-13 11:15:26 *** WorldAuthenticate. Checkpoint 3.
2015-06-13 11:15:29 Calling WorldAuthenticate. Countdown is 3
2015-06-13 11:15:29
2015-06-13 11:15:29 Networking: using port [53484].
2015-06-13 11:15:29 Networking: Connection Established [1]
2015-06-13 11:15:29 WorldAuthenticate: Initiating Login.
2015-06-13 11:15:30 WorldAuthenticate. I got a message of type 0xfa6 (4006).
2015-06-13 11:15:30 WorldRPServer message: server name P1999PVP
2015-06-13 11:15:30
2015-06-13 11:15:30 WorldAuthenticate. I got a message of type 0x3c25 (15397).
2015-06-13 11:15:30 WorldAuthenticate. I got a message of type 0x7cba (31930).
2015-06-13 11:15:30 WorldAuthenticate. I got a message of type 0x52a4 (21156).
2015-06-13 11:15:30 WorldAuthenticate. Access granted.
2015-06-13 11:15:30
2015-06-13 11:15:30 Check 1sa. 0x9141f657
2015-06-13 11:15:30
2015-06-13 11:15:30 Check 1x. 0x9e15bc94
2015-06-13 11:15:30
2015-06-13 11:15:30 Waiting to connect to zone... Character <censored>
2015-06-13 11:15:30
2015-06-13 11:15:31 Zone Connect -- 0 -- Received MSG_ZONE_ADDRESS
2015-06-13 11:15:31 Zone addr [108.61.129.184:28187] received...
2015-06-13 11:15:32 ZONING
2015-06-13 11:15:32 Networking: Connection Closed [0] with 0 pending bytes.
2015-06-13 11:15:32 Networking: using port [53487].
2015-06-13 11:15:32 Networking: Connection Established [1]
2015-06-13 11:15:42 Item done, MSG_WEATHER_EVENT received.
2015-06-13 11:15:42
2015-06-13 11:16:14 Item done, MSG_WEATHER_EVENT received.
2015-06-13 11:16:14
2015-06-13 11:16:32 Could not connect to 108.61.129.184:7022 [client[You must be logged in to view images. Log in or Register.]isconnectReasonConnectFail,server[You must be logged in to view images. Log in or Register.]isconne ctReasonNone]. Negotiation count: 595.
2015-06-13 11:16:32
2015-06-13 11:16:32 Networking: Connection Closed [0] with 0 pending bytes.
2015-06-13 11:16:32 Failed to connect to zoneserver (108.61.129.184, port 7022), result = 1, for MSG_ZONE_ADDRESS.
2015-06-13 11:16:32
2015-06-13 11:16:34 disconnected at C:\EQ\EverQuest\EverQuest.cpp:20223 (char. select) g_world == NULL
2015-06-13 11:16:34
2015-06-13 11:16:34 Character is <censored>.
2015-06-13 11:16:34
2015-06-13 11:16:37 Cleanup 1
2015-06-13 11:16:37
2015-06-13 11:16:37 Cleanup 4
2015-06-13 11:16:37
2015-06-13 11:16:37 Cleanup 5
2015-06-13 11:16:37
2015-06-13 11:16:37 Cleanup 6
2015-06-13 11:16:37
2015-06-13 11:16:37 Cleanup 7
2015-06-13 11:16:37
2015-06-13 11:16:37 Cleanup 8
2015-06-13 11:16:37
2015-06-13 11:16:37 Cleanup 9
2015-06-13 11:16:37
2015-06-13 11:16:37 Cleanup 10
2015-06-13 11:16:37
2015-06-13 11:16:37 Resetting UI.
2015-06-13 11:16:37 Resetting character select UI.
2015-06-13 11:16:37 Resetting game UI.
2015-06-13 11:16:37 UI Reset.
2015-06-13 11:16:37 Cleanup 11
2015-06-13 11:16:37
2015-06-13 11:16:37 Picking a default resolution, desktop is 1920 x 1080, 32 bits
2015-06-13 11:16:37 Ratio is 1.78
2015-06-13 11:16:37 Resolution was capped at 1280 x 720
2015-06-13 11:16:37 Resolution verified 1280 x 720, 32 bits ... diff was 1000 from 0 modes
2015-06-13 11:16:37 Resolution selected 1280 x 720, 32 bits
2015-06-13 11:16:37 CRender::InitDevice: Using 32bit mode.
2015-06-13 11:16:37 CRender::InitDevice: Using vsync 0.
2015-06-13 11:16:37 CRender::InitDevice: Using 24bit depth buffer with 8 bit stencil.
2015-06-13 11:16:37 CRender::InitDevice: HardwareTnL Enabled.
2015-06-13 11:16:37 Using hardware vertex shaders.
2015-06-13 11:16:37 Initializing render system.
2015-06-13 11:16:37 Trilinear Mipmapping available.
2015-06-13 11:16:37 Vertex Shader Version: 3.0
2015-06-13 11:16:37 Pixel Shader Version: 3.0
2015-06-13 11:16:37 Initializing engine internals.
2015-06-13 11:16:37 CRender::InitDevice completed successfully.
2015-06-13 11:16:37 Parsing INI file ./eqlsUIConfig.ini
2015-06-13 11:16:38 INI file ./eqlsUIConfig.ini loaded.

[towbes]

If someone used to have issues crashing on zone, and has been 100% since this no patch. Please post here.

If no one can say that they are now 100% zoning. Please for the love of god roll this patch back.

[Whiteberry]

TBH man, looking through that dump.. It looks like its trying to load the spell particles but is unable to find / load them, and that's what is closing the connection.

Originally Posted by towbes [You must be logged in to view images. Log in or Register.]

2015-06-13 11:13:31 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:13:31 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:13:35 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:13:35 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:14:03 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:03 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:06 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:06 D3DXCreateTextureFromFileEx() failed to create texture gena20.bmp for particle system.
2015-06-13 11:14:39 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:14:39 D3DXCreateTextureFromFileEx() failed to create texture flare_blsp50a.png for particle system.
2015-06-13 11:14:39 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:55 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.
2015-06-13 11:14:55 D3DXCreateTextureFromFileEx() failed to create texture spelab.tga for particle system.

[towbes]

What would case this to happen? All of these are in my EQ install folder. It looks to me like I'm missing a packet or two in the zoning process and it's throwing off the entire load, anyone else have dbg logs from similar circumstances?