Log why MP gets started/waked up (1 Viewer)

[chrisonline]

Is there any log in MediaPortal where i can see why MP has waked up my PC?
Because I have a strange behaviour, every 10 minutes the HTPC is starting.

In the MediaPortal.log i can only see that the HTPC is waked up to handle a requested event.
But which event?

Here the log from "MedaiPortal.log":
2013-03-27 08:50:15.236099 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 18
2013-03-27 08:50:15.236099 [Info.][MPMain(1)]: Main: Windows has resumed from standby or hibernate mode to handle a requested event
2013-03-27 08:50:15.237099 [Info.][MPMain(1)]: Main: OnResumeAutomatic - Done
2013-03-27 08:50:16.402165 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 7
2013-03-27 08:50:16.402165 [Info.][MPMain(1)]: Main: Windows has resumed from hibernate mode
2013-03-27 08:50:16.403166 [Info.][MPMain(1)]: Main: VideoDatabaseV5.db3 sqllite database disk cache activated.
2013-03-27 08:50:16.403166 [Info.][MPMain(1)]: Main: OnResume - Trying to wake up the monitor / tv
2013-03-27 08:50:16.404166 [Info.][MPMain(1)]: Main: OnResume - Switch to basic home screen
2013-03-27 08:50:17.003200 [Info.][MPMain(1)]: Main: OnResume - calling recover device
2013-03-27 08:50:17.004200 [Info.][MPMain(1)]: Main: OnResume - init InputDevices
2013-03-27 08:50:17.004200 [Info.][MPMain(1)]: DirectInput: not enabled
2013-03-27 08:50:17.008200 [Info.][MPMain(1)]: X10 debug: Could not get interface
2013-03-27 08:50:17.016201 [Info.][MPMain(1)]: MAP: using default mappings for Microsoft MCE
2013-03-27 08:50:17.019201 [Info.][MPMain(1)]: MCE: MCE remote enabled
2013-03-27 08:50:17.019201 [Info.][MPMain(1)]: Main: OnResume - set GUIGraphicsContext.State.RUNNING
2013-03-27 08:50:17.020201 [Info.][MPMain(1)]: Main: OnResume - initializing volume handler
2013-03-27 08:50:17.027201 [Info.][MPMain(1)]: Main: OnResume - Done
2013-03-27 08:50:17.028201 [Info.][MPMain(1)]: TVHome.WndProc(): Windows has resumed from hibernate mode
2013-03-27 08:50:17.031201 [Info.][TvClient-TvHome: HeartBeat transmitter thread(50)]: TVHome: OnRemotingConnected, recovered from a disconnection
2013-03-27 08:50:17.033202 [Info.][MPMain(1)]: TvNotify: start
2013-03-27 08:50:27.794817 [Info.][MPMain(1)]: LatestMediaHandler Translation: Cannot find translation file C:\ProgramData\Team MediaPortal\MediaPortal\Language\LatestMediaHandler\de.xml. Failing back to English
2013-03-27 08:50:29.810932 [Info.][MPMain(1)]: SQLiteClient: Closing database: PictureDatabase.db3
2013-03-27 09:00:22.559836 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 4
2013-03-27 09:00:22.560836 [Info.][MPMain(1)]: Main: Windows is suspending
2013-03-27 09:00:22.562836 [Info.][MPMain(1)]: Main: Stopping playback
2013-03-27 09:00:22.562836 [Info.][MPMain(1)]: Main: Stopping AutoPlay
2013-03-27 09:00:22.563836 [Info.][MPMain(1)]: Main: VideoDatabaseV5.db3 sqllite database cache flushed to disk.
2013-03-27 09:00:22.566836 [Info.][MPMain(1)]: Main: OnSuspend - Done
2013-03-27 09:00:22.567836 [Info.][MPMain(1)]: TVHome.WndProc(): Windows is suspending
2013-03-27 09:00:22.572836 [Info.][MPMain(1)]: TvNotify: stop
2013-03-27 09:00:23.202873 [Info.][.NET SystemEvents(4)]: SQLiteClient: Closing database: movingpictures.db3
2013-03-27 09:00:23.806907 [Info.][MPMain(1)]: SQLiteClient: Closing database: FanartHandler.db3
2013-03-27 09:13:47.487113 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 18
2013-03-27 09:13:47.488113 [Info.][MPMain(1)]: Main: Windows has resumed from standby or hibernate mode to handle a requested event
2013-03-27 09:13:47.489113 [Info.][MPMain(1)]: Main: OnResumeAutomatic - Done
2013-03-27 09:13:48.634179 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 7
2013-03-27 09:13:48.634179 [Info.][MPMain(1)]: Main: Windows has resumed from hibernate mode
2013-03-27 09:13:48.635179 [Info.][MPMain(1)]: Main: VideoDatabaseV5.db3 sqllite database disk cache activated.
2013-03-27 09:13:48.636179 [Info.][MPMain(1)]: Main: OnResume - Trying to wake up the monitor / tv
2013-03-27 09:13:48.637179 [Info.][MPMain(1)]: Main: OnResume - Switch to basic home screen
2013-03-27 09:13:53.591462 [Info.][MPMain(1)]: Main: OnResume - calling recover device
2013-03-27 09:13:53.592462 [Info.][MPMain(1)]: Main: OnResume - init InputDevices
2013-03-27 09:13:53.592462 [Info.][MPMain(1)]: DirectInput: not enabled
2013-03-27 09:13:53.641465 [Info.][MPMain(1)]: X10 debug: Could not get interface
2013-03-27 09:13:53.647466 [Info.][MPMain(1)]: MAP: using default mappings for Microsoft MCE
2013-03-27 09:13:53.650466 [Info.][MPMain(1)]: MCE: MCE remote enabled
2013-03-27 09:13:53.651466 [Info.][MPMain(1)]: Main: OnResume - set GUIGraphicsContext.State.RUNNING
2013-03-27 09:13:53.653466 [Info.][MPMain(1)]: Main: OnResume - initializing volume handler
2013-03-27 09:13:53.656466 [Info.][MPMain(1)]: Main: OnResume - Done
2013-03-27 09:13:53.656466 [Info.][MPMain(1)]: TVHome.WndProc(): Windows has resumed from hibernate mode
2013-03-27 09:13:53.716470 [Info.][MPMain(1)]: TvNotify: start
2013-03-27 09:13:53.717470 [Info.][TvClient-TvHome: HeartBeat transmitter thread(42)]: TVHome: OnRemotingConnected, recovered from a disconnection
2013-03-27 09:14:02.152952 [Info.][MPMain(1)]: LatestMediaHandler Translation: Cannot find translation file C:\ProgramData\Team MediaPortal\MediaPortal\Language\LatestMediaHandler\de.xml. Failing back to English
2013-03-27 09:14:55.257990 [Info.][MPMain(1)]: SQLiteClient: Closing database: PictureDatabase.db3
2013-03-27 09:23:56.020919 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 4
2013-03-27 09:23:56.021919 [Info.][MPMain(1)]: Main: Windows is suspending
2013-03-27 09:23:56.021919 [Info.][MPMain(1)]: Main: Stopping playback
2013-03-27 09:23:56.022920 [Info.][MPMain(1)]: Main: Stopping AutoPlay
2013-03-27 09:23:56.022920 [Info.][MPMain(1)]: Main: VideoDatabaseV5.db3 sqllite database cache flushed to disk.
2013-03-27 09:23:56.023920 [Info.][MPMain(1)]: Main: OnSuspend - Done
2013-03-27 09:23:56.024920 [Info.][MPMain(1)]: TVHome.WndProc(): Windows is suspending
2013-03-27 09:23:56.028920 [Info.][MPMain(1)]: TvNotify: stop
2013-03-27 09:23:56.627954 [Info.][.NET SystemEvents(4)]: SQLiteClient: Closing database: movingpictures.db3
2013-03-27 09:23:57.054979 [Info.][MPMain(1)]: SQLiteClient: Closing database: FanartHandler.db3
2013-03-27 09:34:17.105091 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 18
2013-03-27 09:34:17.130093 [Info.][MPMain(1)]: Main: Windows has resumed from standby or hibernate mode to handle a requested event
2013-03-27 09:34:17.130093 [Info.][MPMain(1)]: Main: OnResumeAutomatic - Done
2013-03-27 09:34:18.233156 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 7
2013-03-27 09:34:18.239156 [Info.][MPMain(1)]: Main: Windows has resumed from hibernate mode
2013-03-27 09:34:18.240156 [Info.][MPMain(1)]: Main: VideoDatabaseV5.db3 sqllite database disk cache activated.
2013-03-27 09:34:18.241156 [Info.][MPMain(1)]: Main: OnResume - Trying to wake up the monitor / tv
2013-03-27 09:34:18.243156 [Info.][MPMain(1)]: Main: OnResume - Switch to basic home screen
2013-03-27 09:34:22.684410 [Info.][MPMain(1)]: Main: OnResume - calling recover device
2013-03-27 09:34:22.685411 [Info.][MPMain(1)]: Main: OnResume - init InputDevices
2013-03-27 09:34:22.686411 [Info.][MPMain(1)]: DirectInput: not enabled
2013-03-27 09:34:22.709412 [Info.][MPMain(1)]: X10 debug: Could not get interface
2013-03-27 09:34:22.715412 [Info.][MPMain(1)]: MAP: using default mappings for Microsoft MCE
2013-03-27 09:34:22.718412 [Info.][MPMain(1)]: MCE: MCE remote enabled
2013-03-27 09:34:22.719412 [Info.][MPMain(1)]: Main: OnResume - set GUIGraphicsContext.State.RUNNING
2013-03-27 09:34:22.719412 [Info.][MPMain(1)]: Main: OnResume - initializing volume handler
2013-03-27 09:34:22.722413 [Info.][MPMain(1)]: Main: OnResume - Done
2013-03-27 09:34:22.722413 [Info.][MPMain(1)]: TVHome.WndProc(): Windows has resumed from hibernate mode
2013-03-27 09:34:22.727413 [Info.][TvClient-TvHome: HeartBeat transmitter thread(6)]: TVHome: OnRemotingConnected, recovered from a disconnection
2013-03-27 09:34:22.729413 [Info.][MPMain(1)]: TvNotify: start
2013-03-27 09:34:29.919824 [Info.][MPMain(1)]: LatestMediaHandler Translation: Cannot find translation file C:\ProgramData\Team MediaPortal\MediaPortal\Language\LatestMediaHandler\de.xml. Failing back to English
2013-03-27 09:35:10.205128 [Info.][MPMain(1)]: SQLiteClient: Closing database: PictureDatabase.db3
2013-03-27 09:44:24.079808 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 4
2013-03-27 09:44:24.080808 [Info.][MPMain(1)]: Main: Windows is suspending
2013-03-27 09:44:24.080808 [Info.][MPMain(1)]: Main: Stopping playback
2013-03-27 09:44:24.080808 [Info.][MPMain(1)]: Main: Stopping AutoPlay
2013-03-27 09:44:24.081808 [Info.][MPMain(1)]: Main: VideoDatabaseV5.db3 sqllite database cache flushed to disk.
2013-03-27 09:44:24.082808 [Info.][MPMain(1)]: Main: OnSuspend - Done
2013-03-27 09:44:24.082808 [Info.][MPMain(1)]: TVHome.WndProc(): Windows is suspending
2013-03-27 09:44:24.087809 [Info.][MPMain(1)]: TvNotify: stop
2013-03-27 09:44:24.789849 [Info.][.NET SystemEvents(4)]: SQLiteClient: Closing database: movingpictures.db3
2013-03-27 09:44:25.680900 [Info.][MPMain(1)]: SQLiteClient: Closing database: FanartHandler.db3
2013-03-27 09:53:48.311103 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 18
2013-03-27 09:53:48.377107 [Info.][MPMain(1)]: Main: Windows has resumed from standby or hibernate mode to handle a requested event
2013-03-27 09:53:48.383107 [Info.][MPMain(1)]: Main: OnResumeAutomatic - Done
2013-03-27 09:53:49.480170 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 7
2013-03-27 09:53:49.481170 [Info.][MPMain(1)]: Main: Windows has resumed from hibernate mode
2013-03-27 09:53:49.482170 [Info.][MPMain(1)]: Main: VideoDatabaseV5.db3 sqllite database disk cache activated.
2013-03-27 09:53:49.483170 [Info.][MPMain(1)]: Main: OnResume - Trying to wake up the monitor / tv
2013-03-27 09:53:49.484170 [Info.][MPMain(1)]: Main: OnResume - Switch to basic home screen
2013-03-27 09:53:53.663409 [Info.][MPMain(1)]: Main: OnResume - calling recover device
2013-03-27 09:53:53.663409 [Info.][MPMain(1)]: Main: OnResume - init InputDevices
2013-03-27 09:53:53.664409 [Info.][MPMain(1)]: DirectInput: not enabled
2013-03-27 09:53:53.673410 [Info.][MPMain(1)]: X10 debug: Could not get interface
2013-03-27 09:53:53.682410 [Info.][MPMain(1)]: MAP: using default mappings for Microsoft MCE
2013-03-27 09:53:53.685411 [Info.][MPMain(1)]: MCE: MCE remote enabled
2013-03-27 09:53:53.685411 [Info.][MPMain(1)]: Main: OnResume - set GUIGraphicsContext.State.RUNNING
2013-03-27 09:53:53.686411 [Info.][MPMain(1)]: Main: OnResume - initializing volume handler
2013-03-27 09:53:53.688411 [Info.][MPMain(1)]: Main: OnResume - Done
2013-03-27 09:53:53.688411 [Info.][MPMain(1)]: TVHome.WndProc(): Windows has resumed from hibernate mode
2013-03-27 09:53:53.712412 [Info.][MPMain(1)]: TvNotify: start
2013-03-27 09:53:53.715412 [Info.][TvClient-TvHome: HeartBeat transmitter thread(24)]: TVHome: OnRemotingConnected, recovered from a disconnection
2013-03-27 09:54:01.885880 [Info.][MPMain(1)]: LatestMediaHandler Translation: Cannot find translation file C:\ProgramData\Team MediaPortal\MediaPortal\Language\LatestMediaHandler\de.xml. Failing back to English
2013-03-27 09:55:15.023063 [Info.][MPMain(1)]: SQLiteClient: Closing database: PictureDatabase.db3
2013-03-27 09:55:15.764105 [Info.][MPMain(1)]: TexturePacker: disposing texture:1999
2013-03-27 09:55:15.796107 [Info.][MPMain(1)]: TexturePacker: disposing texture:1997
2013-03-27 09:55:15.798107 [Info.][MPMain(1)]: TexturePacker: disposing texture:1996
2013-03-27 09:55:15.799107 [Info.][MPMain(1)]: TexturePacker: disposing texture:1995
2013-03-27 09:55:15.801107 [Info.][MPMain(1)]: TexturePacker: disposing texture:1979
2013-03-27 09:55:15.804107 [Info.][MPMain(1)]: TexturePacker: disposing texture:1976
2013-03-27 09:55:15.808108 [Info.][MPMain(1)]: TexturePacker: disposing texture:1919
2013-03-27 09:55:15.815108 [Info.][MPMain(1)]: TexturePacker: disposing texture:1910
2013-03-27 09:55:15.817108 [Info.][MPMain(1)]: TexturePacker: disposing texture:1909
2013-03-27 09:55:15.818108 [Info.][MPMain(1)]: TexturePacker: disposing texture:1908
2013-03-27 09:55:15.820108 [Info.][MPMain(1)]: TexturePacker: disposing texture:1907
2013-03-27 09:55:15.822108 [Info.][MPMain(1)]: TexturePacker: disposing texture:1967
2013-03-27 09:55:15.978117 [Info.][MPMain(1)]: TvNotify: stop
2013-03-27 09:55:16.001119 [Info.][MPMain(1)]: Main: Exiting
2013-03-27 09:55:16.004119 [Info.][MPMain(1)]: PlugInManager.Stop()
2013-03-27 09:55:16.005119 [Info.][MPMain(1)]: PluginManager: stopping FanartHandler.FanartHandlerSetup
2013-03-27 09:55:20.515377 [Info.][MPMain(1)]: SQLiteClient: Closing database: FanartHandler.db3
2013-03-27 09:55:20.524377 [Info.][MPMain(1)]: PluginManager: stopping LatestMediaHandler.LatestMediaHandlerSetup
2013-03-27 09:55:20.538378 [Info.][MPMain(1)]: PluginManager: stopping UPNP_RendererPlugin.MP_UpnpRenderer
2013-03-27 09:55:20.579381 [Info.][MPMain(1)]: [MP Upnp Renderer:] Renderer stopped!
2013-03-27 09:55:20.580381 [Info.][MPMain(1)]: PluginManager: stopping MediaPortal.Plugins.OneButtonMusic
2013-03-27 09:55:20.582381 [Info.][MPMain(1)]: OneButtonMusic: Stopped
2013-03-27 09:55:20.583381 [Info.][MPMain(1)]: PluginManager: stopping MediaPortal.Plugins.Process.PowerSchedulerClientPlugin
2013-03-27 09:55:20.609382 [Info.][MPMain(1)]: Stopping PowerScheduler client plugin...
2013-03-27 09:55:20.830395 [Info.][MPMain(1)]: PowerScheduler client plugin stopped
2013-03-27 09:55:20.832395 [Info.][MPMain(1)]: PluginManager: stopping MediaPortal.Audioscrobbler.AudioscrobblerPlugin
2013-03-27 09:55:20.866397 [Info.][MPMain(1)]: PluginManager: stopping MediaPortal.ProcessPlugins.MusicDBReorg.MusicDBReorg
2013-03-27 09:55:20.868397 [Info.][MPMain(1)]: MusicDBReorg: stopped
2013-03-27 09:55:20.868397 [Info.][MPMain(1)]: PluginManager: stopping MediaPortal.MusicShareWatcher.MusicShareWatcherPlugin
2013-03-27 09:55:20.869397 [Info.][MPMain(1)]: MusicShareWatcher Plugin 0.3 stopping.
2013-03-27 09:55:20.870397 [Info.][MPMain(1)]: PluginManager: stopping ProcessPlugins.ViewModeSwitcher.ViewModeSwitcher
2013-03-27 09:55:20.873397 [Info.][MPMain(1)]: fonts.SafeDispose()
2013-03-27 09:55:20.882398 [Info.][MPMain(1)]: TexturePackerispose()
2013-03-27 09:55:20.988404 [Info.][MPMain(1)]: Playlist: Saving default playlist default.m3u
2013-03-27 09:55:21.285421 [Warn.][DashActivity(53)]: GUIWindow:OnWindowLoaded: 'C:\ProgramData\Team MediaPortal\MediaPortal\Skin\Titan\myHome.xml' is missing control id 200 (window property: lblDate)
2013-03-27 09:55:21.286421 [Warn.][DashActivity(53)]: GUIWindow:OnWindowLoaded: 'C:\ProgramData\Team MediaPortal\MediaPortal\Skin\Titan\myHome.xml' is missing control id 201 (window property: lblTime)
2013-03-27 09:55:21.874455 [Info.][MPMain(1)]: SQLiteClient: Closing database: movingpictures.db3
2013-03-27 09:55:22.778506 [Info.][MPMain(1)]: GUIWindowManager: Could not find window -1
2013-03-27 09:55:22.876512 [Info.][(2)]: SQLiteClient: Closing database: movingpictures.db3
2013-03-27 09:55:22.884512 [Info.][(2)]: SQLiteClient: Closing database: PictureDatabase.db3
2013-03-27 09:55:22.887513 [Info.][(2)]: SQLiteClient: Closing database: FolderDatabase3.db3
2013-03-27 09:55:22.991519 [Info.][(2)]: TvCropManager: Stopped
2013-03-27 09:55:22.991519 [Info.][(2)]: SQLiteClient: Closing database: MusicDatabaseV12.db3
2013-03-27 09:55:23.033521 [Info.][(2)]: SQLiteClient: Closing database: TVSeriesDatabase4.db3
2013-03-27 09:55:23.036521 [Info.][(2)]: SQLiteClient: Closing database: VideoDatabaseV5.db3

 

