Scheduled Recordings Failed (MP 1.22) (2 Viewers)

joecrow

Test Group
  • Team MediaPortal
  • August 9, 2012
    2,528
    1,880
    Home Country
    Germany Germany
    Sorry not sure what happened there, attached now.
     

    Attachments

    • MediaPortalLogs_01_05_19__19_06.zip
      1.3 MB

    Owlsroost

    Retired Team Member
  • Premium Supporter
  • October 28, 2008
    5,540
    5,038
    Cambridge
    Home Country
    United Kingdom United Kingdom
    The [ERROR] entries in TVService.log do point to a network problem:

    Code:
    [2019-05-01 19:01:23,334] [Log    ] [7        ] [DEBUG] - EpgGrabber:_epgTimer_Elapsed: timerInterval changed from 1s to 30s
    [2019-05-01 19:01:23,336] [EPG    ] [DVB EPG timer] [INFO ] - Grab for card:#3 transponder #1/3 channel: Das Erste HD
    [2019-05-01 19:01:23,341] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings()
    [2019-05-01 19:01:23,342] [EPG    ] [DVB EPG timer] [INFO ] - EpgCard: grab epg on card: #3 transponder: #0 ch:Das Erste HD
    [2019-05-01 19:01:23,354] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer()
    [2019-05-01 19:01:23,356] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Reboot: 05/05/2019 11:00:00
    [2019-05-01 19:01:23,367] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Set wakeup timer to wakeup system at 05/05/2019 10:59:00
    [2019-05-01 19:01:23,368] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: CheckForStandby()
    [2019-05-01 19:01:25,353] [Log    ] [DVB EPG timer] [ERROR] - Exception   :System.Net.Sockets.SocketException (0x80004005): An attempt was made to access a socket in a way forbidden by its access permissions 192.168.178.100:31456
    
    Server stack trace:
       at System.Net.Sockets.Socket.Connect(IPAddress[] addresses, Int32 port)
       at System.Runtime.Remoting.Channels.RemoteConnection.CreateNewSocket(AddressFamily family)
       at System.Runtime.Remoting.Channels.RemoteConnection.CreateNewSocket()
       at System.Runtime.Remoting.Channels.RemoteConnection.GetSocket()
       at System.Runtime.Remoting.Channels.SocketCache.GetSocket(String machinePortAndSid, Boolean openNew)
       at System.Runtime.Remoting.Channels.Tcp.TcpClientTransportSink.SendRequestWithRetry(IMessage msg, ITransportHeaders requestHeaders, Stream requestStream)
       at System.Runtime.Remoting.Channels.Tcp.TcpClientTransportSink.ProcessMessage(IMessage msg, ITransportHeaders requestHeaders, Stream requestStream, ITransportHeaders& responseHeaders, Stream& responseStream)
       at System.Runtime.Remoting.Channels.BinaryClientFormatterSink.SyncProcessMessage(IMessage msg)
    
    Exception rethrown at [0]:
       at System.Runtime.Remoting.Proxies.RealProxy.HandleReturnMessage(IMessage reqMsg, IMessage retMsg)
       at System.Runtime.Remoting.Proxies.RealProxy.PrivateInvoke(MessageData& msgData, Int32 type)
       at TvControl.IController.IsRecording(IUser& user)
       at TvService.EpgCard.IsCardIdle(Int32 cardId)
       at TvService.EpgCard.GrabEpgForChannel(Channel channel, IChannel tuning, Card card)
       at TvService.EpgCard.GrabEpg()
       at TvService.EpgGrabber.GrabEpgOnCard(EpgCard epgCard)
       at TvService.EpgGrabber._epgTimer_Elapsed(Object sender, ElapsedEventArgs e)
    
    [2019-05-01 19:01:25,378] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:27,386] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:29,395] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:31,404] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:33,412] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:34,681] [Log    ] [3        ] [DEBUG] - Detecting BDA/WDM devices...
    [2019-05-01 19:01:34,683] [Log    ] [3        ] [DEBUG] - Detect legacy AM filter devices
    [2019-05-01 19:01:34,690] [Log    ] [3        ] [DEBUG] - Detect AM KS crossbar devices
    [2019-05-01 19:01:34,692] [Log    ] [3        ] [DEBUG] - Detect AM KS TV tuner devices
    [2019-05-01 19:01:34,693] [Log    ] [3        ] [DEBUG] - Detect BDA source devices
    [2019-05-01 19:01:35,418] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:35,421] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: SetStandbyMode(StandbyAllowed)
    [2019-05-01 19:01:35,423] [Log    ] [PS StandbyWakeup] [INFO ] - PS: System changed from busy state to idle state
    [2019-05-01 19:01:35,424] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: System is idle and may go to standby
    [2019-05-01 19:01:35,427] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Active standby is disabled - standby is handled by Windows
    [2019-05-01 19:01:50,470] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: StandbyWakeupThread triggered by check interval
    [2019-05-01 19:01:50,475] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings()
    [2019-05-01 19:01:50,489] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer()
    [2019-05-01 19:01:50,491] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Reboot: 05/05/2019 11:00:00
    [2019-05-01 19:01:50,502] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Set wakeup timer to wakeup system at 05/05/2019 10:59:00
    [2019-05-01 19:01:50,504] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: CheckForStandby()
    [2019-05-01 19:01:52,513] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:53,335] [EPG    ] [DVB EPG timer] [INFO ] - Grab for card:#3 transponder #2/3 channel: ZDF HD
    [2019-05-01 19:01:53,337] [EPG    ] [DVB EPG timer] [INFO ] - EpgCard: grab epg on card: #3 transponder: #1 ch:ZDF HD
    [2019-05-01 19:01:54,521] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:55,344] [Log    ] [DVB EPG timer] [ERROR] - Exception   :System.Net.Sockets.SocketException (0x80004005): An attempt was made to access a socket in a way forbidden by its access permissions 192.168.178.100:31456
    
    Server stack trace:
       at System.Net.Sockets.Socket.Connect(IPAddress[] addresses, Int32 port)
       at System.Runtime.Remoting.Channels.RemoteConnection.CreateNewSocket(AddressFamily family)
       at System.Runtime.Remoting.Channels.RemoteConnection.CreateNewSocket()
       at System.Runtime.Remoting.Channels.RemoteConnection.GetSocket()
       at System.Runtime.Remoting.Channels.SocketCache.GetSocket(String machinePortAndSid, Boolean openNew)
       at System.Runtime.Remoting.Channels.Tcp.TcpClientTransportSink.SendRequestWithRetry(IMessage msg, ITransportHeaders requestHeaders, Stream requestStream)
       at System.Runtime.Remoting.Channels.Tcp.TcpClientTransportSink.ProcessMessage(IMessage msg, ITransportHeaders requestHeaders, Stream requestStream, ITransportHeaders& responseHeaders, Stream& responseStream)
       at System.Runtime.Remoting.Channels.BinaryClientFormatterSink.SyncProcessMessage(IMessage msg)
    
    Exception rethrown at [0]:
       at System.Runtime.Remoting.Proxies.RealProxy.HandleReturnMessage(IMessage reqMsg, IMessage retMsg)
       at System.Runtime.Remoting.Proxies.RealProxy.PrivateInvoke(MessageData& msgData, Int32 type)
       at TvControl.IController.IsRecording(IUser& user)
       at TvService.EpgCard.IsCardIdle(Int32 cardId)
       at TvService.EpgCard.GrabEpgForChannel(Channel channel, IChannel tuning, Card card)
       at TvService.EpgCard.GrabEpg()
       at TvService.EpgGrabber.GrabEpgOnCard(EpgCard epgCard)
       at TvService.EpgGrabber._epgTimer_Elapsed(Object sender, ElapsedEventArgs e)
    
    [2019-05-01 19:01:56,531] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:01:58,540] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:02:00,548] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:02:02,554] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:02:02,556] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: SetStandbyMode(StandbyAllowed)
    [2019-05-01 19:02:02,557] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: System is idle and may go to standby
    [2019-05-01 19:02:02,558] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Active standby is disabled - standby is handled by Windows
    [2019-05-01 19:02:17,591] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: StandbyWakeupThread triggered by check interval
    [2019-05-01 19:02:17,596] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: LoadSettings()
    [2019-05-01 19:02:17,607] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: SetWakeupTimer()
    [2019-05-01 19:02:17,609] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Inspecting Reboot: 05/05/2019 11:00:00
    [2019-05-01 19:02:17,621] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: Set wakeup timer to wakeup system at 05/05/2019 10:59:00
    [2019-05-01 19:02:17,622] [Log    ] [PS StandbyWakeup] [DEBUG] - PS: CheckForStandby()
    [2019-05-01 19:02:19,631] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
    [2019-05-01 19:02:21,638] [Log    ] [PS StandbyWakeup] [ERROR] - EpgGrabbing: unable to connect to controller at: NEWCORWIN
     

    joecrow

    Test Group
  • Team MediaPortal
  • August 9, 2012
    2,528
    1,880
    Home Country
    Germany Germany
    The [ERROR] entries in TVService.log do point to a network problem:

    Ah ha, yes that could be a clue. I do use a vpn and its control program was updated recently. It maybe that if the vpn is connected when going to sleep it could take a while before it reconnects on wake up (the old version did not attempt to reconnect) and may be blocking network traffic while doing so. I will give it a few days of making sure I disconnect the vpn before sleep and if that works I can set up a schedule to kill the vpn program before sleep. I will update here when I know more.
    Many thanks
     

    Users who are viewing this thread

    Top Bottom