[PATCH] Power Scheduler multiseat addon + WOL (2 Viewers)

T

tom16

Portal Member
March 22, 2009
18
0
Home Country
United Kingdom United Kingdom
Yeah, I noticed the 'unable to connect to slave controller' message. A quick search seems to suggest that was fixed in an SVN at the end of last month, so hopefully that'll go when I update to 1.0.1.

FYI, my NIC is an on board Realtek RTL8168B/8111B Family PCI-E Gigabit Ethernet NIC (NDIS 6.0) if that makes any difference.

Anything else I can check?
 
T

tom16

Portal Member
March 22, 2009
18
0
Home Country
United Kingdom United Kingdom
Indeed, I get the 'Category does not exist' message on running the program, then no network device appeared in the list.

I see the programmer said this can be caused by the way you're connected to a network. My HTPC is connected to the network via an Ethernet over power device (this one to be precise). Perhaps this is causing the issue, although WOL works ok so I assumed these devices were transparent. I'll dig out my extra long cat5 cable tomorrow evening and see what happens then.

I am running the TV service under the admin account - is that making things worse?

----
update:
----
I've just run the Network Monitor demo on my testing PC which has the same software setup as my HTPC, but has no TV cards and is connected directly to my router and it runs fine... I guess this means it's pretty likely the Ethernet over power device is the cause of the problem.

Is a fix/work around likely to be possible or am I going to have to run a cable down to the living room...?

Thanks for your help so far.
 
T

tom16

Portal Member
March 22, 2009
18
0
Home Country
United Kingdom United Kingdom
------
further update
------

I opened up the Performance monitor on my HTPC and found that the network throughput indicator there is always at zero! Also, I can't add any performance counters as the message 'Unable to connect to machine' keeps appearing and no counter categories appear. This at least explains why the network monitor app and your patch aren't working, but I've no idea how to sort this out, especially as as far as I can remember my test PC was set up the same and doesn't suffer this issue :mad:.

Thanks for you help in getting this far, I guess we're outside the scope of this forum now so I'll shut up...
 
J

Jeggo

Portal Member
July 29, 2007
26
1
Home Country
Germany Germany
Hello Jonas,

first of all thanx for your great plugin. Waht would MP be without PowerScheduler?:D

I run MP 1.0 on a Windows Home Server machine. Alltough this platform is not supported it works quite well.
Recordings are done as supposed and shutdown of the system also takes place as configured.
My system should go to hibernation after 15min of idle. For the server I configured backup time from 18:00 to 20:00 each day. To wakeup the server to perform this tasks, I configured PowerScheduler to pick up EPG each day at 18:00 and prevent the system to go to standby during this time. So far everything works as desired...

When I need data from the server or want to use MP, I wake up the server with an WOL call. After MP has started after resume, PowerScheduler shuts down the server right now without waiting to pass the configured idle time (in my case 15min). When I am fast enough to start the MP client, than the server stays on.