[tourettes]

MP doesn't know why the system did wake up. For troubleshooting: http://www.missingremote.com/guide/configuring-standby-your-htpc

 

[chrisonline]

But i am talking about MP itself.
If MP wakes up the system MP should know why he waked up the system

Let me explain:
If MP wake up the system for EPG grabbing, does MP log this anywhere like "Waked up system for EPG grabbing" ?

 

[JimCatMP]

As Touretts states above, the event is handled in Windows - MePo gets signal & ID, not the event data:-<

The wake up is generated by a Power Event being handled by Windows - something in PowerControl settings in Windows, it looks like somehing is kicking the service back into life after 10 mins - WOL event from some other device perhaps?

See http://msdn.microsoft.com/en-us/library/windows/desktop/aa373248(v=vs.85).aspx

Cheers - JCMP

 

[kiwijunglist]

What he is saying that maybe something else other than MP is waking up the HTPC?

Press WIN+R

Type: cmd.exe

Then type: powercfg -lastwake

This will tell you the reason/cause of the most recent wake event

 

[chrisonline]

Ok i understand. I have checked the system logs and attached you will find the entries.
And always it shows TVServer. So the TVServer wakes up the PC.

"PowerEvent wurde vom Dienst erfolreich verarbeitet" means "PowerEvent was successfully processed"

