Test Server 22 March 2011

[Grey]

Hello,

my input on the topic on live THF server.
i run 12 toons:
full graphic options = random crash when zoning
high graphic / old models = max 2 crash in 5 hours session

i zone with clicky gate, succor etc...

I meet issues (1toon freeze when other toon zone in sometimes also with a 2 sec lag approx.

Imac 27 i7 8giga SSD hardware for system & eq

Can you elaborate on this?
Do you play all 12 at the same time, how many do you zone at once?
Which client do you use, whats your latency to the server normally like?

[Grey]

Code: Select all

2011-03-24 15:14:13   Calling WorldAuthenticate.  Countdown is 4
2011-03-24 15:14:13   
2011-03-24 15:14:13   Networking: using port [57390].
2011-03-24 15:14:13   Networking: Connection Established [1]
2011-03-24 15:14:13   WorldAuthenticate: Initiating Login.
2011-03-24 15:14:14   WorldAuthenticate: connection lost during authentication.
2011-03-24 15:14:14   
2011-03-24 15:14:15   Rejected By World. retrying
2011-03-24 15:14:15   
2011-03-24 15:14:15   Networking: Connection Established [2]
2011-03-24 15:14:15   WorldAuthenticate: Initiating Login.
2011-03-24 15:14:45   Networking: Connection Closed [1] with 0 pending bytes.
2011-03-24 15:14:45   *** ERROR: WorldAuthenticate.  My message arrival was NULL, the net has been shutdown.
2011-03-24 15:14:45   *** WorldAuthenticate.  Checkpoint 3.
2011-03-24 15:14:48   Calling WorldAuthenticate.  Countdown is 3
2011-03-24 15:14:48   
2011-03-24 15:14:48   Networking: Connection Established [2]
2011-03-24 15:14:49   WorldAuthenticate: Initiating Login.
2011-03-24 15:14:49   WorldAuthenticate: connection lost during authentication.
2011-03-24 15:14:49   
2011-03-24 15:14:50   Rejected By World. retrying
2011-03-24 15:14:50   
2011-03-24 15:14:50   Networking: Connection Established [3]
2011-03-24 15:14:51   WorldAuthenticate: Initiating Login.
2011-03-24 15:15:21   Networking: Connection Closed [2] with 0 pending bytes.
2011-03-24 15:15:21   *** ERROR: WorldAuthenticate.  My message arrival was NULL, the net has been shutdown.
2011-03-24 15:15:21   *** WorldAuthenticate.  Checkpoint 3.
2011-03-24 15:15:24   Calling WorldAuthenticate.  Countdown is 2
2011-03-24 15:15:24   
2011-03-24 15:15:24   Networking: Connection Established [3]
2011-03-24 15:15:24   WorldAuthenticate: Initiating Login.
2011-03-24 15:15:24   WorldAuthenticate: connection lost during authentication.
2011-03-24 15:15:24   
2011-03-24 15:15:25   Rejected By World. retrying
2011-03-24 15:15:25   
2011-03-24 15:15:25   Networking: Connection Established [4]
2011-03-24 15:15:25   WorldAuthenticate: Initiating Login.
2011-03-24 15:15:56   Networking: Connection Closed [3] with 0 pending bytes.
2011-03-24 15:15:56   *** ERROR: WorldAuthenticate.  My message arrival was NULL, the net has been shutdown.
2011-03-24 15:15:56   *** WorldAuthenticate.  Checkpoint 3.
2011-03-24 15:15:58   Calling WorldAuthenticate.  Countdown is 1
2011-03-24 15:15:58   
2011-03-24 15:15:58   Networking: Connection Established [4]
2011-03-24 15:16:00   WorldAuthenticate: Initiating Login.
2011-03-24 15:16:00   WorldAuthenticate: connection lost during authentication.
2011-03-24 15:16:00   
2011-03-24 15:16:01   Rejected By World. retrying
2011-03-24 15:16:01   
2011-03-24 15:16:01   Networking: Connection Established [5]
2011-03-24 15:16:01   WorldAuthenticate: Initiating Login.
2011-03-24 15:16:32   Networking: Connection Closed [4] with 0 pending bytes.
2011-03-24 15:16:32   *** ERROR: WorldAuthenticate.  My message arrival was NULL, the net has been shutdown.
2011-03-24 15:16:32   *** WorldAuthenticate.  Checkpoint 3.
2011-03-24 15:16:34   Calling WorldAuthenticate.  Countdown is 0
2011-03-24 15:16:34   
2011-03-24 15:16:34   Networking: Connection Established [5]
2011-03-24 15:16:34   WorldAuthenticate: Initiating Login.
2011-03-24 15:16:35   WorldAuthenticate: connection lost during authentication.
2011-03-24 15:16:35   
2011-03-24 15:16:36   Rejected By World. retrying
2011-03-24 15:16:36   
2011-03-24 15:16:36   Networking: Connection Established [6]
2011-03-24 15:16:40   WorldAuthenticate: Initiating Login.
2011-03-24 15:16:40   WorldAuthenticate: connection lost during authentication.
2011-03-24 15:16:40   
2011-03-24 15:16:41   Rejected By World. retrying
2011-03-24 15:16:41   
2011-03-24 15:16:41   Networking: Connection Established [7]
2011-03-24 15:16:45   WorldAuthenticate: Initiating Login.
2011-03-24 15:16:45   WorldAuthenticate: connection lost during authentication.
2011-03-24 15:16:45   
2011-03-24 15:16:46   Rejected By World. abort abort
2011-03-24 15:16:46   
2011-03-24 15:16:48   ERROR: Unable to get player name, g_world is NULL, not connected.
2011-03-24 15:16:48   
2011-03-24 15:16:49   Check 1sa. 0x6e01d339
2011-03-24 15:16:49   
2011-03-24 15:16:49   Attempt to send message 20594 on a void connection.
2011-03-24 15:16:49   Check 1x. 0x9e15bc94
2011-03-24 15:16:49   
2011-03-24 15:16:49   Attempt to send message 23320 on a void connection.
2011-03-24 15:16:49   Attempt to send message 31930 on a void connection.
2011-03-24 15:16:49   Waiting to connect to zone... Character Rednif
2011-03-24 15:16:49   
2011-03-24 15:16:49   disconnected at C:\EQ\EverQuest\EverQuest.cpp:20223 (char. select) g_world == NULL
2011-03-24 15:16:49   
2011-03-24 15:16:49   Character is Rednif.
2011-03-24 15:16:49   
2011-03-24 15:16:52   Cleanup 1
2011-03-24 15:16:52   
2011-03-24 15:16:52   Cleanup 4
2011-03-24 15:16:52   
2011-03-24 15:16:52   Cleanup 5
2011-03-24 15:16:52   
2011-03-24 15:16:52   Cleanup 6
2011-03-24 15:16:52   
2011-03-24 15:16:52   Cleanup 7
2011-03-24 15:16:52   
2011-03-24 15:16:52   Cleanup 8
2011-03-24 15:16:52   
2011-03-24 15:16:52   Cleanup 9
2011-03-24 15:16:52   
2011-03-24 15:16:52   Cleanup 10
2011-03-24 15:16:52   
2011-03-24 15:16:52   Resetting UI.
2011-03-24 15:16:52   Resetting character select UI.
2011-03-24 15:16:52   Resetting game UI.
2011-03-24 15:16:52   UI Reset.
2011-03-24 15:16:52   Cleanup 11
2011-03-24 15:16:52   
2011-03-24 15:16:52   Picking a default resolution, desktop is 1680 x 1050, 32 bits
2011-03-24 15:16:52   Ratio is 1.60
2011-03-24 15:16:52   Resolution was capped at 1280 x 720
2011-03-24 15:16:52   Resolution verified 1280 x 720, 32 bits ... diff was 1000 from 0 modes
2011-03-24 15:16:52   Resolution selected 1280 x 720, 32 bits
2011-03-24 15:16:52   CRender::InitDevice: Using 32bit mode.
2011-03-24 15:16:52   CRender::InitDevice: Using vsync 0.
2011-03-24 15:16:52   CRender::InitDevice: Using 24bit depth buffer with 8 bit stencil.
2011-03-24 15:16:52   CRender::InitDevice: HardwareTnL Enabled. 
2011-03-24 15:16:52   Hardware vertex shaders disabled.
2011-03-24 15:16:52   Initializing render system.
2011-03-24 15:16:52   Trilinear Mipmapping available.
2011-03-24 15:16:52   Vertex Shader Version: 3.0
2011-03-24 15:16:52   Pixel Shader Version: 3.0
2011-03-24 15:16:52   Initializing engine internals.
2011-03-24 15:16:52   CRender::InitDevice completed successfully.
2011-03-24 15:16:53   Parsing INI file ./eqlsUIConfig.ini
2011-03-24 15:16:53   INI file ./eqlsUIConfig.ini loaded.

[Jaxer]

Same logged info as Grey has, i couldn't even load a zone.

Not sure how to post this like Grey did, but i cut out the part where i seemed to fail.


2011-03-24 14:47:50 Connected to thflive.dyndns.org:37659...
2011-03-24 14:47:50
2011-03-24 14:47:50 Zone Connect -- 2 -- Sending MSG_EQ_ADDPLAYER
2011-03-24 14:48:09 Networking: connection terminated [client:DisconnectReasonOtherSideTerminated,server:DisconnectReasonNone]
2011-03-24 14:48:09 disconnected at C:\EQ\EverQuest\EverQuest.cpp:17233 (char. select) DisconnectReasonOtherSideTerminated,DisconnectReasonNone

Hope this will help, as the server is slowly becoming unplayable.

Thanks,

[Banderas]

Code: Select all

[Thu Mar 24 13:15:58 2011]00471:Zone Connect -- 3 -- Received MSG_SEND_PC
[Thu Mar 24 13:15:58 2011]00472:Received our Player from zone.
[Thu Mar 24 13:15:58 2011]00473:Received MSG_EQ_ADDPLAYER, Player = Sukoshi, zone = Velketor's Labyrinth
[Thu Mar 24 13:16:10 2011]00474:MSG_TIME_STAMP received.

[Thu Mar 24 13:16:10 2011]00475:MSG_TIME_STAMP received. (Items inc).

[Thu Mar 24 13:16:52 2011]00476:Received an item via EQI_STARTING_ITEM at loc 0
[Thu Mar 24 13:16:52 2011]00477:Received an item via EQI_STARTING_ITEM at loc 1
[Thu Mar 24 13:16:52 2011]00478:Received an item via EQI_STARTING_ITEM at loc 2
[Thu Mar 24 13:16:52 2011]00479:Received an item via EQI_STARTING_ITEM at loc 3
[Thu Mar 24 13:16:52 2011]00480:Received an item via EQI_STARTING_ITEM at loc 4
[Thu Mar 24 13:16:52 2011]00481:Received an item via EQI_STARTING_ITEM at loc 5
[Thu Mar 24 13:16:52 2011]00482:Received an item via EQI_STARTING_ITEM at loc 6
[Thu Mar 24 13:16:52 2011]00483:Received an item via EQI_STARTING_ITEM at loc 7
[Thu Mar 24 13:16:52 2011]00484:Received an item via EQI_STARTING_ITEM at loc 8
[Thu Mar 24 13:16:52 2011]00485:Received an item via EQI_STARTING_ITEM at loc 9
[Thu Mar 24 13:16:52 2011]00486:Received an item via EQI_STARTING_ITEM at loc 10
[Thu Mar 24 13:16:52 2011]00487:Received an item via EQI_STARTING_ITEM at loc 11
[Thu Mar 24 13:16:52 2011]00488:Received an item via EQI_STARTING_ITEM at loc 12
[Thu Mar 24 13:16:52 2011]00489:Received an item via EQI_STARTING_ITEM at loc 13
[Thu Mar 24 13:16:52 2011]00490:Received an item via EQI_STARTING_ITEM at loc 14
[Thu Mar 24 13:16:52 2011]00491:Received an item via EQI_STARTING_ITEM at loc 15
[Thu Mar 24 13:16:52 2011]00492:Received an item via EQI_STARTING_ITEM at loc 16
[Thu Mar 24 13:16:52 2011]00493:Received an item via EQI_STARTING_ITEM at loc 17
[Thu Mar 24 13:16:52 2011]00494:Received an item via EQI_STARTING_ITEM at loc 18
[Thu Mar 24 13:16:52 2011]00495:Received an item via EQI_STARTING_ITEM at loc 19
[Thu Mar 24 13:16:52 2011]00496:Received an item via EQI_STARTING_ITEM at loc 20
[Thu Mar 24 13:16:52 2011]00497:Received an item via EQI_STARTING_ITEM at loc 22
[Thu Mar 24 13:16:52 2011]00498:Received an item via EQI_STARTING_ITEM at loc 23
[Thu Mar 24 13:16:52 2011]00499:Received an item via EQI_STARTING_ITEM at loc 24
[Thu Mar 24 13:16:52 2011]00500:Received an item via EQI_STARTING_ITEM at loc 25
[Thu Mar 24 13:16:52 2011]00501:Received an item via EQI_STARTING_ITEM at loc 26
[Thu Mar 24 13:16:52 2011]00502:Received an item via EQI_STARTING_ITEM at loc 27
[Thu Mar 24 13:16:52 2011]00503:Received an item via EQI_STARTING_ITEM at loc 28
[Thu Mar 24 13:16:52 2011]00504:Received an item via EQI_STARTING_ITEM at loc 29
[Thu Mar 24 13:16:52 2011]00505:Received an item via EQI_STARTING_ITEM at loc 30
[Thu Mar 24 13:16:52 2011]00506:Received an item via EQI_STARTING_ITEM at loc 2000
[Thu Mar 24 13:16:52 2011]00507:Received an item via EQI_STARTING_ITEM at loc 2001
[Thu Mar 24 13:16:52 2011]00508:Received an item via EQI_STARTING_ITEM at loc 2002
[Thu Mar 24 13:16:52 2011]00509:Received an item via EQI_STARTING_ITEM at loc 2003
[Thu Mar 24 13:16:52 2011]00510:Received an item via EQI_STARTING_ITEM at loc 2004
[Thu Mar 24 13:16:52 2011]00511:Received an item via EQI_STARTING_ITEM at loc 2005
[Thu Mar 24 13:16:52 2011]00512:Received an item via EQI_STARTING_ITEM at loc 2006
[Thu Mar 24 13:16:52 2011]00513:Received an item via EQI_STARTING_ITEM at loc 2007
[Thu Mar 24 13:16:52 2011]00514:Received an item via EQI_STARTING_ITEM at loc 2008
[Thu Mar 24 13:16:52 2011]00515:Received an item via EQI_STARTING_ITEM at loc 2009
[Thu Mar 24 13:16:52 2011]00516:Received an item via EQI_STARTING_ITEM at loc 2010
[Thu Mar 24 13:16:52 2011]00517:Received an item via EQI_STARTING_ITEM at loc 2011
[Thu Mar 24 13:16:52 2011]00518:Received an item via EQI_STARTING_ITEM at loc 2012
[Thu Mar 24 13:16:52 2011]00519:Received an item via EQI_STARTING_ITEM at loc 2013
[Thu Mar 24 13:16:52 2011]00520:Received an item via EQI_STARTING_ITEM at loc 2014
[Thu Mar 24 13:16:52 2011]00521:Received an item via EQI_STARTING_ITEM at loc 2015
[Thu Mar 24 13:16:52 2011]00522:Received an item via EQI_STARTING_ITEM at loc 2016
[Thu Mar 24 13:16:52 2011]00523:Received an item via EQI_STARTING_ITEM at loc 2017
[Thu Mar 24 13:16:52 2011]00524:Received an item via EQI_STARTING_ITEM at loc 2018
[Thu Mar 24 13:16:52 2011]00525:Received an item via EQI_STARTING_ITEM at loc 2019
[Thu Mar 24 13:16:52 2011]00526:Received an item via EQI_STARTING_ITEM at loc 2020
[Thu Mar 24 13:16:52 2011]00527:Received an item via EQI_STARTING_ITEM at loc 2021
[Thu Mar 24 13:16:52 2011]00528:Received an item via EQI_STARTING_ITEM at loc 2022
[Thu Mar 24 13:16:52 2011]00529:Received an item via EQI_STARTING_ITEM at loc 2023
[Thu Mar 24 13:16:52 2011]00530:Received an item via EQI_STARTING_ITEM at loc 2500
[Thu Mar 24 13:16:52 2011]00531:Received an item via EQI_STARTING_ITEM at loc 2501
[Thu Mar 24 13:16:54 2011]00532:Item done, MSG_WEATHER_EVENT received.

[Thu Mar 24 13:16:54 2011]00533:Initializing zone.
[Thu Mar 24 13:16:54 2011]00534:Initializing world.
[Thu Mar 24 13:16:54 2011]00535:Verifying world files.
[Thu Mar 24 13:16:54 2011]00536:Attempting to load velketor.EQG.
[Thu Mar 24 13:16:54 2011]00537:Loading zone specific files.
[Thu Mar 24 13:16:54 2011]00538:Loading velketor_obj2
[Thu Mar 24 13:16:54 2011]00539:Loading velketor_obj
[Thu Mar 24 13:16:54 2011]00540:Loading velketor_chr2
[Thu Mar 24 13:16:54 2011]00541:Loading velketor_chr
[Thu Mar 24 13:16:55 2011]00542:Loaded tar.EQG.
[Thu Mar 24 13:16:55 2011]00543:Loaded NPC with code tar from tar.s3d

[Thu Mar 24 13:16:55 2011]00544:Loading velketor
[Thu Mar 24 13:16:55 2011]00545:Loading objects
[Thu Mar 24 13:16:55 2011]00546:Loading lights
[Thu Mar 24 13:16:55 2011]00547:Initializing cameras.
[Thu Mar 24 13:16:55 2011]00548:* Bad Initial Camera Location!

[Thu Mar 24 13:16:55 2011]00549:Initializing lights.
[Thu Mar 24 13:16:55 2011]00550:Initializing visual effects.
[Thu Mar 24 13:16:55 2011]00551:Initializing target indicator.
[Thu Mar 24 13:16:55 2011]00552:Initializing player path.
[Thu Mar 24 13:16:55 2011]00553:Performing post-load operations.
[Thu Mar 24 13:16:55 2011]00554:Initializing precipitation system.
[Thu Mar 24 13:16:55 2011]00555:World initialized: velketor
[Thu Mar 24 13:16:55 2011]00556:Requesting zone data.
[Thu Mar 24 13:16:55 2011]00557:Resetting cameras.
[Thu Mar 24 13:16:55 2011]00558:Resetting vision.
[Thu Mar 24 13:16:55 2011]00559:Resetting overlays.
[Thu Mar 24 13:16:55 2011]00560:Zone initialized.
[Thu Mar 24 13:16:55 2011]00561:Creating INI files.
[Thu Mar 24 13:16:55 2011]00562:Requesting AA data.
[Thu Mar 24 13:16:55 2011]00563:Requesting Skill rank data.
[Thu Mar 24 13:16:55 2011]00564:Loading UI.
[Thu Mar 24 13:16:55 2011]00565:Deactivating previous UI.
[Thu Mar 24 13:16:55 2011]00566:Unloading previous textures.
[Thu Mar 24 13:16:55 2011]00567:Resetting UI.
[Thu Mar 24 13:16:55 2011]00568:Resetting character select UI.
[Thu Mar 24 13:16:56 2011]00569:Resetting game UI.
[Thu Mar 24 13:16:56 2011]00570:UI Reset.
[Thu Mar 24 13:16:56 2011]00571:Initializing UI.
[Thu Mar 24 13:16:56 2011]00572:Initializing UI manager.
[Thu Mar 24 13:16:56 2011]00573:Parsing INI file .\Sukoshi_HiddenForest.ini
[Thu Mar 24 13:16:56 2011]00574:INI file .\Sukoshi_HiddenForest.ini loaded.
[Thu Mar 24 13:16:56 2011]00575:Initializing fonts.
[Thu Mar 24 13:16:56 2011]00576:Parsing UI XML.
[Thu Mar 24 13:16:56 2011]00577:Parsing INI file .\UI_Sukoshi_HiddenForest.ini
[Thu Mar 24 13:16:56 2011]00578:INI file .\UI_Sukoshi_HiddenForest.ini loaded.
[Thu Mar 24 13:16:56 2011]00579:Loading default UI resources.
[Thu Mar 24 13:16:56 2011]00580:Initializing game UI.
[Thu Mar 24 13:16:57 2011]00581:Loading Journal.
[Thu Mar 24 13:16:57 2011]00582:Journal loaded.
[Thu Mar 24 13:16:57 2011]00583:Loading Icons.
[Thu Mar 24 13:16:58 2011]00584:Resetting viewport.
[Thu Mar 24 13:16:58 2011]00585:Game UI Initialized.
[Thu Mar 24 13:16:58 2011]00586:Entering main loop.
[Thu Mar 24 13:16:58 2011]00587:DoMainLoop - Just after packet processing()
[Thu Mar 24 13:16:58 2011]00588:DoMainLoop - Just after actor creation()
[Thu Mar 24 13:16:58 2011]00589:Loading game sounds.
[Thu Mar 24 13:16:58 2011]00590:Requesting initialization data.
[Thu Mar 24 13:16:58 2011]00591:DoMainLoop: just before first while(!EverQuest.ReceievedWorldObjects).


... and it just hangs there, black screen, frozen.

Going to give three finger salute and try again.

[Lola]

Hi Grey,

yes I do log 12 titanium client, no 3rd party program at all.
I sometimes :
succor 2 groups of 6 simultanetly
gate all chars with clickies i.e all T clients are loading a new zone at the same time.
I zone them all from Vale to poair

It was to mention that with old models i do not face issues except 2/3 crash per session and that is in PoFire.
I ll check latency etc later on

[Banderas]

Now it worked ... comparing where it was stuck before, the next line on this attempt, where it seems to hang before, was:

Code: Select all

Thu Mar 24 13:23:10 2011]00365:Zone Connect -- Received MSG_SND_WOBJECTS_RESPONSE
[Thu Mar 24 13:23:10 2011]00366:Zone Connect -- Received MSG_READY_ENTER_WORLD
[Thu Mar 24 13:23:10 2011]00367:DoMainLoop: complete after first while(!EverQuest.ReceievedWorldObjects).
[Thu Mar 24 13:23:10 2011]00368:DoMainLoop: just before second while(!ReadyEnterWorld).
[Thu Mar 24 13:23:10 2011]00369:Zone Connect -- Sending out a MSG_READY_ENTER_WORLD.
[Thu Mar 24 13:23:10 2011]00370:DoMainLoop: completed second while(!ReadyEnterWorld).
[Thu Mar 24 13:23:10 2011]00371:Setting up models.
[Thu Mar 24 13:23:10 2011]00372:Setting up character.
[Thu Mar 24 13:23:10 2011]00373:Activating music.
[Thu Mar 24 13:23:10 2011]00374:Initialization complete.
Entering main loop.
[Thu Mar 24 13:23:10 2011]00375:Zone Connect -- Received MSG_READY_ENTER_WORLD
[Thu Mar 24 13:23:14 2011]00376:Item done, MSG_WEATHER_EVENT received.



[Grey]

sounds good, the more info we all post here the easier I hope it will be for the staff.