Code: 
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler: User input detected at 25.03.2009 19:08:52
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3285 , True
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: NetworkMonitorHandler: standby allowed
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3285 , True
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler: System is unattended and idle - initiate suspend/hibernate
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler: Manual system suspend requested by 
2009-03-26 07:44:02.687500 [Powerscheduler Timer]: PowerScheduler: Concurrent shutdown was ignored: Hibernate ; force: True
2009-03-26 07:44:02.718750 [20]: dvb:abort grabbing epg
2009-03-26 07:44:04.656250 [20]: Timeshifting epg grabber stopped.
2009-03-26 07:44:06.906250 [EPG Update thread]: EPG: database updated for #0 YOU FM
2009-03-26 07:44:06.906250 [EPG Update thread]: user:epg remove
2009-03-26 07:44:06.906250 [EPG Update thread]: tvcard:FreeSubChannel:1 #0 keep graph=False
2009-03-26 07:44:06.906250 [EPG Update thread]: DVB subch:0 Decompose()
2009-03-26 07:44:06.953125 [EPG Update thread]: FreeSubChannel CA: freeing sub channel : 0
2009-03-26 07:44:06.953125 [EPG Update thread]: tvcard:FreeAllSubChannels:
2009-03-26 07:44:06.953125 [EPG Update thread]: dvb:StopGraph
2009-03-26 07:44:10.390625 [EPG Update thread]: Stopcard
2009-03-26 07:44:10.390625 [EPG Update thread]: tvcard:FreeAllSubChannels:
2009-03-26 07:44:10.578125 [PowerEventThread]: TV service PowerEventThread 30
2009-03-26 07:44:10.578125 [PowerEventThread]: OnPowerEvent: PowerStatus: ResumeCritical
2009-03-26 07:44:10.578125 [PowerEventThread]: OnPowerEventHandler: PowerStatus: ResumeCritical
2009-03-26 07:44:10.578125 [PowerEventThread]: PowerScheduler: System has resumed from standby after a critical suspend
2009-03-26 07:44:10.578125 [PowerEventThread]: OnPowerEvent: PowerStatus: ResumeAutomatic
2009-03-26 07:44:10.593750 [PowerEventThread]: OnPowerEventHandler: PowerStatus: ResumeAutomatic
2009-03-26 07:44:10.593750 [PowerEventThread]: PowerScheduler: System has resumed automatically from standby
2009-03-26 07:44:10.593750 [PowerEventThread]: TV service PowerEventThread 30
2009-03-26 07:44:10.593750 [WinController exit thread]: WindowsController: ExitWindows performed, result: True
2009-03-26 07:44:31.562500 [26]: card: Tune 1 to domradio
2009-03-26 07:44:31.562500 [26]: card: user: epg:1:-1 tune DVBS:radio:BetaDigital domradio Freq:12460000 ONID:133 TSID:5 SID:171 PMT:0x68 FTA:True LCN:174 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
2009-03-26 07:44:31.562500 [26]: dvbs:  Tune:DVBS:radio:BetaDigital domradio Freq:12460000 ONID:133 TSID:5 SID:171 PMT:0x68 FTA:True LCN:174 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearH InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
2009-03-26 07:44:31.562500 [26]: dvb:GetNewSubChannel:0 #0
2009-03-26 07:44:31.578125 [26]: LNB low:9750 hi:10600 switch:11700
2009-03-26 07:44:31.578125 [26]:   Channel modulation is set to ModNotSet
2009-03-26 07:44:31.578125 [26]:   Channel FECRate is set to Rate3_4
2009-03-26 07:44:31.687500 [26]: dvb:Submiting tunerequest Channel:domradio subChannel:0 
2009-03-26 07:44:31.687500 [26]: dvb:using existing subchannel:0
2009-03-26 07:44:31.687500 [26]: dvb:Submit tunerequest size:1 new:0
2009-03-26 07:44:31.687500 [26]: subch:0 OnBeforeTune
2009-03-26 07:44:31.718750 [26]: dvb:Submit tunerequest calling put_TuneRequest
2009-03-26 07:44:31.812500 [26]: dvb:Submit tunerequest done calling put_TuneRequest
2009-03-26 07:44:31.812500 [26]: subch:0 OnAfterTune
2009-03-26 07:44:31.812500 [26]: subch:0 OnGraphStart
2009-03-26 07:44:31.812500 [26]: subch:0 Graph already running - skip WaitForPMT
2009-03-26 07:44:31.812500 [26]: dvb:  RunGraph
2009-03-26 07:44:32.328125 [26]: dvb:  LockedInOnSignal ok
2009-03-26 07:44:32.328125 [26]: subch:0 OnGraphStarted
2009-03-26 07:44:32.328125 [26]: subch:0 SetupPmtGrabber:pid 68 sid:AB
2009-03-26 07:44:32.328125 [26]: subch:0 set pmt grabber pmt:68 sid:AB
2009-03-26 07:44:32.343750 [26]: WaitForPMT: Waiting for PMT.
2009-03-26 07:44:32.468750 [13]: subch:0 OnPMTReceived() True
2009-03-26 07:44:32.468750 [26]: WaitForPMT: Found PMT after 0,125 seconds.
2009-03-26 07:44:32.468750 [26]: subch:0 SendPmt:AB AB FFFFFFFF B
2009-03-26 07:44:32.468750 [26]: Decode pmt
2009-03-26 07:44:32.468750 [26]: Set descriptor data with length 6
2009-03-26 07:44:32.468750 [26]: PROBLEM : descriptor lengths dont match 3 9
2009-03-26 07:44:32.468750 [26]: subch:0 SendPMT version:11 len:27 171
2009-03-26 07:44:32.484375 [26]: subch:0 cam flags:True
2009-03-26 07:44:32.484375 [26]: subch:0 SetMpegPidMapping
2009-03-26 07:44:32.484375 [26]: subch:0  pid:170 pcr
2009-03-26 07:44:32.484375 [26]: subch:0  pid:68 pmt
2009-03-26 07:44:32.484375 [26]: subch:0  pid:170 audio lang:deu type:MPEG-2
2009-03-26 07:44:32.484375 [26]: subch:0    map pid:170 audio lang:deu type:MPEG-2
2009-03-26 07:44:32.500000 [26]: subch:0 stop tif
2009-03-26 07:44:32.500000 [26]: WaitForPMT: sending PMT to CAM took 0,03125 seconds.
2009-03-26 07:44:32.531250 [26]: card: Tuner locked: True
2009-03-26 07:44:32.531250 [26]: **************************************************
2009-03-26 07:44:32.531250 [26]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 94 *****
2009-03-26 07:44:32.531250 [26]: **************************************************
2009-03-26 07:44:32.531250 [26]: card: tuned user: epg subchannel: 0
2009-03-26 07:44:32.531250 [26]: user:epg add
2009-03-26 07:44:32.531250 [DVB EPG timer]: dvb:grab epg...
2009-03-26 07:45:01.546875 [Powerscheduler Timer]: PowerScheduler: User input detected at 25.03.2009 19:08:52
2009-03-26 07:45:01.546875 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:45:01.546875 [Powerscheduler Timer]: NetworkMonitorHandler: standby allowed
2009-03-26 07:45:01.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:45:01.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:45:01.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:45:01.562500 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:45:01.562500 [Powerscheduler Timer]: PowerScheduler: System is unattended and idle - initiate suspend/hibernate
2009-03-26 07:45:01.562500 [Powerscheduler Timer]: PowerScheduler: Manual system suspend requested by 
2009-03-26 07:45:01.562500 [Powerscheduler Timer]: PowerScheduler: Entering shutdown Hibernate ; forced: True -- kick off shutdown thread
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler: Shutdown thread is running: Hibernate, force: True
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler: Informing handlers about UserShutdownNow
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: NetworkMonitorHandler: standby allowed
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler: Shutdown is allowed True ; forced: True
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:45:01.562500 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:45:01.578125 [Powerscheduler Suspender]: NetworkMonitorHandler: standby allowed
2009-03-26 07:45:01.578125 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:45:01.578125 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:45:01.578125 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:45:01.593750 [Powerscheduler Suspender]: PowerScheduler: Set wakeup timer to wakeup system in 253,973697916667 minutes
2009-03-26 07:45:01.593750 [Powerscheduler Suspender]: PowerScheduler: Entering shutdown Hibernate ; forced: True
2009-03-26 07:45:01.593750 [WinController exit thread]: WindowsController: Performing ExitWindows Hibernate, force: True
2009-03-26 07:47:14.531250 [Powerscheduler Timer]: PowerScheduler: User input detected at 25.03.2009 19:08:52
2009-03-26 07:47:14.531250 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3282 , True
2009-03-26 07:47:14.546875 [Powerscheduler Timer]: NetworkMonitorHandler: standby allowed
2009-03-26 07:47:14.546875 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler: User input detected at 25.03.2009 19:08:52
2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3285 , True
2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler: System is unattended and idle - initiate suspend/hibernate
2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler: Manual system suspend requested by 
2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler: Concurrent shutdown was ignored: Hibernate ; force: True
2009-03-26 07:47:23.593750 [PowerEventThread]: TV service PowerEventThread 30
2009-03-26 07:47:23.609375 [PowerEventThread]: OnPowerEvent: PowerStatus: ResumeAutomatic
2009-03-26 07:47:23.609375 [PowerEventThread]: OnPowerEventHandler: PowerStatus: ResumeAutomatic
2009-03-26 07:47:23.609375 [PowerEventThread]: PowerScheduler: System has resumed automatically from standby
2009-03-26 07:47:23.625000 [WinController exit thread]: WindowsController: ExitWindows performed, result: True
2009-03-26 07:47:23.625000 [PowerEventThread]: TV service PowerEventThread 30
2009-03-26 07:47:23.625000 [PowerEventThread]: OnPowerEvent: PowerStatus: ResumeCritical
2009-03-26 07:47:23.625000 [PowerEventThread]: OnPowerEventHandler: PowerStatus: ResumeCritical
2009-03-26 07:47:23.625000 [PowerEventThread]: PowerScheduler: System has resumed from standby after a critical suspend
2009-03-26 07:48:14.500000 [Powerscheduler Timer]: PowerScheduler: User input detected at 25.03.2009 19:08:52
2009-03-26 07:48:14.500000 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3290 , True
2009-03-26 07:48:14.500000 [Powerscheduler Timer]: NetworkMonitorHandler: standby allowed
2009-03-26 07:48:14.500000 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:48:14.515625 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:48:14.515625 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:48:14.515625 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3290 , True
2009-03-26 07:48:14.515625 [Powerscheduler Timer]: PowerScheduler: System is unattended and idle - initiate suspend/hibernate
2009-03-26 07:48:14.515625 [Powerscheduler Timer]: PowerScheduler: Manual system suspend requested by 
2009-03-26 07:48:14.515625 [Powerscheduler Timer]: PowerScheduler: Entering shutdown Hibernate ; forced: True -- kick off shutdown thread
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler: Shutdown thread is running: Hibernate, force: True
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler: Informing handlers about UserShutdownNow
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: NetworkMonitorHandler: standby allowed
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler: Shutdown is allowed True ; forced: True
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:48:14.515625 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:48:14.531250 [Powerscheduler Suspender]: NetworkMonitorHandler: standby allowed
2009-03-26 07:48:14.531250 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:48:14.531250 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:48:14.531250 [Powerscheduler Suspender]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:48:14.546875 [Powerscheduler Suspender]: PowerScheduler: Set wakeup timer to wakeup system in 250,7578125 minutes
2009-03-26 07:48:14.546875 [Powerscheduler Suspender]: PowerScheduler: Entering shutdown Hibernate ; forced: True
2009-03-26 07:48:14.546875 [WinController exit thread]: WindowsController: Performing ExitWindows Hibernate, force: True
2009-03-26 07:49:55.546875 [Powerscheduler Timer]: PowerScheduler: User input detected at 25.03.2009 19:08:52
2009-03-26 07:49:55.546875 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: NetworkMonitorHandler: standby allowed
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:GenericWakeupHandler time:31.12.9999 23:59:59
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:ScheduledRecordingsHandler time:26.03.2009 12:00:00
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: PowerScheduler.NextWakeupTime: inspecting handler:EpgGrabbingHandler time:26.03.2009 18:00:00
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: PowerScheduler: System is unattended and idle - initiate suspend/hibernate
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: PowerScheduler: Manual system suspend requested by 
2009-03-26 07:49:55.562500 [Powerscheduler Timer]: PowerScheduler: Concurrent shutdown was ignored: Hibernate ; force: True
2009-03-26 07:50:04.609375 [PowerEventThread]: TV service PowerEventThread 30
2009-03-26 07:50:04.609375 [PowerEventThread]: TV service PowerEventThread 30
2009-03-26 07:50:04.609375 [PowerEventThread]: OnPowerEvent: PowerStatus: ResumeCritical
2009-03-26 07:50:04.609375 [PowerEventThread]: OnPowerEventHandler: PowerStatus: ResumeCritical
2009-03-26 07:50:04.609375 [PowerEventThread]: PowerScheduler: System has resumed from standby after a critical suspend
2009-03-26 07:50:04.609375 [PowerEventThread]: OnPowerEvent: PowerStatus: ResumeAutomatic
2009-03-26 07:50:04.609375 [PowerEventThread]: OnPowerEventHandler: PowerStatus: ResumeAutomatic
2009-03-26 07:50:04.609375 [PowerEventThread]: PowerScheduler: System has resumed automatically from standby
2009-03-26 07:50:04.609375 [WinController exit thread]: WindowsController: ExitWindows performed, result: True
2009-03-26 07:50:45.359375 [23]: Controller: StartTimeShifting TELE 5 2223
2009-03-26 07:50:45.406250 [23]: user:epg remove
2009-03-26 07:50:45.406250 [23]: tvcard:FreeSubChannel:1 #0 keep graph=False
2009-03-26 07:50:45.406250 [23]: DVB subch:0 Decompose()
2009-03-26 07:50:46.437500 [23]: FreeSubChannel CA: freeing sub channel : 0
2009-03-26 07:50:46.437500 [23]: tvcard:FreeAllSubChannels:
2009-03-26 07:50:46.437500 [23]: dvb:StopGraph
2009-03-26 07:50:46.562500 [23]: Controller: find free card for channel TELE 5
2009-03-26 07:50:46.562500 [23]: Controller:   got 2 tuning details for TELE 5
2009-03-26 07:50:46.562500 [23]: Controller:   channel #1 DVBS:tv:BetaDigital TELE 5 Freq:12480000 ONID:133 TSID:33 SID:51 PMT:0x63 FTA:True LCN:2223 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet 
2009-03-26 07:50:46.562500 [23]: Controller:    card:1 type:DvbS is available priority:3 #users:0 same transponder:False
2009-03-26 07:50:46.562500 [23]: Controller:    card:2 type:DvbS is available priority:2 #users:0 same transponder:False
2009-03-26 07:50:46.562500 [23]: Controller:    card:3 type:RadioWebStream cannot tune to channel
2009-03-26 07:50:46.562500 [23]: Controller:    card:4 type:DvbS channel not mapped
2009-03-26 07:50:46.562500 [23]: Controller:   channel #2 DVBS:tv:BetaDigital TELE 5 Freq:12480000 ONID:133 TSID:33 SID:51 PMT:0x63 FTA:True LCN:2223 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet 
2009-03-26 07:50:46.562500 [23]: Controller:    card:3 type:RadioWebStream cannot tune to channel
2009-03-26 07:50:46.562500 [23]: Controller:    card:4 type:DvbS channel not mapped
2009-03-26 07:50:46.562500 [23]: Controller: found 2 available
2009-03-26 07:50:46.578125 [23]: card: CardTune 1 TELE 5 Coyote:1:-1
2009-03-26 07:50:46.578125 [23]: card: Tune 1 to TELE 5
2009-03-26 07:50:46.578125 [23]: card: user: Coyote:1:-1 tune DVBS:tv:BetaDigital TELE 5 Freq:12480000 ONID:133 TSID:33 SID:51 PMT:0x63 FTA:True LCN:2223 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
2009-03-26 07:50:46.578125 [23]: dvbs:  Tune:DVBS:tv:BetaDigital TELE 5 Freq:12480000 ONID:133 TSID:33 SID:51 PMT:0x63 FTA:True LCN:2223 SymbolRate:27500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:Rate3_4 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
2009-03-26 07:50:46.578125 [23]: dvb:GetNewSubChannel:0 #0
2009-03-26 07:50:46.593750 [23]: LNB low:9750 hi:10600 switch:11700
2009-03-26 07:50:46.593750 [23]:   Channel modulation is set to ModNotSet
2009-03-26 07:50:46.593750 [23]:   Channel FECRate is set to Rate3_4
2009-03-26 07:50:46.703125 [23]: dvb:Submiting tunerequest Channel:TELE 5 subChannel:0 
2009-03-26 07:50:46.703125 [23]: dvb:using existing subchannel:0
2009-03-26 07:50:46.703125 [23]: dvb:Submit tunerequest size:1 new:0
2009-03-26 07:50:46.703125 [23]: subch:0 OnBeforeTune
2009-03-26 07:50:46.734375 [23]: dvb:Submit tunerequest calling put_TuneRequest
2009-03-26 07:50:46.843750 [23]: dvb:Submit tunerequest done calling put_TuneRequest
2009-03-26 07:50:46.843750 [23]: subch:0 OnAfterTune
2009-03-26 07:50:46.843750 [23]: subch:0 OnGraphStart
2009-03-26 07:50:46.843750 [23]: subch:0 Graph already running - skip WaitForPMT
2009-03-26 07:50:46.843750 [23]: dvb:  RunGraph
2009-03-26 07:50:47.390625 [23]: dvb:  LockedInOnSignal ok
2009-03-26 07:50:47.390625 [23]: subch:0 OnGraphStarted
2009-03-26 07:50:47.390625 [23]: subch:0 SetupPmtGrabber:pid 63 sid:33
2009-03-26 07:50:47.390625 [23]: subch:0 set pmt grabber pmt:63 sid:33
2009-03-26 07:50:47.421875 [23]: WaitForPMT: Waiting for PMT.
2009-03-26 07:50:47.515625 [13]: subch:0 OnPMTReceived() True
2009-03-26 07:50:47.515625 [23]: WaitForPMT: Found PMT after 0,09375 seconds.
2009-03-26 07:50:47.515625 [23]: subch:0 SendPmt:33 33 FFFFFFFF 12
2009-03-26 07:50:47.515625 [23]: Decode pmt
2009-03-26 07:50:47.515625 [23]: Set descriptor data with length 3
2009-03-26 07:50:47.515625 [23]: PROBLEM : descriptor lengths dont match 7 10
2009-03-26 07:50:47.515625 [23]: Set descriptor data with length 3
2009-03-26 07:50:47.515625 [23]: Set descriptor data with length 6
2009-03-26 07:50:47.515625 [23]: PROBLEM : descriptor lengths dont match 3 9
2009-03-26 07:50:47.515625 [23]: subch:0 SendPMT version:18 len:50 51
2009-03-26 07:50:47.515625 [23]: subch:0 cam flags:True
2009-03-26 07:50:47.515625 [23]: subch:0 SetMpegPidMapping
2009-03-26 07:50:47.515625 [23]: subch:0  pid:5FF pcr
2009-03-26 07:50:47.515625 [23]: subch:0  pid:63 pmt
2009-03-26 07:50:47.515625 [23]: subch:0  pid:26 teletext type:6
2009-03-26 07:50:47.515625 [23]: subch:0    map pid:26 teletext type:6
2009-03-26 07:50:47.515625 [23]: subch:0  pid:5FF video type:MPEG-2
2009-03-26 07:50:47.515625 [23]: subch:0    map pid:5FF video type:MPEG-2
2009-03-26 07:50:47.531250 [23]: subch:0  pid:600 audio lang:deu type:MPEG-1
2009-03-26 07:50:47.531250 [23]: subch:0    map pid:600 audio lang:deu type:MPEG-1
2009-03-26 07:50:47.562500 [23]: subch:0 stop tif
2009-03-26 07:50:47.562500 [23]: WaitForPMT: sending PMT to CAM took 0,046875 seconds.
2009-03-26 07:50:47.593750 [23]: card: Tuner locked: True
2009-03-26 07:50:47.593750 [23]: **************************************************
2009-03-26 07:50:47.593750 [23]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 94 *****
2009-03-26 07:50:47.593750 [23]: **************************************************
2009-03-26 07:50:47.593750 [23]: card: tuned user: Coyote subchannel: 0
2009-03-26 07:50:47.593750 [23]: user:Coyote add
2009-03-26 07:50:47.593750 [23]: card2:Coyote 1 0
2009-03-26 07:50:47.593750 [23]: Controller: Coyote 1 0
2009-03-26 07:50:47.593750 [23]: control2:Coyote 1 0
2009-03-26 07:50:47.593750 [23]: Controller: delete timeshift files S:\Recordings\Timeshift\live1-0.ts
2009-03-26 07:50:47.640625 [23]: Controller:   delete S:\Recordings\Timeshift\live1-0.ts.tsbuffer
2009-03-26 07:50:47.640625 [23]: Controller:   delete S:\Recordings\Timeshift\live1-0.ts.tsbuffer1.ts
2009-03-26 07:50:47.640625 [23]: Controller:   delete S:\Recordings\Timeshift\live1-0.ts.tsbuffer2.ts
2009-03-26 07:50:47.640625 [23]: Controller:   delete S:\Recordings\Timeshift\live1-0.ts.tsbuffer3.ts
2009-03-26 07:50:47.640625 [23]: Controller:   delete S:\Recordings\Timeshift\live1-0.ts.tsbuffer4.ts
2009-03-26 07:50:47.640625 [23]: Controller:   delete S:\Recordings\Timeshift\live1-0.ts.tsbuffer5.ts
2009-03-26 07:50:47.640625 [23]: Controller:   delete S:\Recordings\Timeshift\live1-0.ts.tsbuffer6.ts
2009-03-26 07:50:47.640625 [23]: card: StartTimeShifting 1 S:\Recordings\Timeshift\live1-0.ts 
2009-03-26 07:50:47.640625 [23]: card: CAM enabled : False
2009-03-26 07:50:47.640625 [23]: subch:0 SetTimeShiftFileName:S:\Recordings\Timeshift\live1-0.ts
2009-03-26 07:50:47.640625 [23]: Set video / audio observer
2009-03-26 07:50:47.671875 [23]: subch:0 SetTimeShiftFileName fill in pids
2009-03-26 07:50:47.781250 [23]: subch:0-0 tswriter StartTimeshifting...
2009-03-26 07:50:47.796875 [23]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo
2009-03-26 07:50:47.906250 [13]: PID seen - type = Audio
2009-03-26 07:50:47.906250 [13]: audioVideoEventHandler Audio
2009-03-26 07:50:48.015625 [13]: PID seen - type = Video
2009-03-26 07:50:48.015625 [13]: audioVideoEventHandler Video
2009-03-26 07:50:48.015625 [23]: card: WaitForTimeShiftFile - video and audio are seen after 0,21875 seconds
2009-03-26 07:50:48.218750 [23]: user:Coyote card:1 sub:0 add stream:S:\Recordings\Timeshift\live1-0.ts.tsbuffer
2009-03-26 07:50:48.218750 [23]: RTSP: add stream stream1.0 file:S:\Recordings\Timeshift\live1-0.ts.tsbuffer
2009-03-26 07:50:48.359375 [23]: Controller: StartTimeShifting started on card:1 to S:\Recordings\Timeshift\live1-0.ts.tsbuffer
2009-03-26 07:50:48.359375 [Channel state thread]: Controller: DoSetChannelStates for 45 channels
2009-03-26 07:50:55.546875 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:50:55.546875 [Powerscheduler Timer]: PowerScheduler.DisAllowShutdown: handler ActiveStreamsHandler wants to prevent standby
2009-03-26 07:50:55.546875 [Powerscheduler Timer]: PowerScheduler: System changed from idle state to busy state
2009-03-26 07:51:55.562500 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:51:55.562500 [Powerscheduler Timer]: PowerScheduler.DisAllowShutdown: handler ActiveStreamsHandler wants to prevent standby
2009-03-26 07:52:55.578125 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:52:55.578125 [Powerscheduler Timer]: PowerScheduler.DisAllowShutdown: handler ActiveStreamsHandler wants to prevent standby
2009-03-26 07:53:55.593750 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:53:55.593750 [Powerscheduler Timer]: PowerScheduler.DisAllowShutdown: handler ActiveStreamsHandler wants to prevent standby
2009-03-26 07:54:55.609375 [Powerscheduler Timer]: PowerScheduler: lastUserTime: 19:08:52.3288 , True
2009-03-26 07:54:55.609375 [Powerscheduler Timer]: PowerScheduler.DisAllowShutdown: handler ActiveStreamsHandler wants to prevent standby