How can i check why the TVService has waked up my PC?[DOUBLEPOST=1364381914][/DOUBLEPOST]Attached the settings of the "PowerScheduler" in TVSettings.[DOUBLEPOST=1364381978][/DOUBLEPOST]

What he is saying that maybe something else other than MP is waking up the HTPC?

Press WIN+R

Type: cmd.exe

Then type: powercfg -lastwake

This will tell you the reason/cause of the most recent wake event

Thanks will try that.

 

[mbuzina]

You can also check the System Event log for power Events, they should be logged if Windows knows about the source (otherwise source is said to be unknown).

 

[chrisonline]

What he is saying that maybe something else other than MP is waking up the HTPC?

Press WIN+R

Type: cmd.exe

Then type: powercfg -lastwake

This will tell you the reason/cause of the most recent wake event

Attached the output, but nothing usefuel.[DOUBLEPOST=1364385841][/DOUBLEPOST]

You can also check the System Event log for power Events, they should be logged if Windows knows about the source (otherwise source is said to be unknown).

I have already done this, see post before.
In the System log of Windows i see always "TVServer".

 

[mbuzina]

I have already done this, see post before. In the System log of Windows i see always "TVServer".

That is not the Power Event. The event you list just show that TV Server handled a power event. Look for Events from the Source "Power Troubleshooter" with ID 1. They contain text like this:

Das System wurde aus einem Standbymodus reaktiviert.
 
Zeit im Energiesparmodus: ‎2013‎-‎03‎-‎27T11:23:50.596927000Z
 
Reaktivierungszeit: ‎2013‎-‎03‎-‎27T11:26:25.192055500Z
 
Reaktivierungsquelle: Netzschalter

 

[chrisonline]

Thanks.

At 08:50 there is:
Reaktivierungsquelle: Gerät - Realtek PCIe GBE Family Controller

And afterwards at 09:00 and onwards:
Reaktivierungsquelle: unknown

The first time seems is the network card, but later it is "unknown"!
I will check my network card.