Delay after resume from standby (1 Viewer)

[nino]

Hi everyone,

After wakeup from standby, there is a long delay (sometimes up to two minutes) until mediaportal starts working again (e.g. react to remote control, show the current time etc.). Disabling plugins and configuring the (single seat) setup to use a loopback device didn't help.

Any help would be greatly appreciated,
Thanks!
nino

PS: extract from the logs (after a relatively short delay) starting right after wakeup at 1:17:34. Mediaportal became responsive around 1:18:15

mediaportal:
[2013-11-06 01:17:34,185] [Log ] [MPMain ] [DEBUG] - Main: WM_POWERBROADCAST (PBT_APMRESUMEAUTOMATIC)
[2013-11-06 01:17:44,906] [Log ] [MPMain ] [INFO ] - Main: OnResume - set GUIGraphicsContext.State.RUNNING
[2013-11-06 01:17:44,907] [Log ] [MPMain ] [INFO ] - Main: VideoDatabaseV5.db3 sqllite database disk cache activated.
[2013-11-06 01:17:44,907] [Log ] [MPMain ] [INFO ] - Main: OnResume - Init Input Devices
[2013-11-06 01:17:44,908] [Log ] [MPMain ] [INFO ] - DirectInput: not enabled
[2013-11-06 01:17:44,912] [Log ] [MPMain ] [INFO ] - MAP: using custom mappings for Microsoft MCE
[2013-11-06 01:17:44,914] [Log ] [MPMain ] [INFO ] - MCE: MCE remote enabled
[2013-11-06 01:17:44,914] [Log ] [MPMain ] [DEBUG] - Main: OnResume - Autoplay start listening
[2013-11-06 01:17:44,916] [Log ] [MPMain ] [DEBUG] - Main: OnResume - Initializing volume handler
[2013-11-06 01:17:44,917] [Log ] [MPMain ] [INFO ] - Main: OnResume - Done
[2013-11-06 01:17:44,918] [Log ] [MPMain ] [DEBUG] - PS: RESUMEAUTOMATIC
[2013-11-06 01:17:44,919] [Log ] [MPMain ] [DEBUG] - PS: System has resumed from standby
[2013-11-06 01:17:44,921] [Log ] [MPMain ] [DEBUG] - PS: Run external command
[2013-11-06 01:18:12,449] [Log ] [MPMain ] [DEBUG] - PS: Registered client's PowerScheduler as RemoteStandbyHandler / RemoteWakeupHandler with tag 10
[2013-11-06 01:18:12,451] [Log ] [MPMain ] [DEBUG] - PS: Signal "Resume" to the StandbyWakeupThread
[2013-11-06 01:18:12,451] [Log ] [MPMain ] [DEBUG] - PS: Send "ResumedFromStandby" event
[2013-11-06 01:18:12,451] [Log ] [PS StandbyWakeup] [DEBUG] - PS: StandbyWakeupThread resumed

tvservice:
[2013-11-06 01:17:33,863] [Log ] [PowerEventThread] [INFO ] - TvController.OnResume()
[2013-11-06 01:17:33,863] [Log ] [PowerEventThread] [INFO ] - Controller: setup HeartBeat Monitor
[2013-11-06 01:17:33,865] [Log ] [HeartBeatMonitor] [INFO ] - Controller: Heartbeat Monitor initiated, max timeout allowed is 30 sec.
[2013-11-06 01:17:33,867] [Log ] [PowerEventThread] [INFO ] - Scheduler: started
[2013-11-06 01:17:33,888] [Log ] [PowerEventThread] [INFO ] - Scheduler: loaded 2 schedules
[2013-11-06 01:17:33,890] [Log ] [PowerEventThread] [INFO ] - DiskManagement: started
[2013-11-06 01:17:33,890] [Log ] [PowerEventThread] [INFO ] - PS: ReInitController
[2013-11-06 01:21:31,113] [Log ] [PS StandbyWakeup] [INFO ] - PS: System changed from idle state to busy state

 

[michael_t]

...

Could you please send full logs of the situation?

