[mythtv-users] Recording from an IPTV source

Sun Nov 27 07:16:18 UTC 2022

On 26/11/2022 20:33, John P Poet wrote:
> More context in the logs might help. When you run mythbackend add `-v
> channel, record` to get some more relevant messages.

A new recording attempt after creating a file as follows:

# cat /etc/mythtv/additional.args
ADDITIONAL_ARGS=-v channel,record

The resulting logfile included the following line:

Nov 27 07:38:00 hobbiton mythbackend: mythbackend[3628]: E Scheduler
tv_rec.cpp:4092 (LoadProfile) TVRec[1]: Profile 'Default' not found, and
unable to load fallback profile 'Default'.  Results may be unpredicable

So I created a recording profile called Default and tried again.
Resulting logfile below; first weird-looking line is

Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: W TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('10:LockTimeout?') = 'ERR: Not
open' took 2ms <-- NOTE
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: E TVRecEvent
recorders/ExternalSignalMonitor.cpp:238 (GetLockTimeout)
ExternSigMon[1](): GetLockTimeout: invalid response 'ERR: Not open'

Any ideas as to what that means?

(I will try adding a delay to the tuning script such that there is a
greater chance of the stream already coming in by the time ffmpeg is
started).

Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
ProcessRequest mainserver.cpp:1811 (HandleAnnounce) MainServer:
MainServer::ANN Monitor
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
ProcessRequest mainserver.cpp:1813 (HandleAnnounce) MainServer: adding:
hobbiton(561967d63160) as a client (events: 0)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
scheduler.cpp:2330 (HandleReschedule) Reschedule requested for MATCH 8 0
0 - PHP
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
MythSocketThread(58) mainserver.cpp:7889 (connectionClosed) Monitor
sock(561967d63160) 'hobbiton' disconnected
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
ProcessRequest mainserver.cpp:1811 (HandleAnnounce) MainServer:
MainServer::ANN Monitor
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
ProcessRequest mainserver.cpp:1813 (HandleAnnounce) MainServer: adding:
hobbiton(561967d586e0) as a client (events: 2)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
scheduler.cpp:2444 (HandleReschedule) Scheduled 2 items in 0.0 = 0.01
match + 0.00 check + 0.00 place
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
tv_rec.cpp:305 (RecordPending) TVRec[1]: RecordPending on inputid [1]
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
cardutil.cpp:2167 (GetConflictingInputs) CardUtil[1]:
GetConflictingInputs(1)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
tv_rec.cpp:417 (StartRecording) TVRec[1]: StartRecording("BBC
Proms":"2020: Last Night of the Proms")
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
tv_rec.cpp:707 (SetRecordingStatus) TVRec[1]:
SetRecordingStatus(Unknown->Aborted) on line 423
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
tv_rec.cpp:809 (StartedRecording) TVRec[1]:
StartedRecording(10026_2022-11-27T06:58:00Z)
fn(/home/mythtv/storage/default/10026_20221127065800.ts)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: E Scheduler
tv_rec.cpp:4092 (LoadProfile) TVRec[1]: Profile 'Default' not found, and
unable to load fallback profile 'Default'.  Results may be unpredicable
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
tv_rec.cpp:4370 (ClearFlags) TVRec[1]: ClearFlags(CancelNextRecording,)
-> RunMainLoop, @ tv_rec.cpp:606
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
tv_rec.cpp:707 (SetRecordingStatus) TVRec[1]:
SetRecordingStatus(Aborted->Tuning) on line 609
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:1077 (HandleStateChange) TVRec[1]: Changing from None to
RecordingOnly
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4370 (ClearFlags) TVRec[1]:
ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, @
tv_rec.cpp:1320
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:3442 (HandleTuning) TVRec[1]: HandleTuning Request:
Program(ProgramInfo(10026_20221127065800.ts): channame(BBC
Entertainment)#012             startts(Sun Nov 27 05:45:00 2022 GMT)
endts(Sun Nov 27 07:40:00 2022 GMT)#012             recstartts(Sun Nov
27 06:58:00 2022 GMT) recendts(Sun Nov 27 07:40:00 2022 GMT)#012
    title(BBC Proms)) channel() input() flags(Recording,)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:3511 (TuningShutdowns) TVRec[1]:
