mp slower startup after update to 1.6 (2 Viewers)

mhoogenbosch

MP Donator
  • Premium Supporter
  • April 21, 2008
    308
    70
    Utrecht, Netherlands
    Home Country
    Netherlands Netherlands
    Sure , no problem.
    With IPv6 ~34 sec
    Without IPv6 ~33 sec

    I'm timing with the stopwatch on my phone, so it gives different results than logging.

    Oh, btw, i''ve entered a fixed IP, so don''t use DHCP for my HTPC. In my experience this is faster and causes less trouble with drive mappings, unc path''s (especially because i''m recording to a UNC path).

    Oh, btw2 :), i'm using a SSD for the system. Should be fast enough.
     

    Attachments

    • IPv6Enabled.zip
      39.5 KB
    • IPv6Disabled.zip
      30.4 KB
    Last edited:

    mm1352000

    Retired Team Member
  • Premium Supporter
  • September 1, 2008
    21,577
    8,224
    Home Country
    New Zealand New Zealand
    Wow. :(
    I look at your log files and I just have the impression that something is wrong. Like the MP program or configuration files are being scanned by some kind of anti-virus/malware/spyware program. It should not be that slow. One of the biggest single culprits:
    [2014-01-09 21:33:19,989] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin loading '\windows\SleepControl.dll' (non threaded)
    [2014-01-09 21:33:24,389] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\SleepControl.dll' (4399,2077 ms running time)

    Ugh! Almost 4.5 seconds to load one plugin. I think that is worth mentioning to the plugin creator, because that is really user unfriendly.

    In general, plugins seem to be the biggest problem for you:
    [2014-01-09 21:33:10,458] [Log ] [MPMain ] [INFO ] - PluginManager: 'C:\Program Files (x86)\Team MediaPortal\MediaPortal\Plugins\windows\ArgusTV.UI.MediaPortal.dll' file version: 2.2.1.0
    [2014-01-09 21:33:12,189] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\ArgusTV.UI.MediaPortal.dll' (1747,2031 ms running time)

    [2014-01-09 21:33:13,001] [Log ] [MPMain ] [INFO ] - PluginManager: 'C:\Program Files (x86)\Team MediaPortal\MediaPortal\Plugins\windows\InfoService.dll' file version: 1.7.2.248
    [2014-01-09 21:33:14,046] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\InfoService.dll' (1076,4019 ms running time)

    [2014-01-09 21:33:15,263] [Log ] [MPMain ] [INFO ] - PluginManager: 'C:\Program Files (x86)\Team MediaPortal\MediaPortal\Plugins\windows\MPEIPlugin.dll' file version: 1.2.1.194
    [2014-01-09 21:33:17,400] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\MPEIPlugin.dll' (2152,8038 ms running time)

    [2014-01-09 21:33:17,400] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin loading '\windows\MP-TVSeries.dll' (non threaded)
    [2014-01-09 21:33:19,818] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\MP-TVSeries.dll' (2418,0043 ms running time)

    [2014-01-09 21:33:14,108] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin loading '\windows\MovingPictures.dll' (non threaded)
    [2014-01-09 21:33:15,247] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\MovingPictures.dll' (1138,802 ms running time)

    [2014-01-09 21:33:24,404] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin loading '\windows\SubCentral.dll' (non threaded)
    [2014-01-09 21:33:25,340] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\SubCentral.dll' (936,0017 ms running time)

    [2014-01-09 21:33:25,621] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin loading '\windows\TraktPlugin.dll' (non threaded)
    [2014-01-09 21:33:27,165] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\TraktPlugin.dll' (1544,4027 ms running time)

    [2014-01-09 21:33:33,827] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin starting 'FanartHandler.FanartHandlerSetup'
    [2014-01-09 21:33:36,884] [Log ] [MPMain ] [DEBUG] - PluginManager: End starting 'FanartHandler.FanartHandlerSetup' (3057,6053 ms running time)

    [2014-01-09 21:33:36,884] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin starting 'LatestMediaHandler.LatestMediaHandlerSetup'
    [2014-01-09 21:33:38,382] [Log ] [MPMain ] [DEBUG] - PluginManager: End starting 'LatestMediaHandler.LatestMediaHandlerSetup' (1497,6027 ms running time)

    Total of ~19 seconds just in those plugins... :(

    This is also interesting:
    [2014-01-09 21:33:29,615] [Log ] [MPMain ] [DEBUG] - Cacheing expression: eq(#Titan.ShowUpdateInd,'true')
    [2014-01-09 21:33:33,499] [Log ] [MPMain ] [DEBUG] - Window: WindowPlugins.home.GUIBasicHome init

    Not sure what the delay is there.

    Summary: plugins are the biggest culprit... but it still seems like MP is running in molasses. Please check the anti-* stuff.

    mm
     

    seco

    Retired Team Member
  • Premium Supporter
  • August 7, 2007
    1,575
    1,239
    Home Country
    Finland Finland
    This is why I asked where the "slowness" is and suggested to disable all 3rd party plugin...
     

    mm1352000

    Retired Team Member
  • Premium Supporter
  • September 1, 2008
    21,577
    8,224
    Home Country
    New Zealand New Zealand
    This is why I asked where the "slowness" is and suggested to disable all 3rd party plugin...
    Even then though...
    I'm running MP 1.6 PR still (shoot me!).

    [2014-01-10 10:42:45,031] [Log ] [MPMain ] [INFO ] - Main: MediaPortal v1.5.100.0 is starting up on Windows XP ( Service Pack 3 ) [5.1.2600.196608]
    ...
    [2014-01-10 10:42:51,062] [Log ] [MPMain ] [DEBUG] - D3D: OnLostFocus()

    Total load time with no 3rd party plugins, DefaultWide, normal HDD (with only 7GB free - ie. quite full and fragmented).

    Quite frankly, I would not even consider using MP if it took 30+ seconds to load. That's a deal breaker.
     

    breese

    Retired Team Member
  • Premium Supporter
  • July 11, 2011
    3,902
    770
    65
    Arlington Heights, Illinois
    Home Country
    United States of America United States of America
    What about starting it with watchdog.... Then we should also get the System and Application Events.
    Maybe there is a hardware / hard drives issue....
     

    mhoogenbosch

    MP Donator
  • Premium Supporter
  • April 21, 2008
    308
    70
    Utrecht, Netherlands
    Home Country
    Netherlands Netherlands
    Okay, did some testing.

    First did some exclusions to the a-v system. Excluded:

    c:\programdata\team mediaportal
    c:\program files (x86)\team mediaportal
    c:\programdata\argus tv
    c:\program files (x86)\argus tv
    c:\timeshift

    This resulded in exactly the same timings as without the a-v. Stable at 28 seconds.

    The other is the debug mode, this starts in 9 seconds. So that's ~ 20 seconds of plugins.... wauw that's a lot!

    Uninstalled sleepcontrol, don't use it anyways, now indeed it boots up at 24 seconds.
     

    Attachments

    • AVDisabled.zip
      38.8 KB
    • DebugModusWithoutAV.zip
      36.4 KB
    Last edited:

    breese

    Retired Team Member
  • Premium Supporter
  • July 11, 2011
    3,902
    770
    65
    Arlington Heights, Illinois
    Home Country
    United States of America United States of America
    Is there a possibility there is a CPU, Memory, Hard Drive issue with your machine.
    If you read on you might understand why I ask....

    At about 4 seconds into the load there is an issue with your network

    [2014-01-10 19:31:30,457] [Log ] [MPMain ] [INFO ] - String not found, using English: 34064 : An Internet connection is required\nFor Last.FM Radio
    [2014-01-10 19:31:30,457] [Log ] [MPMain ] [INFO ] - String not found, using English: 300232 : Only update files after {0}
    [2014-01-10 19:31:30,519] [Log ] [MPMain ] [DEBUG] - RemoteControl: RegisterChannel first called in Domain MediaPortal.exe for thread MPMain with id 1


    Takes 2 seconds to get to here.....

    [2014-01-10 19:31:32,157] [Log ] [CacheChannels] [DEBUG] - CacheChannelsThread: started
    [2014-01-10 19:31:32,204] [Log ] [CacheChannels] [INFO ] - ChannelNavigator::LoadSettings()
    [2014-01-10 19:31:32,859] [Log ] [CacheChannels] [DEBUG] - CacheChannelsThread: ended
    [2014-01-10 19:31:33,530] [Log ] [19 ] [INFO ] - [MPEI] Next download of updates scheduled for 15-1-2014 21:09:17
    [2014-01-10 19:31:34,638] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\SleepControl.dll' (4290,0076 ms running time)
    [2014-01-10 19:31:34,638] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin loading '\windows\SubCentral.dll' (non threaded)
    [2014-01-10 19:31:34,638] [Log ] [MPMain ] [INFO ] - PluginManager: 'C:\Program Files (x86)\Team MediaPortal\MediaPortal\Plugins\windows\SubCentral.dll' file version: 1.2.2.312


    From the Trakt log, this is now also running
    2014-01-10 19:31:35.605 [INFO] [MPMain][01]: Starting Trakt v3.1.3.0
    And while there are errors within TrakT, it runs right thru till
    2014-01-10 19:31:44.622 [DEBG] [DashShows][38]: Unable to find Facade [id:98301], check that trakt skin settings are correctly defined!
    2014-01-10 19:31:44.669 [DEBG] [DashMovies][06]: Unable to find Facade [id:98302], check that trakt skin settings are correctly defined!
    2014-01-10 19:31:57.008 [DEBG] [MPMain][01]: Stopping Sync if running

    That is 9 seconds of TrakT while the MediaPortal loader is also running

    Back to MediaPortal.log
    [2014-01-10 19:31:35,465] [Log ] [MPMain ] [DEBUG] - PluginManager: End loading '\windows\SubCentral.dll' (826,8014 ms running time)
    [2014-01-10 19:31:35,465] [Log ] [MPMain ] [DEBUG] - PluginManager: Begin loading '\windows\TitanSkinUpdater.dll' (non threaded)
    [2014-01-10 19:31:35,465] [Log ] [MPMain ] [INFO ] - PluginManager: 'C:\Program Files (x86)\Team MediaPortal\MediaPortal\Plugins\windows\TitanSkinUpdater.dll' file version: 1.4.0.0


    At about 8 1/2 seconds sense this all started
    There is a log of Cacheing

    [2014-01-10 19:31:38,709] [Log ] [MPMain ] [DEBUG] - Cacheing expression:
    [2014-01-10 19:31:38,803] [Log ] [MPMain ] [DEBUG] - Cacheing expression: eq(#Titan.ShowUpdateInd,'true')
    Where when its done, there is a 2 second delay
    [2014-01-10 19:31:42,765] [Log ] [MPMain ] [DEBUG] - Window: WindowPlugins.home.GUIBasicHome init

    Between the delays of Internet access and Cache access, one might have to question a part or multiple parts of the hardware.
    Also, I do not understand why most of the system is loaded as (non threaded)

    Anyone see or know something I might have missed?
     

    mhoogenbosch

    MP Donator
  • Premium Supporter
  • April 21, 2008
    308
    70
    Utrecht, Netherlands
    Home Country
    Netherlands Netherlands
    Ouch, that's a massive load of information. To be honest i don't know if there is something wrong with my CPU / MEM or HDD. DOn't now how to check this. There doesn't seem to be someting wrong, but that nessecerely means there isn't.

    what does 'non threaded' mean? Because the CPU i have is a dual core with HT, so , it should be doing some threading, right?

    I'll open up taskmanager en gpu-z to see what happens during the startup.

    ---

    I added a screenshot of the taskmanager right after mepo has started. GPU-Z says the GPU stays at ~10% load... How can I check if there is something wrong.

    The harddrive is a SSD of corsair.

    There is a tool SSD Toolbox from corsair, ive run that, but it says the drive is OK
     

    Attachments

    • right after startup mepo.png
      right after startup mepo.png
      68.7 KB
    Last edited:

    breese

    Retired Team Member
  • Premium Supporter
  • July 11, 2011
    3,902
    770
    65
    Arlington Heights, Illinois
    Home Country
    United States of America United States of America
    While your at it..
    Right click on my computer and then click on Manage
    Click on the Arrow next to Event Viewer
    Click on the arrow next to Windows Logs
    Check for errors related to hardware in Application and in System

    of the System Specs in your profile, which machine is this?

    There is a built in Windows Memory test.
    click start and then Help and Support
    Type in Memory Test ‌

    Another test is to check the hard drive for errors. This could take some time and it is best to not try and stop it if you run it.
    Right click on the C: Get Properties
    Tools Tab
    Check Now button
    Make sure both options are selected and Start
    It will tell you it will begin after the next reboot
    Reboot the machine
    WARNING: Depending on the size of the drive, this could take a couple of hours
     

    Users who are viewing this thread

    Top Bottom