MP locking up when idle. (1 Viewer)

[doveman]

MediaPortal Version: v1.2.1
MediaPortal Skin: StreamedMP
Windows Version: Win7 Ult 64
CPU Type: Phenom II X4 955
HDD: 2TB Samsung F4
Memory: 8GB DDR3 1600Mhz
Motherboard: MSI 990FXA-GD80
Video Card: HD6950 2GB
Video Card Driver: 11.10
Sound Card: onboard Realtek AC97 (ALC892)
Sound Card AC3: no AC3
Sound Card Driver: 6.01.6482
1. TV Card: Hauppauge Nova-T 500
1. TV Card Type: DVB-T
1. TV Card Driver: 4.3.27240
MPEG2 Video Codec: Cyberlink PDVD11
MPEG2 Audio Codec: ffdshow
h.264 Video Codec: ffdshow
Satelite/CableTV Provider:
HTPC Case: Custom
Cooling: Scythe 120mm Bottom Intake Fan, TRUE Rev. c CPU HSF
Power Supply: Antec CP-850
Remote: Nova-T 500
TV: Sony XBR800 36"
TV - HTPC Connection: DVI

Firstly let me say I'm using several mods so appreciate it may not be possible to help me with this bug, but as the mods are all associated with playback and this bug is not a playback issue I thought it worth asking anyway

I've been trying to get my PC to sleep with PS++ (actually, leaving Windows to manage sleep but PS++ is installed). It's set to sleep after 60mins but isn't doing so, but that's not the bug I'm reporting. The problem is that when I came home and checked whether the PC had gone to sleep (it hadn't), MP was completely frozen on the EPG screen and I had to kill it and restart it to get it working again. This has happened several times now.

I'll try running in debug mode later and see if it happens then but thought I might as well report it and upload the logs I've got now. If no-one wants to look at this until I can provide debug mode logs, I'll understand. I should be able to test with a clean install (i.e. no mods installed) as well, as it only seems to require me to leave the PC idle for an hour or so to trigger it, although if it's only triggered after watching TV (which I had been doing before I went out) then it could be tricky as I need the part_DWM dshowhelper for playback to work properly with my dual-screen.

 

[mm1352000]

Hi doveman

Timing information would be really helpful. Without that I'm finding it difficult to know which issues to be looking at - there are more than a few crashes in your logs.

mm

PS: please don't set new bug report thread statuses to "bug". We do that after a problem is confirmed.

 

[doveman]

Hi doveman

Timing information would be really helpful. Without that I'm finding it difficult to know which issues to be looking at - there are more than a few crashes in your logs.

mm

PS: please don't set new bug report thread statuses to "bug". We do that after a problem is confirmed.

Yeah, I didn't want to set it to bug, but there was a bug on the forum at the time and Confirm had disappeared from the choices!

I'll try and remember to give times with future reports, but I generally collect the logs straight after I experience the problem so it should be towards the end of them that's relevant.

It seems it's not MP/PS++ that's stopping my PC sleeping though, as I tried killing TVService before going to bed last night and it still didn't sleep, so I'm killing stuff off in an attempt to get it to work!

 

[Owlsroost]

If you look in MediaPortal.log, 60 minutes after the system became idle, it tried to suspend and then resumed almost immediately (then StartHCW failed with an error). I suspect the failure to suspend is probably part of the freeze problem.