TuningShutdowns(Program(ProgramInfo(10026_20221127065800.ts):
channame(BBC Entertainment)#012             startts(Sun Nov 27 05:45:00
2022 GMT) endts(Sun Nov 27 07:40:00 2022 GMT)#012
recstartts(Sun Nov 27 06:58:00 2022 GMT) recendts(Sun Nov 27 07:40:00
2022 GMT)#012             title(BBC Proms)) channel(26) input(MPEG2TS)
flags(Recording,))
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4370 (ClearFlags) TVRec[1]: ClearFlags(PENDINGACTIONS,) ->
RunMainLoop, @ tv_rec.cpp:3578
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:3464 (HandleTuning) TVRec[1]: No recorder yet, calling
TuningFrequency
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:3600 (TuningFrequency) TVRec[1]: TuningFrequency
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/dtvchannel.cpp:159 (SetChannelByString)
DTVChan[1](/usr/bin/mythexternrecorder --conf mythexternrecorder1.conf):
SetChannelByString(26):
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalChannel.cpp:21 (Open)
ExternChan[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Open()
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/channelbase.cpp:609 (InitializeInput) ChannelBase[1]: Input
#1: 'MPEG2TS' schan(100) sourceid(1)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:564 (ExternalStreamHandler)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): args "--conf mythexternrecorder1.conf
--verbose general,channel,record --loglevel info --quiet --syslog local7
--inputid 1"
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:931 (OpenApp)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Spawn '/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf'
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:236 (Run) ExternIO::Run()
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:326 (Fork) ExternIO::Fork
'mythexternrecorder --conf mythexternrecorder1.conf --verbose
general,channel,record --loglevel info --quiet --syslog local7 --inputid 1'
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:384 (Fork) Spawned
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1335 (ProcessVer1)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessCommand('APIVersion?') = 'OK:2' took 12ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('1:APIVersion:2') = 'OK:2' took 0ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('2:Version?') = 'OK:1.0' took 0ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: W TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('3:Description?') = 'WARN:Not set'
took 0ms <-- NOTE
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('4:HasTuner?') = 'OK:No' took 9ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('5:HasPictureAttributes?') =
'OK:No' took 10ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('6:FlowControl?') = 'OK:XON/XOFF'
took 0ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:988 (OpenApp)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): App opened successfully
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:989 (OpenApp)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Capabilities: tuner(no) Picture
attributes(no) Flow control(XON/XOFF)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('7:BlockSize:1540096') = 'OK' took 9ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:473 (Get) ExternSH[1:1]: Creating
new stream handler for /usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf (1 in use)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalChannel.cpp:53 (Open)
ExternChan[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Opened
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
cardutil.cpp:2167 (GetConflictingInputs) CardUtil[1]:
GetConflictingInputs(1)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/channelbase.cpp:253 (IsInputAvailable) ChannelBase[1]: Input
is free on 0/0
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalChannel.cpp:90 (Tune)
ExternChan[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Tune(26)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/dtvchannel.cpp:320 (SetChannelByString)
DTVChan[1](/usr/bin/mythexternrecorder --conf mythexternrecorder1.conf):
SetChannelByString(26): success
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalChannel.cpp:21 (Open)
ExternChan[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Open()
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('8:Version?') = 'OK:1.0' took 0ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/dtvchannel.cpp:159 (SetChannelByString)
DTVChan[1](/usr/bin/mythexternrecorder --conf mythexternrecorder1.conf):
SetChannelByString(26):
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
cardutil.cpp:2167 (GetConflictingInputs) CardUtil[1]:
GetConflictingInputs(1)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/channelbase.cpp:253 (IsInputAvailable) ChannelBase[1]: Input
is free on 0/0
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalChannel.cpp:90 (Tune)
ExternChan[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Tune(26)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/dtvchannel.cpp:320 (SetChannelByString)
DTVChan[1](/usr/bin/mythexternrecorder --conf mythexternrecorder1.conf):
SetChannelByString(26): success
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:3735 (TuningFrequency) TVRec[1]: Starting Signal Monitor
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:1977 (SetupSignalMonitor) TVRec[1]: SetupSignalMonitor(1, 0)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalChannel.cpp:21 (Open)
ExternChan[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): Open()
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('9:Version?') = 'OK:1.0' took 0ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalSignalMonitor.cpp:45 (ExternalSignalMonitor)
ExternSigMon[1](): ctor
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:482 (Get) ExternSH[1:1]: Using
existing stream handler for /usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf (2 in use)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1433 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): 0:ERR:Already dead.
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: W TVRecEvent
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('10:LockTimeout?') = 'ERR: Not
open' took 2ms <-- NOTE
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: E TVRecEvent
recorders/ExternalSignalMonitor.cpp:238 (GetLockTimeout)
ExternSigMon[1](): GetLockTimeout: invalid response 'ERR: Not open'
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:2001 (SetupSignalMonitor) TVRec[1]: Signal monitor
successfully created
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:1797 (SetupDTVSignalMonitor) TVRec[1]: Setting up table
monitoring.
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: E TVRecEvent
tv_rec.cpp:4092 (LoadProfile) TVRec[1]: Profile 'Live TV' not found, and
unable to load fallback profile 'Default'.  Results may be unpredicable
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:1911 (SetupDTVSignalMonitor) TVRec[1]: MPEG program number: 1
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/dtvsignalmonitor.cpp:216 (SetProgramNumber) DTVSigMon[1]:
SetProgramNumber(1)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
mpeg/mpegstreamdata.cpp:73 (SetDesiredProgram)
MPEGStream[1](0x7f3ba001fc50): SetDesiredProgram(1)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:1931 (SetupDTVSignalMonitor) TVRec[1]: Successfully set up
MPEG table monitoring.
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4361 (SetFlags) TVRec[1]: SetFlags(SignalMonitorRunning,) ->
RunMainLoop,SignalMonitorRunning, @ tv_rec.cpp:3762
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4370 (ClearFlags) TVRec[1]: ClearFlags(WaitingForSignal,) ->
RunMainLoop,SignalMonitorRunning, @ tv_rec.cpp:3763
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4361 (SetFlags) TVRec[1]: SetFlags(WaitingForSignal,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning, @ tv_rec.cpp:3768
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4370 (ClearFlags) TVRec[1]: ClearFlags(NeedToStartRecorder,)
-> RunMainLoop,WaitingForSignal,SignalMonitorRunning, @ tv_rec.cpp:3829
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4361 (SetFlags) TVRec[1]: SetFlags(NeedToStartRecorder,) ->
RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning, @
tv_rec.cpp:3831
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: E TVRecEvent
tv_rec.cpp:3891 (TuningSignalCheck) TVRec[1]: TuningSignalCheck:
SignalMonitor failed
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4370 (ClearFlags) TVRec[1]: ClearFlags(NeedToStartRecorder,)
-> RunMainLoop,WaitingForSignal,SignalMonitorRunning, @ tv_rec.cpp:3894
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:707 (SetRecordingStatus) TVRec[1]:
SetRecordingStatus(Tuning->Recorder Failed) on line 3955
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I SignalMonitor
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('11:SignalStrengthPercent?') =
'OK:20' took 0ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:2034 (TeardownSignalMonitor) TVRec[1]:
TeardownSignalMonitor() -- begin
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalSignalMonitor.cpp:68 (~ExternalSignalMonitor)
ExternSigMon[1](): dtor
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalSignalMonitor.cpp:79 (Stop) ExternSigMon[1](): Stop()
-- begin
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I SignalMonitor
recorders/ExternalStreamHandler.cpp:1482 (ProcessVer2)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): ProcessV2('12:HasLock?') = 'OK:No' took 0ms
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I CoreContext
scheduler.cpp:717 (UpdateRecStatus) Updating status for "BBC
Proms":"2020: Last Night of the Proms" on cardid [1] (Pending =>
Recorder Failed)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1181 (StopStreaming)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): StopStreaming 0 listeners
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:1187 (StopStreaming)
ExternSH[1](/usr/bin/mythexternrecorder --conf
mythexternrecorder1.conf): StopStreaming requested, but we are not
streaming!
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/streamhandler.cpp:82 (RemoveListener) SH[1]:
RemoveListener(0x7f3ba001fc50) -- begin
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/streamhandler.cpp:94 (RemoveListener) SH[1]:
RemoveListener(0x7f3ba001fc50) -- locked
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/streamhandler.cpp:111 (RemoveListener) SH[1]:
RemoveListener(0x7f3ba001fc50) -- end
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalSignalMonitor.cpp:89 (Stop) ExternSigMon[1](): Stop()
-- end
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
recorders/ExternalStreamHandler.cpp:510 (Return) ExternSH[1:1]: Return
handler (1 still in use)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:2053 (TeardownSignalMonitor) TVRec[1]:
TeardownSignalMonitor() -- end
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4370 (ClearFlags) TVRec[1]: ClearFlags(SignalMonitorRunning,)
-> RunMainLoop,WaitingForSignal, @ tv_rec.cpp:3981
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I TVRecEvent
tv_rec.cpp:4370 (ClearFlags) TVRec[1]: ClearFlags(WaitingForSignal,) ->
RunMainLoop, @ tv_rec.cpp:3983
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
scheduler.cpp:2330 (HandleReschedule) Reschedule requested for CHECK -9
8 0 UpdateRecStatus2 | BBC Proms | 2020: Last Night of the Proms |  |
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
MythSocketThread(58) mainserver.cpp:7889 (connectionClosed) Monitor
sock(561967d586e0) 'hobbiton' disconnected
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I Scheduler
scheduler.cpp:2444 (HandleReschedule) Scheduled 2 items in 0.0 = 0.01
match + 0.00 check + 0.00 place
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
ProcessRequest mainserver.cpp:1811 (HandleAnnounce) MainServer:
MainServer::ANN Monitor
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
ProcessRequest mainserver.cpp:1813 (HandleAnnounce) MainServer: adding:
hobbiton(561967d545c0) as a client (events: 0)
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
MythSocketThread(58) mainserver.cpp:7889 (connectionClosed) Monitor
sock(561967d545c0) 'hobbiton' disconnected
Nov 27 07:57:51 hobbiton mythbackend: mythbackend[4402]: I
MetadataDownload metadatagrabber.cpp:377 (RunGrabber) Running Grabber:
/usr/share/mythtv/metadata/Television/ttvdb4.py -l en -a US -N BBC Proms
2020: Last Night of the Proms