Michael

 

[nino]

Hi Michael,

I uploaded logfiles.

This is what I did:
* stopped tvservice and mediaportal
* deleted all logfiles
* started tvservice
* started mediaportal
* started live tv as soon as mediaportal was responsive
* stopped live tv and waited until pc had gone to suspend mode
* woke pc up by pressing button on remote control
* as soon as mediaportal was responsive navigated to tv guide and started a program

It took almost two minutes for mediaportal to startup initially. It took more than a minute until mediaportal was responsive after waking up from suspend mode. I'd really appreciate if the delay after resume could be reduced.

With mediaportal 1.4 both the inital startup time and the resume delay were much shorter. But even then it used to take 20-30 seconds until mediaportal was responsive again after resuming from suspend mode.

Thanks for any help!

nino

 

[michael_t]

Hi Michael,

I uploaded logfiles.

This is what I did:
* stopped tvservice and mediaportal
* deleted all logfiles
* started tvservice
* started mediaportal
* started live tv as soon as mediaportal was responsive
* stopped live tv and waited until pc had gone to suspend mode
* woke pc up by pressing button on remote control
* as soon as mediaportal was responsive navigated to tv guide and started a program

It took almost two minutes for mediaportal to startup initially. It took more than a minute until mediaportal was responsive after waking up from suspend mode. I'd really appreciate if the delay after resume could be reduced.

With mediaportal 1.4 both the inital startup time and the resume delay were much shorter. But even then it used to take 20-30 seconds until mediaportal was responsive again after resuming from suspend mode.

Thanks for any help!

nino

Thank you for the logs. I can confirm your observation that the start and the restart of MP takes much too long time (in both cases there is at least one minute without any logged activity of the MP client). But there is also no hint what is wrong with your system. So as a first step of debugging I would recommend you to disable all community plugins (you can start MP in debug mode, which does this implicitly) and see if the problem still exists. BTW: You should also activate DEBUG log mode in the tv server...

Michael

 

[nino]

Hi Michael,

Here are logfiles with activated tvserver debug level and mediaportal running in debug mode. Initial startup still takes quite a long time (much faster with mediaportal 1.4). Resuming from standby now takes only about 15 seconds. I previously tried disabling plugins but couldn't find a particular one which could be solely responsible for the long delay.

Thanks,
nino

 

[ofh]

Hi
Just want to tell that I have the same delay on a client/server setup, after upgrading to 1.5.
No prob. On 1.4.
No logs added !!
Hope it Will be fixed in 1.5.1
BR OFH

 

[netexplorer]

Have you checked the option Reinitialize TV controller on wakeup (also reinitializes tuner) ?
If so, try to disable it.

 

[michael_t]

Hi Michael,

Here are logfiles with activated tvserver debug level and mediaportal running in debug mode. Initial startup still takes quite a long time (much faster with mediaportal 1.4). Resuming from standby now takes only about 15 seconds. I previously tried disabling plugins but couldn't find a particular one which could be solely responsible for the long delay.

Thanks,
nino

Your community plugins are still activated and I suspect one of them to be the cause of your problems. You should definitively disable all of them and test again. And there are some strange warnings that some Titan skin files are missing. I do not think it has something to do with your problems, but it is an indication that there might be something wrong with your installation. Maybe you should reinstall MP to get this fixed.

Michael

 

[michael_t]

Have you checked the option Reinitialize TV controller on wakeup (also reinitializes tuner) ?
If so, try to disable it.

What should this help for? @nino's system is obviously hanging in the client, not the server.

Michael

 

[michael_t]

Hi
Just want to tell that I have the same delay on a client/server setup, after upgrading to 1.5.
No prob. On 1.4.
No logs added !!
Hope it Will be fixed in 1.5.1
BR OFH

Once I saw a sign on a shop door. It said: "No shoes, no shirt, no service!". For MP problems this is: "No logs, no system specs, no help!"
Please send logs, if you have a problem - otherwise nobody can help you (and nobody knows what to fix in MP 1.5.1)!

Michael