2011-12-19 15:23:49.727456 [Debug][PS StandbyWakeup(34)]: PS: StandbyWakeupThread triggered by check interval
2011-12-19 15:23:49.733456 [Debug][PS StandbyWakeup(34)]: PS: LoadSettings()
2011-12-19 15:23:51.042531 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 4
2011-12-19 15:23:51.042531 [Info.][MPMain(1)]: Main: Windows is suspending
2011-12-19 15:23:51.043531 [Info.][MPMain(1)]: Main: Stopping playback
2011-12-19 15:23:51.044531 [Debug][MPMain(1)]: Main: SaveLastActiveModule - enabled True
2011-12-19 15:23:51.045532 [Debug][MPMain(1)]: Main: SaveLastActiveModule - module 600
2011-12-19 15:23:51.045532 [Debug][MPMain(1)]: Main: SaveLastActiveModule - fullscreen False
2011-12-19 15:23:51.049532 [Info.][MPMain(1)]: Main: Stopping AutoPlay
2011-12-19 15:23:51.049532 [Info.][(3)]: HCWHelper: received APP|SHUTDOWN|-8588772986544300487~
2011-12-19 15:23:51.050532 [Info.][MPMain(1)]: open folderdatabase
2011-12-19 15:23:51.052532 [Info.][MPMain(1)]: picture database opened
2011-12-19 15:23:51.053532 [Info.][MPMain(1)]: Main: OnSuspend - Done
2011-12-19 15:23:51.053532 [Info.][MPMain(1)]: TVHome.WndProc(): Windows is suspending
2011-12-19 15:23:51.054532 [Debug][MPMain(1)]: TVHome.OnSuspend()
2011-12-19 15:23:51.055532 [Info.][MPMain(1)]: TvNotify: stop
2011-12-19 15:23:51.055532 [Debug][MPMain(1)]: TVHome: HeartBeat Transmitter stopped.
2011-12-19 15:23:51.065533 [Info.][MPMain(1)]: plugin: MPStartIt.WndProc(): Windows is going into powerstate (hibernation/standby)
2011-12-19 15:23:51.065533 [Debug][MPMain(1)]: PS: SUSPEND
2011-12-19 15:23:51.065533 [Debug][MPMain(1)]: PS: System is going to suspend
2011-12-19 15:23:51.066533 [Debug][PS StandbyWakeup(34)]: PS: StandbyWakeupThread suspended
2011-12-19 15:23:51.265544 [Debug][MPMain(1)]: PS: Unregister handlers with tvservice with tag 6
2011-12-19 15:23:51.267544 [Debug][MPMain(1)]: PS: Resetting TVServer RemoteControl interface
2011-12-19 15:23:54.012701 [Info.][(3)]: HCWHelper: OnClosing
2011-12-19 15:23:54.013701 [Info.][(3)]: HCWHelper: closing driver successful
2011-12-19 15:23:54.017702 [Info.][(1)]: HCWHelper: Shutting down
2011-12-19 15:23:54.107707 [Info.][.NET SystemEvents(4)]: SQLiteClient: Closing database: movingpictures.db3
2011-12-19 15:23:54.163710 [Info.][MPMain(1)]: SQLiteClient: Closing database: FanartHandler.db3
2011-12-19 15:23:54.718742 [Info.][MPMain(1)]: Main: WM_POWERBROADCAST: 18
2011-12-19 15:23:54.718742 [Info.][MPMain(1)]: Main: Windows has resumed from standby or hibernate mode to handle a requested event
2011-12-19 15:23:54.719742 [Debug][MPMain(1)]: Main: OnResumeAutomatic - set lock for syncronous inits
2011-12-19 15:23:54.719742 [Info.][MPMain(1)]: Main: OnResumeAutomatic - Done
2011-12-19 15:23:54.719742 [Debug][MPMain(1)]: PS: RESUMEAUTOMATIC
2011-12-19 15:23:54.720742 [Debug][MPMain(1)]: PS: System has resumed from standby
2011-12-19 15:23:57.873922 [Info.][(10)]: Moving-PicturesXML: BuildXML
2011-12-19 15:23:57.891923 [Debug][(10)]: Moving-PicturesXML: XMLSaveFile: True
2011-12-19 15:23:57.898924 [Debug][(10)]: Moving-PicturesXML: XMLFTPFile: False
2011-12-19 15:24:29.847751 [Debug][MPMain(1)]: PS: Registered client's PowerScheduler as RemoteStandbyHandler / RemoteWakeupHandler with tag 7
2011-12-19 15:24:29.847751 [Debug][PS StandbyWakeup(34)]: PS: StandbyWakeupThread resumed
2011-12-19 15:24:29.848751 [Info.][MPMain(1)]: StartHCW failed. Exception is: Object reference not set to an instance of an object.
2011-12-19 15:24:30.847808 [Debug][PS StandbyWakeup(34)]: PS: LoadSettings()
2011-12-19 15:24:30.872810 [Debug][(37)]: PS: Inspecting WakeableWakeupPlugins: 
2011-12-19 15:24:30.891811 [Debug][(37)]: PS: Inspecting WakeableStandbyPlugins: 
2011-12-19 15:24:30.891811 [Debug][(37)]: PS: Check if user interface is idle
2011-12-19 15:24:30.891811 [Debug][(37)]: PS: User interface is idle
2011-12-19 15:24:30.892811 [Debug][(37)]: PS: Check whether the next event is almost due
2011-12-19 15:24:45.853666 [Debug][PS StandbyWakeup(34)]: PS: StandbyWakeupThread triggered by check interval
2011-12-19 15:24:45.855667 [Debug][PS StandbyWakeup(34)]: PS: LoadSettings()

 

[doveman]

If you look in MediaPortal.log, 60 minutes after the system became idle, it tried to suspend and then resumed almost immediately (then StartHCW failed with an error). I suspect the failure to suspend is probably part of the freeze problem.

Yeah, you're probably right. I wasn't sure if it was the system or MP/PS++ that was trying/failing to suspend. I did run in debug mode yesterday and it didn't lock up, but it doesn't always happen in normal mode anyway, so that doesn't really mean much. I'll keep trying to get suspend working without TVService/MP first.