As you see in the log, I woke up the server at 07:44 and it went to hibernation at 07:45.
At 07:47 I woke up the server once again and managed to start the MP client fast enough to prevent an shutdown of the server.

Concerning the monitoring of the network traffic the following ideas came to my mind:
- To prevent shutdown of the server, check before shutdown if some clients are still running.
Just make a list of all the clients that should prevent shutdown (e.g. client1, client2, client4 (client3 should not prevent shutdown)).
- If a MP client is started, than it should start the MP server (maybe show a short message "Waiting for TV-server...").

CU

Jens
 
JBravo

JBravo

MP Donator
  • Premium Supporter
    • November 11, 2007
    269
    27
    Home Country
    Sweden Sweden
    Hi,

    I only did this small patch to PowerScheduler, but thanks anyway:)

    You seem to have some issues with your setup:
    2009-03-26 07:47:14.562500 [Powerscheduler Timer]: PowerScheduler: User input detected at 25.03.2009 19:08:52
    Click to expand...

    The last user input is detected more than 15min before current time, this will cause PS to initiate standby directly in this case. This is however not related to this patch.

    Concerning the monitoring of the network traffic the following ideas came to my mind:
    - To prevent shutdown of the server, check before shutdown if some clients are still running.
    Just make a list of all the clients that should prevent shutdown (e.g. client1, client2, client4 (client3 should not prevent shutdown)).
    - If a MP client is started, than it should start the MP server (maybe show a short message "Waiting for TV-server...").
    Click to expand...

    Done that and did that:D

    For your first concern install my patch for PS client (see first post). Make sure that PS Client is enabled in MP. The client will now keep the server alive as long as it's running.

    In the next case make sure that your server is configured to wake on all network activity (Device Manager-> Network Adapters -> Network Card X, right-click, Properties -> Power Managment, Check 'Allow this device to bring the computer out of standby'). If ok you should now be able to wake the server with e.g Ping xxx.xxx.xxx.xxx.

    In MediaPortal Configuration, set the IP of the TV server (not machine name).

    When the MP client starts it tries to connect to the server, and voila the server starts. No need for WOL.

    Also make sure that Window standby handling is not used, PS should control things.

    Edit:
    I'm only using standby (s3) , hibernate (s4) takes to long time when starting. Furthermore I'm not using the 'Force' option.
     
    J

    Jeggo

    Portal Member
    July 29, 2007
    26
    1
    Home Country
    Germany Germany
    Hi,

    JBravo said:
    I only did this small patch to PowerScheduler, but thanks anyway:)
    Click to expand...

    It has nothing to do with patch. My system did the same with the version included in MP 1.0

    For your first concern install my patch for PS client (see first post). Make sure that PS Client is enabled in MP. The client will now keep the server alive as long as it's running.
    Click to expand...
    This worked before. My idea was to keep the server alive while I am not using MP. As far as I understand it
    now, the server will go to standby/hibernation after idle time has passed.
    Sure one possiblity to avoid this is to monitor the network traffic. But as mentioned earlier by othe users this
    might also cause problems. So my idea is to check if the clients on the list are online or not (even if they are not
    using MP).

    So it should work like this:
    - Server is running
    - Client using MP
    - Client ends MP but client still in use
    - After idle time has passed
    if client is in list then do nothing
    if client is not in list then standby/hibernation
    - Reset idle timer
    - Wait until idle time has passed
    - After idle time has passed
    if client is in list then do nothing
    if client is not in list then standby/hibernation
    - Reset idle timer
    and so on



    In the next case make sure that your server is configured to wake on all network activity (Device Manager-> Network Adapters -> Network Card X, right-click, Properties -> Power Managment, Check 'Allow this device to bring the computer out of standby'). If ok you should now be able to wake the server with e.g Ping xxx.xxx.xxx.xxx.

    In MediaPortal Configuration, set the IP of the TV server (not machine name).

    When the MP client starts it tries to connect to the server, and voila the server starts. No need for WOL.
    Click to expand...
    I will try this out.

    Also make sure that Window standby handling is not used, PS should control things.
    Click to expand...
    This was allready turned of. So full control for PS.

    CU

    Jens
     
    JBravo

    JBravo

    MP Donator
  • Premium Supporter
    • November 11, 2007
    269
    27
    Home Country
    Sweden Sweden
    So it should work like this:
    - Server is running
    - Client using MP
    - Client ends MP but client still in use
    - After idle time has passed
    if client is in list then do nothing
    if client is not in list then standby/hibernation
    - Reset idle timer
    - Wait until idle time has passed
    - After idle time has passed
    if client is in list then do nothing
    if client is not in list then standby/hibernation
    - Reset idle timer
    and so on
    Click to expand...

    I see your point, but this is out of the scope for this patch.

    You can always try this one https://forum.team-mediaportal.com/plugins-47/new-mp-1-0-features-fixes-network-share-monitoring-new-schedule-option-48181/ it includes a network share monitor for PS.
     
    J

    Jeggo

    Portal Member
    July 29, 2007
    26
    1
    Home Country
    Germany Germany
    Hello Jonas,

    I still have the same behaviour than posted in my log earlier.

    My server is on between 18:00 and 20:00 to grab EPG. During this time I start MP on a client (e.g. to program some new recording schedules). I end MP on the client at 19:25. The server stays on until 20:00 and enters standby a little later (no standby between 18:00 and 20:00).

    Later the server wakes up (e.g. at 22:00 till 23:00) to record a TV-show and went to standby after the recording has finished.

    The next day I wake up the server from the client with a WOL command (MP not running on client). Server resumes and PS reports that the last user input was at 19:25 the day before (idle time of 15min is passed). So the server enters standby again.

    I think the last user action should be cleared after the server resumes from standby and idle time should start again.
    As you mentioned earlier, you start your server by starting the MP client. So MP is allready running when the server resumes PS. So you would not see this behaviour.

    If I have not configured something wrong, I would expect that your system will react in the same way when you do the following:
    - Start server
    - Start MP on client and do something (e.g. program a recording, watch TV)
    - Stop MP on client and wait until server went to standby
    - Wake up server either manually (press the power button) or by a WOL command from a client
    Important do not run MP on any of your clients. I would expect, that your server enters standby before the configures idle time has passed.

    CU

    Jens

    It looks like PS remembers the last user action
     

    Users who are viewing this thread

    Online now: 3 (members: 0, guests: 3)

    About The Project

    The vision of the MediaPortal project is to create a free open source media centre application, which supports all advanced media centre functions, and is accessible to all Windows users.

    In reaching this goal we are working every day to make sure our software is one of the best.

             

    Quick Navigation

    Support MediaPortal!

    The team works very hard to make sure the community is running the best HTPC-software. We give away MediaPortal for free but hosting and software is not for us.

    Care to support our work with a few bucks? We'd really appreciate it!

    Community platform by XenForo® © 2010-2021 XenForo Ltd.
    Top Bottom