frontend 2007-07-18 23:15:59.257 write -> 25 29 GET_NEXT_FREE_RECORDER[]:[]-1 2007-07-18 23:15:59.259 read <- 25 24 1[]:[]127.0.0.1[]:[]6543 2007-07-18 23:15:59.266 TV: Attempting to change from None to WatchingLiveTV 2007-07-18 23:15:59.266 MythSocket(94f2898:29): new socket 2007-07-18 23:15:59.266 MythSocket(94f2898:29): attempting connect() to (127.0.0.1:6543) 2007-07-18 23:15:59.266 MythSocket(94f2898:29): state change Idle -> Connected 2007-07-18 23:15:59.266 write -> 29 21 MYTH_PROTO_VERSION 31 2007-07-18 23:15:59.269 read <- 29 13 ACCEPT[]:[]31 2007-07-18 23:15:59.269 Using protocol version 31 2007-07-18 23:15:59.269 write -> 29 24 ANN Playback romanenko 0 2007-07-18 23:15:59.271 read <- 29 2 OK 2007-07-18 23:15:59.271 write -> 29 78 QUERY_RECORDER 1[]:[]SPAWN_LIVETV[]:[]live-romanenko-2007-07-18T2... 2007-07-18 23:16:05.629 MythSocket(83896b0:24): socket is readable 2007-07-18 23:16:05.629 MythSocket(83896b0:24): cb->readyRead() 2007-07-18 23:16:05.630 read <- 24 51 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty 2007-07-18 23:16:05.631 MythSocket(83896b0:24): socket is readable 2007-07-18 23:16:05.632 MythSocket(83896b0:24): cb->readyRead() 2007-07-18 23:16:05.632 read <- 24 84 BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-romanenko-2007-07-18... 2007-07-18 23:16:06.278 MythSocket(94f2898:29): readStringList: Error, timeout (quick). 2007-07-18 23:16:06.279 MythSocket(94f2898:29): state change Connected -> Idle 2007-07-18 23:16:06.279 RemoteEncoder::SendReceiveStringList(): No response. 2007-07-18 23:16:06.303 MythSocket(94f2898:-1): writeStringList: Error, called with unconnected socket. 2007-07-18 23:16:06.303 MythSocket(94f2898:-1): readStringList: Error, called with unconnected socket. 2007-07-18 23:16:06.303 RemoteEncoder::SendReceiveStringList(): No response. 2007-07-18 23:16:06.322 MythSocket(94f2898:-1): writeStringList: Error, called with unconnected socket. 2007-07-18 23:16:06.323 MythSocket(94f2898:-1): readStringList: Error, called with unconnected socket. 2007-07-18 23:16:06.323 RemoteEncoder::SendReceiveStringList(): No response. 2007-07-18 23:16:06.342 MythSocket(94f2898:-1): writeStringList: Error, called with unconnected socket. 2007-07-18 23:16:06.343 MythSocket(94f2898:-1): readStringList: Error, called with unconnected socket. 2007-07-18 23:16:06.343 RemoteEncoder::SendReceiveStringList(): No response. backend 2007-07-18 23:15:55.652 MythSocket(ad201a98:19): DownRef: 1 2007-07-18 23:15:55.671 MythSocket(ad201a98:19): socket is readable 2007-07-18 23:15:55.671 MythSocket(ad201a98:19): socket closed 2007-07-18 23:15:55.671 MythSocket(ad201a98:19): state change Connected -> Idle 2007-07-18 23:15:55.672 MythSocket(ad201a98:-1): cb->connectionClosed() 2007-07-18 23:15:58.530 JobQueue: Currently set at 1 job(s) max and to run new jobs from 00:00 to 23:59 2007-07-18 23:15:58.531 MSqlQuery: SELECT j.id, j.chanid, j.starttime, j.inserttime, j.type, j.cmds, j.flags, j.status, j.statustime, j.hostname, j.args, j.comment, r.endtime FROM jobqueue j, recorded r WHERE j.chanid = r.chanid AND j.starttime = r.starttime ORDER BY j.inserttime, j.chanid, j.id; 2007-07-18 23:15:58.531 JobQueue: GetJobsInQueue: findJobs search bitmask 4, found 0 total jobs 2007-07-18 23:15:59.257 MythSocket(81f0520:15): socket is readable 2007-07-18 23:15:59.257 MythSocket(81f0520:15): cb->readyRead() 2007-07-18 23:15:59.257 MythSocket(81f0520:15): UpRef: 2 2007-07-18 23:15:59.258 read <- 15 29 GET_NEXT_FREE_RECORDER[]:[]-1 2007-07-18 23:15:59.258 Getting next free recorder after : -1 2007-07-18 23:15:59.258 Card 1 is local. 2007-07-18 23:15:59.258 write -> 15 24 1[]:[]127.0.0.1[]:[]6543 2007-07-18 23:15:59.259 MythSocket(81f0520:15): DownRef: 1 2007-07-18 23:15:59.267 MythSocket(ad201948:20): new socket 2007-07-18 23:15:59.267 MythSocket(ad201948:20): setSocket: 19 2007-07-18 23:15:59.267 MythSocket(ad201948:19): state change Idle -> Connected 2007-07-18 23:15:59.267 MythSocket(ad201948:19): UpRef: 1 2007-07-18 23:15:59.268 MythSocket(ad201948:19): socket is readable 2007-07-18 23:15:59.268 MythSocket(ad201948:19): cb->readyRead() 2007-07-18 23:15:59.268 MythSocket(ad201948:19): UpRef: 2 2007-07-18 23:15:59.268 read <- 19 21 MYTH_PROTO_VERSION 31 2007-07-18 23:15:59.269 write -> 19 13 ACCEPT[]:[]31 2007-07-18 23:15:59.269 MythSocket(ad201948:19): socket is readable 2007-07-18 23:15:59.269 MythSocket(ad201948:19): cb->readyRead() 2007-07-18 23:15:59.270 MythSocket(ad201948:19): UpRef: 3 2007-07-18 23:15:59.270 read <- 19 24 ANN Playback romanenko 0 2007-07-18 23:15:59.270 MainServer::HandleAnnounce Playback 2007-07-18 23:15:59.270 adding: romanenko as a client (events: 0) 2007-07-18 23:15:59.270 write -> 19 2 OK 2007-07-18 23:15:59.271 MythSocket(ad201948:19): DownRef: 2 2007-07-18 23:15:59.271 MythSocket(ad201948:19): socket is readable 2007-07-18 23:15:59.271 MythSocket(ad201948:19): cb->readyRead() 2007-07-18 23:15:59.272 MythSocket(ad201948:19): UpRef: 3 2007-07-18 23:15:59.272 read <- 19 78 QUERY_RECORDER 1[]:[]SPAWN_LIVETV[]:[]live-romanenko-2007-07-18T23:15:59[]:[]0 2007-07-18 23:15:59.273 MSqlQuery: SELECT chanid, starttime, endtime, discontinuity, chainpos, hostprefix, cardtype, channame, input FROM tvchain WHERE chainid = 'live-romanenko-2007-07-18T23:15:59' ORDER BY chainpos; 2007-07-18 23:15:59.274 MSqlQuery: SELECT chanid, starttime, endtime, discontinuity, chainpos, hostprefix, cardtype, channame, input FROM tvchain WHERE chainid = 'live-romanenko-2007-07-18T23:15:59' ORDER BY chainpos; 2007-07-18 23:15:59.274 TVRec(1): Changing from None to WatchingLiveTV 2007-07-18 23:15:59.274 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,RingBufferReady, 2007-07-18 23:15:59.275 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,RingBufferReady, 2007-07-18 23:15:59.275 TVRec(1): Request: Program(no) channel() input() flags(LiveTV,) 2007-07-18 23:15:59.276 MSqlQuery: SELECT startchan FROM capturecard, cardinput WHERE capturecard.cardid = cardinput.cardid AND capturecard.cardid = 1 AND inputname = 'DVBInput #1' 2007-07-18 23:15:59.276 TVRec(1): HW Tuner: 1->1 2007-07-18 23:15:59.276 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady, 2007-07-18 23:15:59.276 DVBChan(1): Opening DVB channel 2007-07-18 23:15:59.276 MythSocket(ad201948:19): DownRef: 2 2007-07-18 23:15:59.277 DVBChan(1): Using DVB card 1, with frontend 'DST DVB-S'. 2007-07-18 23:15:59.277 DiSEqCDevTree: Changing LNB voltage to 18V 2007-07-18 23:16:00.262 DiSEqCDevTree: Resetting DiSEqC Bus 2007-07-18 23:16:00.262 DiSEqCDevTree: Sending DiSEqC Command: e0 0 0 2007-07-18 23:16:00.879 MSqlQuery: SELECT cardinputid, inputname, startchan, tunechan, externalcommand, sourceid, childcardid FROM cardinput WHERE cardid = 1 2007-07-18 23:16:00.882 MSqlQuery: SELECT chanid, favid FROM favorites 2007-07-18 23:16:00.883 MSqlQuery: SELECT channum, callsign, chanid, atsc_major_chan, atsc_minor_chan, name, icon, visible FROM channel WHERE sourceid='1' 2007-07-18 23:16:01.056 MSqlQuery: SELECT chanid, favid FROM favorites 2007-07-18 23:16:01.058 MSqlQuery: SELECT channum, callsign, chanid, atsc_major_chan, atsc_minor_chan, name, icon, visible FROM channel WHERE sourceid='1' 2007-07-18 23:16:03.676 ChannelBase(1): Input #1: 'DVBInput #1' schan(803) sourceid(1) ccid(1) 2007-07-18 23:16:03.678 ChannelBase(1): Input #2: 'DVBInput #2' schan(61) sourceid(1) ccid(1) 2007-07-18 23:16:03.678 ChannelBase(1): Current Input #1: 'DVBInput #1' 2007-07-18 23:16:03.678 DVBChan(1): SetChannelByString(803): 2007-07-18 23:16:03.679 MSqlQuery: SELECT channel.chanid FROM channel, capturecard, cardinput WHERE channel.channum = '803' AND channel.sourceid = cardinput.sourceid AND cardinput.inputname = 'DVBInput #1' AND cardinput.cardid = capturecard.cardid AND capturecard.cardid = 1 AND capturecard.hostname = 'romanenko' 2007-07-18 23:16:03.680 MSqlQuery: SELECT finetune, freqid, tvformat, freqtable, commfree, mplexid, atsc_major_chan, atsc_minor_chan, serviceid FROM channel, videosource WHERE videosource.sourceid = channel.sourceid AND channum = '803' AND channel.sourceid = 1 2007-07-18 23:16:03.680 MSqlQuery: SELECT transportid, networkid, frequency, modulation FROM dtv_multiplex WHERE mplexid = 2 2007-07-18 23:16:03.681 MSqlQuery: SELECT frequency, inversion, symbolrate, fec, polarity, hp_code_rate, lp_code_rate, constellation, transmission_mode, guard_interval, hierarchy, modulation, bandwidth FROM dtv_multiplex WHERE dtv_multiplex.mplexid = 2 2007-07-18 23:16:03.681 DVBChan(1): Frequency: 12603080 Symbol Rate: 20000000 Pol: r Inv: Auto 2007-07-18 23:16:03.681 DiSEqCDevTree: Changing LNB voltage to 13V 2007-07-18 23:16:04.182 DiSEqCDevTree: Changing to DiSEqC switch port 2/4 2007-07-18 23:16:04.182 DiSEqCDevTree: Sending DiSEqC Command: e0 10 39 f1 2007-07-18 23:16:05.230 DVBChan(1): Old Params: Frequency: 12603080 Symbol Rate: 20000000 Pol: r Inv: Auto DVBChan(1): New Params: Frequency: 12603080 Symbol Rate: 20000000 Pol: r Inv: Auto 2007-07-18 23:16:05.231 DVBChan(1): Tune(): Tuning to 1353080kHz 2007-07-18 23:16:05.572 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2007-07-18 23:16:05.572 DVBChan(1): Tune(): Frequency tuning successful. 2007-07-18 23:16:05.572 DVBChan(1): SetChannelByString(803): Tuned to frequency. 2007-07-18 23:16:05.572 TVRec(1): CreateLiveTVRingBuffer() 2007-07-18 23:16:05.572 TVRec(1): GetProgramRingBufferForLiveTV() 2007-07-18 23:16:05.573 MSqlQuery: SELECT channel.chanid FROM channel WHERE channum = '803' AND sourceid = 1 2007-07-18 23:16:05.577 MSqlQuery: SELECT DISTINCT program.chanid, program.starttime, program.endtime, program.title, program.subtitle, program.description, program.category, channel.channum, channel.callsign, channel.name, program.previouslyshown, channel.commfree, channel.outputfilters, program.seriesid, program.programid, program.airdate, program.stars, program.originalairdate, program.category_type, oldrecstatus.recordid, oldrecstatus.rectype, oldrecstatus.recstatus, oldrecstatus.findid FROM program LEFT JOIN channel ON program.chanid = channel.chanid LEFT JOIN oldrecorded AS oldrecstatus ON program.title = oldrecstatus.title AND channel.callsign = oldrecstatus.station AND program.starttime = oldrecstatus.starttime WHERE program.chanid = '1803' AND program.starttime < '2007-07-18T23:16:50' AND program.endtime > '2007-07-18T23:16:50' GROUP BY program.starttime, channel.channum, channel.callsign, program.title ORDER BY program.starttime, atsc_major_chan,atsc_minor_chan,channum,callsign LIMIT 1000 2007-07-18 23:16:05.585 MSqlQuery: SELECT name, id FROM recordingprofiles WHERE profilegroup = 6 ORDER BY id 2007-07-18 23:16:05.587 MSqlQuery: SELECT DISTINCT recgroup FROM recorded 2007-07-18 23:16:05.588 MSqlQuery: SELECT DISTINCT recgroup FROM record 2007-07-18 23:16:05.589 MSqlQuery: SELECT name FROM playgroup WHERE name <> 'Default' ORDER BY name; 2007-07-18 23:16:05.590 MSqlQuery: SELECT cardinputid,cardid,inputname,displayname FROM cardinput ORDER BY cardinputid 2007-07-18 23:16:05.591 MSqlQuery: SELECT channum, callsign, name FROM channel WHERE chanid = '1803'; 2007-07-18 23:16:05.592 MSqlQuery: SELECT name FROM playgroup WHERE name = 'CityNews Tonight' OR name = 'News' OR (titlematch <> '' AND 'CityNews Tonight' REGEXP titlematch) 2007-07-18 23:16:05.593 MSqlQuery: SELECT name FROM playgroup WHERE name = 'CityNews Tonight' OR name = 'News' OR (titlematch <> '' AND 'CityNews Tonight' REGEXP titlematch) 2007-07-18 23:16:05.593 MSqlQuery: LOCK TABLES recorded WRITE 2007-07-18 23:16:05.595 MSqlQuery: SELECT recordid FROM recorded WHERE chanid = '1803' AND starttime = '2007-07-18T23:16:05' 2007-07-18 23:16:05.598 MSqlQuery: INSERT INTO recorded (chanid, starttime, endtime, title, subtitle, description, hostname, category, recgroup, autoexpire, recordid, seriesid, programid, stars, previouslyshown, originalairdate, findid, transcoder, playgroup, recpriority, basename, progstart, progend, profile, duplicate) VALUES ('1803', '2007-07-18T23:16:05', '2007-07-18T23:35:00', 'CityNews Tonight', '', '', 'romanenko', 'News', 'Default', 1, 0, 'SH764035', 'SH7640350000',0, 0, '2005-08-03', 0, 0, 'Default', 0, '1803_20070718231605.mpg', '2007-07-18T23:00:00', '2007-07-18T23:35:00', 'Default', 0) 2007-07-18 23:16:05.599 MSqlQuery: UNLOCK TABLES 2007-07-18 23:16:05.600 MSqlQuery: UPDATE record SET last_record = NOW() WHERE recordid = 0 2007-07-18 23:16:05.601 MSqlQuery: DELETE FROM recordedseek WHERE chanid = '1803' AND starttime = '2007-07-18T23:16:05'; 2007-07-18 23:16:05.603 MSqlQuery: DELETE FROM recordedmarkup WHERE chanid = '1803' AND starttime = '2007-07-18T23:16:05'; 2007-07-18 23:16:05.605 MSqlQuery: REPLACE INTO recordedcredits SELECT * FROM credits WHERE chanid = '1803' AND starttime = '2007-07-18T23:00:00'; 2007-07-18 23:16:05.607 MSqlQuery: REPLACE INTO recordedprogram SELECT * from program WHERE chanid = '1803' AND starttime = '2007-07-18T23:00:00' AND title = 'CityNews Tonight'; 2007-07-18 23:16:05.609 MSqlQuery: REPLACE INTO recordedrating SELECT * from programrating WHERE chanid = '1803' AND starttime = '2007-07-18T23:00:00'; 2007-07-18 23:16:05.609 TVRec(1): StartedRecording(0x88dd8c8) fn(/data/1803_20070718231605.mpg) 2007-07-18 23:16:05.616 MSqlQuery: UPDATE recorded SET autoexpire = 10000 WHERE chanid = '1803' AND starttime = '2007-07-18T23:16:05' ; 2007-07-18 23:16:05.617 MSqlQuery: UPDATE recorded SET recgroup = 'LiveTV' WHERE chanid = '1803' AND starttime = '2007-07-18T23:16:05' ; 2007-07-18 23:16:05.620 MSqlQuery: INSERT INTO tvchain (chanid, starttime, endtime, chainid, chainpos, discontinuity, watching, hostprefix, cardtype, channame, input) VALUES('1803', '2007-07-18T23:16:05', '2007-07-18T23:35:00', 'live-romanenko-2007-07-18T23:15:59', 0, 0, 0, 'myth://127.0.0.1:6543/', 'DUMMY', '803', 'DVBInput #1' ); 2007-07-18 23:16:05.620 Chain: Appended@0 '1803_20070718231605' 2007-07-18 23:16:05.622 MSqlQuery: DELETE FROM inuseprograms WHERE chanid = '1803' AND starttime = '2007-07-18T23:16:05' AND hostname = 'romanenko' AND recusage = 'recorder' ; 2007-07-18 23:16:05.624 MSqlQuery: INSERT INTO inuseprograms (chanid, starttime, recusage, hostname, lastupdatetime) VALUES ('1803', '2007-07-18T23:16:05', 'recorder', 'romanenko', '2007-07-18T23:16:05'); 2007-07-18 23:16:05.624 TVRec(1): Starting Signal Monitor 2007-07-18 23:16:05.624 TVRec(1): SetupSignalMonitor(1, 1) 2007-07-18 23:16:05.624 DVBChan(1): Opening DVB channel 2007-07-18 23:16:05.628 MythSocket(81f0520:15): UpRef: 2 2007-07-18 23:16:05.628 MythSocket(81f0520:15): DownRef: 1 2007-07-18 23:16:05.629 MythSocket(81e0758:18): UpRef: 2 2007-07-18 23:16:05.629 write -> 18 51 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty 2007-07-18 23:16:05.630 MythSocket(81e0758:18): DownRef: 1 2007-07-18 23:16:05.630 MythSocket(ad201948:19): UpRef: 3 2007-07-18 23:16:05.630 MythSocket(ad201948:19): DownRef: 2 2007-07-18 23:16:05.631 MythSocket(81f0520:15): UpRef: 2 2007-07-18 23:16:05.631 MythSocket(81f0520:15): DownRef: 1 2007-07-18 23:16:05.631 MythSocket(81e0758:18): UpRef: 2 2007-07-18 23:16:05.631 write -> 18 84 BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-romanenko-2007-07-18T23:15:59[]:[]empty 2007-07-18 23:16:05.632 MythSocket(81e0758:18): DownRef: 1 2007-07-18 23:16:05.632 MythSocket(ad201948:19): UpRef: 3 2007-07-18 23:16:05.632 MythSocket(ad201948:19): DownRef: 2 2007-07-18 23:16:05.976 DVBSignalMonitor(1)::constructor(1,Warning, can not measure Bit Error Rate): Operation not supported 2007-07-18 23:16:05.976 DVBSignalMonitor(1)::constructor(1,Warning, can not count Uncorrected Blocks): Operation not supported 2007-07-18 23:16:05.976 SM(1)::AddFlags: Seen() Match() Wait(Sig,SNR,) 2007-07-18 23:16:05.976 DVBSM(1)::constructor(): initial flags 0x1400000 2007-07-18 23:16:06.282 TVRec(1): Signal monitor successfully created 2007-07-18 23:16:06.283 TVRec(1): Setting up table monitoring. 2007-07-18 23:16:06.284 MSqlQuery: SELECT freetoaironly FROM cardinput WHERE cardid = 1 AND inputname = 'DVBInput #1' 2007-07-18 23:16:06.285 MSqlQuery: SELECT recordingprofiles.id, profilegroups.hostname, profilegroups.is_default FROM recordingprofiles, profilegroups, capturecard WHERE profilegroups.id = recordingprofiles.profilegroup AND profilegroups.cardtype = 'DVB' AND recordingprofiles.name = 'Live TV' 2007-07-18 23:16:06.286 MSqlQuery: SELECT cardtype FROM profilegroups, recordingprofiles WHERE profilegroups.id = recordingprofiles.profilegroup AND recordingprofiles.id = 18 2007-07-18 23:16:06.292 MSqlQuery: SELECT name FROM recordingprofiles WHERE id = 18; 2007-07-18 23:16:06.293 MSqlQuery: SELECT value FROM codecparams WHERE profile = 18 AND name = 'transcodefilters'; 2007-07-18 23:16:06.294 MSqlQuery: SELECT value FROM codecparams WHERE profile = 18 AND name = 'transcodelossless'; 2007-07-18 23:16:06.295 MSqlQuery: SELECT value FROM codecparams WHERE profile = 18 AND name = 'transcoderesize'; 2007-07-18 23:16:06.295 MSqlQuery: SELECT value FROM codecparams WHERE profile = 18 AND name = 'autotranscode'; 2007-07-18 23:16:06.296 MSqlQuery: SELECT value FROM codecparams WHERE profile = 18 AND name = 'recordingtype'; 2007-07-18 23:16:06.297 Using profile 'Live TV' to record 2007-07-18 23:16:06.297 TVRec(1): DVB service_id 803 on net_id 257 tsid 127 2007-07-18 23:16:06.297 DTVSM(1)::SetDVBService(transport_id: 127, network_id: 257, service_id: 803): 2007-07-18 23:16:06.297 SM(1)::RemoveFlags: Seen(PMT,SDT,) Match(PMT,SDT,) Wait() 2007-07-18 23:16:06.298 SM(1)::AddFlags: Seen() Match() Wait(PMT,NIT,) 2007-07-18 23:16:06.298 SM(1)::AddFlags: Seen() Match() Wait(PMT,NIT,)