2018-06-11 23:48:57.195309 I [15672/15679] EIT tv_rec.cpp:3154 (QueueEITChannelChange) - TVRec[1]: QueueEITChannelChange(54_1) -- begin 2018-06-11 23:48:57.195347 I [15672/15679] EIT tv_rec.cpp:3172 (QueueEITChannelChange) - TVRec[1]: QueueEITChannelChange(54_1) -- end --> 1 2018-06-11 23:48:57.196186 I [15672/15679] EIT mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager20) SELECT channel.chanid FROM channel WHERE channum = '54_1' AND sourceid = '1' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.196254 D [15672/15679] EIT mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager20) Result: "chanid = 1541" 2018-06-11 23:48:57.196460 I [15672/15679] EIT eitscanner.cpp:143 (run) - EITScanner (1): Now looking for EIT data on multiplex of channel 54_1 2018-06-11 23:48:57.196608 I [15672/15679] EIT eitcache.cpp:432 (PruneOldEntries) - EITCache: Pruning all entries that ended before UTC 2018-06-11T04:54:04Z 2018-06-11 23:48:57.196631 I [15672/15679] EIT eitcache.cpp:108 (delete_in_db) - EITCache: Deleting old cache entries from the database 2018-06-11 23:48:57.197478 I [15672/15679] EIT mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager20) DELETE FROM eit_cache WHERE endtime < '1528692844' <<<< Took 0ms 2018-06-11 23:48:57.219432 I [15672/15678] TVRecEvent tv_rec.cpp:3515 (HandleTuning) - TVRec[1]: HandleTuning Request: Program(NULL) channel(54_1) input() flags(EITScan,) 2018-06-11 23:48:57.219485 I [15672/15678] TVRecEvent tv_rec.cpp:3584 (TuningShutdowns) - TVRec[1]: TuningShutdowns(Program(NULL) channel(54_1) input() flags(EITScan,)) 2018-06-11 23:48:57.219522 I [15672/15678] TVRecEvent tv_rec.cpp:2116 (TeardownSignalMonitor) - TVRec[1]: TeardownSignalMonitor() -- begin 2018-06-11 23:48:57.220609 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT chanid,visible FROM channel WHERE channum = '42_1' AND sourceid = '1' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.220700 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "chanid = 1421, visible = 1" 2018-06-11 23:48:57.222427 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) DELETE FROM pidcache WHERE chanid = '1421' AND tableid < 65536 <<<< Took 1ms 2018-06-11 23:48:57.223789 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT pid, tableid FROM pidcache WHERE chanid = '1421' <<<< Took 0ms, Returned 0 row(s) 2018-06-11 23:48:57.225315 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7424', tableid = '256' <<<< Took 0ms 2018-06-11 23:48:57.226048 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7425', tableid = '257' <<<< Took 0ms 2018-06-11 23:48:57.226731 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7426', tableid = '258' <<<< Took 0ms 2018-06-11 23:48:57.227501 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7427', tableid = '259' <<<< Took 0ms 2018-06-11 23:48:57.228216 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7680', tableid = '512' <<<< Took 0ms 2018-06-11 23:48:57.228899 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7681', tableid = '513' <<<< Took 0ms 2018-06-11 23:48:57.229571 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7682', tableid = '514' <<<< Took 0ms 2018-06-11 23:48:57.230296 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7683', tableid = '515' <<<< Took 0ms 2018-06-11 23:48:57.231007 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '7808', tableid = '4' <<<< Took 0ms 2018-06-11 23:48:57.231667 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '8187', tableid = '0' <<<< Took 0ms 2018-06-11 23:48:57.232338 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) INSERT INTO pidcache SET chanid = '1421', pid = '8187', tableid = '769' <<<< Took 0ms 2018-06-11 23:48:57.232463 I [15672/15678] TVRecEvent recorders/hdhrsignalmonitor.cpp:62 (~HDHRSignalMonitor) - HDHRSigMon[1](104240F7-0): dtor 2018-06-11 23:48:57.232490 I [15672/15678] TVRecEvent recorders/hdhrsignalmonitor.cpp:72 (Stop) - HDHRSigMon[1](104240F7-0): Stop() -- begin 2018-06-11 23:48:57.232520 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:301 (Stop) - SigMon[1](104240F7-0)::Stop: begin 2018-06-11 23:48:57.269771 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:311 (Stop) - SigMon[1](104240F7-0)::Stop: end 2018-06-11 23:48:57.269816 I [15672/15678] TVRecEvent recorders/streamhandler.cpp:123 (RemoveListener) - SH(104240F7-0): RemoveListener(0xffffffffa7fe57ac) -- begin 2018-06-11 23:48:57.269847 I [15672/15678] TVRecEvent recorders/streamhandler.cpp:135 (RemoveListener) - SH(104240F7-0): RemoveListener(0xffffffffa7fe57ac) -- locked 2018-06-11 23:48:57.269877 D [15672/15678] TVRecEvent recorders/streamhandler.cpp:193 (Stop) - SH(104240F7-0): Stopping 2018-06-11 23:48:57.288762 I [15672/16243] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:199 (run) - HDHRSH(104240F7-0): RunTS(): shutdown 2018-06-11 23:48:57.291550 I [15672/16243] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:223 (run) - HDHRSH(104240F7-0): stream stats: packet_count=309908 network_errors=0 transport_errors=0 sequence_errors=0 overflow_errors=0 2018-06-11 23:48:57.291591 I [15672/16243] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:227 (run) - HDHRSH(104240F7-0): RunTS(): end 2018-06-11 23:48:57.291621 I [15672/16243] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:231 (run) - HDHRSH(104240F7-0): Release tuner lock. 2018-06-11 23:48:57.292737 D [15672/15678] TVRecEvent recorders/streamhandler.cpp:196 (Stop) - SH(104240F7-0): Stopped 2018-06-11 23:48:57.292777 I [15672/15678] TVRecEvent recorders/streamhandler.cpp:152 (RemoveListener) - SH(104240F7-0): RemoveListener(0xffffffffa7fe57ac) -- end 2018-06-11 23:48:57.292810 I [15672/15678] TVRecEvent recorders/hdhrsignalmonitor.cpp:78 (Stop) - HDHRSigMon[1](104240F7-0): Stop() -- end 2018-06-11 23:48:57.292891 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:301 (Stop) - SigMon[1](104240F7-0)::Stop: begin 2018-06-11 23:48:57.292920 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:311 (Stop) - SigMon[1](104240F7-0)::Stop: end 2018-06-11 23:48:57.292976 I [15672/15678] TVRecEvent tv_rec.cpp:2135 (TeardownSignalMonitor) - TVRec[1]: TeardownSignalMonitor() -- end 2018-06-11 23:48:57.293032 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3604 2018-06-11 23:48:57.293430 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3650 2018-06-11 23:48:57.293482 I [15672/15678] TVRecEvent tv_rec.cpp:3537 (HandleTuning) - TVRec[1]: No recorder yet, calling TuningFrequency 2018-06-11 23:48:57.293509 I [15672/15678] TVRecEvent tv_rec.cpp:3672 (TuningFrequency) - TVRec[1]: TuningFrequency 2018-06-11 23:48:57.293547 I [15672/15678] TVRecEvent recorders/hdhrchannel.cpp:57 (Open) - HDHRChan[1](104240F7-0): Opening HDHR channel 2018-06-11 23:48:57.293579 I [15672/15678] TVRecEvent recorders/dtvchannel.cpp:178 (SetChannelByString) - DTVChan[1](104240F7-0): SetChannelByString(54_1): 2018-06-11 23:48:57.293607 I [15672/15678] TVRecEvent cardutil.cpp:1543 (GetConflictingInputs) - CardUtil: GetConflictingInputs() input 1 2018-06-11 23:48:57.294801 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT DISTINCT c.cardid FROM ( SELECT inputgroupid FROM inputgroup WHERE cardinputid = '1' ) g JOIN inputgroup ig ON ig.inputgroupid = g.inputgroupid JOIN capturecard c ON c.cardid = ig.cardinputid AND c.cardid <> '1' ORDER BY c.cardid <<<< Took 0ms, Returned 0 row(s) 2018-06-11 23:48:57.295018 I [15672/15678] TVRecEvent recorders/channelbase.cpp:262 (IsInputAvailable) - ChannelBase[1]: Input is free on 0/0 2018-06-11 23:48:57.296183 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT finetune, freqid, tvformat, freqtable, commmethod, mplexid, atsc_major_chan, atsc_minor_chan, serviceid, chanid, visible FROM channel, videosource WHERE videosource.sourceid = channel.sourceid AND channum = '54_1' AND channel.sourceid = '1' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.296449 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "finetune = 0, freqid = 49, tvformat = ATSC, freqtable = default, commmethod = -1, mplexid = 6, atsc_major_chan = 54, atsc_minor_chan = 1, serviceid = 3, chanid = 1541, visible = 1" 2018-06-11 23:48:57.297377 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT transportid, networkid, frequency, modulation, sistandard FROM dtv_multiplex WHERE mplexid = '6' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.297516 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "transportid = 2763, networkid = 0, frequency = 683000000, modulation = 8vsb, sistandard = atsc" 2018-06-11 23:48:57.299058 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT frequency, inversion, symbolrate, fec, polarity, hp_code_rate, lp_code_rate, constellation, transmission_mode, guard_interval, hierarchy, modulation, bandwidth, sistandard, mod_sys, rolloff FROM dtv_multiplex WHERE dtv_multiplex.mplexid = '6' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.299386 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "frequency = 683000000, inversion = a, symbolrate = 0, fec = auto, polarity = v, hp_code_rate = auto, lp_code_rate = auto, constellation = 8vsb, transmission_mode = a, guard_interval = auto, hierarchy = a, modulation = 8vsb, bandwidth = a, sistandard = atsc, mod_sys = UNDEFINED, rolloff = 0.35" 2018-06-11 23:48:57.299745 I [15672/15678] TVRecEvent recorders/hdhrchannel.cpp:170 (Tune) - HDHRChan[1](104240F7-0): Tuning to 8vsb:683000000 2018-06-11 23:48:57.300937 I [15672/15678] TVRecEvent recorders/hdhrstreamhandler.cpp:513 (TuneChannel) - HDHRSH(104240F7-0): Tuning channel 8vsb:683000000 (was 8vsb:647000000) 2018-06-11 23:48:57.402118 I [15672/15678] TVRecEvent recorders/dtvchannel.cpp:326 (SetChannelByString) - DTVChan[1](104240F7-0): SetChannelByString(54_1): success 2018-06-11 23:48:57.402173 I [15672/15678] TVRecEvent tv_rec.cpp:3799 (TuningFrequency) - TVRec[1]: Starting Signal Monitor 2018-06-11 23:48:57.402208 I [15672/15678] TVRecEvent tv_rec.cpp:2060 (SetupSignalMonitor) - TVRec[1]: SetupSignalMonitor(1, 0) 2018-06-11 23:48:57.402244 I [15672/15678] TVRecEvent recorders/hdhrchannel.cpp:57 (Open) - HDHRChan[1](104240F7-0): Opening HDHR channel 2018-06-11 23:48:57.402454 I [15672/15678] TVRecEvent recorders/hdhrsignalmonitor.cpp:48 (HDHRSignalMonitor) - HDHRSigMon[1](104240F7-0): ctor 2018-06-11 23:48:57.402495 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:260 (AddFlags) - SigMon[1](104240F7-0)::AddFlags: Seen() Match() Wait(Sig,) 2018-06-11 23:48:57.402535 I [15672/15678] TVRecEvent recorders/hdhrstreamhandler.cpp:56 (Get) - HDHRSH: Using existing stream handler 104240F7-0 for 104240F7-0 (2 in use) 2018-06-11 23:48:57.402574 I [15672/15678] TVRecEvent tv_rec.cpp:2083 (SetupSignalMonitor) - TVRec[1]: Signal monitor successfully created 2018-06-11 23:48:57.402601 I [15672/15678] TVRecEvent tv_rec.cpp:1878 (SetupDTVSignalMonitor) - TVRec[1]: Setting up table monitoring. 2018-06-11 23:48:57.402716 D [15672/15678] TVRecEvent standardsettings.cpp:194 (haveChanged) - Setting Lossless transcoding changed to 0 2018-06-11 23:48:57.402767 D [15672/15678] TVRecEvent standardsettings.cpp:194 (haveChanged) - Setting Resize video while transcoding changed to 0 2018-06-11 23:48:57.402814 D [15672/15678] TVRecEvent standardsettings.cpp:194 (haveChanged) - Setting Enable auto-transcode after recording changed to 0 2018-06-11 23:48:57.403921 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT recordingprofiles.id, profilegroups.hostname, profilegroups.is_default FROM recordingprofiles, profilegroups WHERE profilegroups.id = recordingprofiles.profilegroup AND profilegroups.cardtype = 'HDHOMERUN' AND recordingprofiles.name = 'Live TV' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.404022 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "id = 35, hostname = , is_default = 1" 2018-06-11 23:48:57.404994 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT CAST(name AS CHAR) FROM recordingprofiles WHERE id = '35' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.405074 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "CAST(name AS CHAR) = Live TV" 2018-06-11 23:48:57.406255 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT CAST(value AS CHAR) FROM codecparams WHERE profile = '35' AND name = 'transcodefilters' <<<< Took 0ms, Returned 0 row(s) 2018-06-11 23:48:57.407485 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT CAST(value AS CHAR) FROM codecparams WHERE profile = '35' AND name = 'transcodelossless' <<<< Took 0ms, Returned 0 row(s) 2018-06-11 23:48:57.408623 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT CAST(value AS CHAR) FROM codecparams WHERE profile = '35' AND name = 'transcoderesize' <<<< Took 0ms, Returned 0 row(s) 2018-06-11 23:48:57.409700 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT CAST(value AS CHAR) FROM codecparams WHERE profile = '35' AND name = 'autotranscode' <<<< Took 0ms, Returned 0 row(s) 2018-06-11 23:48:57.410788 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT CAST(value AS CHAR) FROM codecparams WHERE profile = '35' AND name = 'recordmpts' <<<< Took 0ms, Returned 0 row(s) 2018-06-11 23:48:57.411187 I [15672/15678] TVRecEvent tv_rec.cpp:4142 (LoadProfile) - TVRec[1]: Using profile 'Live TV' to record 2018-06-11 23:48:57.411242 I [15672/15678] TVRecEvent tv_rec.cpp:1911 (SetupDTVSignalMonitor) - TVRec[1]: ATSC channel: 54_1 2018-06-11 23:48:57.411371 I [15672/15678] TVRecEvent recorders/dtvsignalmonitor.cpp:206 (SetChannel) - DTVSigMon[1](104240F7-0)::SetChannel(54, 1): 2018-06-11 23:48:57.411433 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:266 (RemoveFlags) - SigMon[1](104240F7-0)::RemoveFlags: Seen(PAT,PMT,VCT,Crypt,) Match(PAT,PMT,VCT,Crypt,) Wait() 2018-06-11 23:48:57.411551 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:260 (AddFlags) - SigMon[1](104240F7-0)::AddFlags: Seen() Match() Wait(PAT,VCT,) 2018-06-11 23:48:57.412450 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT chanid,visible FROM channel WHERE channum = '54_1' AND sourceid = '1' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:48:57.412544 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "chanid = 1541, visible = 1" 2018-06-11 23:48:57.414031 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT pid, tableid FROM pidcache WHERE chanid = '1541' <<<< Took 0ms, Returned 18 row(s) 2018-06-11 23:48:57.414122 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 8187, tableid = 769" 2018-06-11 23:48:57.414197 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 8187, tableid = 0" 2018-06-11 23:48:57.414269 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7687, tableid = 519" 2018-06-11 23:48:57.414336 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7686, tableid = 518" 2018-06-11 23:48:57.414396 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7685, tableid = 517" 2018-06-11 23:48:57.414460 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7684, tableid = 516" 2018-06-11 23:48:57.414519 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7683, tableid = 515" 2018-06-11 23:48:57.414580 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7682, tableid = 514" 2018-06-11 23:48:57.414644 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7681, tableid = 513" 2018-06-11 23:48:57.414714 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7680, tableid = 512" 2018-06-11 23:48:57.414778 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7431, tableid = 263" 2018-06-11 23:48:57.414842 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7430, tableid = 262" 2018-06-11 23:48:57.414905 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7429, tableid = 261" 2018-06-11 23:48:57.414970 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7428, tableid = 260" 2018-06-11 23:48:57.415031 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7427, tableid = 259" 2018-06-11 23:48:57.415090 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7426, tableid = 258" 2018-06-11 23:48:57.415150 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7425, tableid = 257" 2018-06-11 23:48:57.415214 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "pid = 7424, tableid = 256" 2018-06-11 23:48:57.415501 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:260 (AddFlags) - SigMon[1](104240F7-0)::AddFlags: Seen() Match() Wait(MGT,) 2018-06-11 23:48:57.415539 I [15672/15678] TVRecEvent tv_rec.cpp:1933 (SetupDTVSignalMonitor) - TVRec[1]: Successfully set up ATSC table monitoring. 2018-06-11 23:48:57.415665 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:285 (Start) - SigMon[1](104240F7-0)::Start: begin 2018-06-11 23:48:57.416077 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:293 (Start) - SigMon[1](104240F7-0)::Start: end 2018-06-11 23:48:57.416149 I [15672/15678] TVRecEvent tv_rec.cpp:4426 (SetFlags) - TVRec[1]: SetFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,SignalMonitorRunning,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3826 2018-06-11 23:48:57.416208 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,SignalMonitorRunning,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3827 2018-06-11 23:48:57.416275 I [15672/15678] TVRecEvent tv_rec.cpp:4426 (SetFlags) - TVRec[1]: SetFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,WaitingForSignal,SignalMonitorRunning,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3832 2018-06-11 23:48:57.416341 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,WaitingForSignal,SignalMonitorRunning,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3893 2018-06-11 23:48:57.416487 I [15672/15678] TVRecEvent tv_rec.cpp:4013 (TuningSignalCheck) - TVRec[1]: TuningSignalCheck: Still waiting. Will timeout @ 23:49:00.416 2018-06-11 23:48:57.417973 D [15672/16258] SignalMonitor recorders/hdhrsignalmonitor.cpp:120 (UpdateValues) - HDHRSigMon[1](104240F7-0): Tuner status: '95:0:0' 2018-06-11 23:48:57.470713 D [15672/16258] SignalMonitor recorders/hdhrsignalmonitor.cpp:120 (UpdateValues) - HDHRSigMon[1](104240F7-0): Tuner status: '94:0:0' 2018-06-11 23:48:57.470772 I [15672/16258] SignalMonitor recorders/streamhandler.cpp:81 (AddListener) - SH(104240F7-0): AddListener(0xffffffffa7fe57ac) -- begin 2018-06-11 23:48:57.470800 I [15672/16258] SignalMonitor recorders/streamhandler.cpp:93 (AddListener) - SH(104240F7-0): AddListener(0xffffffffa7fe57ac) -- locked 2018-06-11 23:48:57.538046 I [15672/16258] SignalMonitor recorders/streamhandler.cpp:115 (AddListener) - SH(104240F7-0): AddListener(0xffffffffa7fe57ac) -- end 2018-06-11 23:48:57.538097 I [15672/16259] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:145 (run) - HDHRSH(104240F7-0): RunTS(): begin 2018-06-11 23:49:00.417226 I [15672/15678] TVRecEvent mythcorecontext.cpp:1690 (dispatch) - MythCoreContext::dispatch(): MythEvent: SYSTEM_EVENT TUNING_SIGNAL_TIMEOUT CARDID 1 SENDER pvr1 2018-06-11 23:49:00.417336 E [15672/15678] TVRecEvent tv_rec.cpp:3956 (TuningSignalCheck) - TVRec[1]: TuningSignalCheck: SignalMonitor timed out 2018-06-11 23:49:00.417389 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,WaitingForSignal,SignalMonitorRunning,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3958 2018-06-11 23:49:00.417439 I [15672/15678] TVRecEvent tv_rec.cpp:728 (SetRecordingStatus) - TVRec[1]: SetRecordingStatus(Recording->Recorder Failed) on line 4019 2018-06-11 23:49:00.417493 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,SignalMonitorRunning,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:4047 2018-06-11 23:49:00.418481 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT SUM(useeit) FROM videosource, capturecard WHERE videosource.sourceid = capturecard.sourceid AND capturecard.cardid = '1' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:49:00.418572 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "SUM(useeit) = 1" 2018-06-11 23:49:00.419543 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT chanid,visible FROM channel WHERE channum = '54_1' AND sourceid = '1' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:49:00.419629 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "chanid = 1541, visible = 1" 2018-06-11 23:49:00.420739 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT chanid,visible FROM channel WHERE channum = '54_1' AND sourceid = '1' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:49:00.420826 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "chanid = 1541, visible = 1" 2018-06-11 23:49:00.421614 I [15672/15678] TVRecEvent mythdbcon.cpp:728 (exec) - MSqlQuery::exec(DBManager2) SELECT sourceid FROM channel WHERE chanid = '1541' <<<< Took 0ms, Returned 1 row(s) 2018-06-11 23:49:00.421720 D [15672/15678] TVRecEvent mythdbcon.cpp:804 (seekDebug) - MSqlQuery::next(DBManager2) Result: "sourceid = 1" 2018-06-11 23:49:00.421817 I [15672/15678] TVRecEvent eitscanner.cpp:209 (StartPassiveScan) - EITScanner (1): Started passive scan. 2018-06-11 23:49:00.421915 I [15672/15678] TVRecEvent tv_rec.cpp:3515 (HandleTuning) - TVRec[1]: HandleTuning Request: Program(NULL) channel() input() flags(NOREC,) 2018-06-11 23:49:00.421957 I [15672/15678] TVRecEvent tv_rec.cpp:3584 (TuningShutdowns) - TVRec[1]: TuningShutdowns(Program(NULL) channel() input() flags(NOREC,)) 2018-06-11 23:49:00.421991 I [15672/15678] TVRecEvent tv_rec.cpp:2116 (TeardownSignalMonitor) - TVRec[1]: TeardownSignalMonitor() -- begin 2018-06-11 23:49:00.422027 I [15672/15678] TVRecEvent recorders/hdhrsignalmonitor.cpp:62 (~HDHRSignalMonitor) - HDHRSigMon[1](104240F7-0): dtor 2018-06-11 23:49:00.422050 I [15672/15678] TVRecEvent recorders/hdhrsignalmonitor.cpp:72 (Stop) - HDHRSigMon[1](104240F7-0): Stop() -- begin 2018-06-11 23:49:00.422075 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:301 (Stop) - SigMon[1](104240F7-0)::Stop: begin 2018-06-11 23:49:00.444916 I [15672/15687] TaskQueue referencecounter.cpp:114 (IncrRef) - (0xffffffffa8e2ce90)::IncrRef() -> 2 2018-06-11 23:49:00.444954 I [15672/15687] TaskQueue referencecounter.cpp:145 (DecrRef) - (0xffffffffa8e2ce90)::DecrRef() -> 1 2018-06-11 23:49:00.444950 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:311 (Stop) - SigMon[1](104240F7-0)::Stop: end 2018-06-11 23:49:00.444977 I [15672/15687] TaskQueue referencecounter.cpp:114 (IncrRef) - (0xffffffffa8e091a8)::IncrRef() -> 2 2018-06-11 23:49:00.444993 I [15672/15678] TVRecEvent recorders/streamhandler.cpp:123 (RemoveListener) - SH(104240F7-0): RemoveListener(0xffffffffa7fe57ac) -- begin 2018-06-11 23:49:00.445002 I [15672/15687] TaskQueue referencecounter.cpp:145 (DecrRef) - (0xffffffffa8e091a8)::DecrRef() -> 1 2018-06-11 23:49:00.445022 I [15672/15678] TVRecEvent recorders/streamhandler.cpp:135 (RemoveListener) - SH(104240F7-0): RemoveListener(0xffffffffa7fe57ac) -- locked 2018-06-11 23:49:00.445024 I [15672/15687] TaskQueue referencecounter.cpp:114 (IncrRef) - (0xffffffffa8e0a438)::IncrRef() -> 2 2018-06-11 23:49:00.445049 I [15672/15687] TaskQueue referencecounter.cpp:145 (DecrRef) - (0xffffffffa8e0a438)::DecrRef() -> 1 2018-06-11 23:49:00.445051 D [15672/15678] TVRecEvent recorders/streamhandler.cpp:193 (Stop) - SH(104240F7-0): Stopping 2018-06-11 23:49:00.445071 I [15672/15687] TaskQueue referencecounter.cpp:114 (IncrRef) - (0xffffffffa8e17c58)::IncrRef() -> 2 2018-06-11 23:49:00.445095 I [15672/15687] TaskQueue referencecounter.cpp:145 (DecrRef) - (0xffffffffa8e17c58)::DecrRef() -> 1 2018-06-11 23:49:00.445117 I [15672/15687] TaskQueue referencecounter.cpp:114 (IncrRef) - (0xffffffffa8e2f5d0)::IncrRef() -> 2 2018-06-11 23:49:00.445140 I [15672/15687] TaskQueue referencecounter.cpp:145 (DecrRef) - (0xffffffffa8e2f5d0)::DecrRef() -> 1 2018-06-11 23:49:00.445169 I [15672/15687] TaskQueue referencecounter.cpp:114 (IncrRef) - (0xffffffffa8e2c888)::IncrRef() -> 2 2018-06-11 23:49:00.445194 I [15672/15687] TaskQueue referencecounter.cpp:145 (DecrRef) - (0xffffffffa8e2c888)::DecrRef() -> 1 2018-06-11 23:49:00.462908 I [15672/16259] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:199 (run) - HDHRSH(104240F7-0): RunTS(): shutdown 2018-06-11 23:49:00.465995 I [15672/16259] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:223 (run) - HDHRSH(104240F7-0): stream stats: packet_count=90 network_errors=0 transport_errors=192 sequence_errors=0 overflow_errors=0 2018-06-11 23:49:00.466028 I [15672/16259] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:227 (run) - HDHRSH(104240F7-0): RunTS(): end 2018-06-11 23:49:00.466048 I [15672/16259] HDHRStreamHandler recorders/hdhrstreamhandler.cpp:231 (run) - HDHRSH(104240F7-0): Release tuner lock. 2018-06-11 23:49:00.467382 D [15672/15678] TVRecEvent recorders/streamhandler.cpp:196 (Stop) - SH(104240F7-0): Stopped 2018-06-11 23:49:00.467430 I [15672/15678] TVRecEvent recorders/streamhandler.cpp:152 (RemoveListener) - SH(104240F7-0): RemoveListener(0xffffffffa7fe57ac) -- end 2018-06-11 23:49:00.467467 I [15672/15678] TVRecEvent recorders/hdhrsignalmonitor.cpp:78 (Stop) - HDHRSigMon[1](104240F7-0): Stop() -- end 2018-06-11 23:49:00.467549 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:301 (Stop) - SigMon[1](104240F7-0)::Stop: begin 2018-06-11 23:49:00.467583 D [15672/15678] TVRecEvent recorders/signalmonitor.cpp:311 (Stop) - SigMon[1](104240F7-0)::Stop: end 2018-06-11 23:49:00.467645 I [15672/15678] TVRecEvent tv_rec.cpp:2135 (TeardownSignalMonitor) - TVRec[1]: TeardownSignalMonitor() -- end 2018-06-11 23:49:00.467706 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3604 2018-06-11 23:49:00.467898 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,EITScannerRunning,RingBufferReady, @ tv_rec.cpp:3650 2018-06-11 23:49:00.467942 I [15672/15678] TVRecEvent tv_rec.cpp:3537 (HandleTuning) - TVRec[1]: No recorder yet, calling TuningFrequency 2018-06-11 23:49:00.467969 I [15672/15678] TVRecEvent tv_rec.cpp:3672 (TuningFrequency) - TVRec[1]: TuningFrequency 2018-06-11 23:49:00.468009 I [15672/15678] TVRecEvent recorders/hdhrchannel.cpp:57 (Open) - HDHRChan[1](104240F7-0): Opening HDHR channel 2018-06-11 23:49:00.468041 E [15672/15678] TVRecEvent tv_rec.cpp:3750 (TuningFrequency) - TVRec[1]: Failed to set channel to . Reverting to kState_None 2018-06-11 23:49:00.468174 I [15672/15678] TVRecEvent tv_rec.cpp:3515 (HandleTuning) - TVRec[1]: HandleTuning Request: Program(NULL) channel() input() flags(KillRec,) 2018-06-11 23:49:00.468225 I [15672/15678] TVRecEvent tv_rec.cpp:3584 (TuningShutdowns) - TVRec[1]: TuningShutdowns(Program(NULL) channel() input() flags(KillRec,)) 2018-06-11 23:49:00.468424 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(EITScannerRunning,) -> FrontendReady,RunMainLoop,RingBufferReady, @ tv_rec.cpp:3592 2018-06-11 23:49:00.468519 I [15672/15678] TVRecEvent tv_rec.cpp:4435 (ClearFlags) - TVRec[1]: ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,RingBufferReady, @ tv_rec.cpp:3650