Need help to analyze log, before wife get too angry with MP: (1 Viewer)

Al_Capone

MP Donator
  • Premium Supporter
  • September 26, 2006
    527
    19
    Home Country
    Norway Norway
    TV stops working while timeshifting xx minutes.
    Tv off then TV On fixes it, except all timeshifted time is lost forever.

    please help me understand why this f*ck*ng sh**t happens to me..
    it happened aroun 22:48 ....

    Please...

    TV error log:
    Code:
    2009-08-02 21:09:03.662979 [45]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 21:09:03.672993 [45]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 21:09:03.672993 [45]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 21:09:03.672993 [45]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.566036 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.606094 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.606094 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.616108 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.616108 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.616108 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.616108 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.626123 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.636137 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.636137 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.636137 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.636137 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.636137 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.646152 [46]: Controller: Error on delete in CleanTimeshiftFiles
    2009-08-02 22:48:53.646152 [46]: Controller: Error on delete in CleanTimeshiftFiles

    TV log:
    Code:
    2009-08-02 21:09:03.562835 [45]: FireDTV:GetCAMStatus() finished
    2009-08-02 21:09:03.562835 [45]:   FireDTV:cam is inserted
    2009-08-02 21:09:03.562835 [45]:   FireDTV:cam is valid
    2009-08-02 21:09:03.562835 [45]:   FireDTV:cam is ready
    2009-08-02 21:09:03.562835 [45]: subch:0 cam flags:True
    2009-08-02 21:09:03.562835 [45]: subch:0 SetMpegPidMapping
    2009-08-02 21:09:03.562835 [45]: subch:0  pid:1FF4 pcr
    2009-08-02 21:09:03.562835 [45]: subch:0  pid:100 pmt
    2009-08-02 21:09:03.562835 [45]: subch:0  pid:200 video type:MPEG-2
    2009-08-02 21:09:03.562835 [45]: subch:0    map pid:200 video type:MPEG-2
    2009-08-02 21:09:03.562835 [45]: subch:0  pid:280 audio lang:nor type:MPEG-2
    2009-08-02 21:09:03.562835 [45]: subch:0    map pid:280 audio lang:nor type:MPEG-2
    2009-08-02 21:09:03.562835 [45]: subch:0  pid:240 teletext type:6
    2009-08-02 21:09:03.562835 [45]: subch:0    map pid:240 teletext type:6
    2009-08-02 21:09:03.562835 [45]: subch:0  pid:8FB type:B
    2009-08-02 21:09:03.572849 [45]: subch:0  pid:350 type:C0
    2009-08-02 21:09:03.572849 [45]: subch:0  pid:A29 type:5
    2009-08-02 21:09:03.572849 [45]: subch:0  pid:A34 type:B
    2009-08-02 21:09:03.572849 [45]: subch:0  pid:A35 type:C
    2009-08-02 21:09:03.572849 [45]: FireDTV: HW Filtering disabled.
    2009-08-02 21:09:03.572849 [45]: subch:0 stop tif
    2009-08-02 21:09:03.572849 [45]: WaitForPMT: sending PMT to CAM took 0,1402016 seconds.
    2009-08-02 21:09:03.622921 [45]: card: Tuner locked: True
    2009-08-02 21:09:03.632936 [45]: **************************************************
    2009-08-02 21:09:03.632936 [45]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 *****
    2009-08-02 21:09:03.632936 [45]: **************************************************
    2009-08-02 21:09:03.632936 [45]: card: tuned user: HUGIN subchannel: 0
    2009-08-02 21:09:03.632936 [45]: user:HUGIN add
    2009-08-02 21:09:03.632936 [45]: card2:HUGIN 1 0
    2009-08-02 21:09:03.632936 [45]: Controller: HUGIN 1 0
    2009-08-02 21:09:03.632936 [45]: control2:HUGIN 1 0
    2009-08-02 21:09:03.632936 [45]: Controller: delete timeshift files D:\TV\live1-0.ts
    2009-08-02 21:09:03.632936 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer
    2009-08-02 21:09:03.632936 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer1.ts
    2009-08-02 21:09:03.642950 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer10.ts
    2009-08-02 21:09:03.662979 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer11.ts
    2009-08-02 21:09:03.662979 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer12.ts
    2009-08-02 21:09:03.662979 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer13.ts
    2009-08-02 21:09:03.662979 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer2.ts
    2009-08-02 21:09:03.662979 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer3.ts
    2009-08-02 21:09:03.662979 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer4.ts
    2009-08-02 21:09:03.672993 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer5.ts
    2009-08-02 21:09:03.672993 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer6.ts
    2009-08-02 21:09:03.672993 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer7.ts
    2009-08-02 21:09:03.672993 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer8.ts
    2009-08-02 21:09:03.672993 [45]: Controller:   delete D:\TV\live1-0.ts.tsbuffer9.ts
    2009-08-02 21:09:03.672993 [45]: card: StartTimeShifting 1 D:\TV\live1-0.ts 
    2009-08-02 21:09:03.672993 [45]: card: CAM enabled : True
    2009-08-02 21:09:03.672993 [45]: subch:0 SetTimeShiftFileName:D:\TV\live1-0.ts
    2009-08-02 21:09:03.672993 [45]: Set video / audio observer
    2009-08-02 21:09:03.672993 [45]: subch:0 SetTimeShiftFileName fill in pids
    2009-08-02 21:09:03.683008 [45]: subch:0-0 tswriter StartTimeshifting...
    2009-08-02 21:09:03.683008 [45]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo
    2009-08-02 21:09:03.693022 [53]: PID seen - type = Video
    2009-08-02 21:09:03.693022 [53]: audioVideoEventHandler Video
    2009-08-02 21:09:03.833224 [53]: PID seen - type = Audio
    2009-08-02 21:09:03.833224 [53]: audioVideoEventHandler Audio
    2009-08-02 21:09:03.833224 [45]: card: WaitForTimeShiftFile - video and audio are seen after 0,150216 seconds
    2009-08-02 21:09:03.833224 [45]: user:HUGIN card:1 sub:0 add stream:D:\TV\live1-0.ts.tsbuffer
    2009-08-02 21:09:03.833224 [45]: RTSP: add stream stream1.0 file:D:\TV\live1-0.ts.tsbuffer
    2009-08-02 21:09:03.833224 [45]: Controller: StartTimeShifting started on card:1 to D:\TV\live1-0.ts.tsbuffer
    2009-08-02 21:09:03.833224 [Channel state thread]: Controller: DoSetChannelStates for 59 channels
    2009-08-02 22:48:50.111068 [46]: Controller: StopTimeShifting 1
    2009-08-02 22:48:50.131097 [46]: card FireDTV BDA Tuner DVBS2: StopTimeShifting user:HUGIN sub:0
    2009-08-02 22:48:50.131097 [46]: card: StopTimeShifting user:HUGIN sub:0
    2009-08-02 22:48:50.131097 [46]: card not IDLE - freeing subch: 0
    2009-08-02 22:48:50.131097 [46]: subch:0-0 tswriter StopTimeshifting...
    2009-08-02 22:48:50.391472 [46]: tvcard:FreeSubChannel: subchannels count 1 subch#0 keep graph=False
    2009-08-02 22:48:50.391472 [46]: DVB subch:0 Decompose()
    2009-08-02 22:48:50.391472 [46]: FreeSubChannel CA: freeing sub channel : 0
    2009-08-02 22:48:50.391472 [46]: tvcard:FreeSubChannel : no subchannels present, stopping graph
    2009-08-02 22:48:50.391472 [46]: dvb:StopGraph called
    2009-08-02 22:48:50.391472 [46]: tvcard:FreeAllSubChannels:
    2009-08-02 22:48:50.391472 [46]: dvb:StopGraph
    2009-08-02 22:48:50.391472 [46]: user:HUGIN remove
    2009-08-02 22:48:50.401486 [46]: Controller:Timeshifting stopped on card:1
    2009-08-02 22:48:50.401486 [46]: RTSP: remove stream stream1.0
    2009-08-02 22:48:50.411500 [Channel state thread]: Controller: DoSetChannelStates for 59 channels
    2009-08-02 22:48:51.983761 [46]: Controller: StartTimeShifting NRK1 952
    2009-08-02 22:48:51.983761 [46]: Controller: find free card for channel NRK1
    2009-08-02 22:48:51.983761 [46]: Controller:   got 1 tuning details for NRK1
    2009-08-02 22:48:51.983761 [46]: Controller:   channel #1 DVBS:tv:Telenor NRK1 Freq:11372000 ONID:70 TSID:35 SID:1501 PMT:0x100 FTA:False LCN:173 SymbolRate:24500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:Rate7_8 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet 
    2009-08-02 22:48:51.993776 [46]: Controller:    card:1 type:DvbS is available priority:2 #users:0 same transponder:False
    2009-08-02 22:48:51.993776 [46]: Controller:    card:2 type:RadioWebStream cannot tune to channel
    2009-08-02 22:48:51.993776 [46]: Controller: found 1 available
    2009-08-02 22:48:51.993776 [46]: card: CardTune 1 NRK1 HUGIN:1:-1
    2009-08-02 22:48:51.993776 [46]: card: Tune 1 to NRK1
    2009-08-02 22:48:51.993776 [46]: card: user: HUGIN:1:-1 tune DVBS:tv:Telenor NRK1 Freq:11372000 ONID:70 TSID:35 SID:1501 PMT:0x100 FTA:False LCN:173 SymbolRate:24500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:Rate7_8 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
    2009-08-02 22:48:52.003790 [46]: dvbs:  Tune:DVBS:tv:Telenor NRK1 Freq:11372000 ONID:70 TSID:35 SID:1501 PMT:0x100 FTA:False LCN:173 SymbolRate:24500 Modulation:ModNotSet Polarisation:LinearV InnerFecRate:Rate7_8 DisEqc:None band:Universal Pilot:NotSet RollOff:NotSet
    2009-08-02 22:48:52.003790 [46]: dvb:GetNewSubChannel:0 #0
    2009-08-02 22:48:52.003790 [46]: TvDvbChannel ctor new subchIndex:0
    2009-08-02 22:48:52.003790 [46]: LNB low:9750 hi:10600 switch:11700
    2009-08-02 22:48:52.003790 [46]: DigitalEverywhere DVB-S2 modulation set to:ModNotSet
    2009-08-02 22:48:52.003790 [46]: DigitalEverywhere Pilot set to:NotSet
    2009-08-02 22:48:52.003790 [46]: DigitalEverywhere RollOff set to:NotSet
    2009-08-02 22:48:52.003790 [46]: DigitalEverywhere fec set to:8
    2009-08-02 22:48:52.003790 [46]:   Channel modulation is set to ModNotSet
    2009-08-02 22:48:52.003790 [46]:   Channel FECRate is set to Rate7_8
    2009-08-02 22:48:52.003790 [46]: FireDTV SendDiseqcCommand() diseqc:None, antenna:0 frequency:11372000,  polarisation:LinearV hiband:False
    2009-08-02 22:48:52.013804 [46]: FireDTV:SendDiseq: 0xFF 0xFF 0xFF 0x1 0x4 0xE0 0x10 0x38 0xFC 0x0 
    2009-08-02 22:48:52.414380 [46]: dvb:Submiting tunerequest Channel:NRK1 subChannel:0 
    2009-08-02 22:48:52.414380 [46]: dvb:using existing subchannel:0
    2009-08-02 22:48:52.414380 [46]: dvb:Submit tunerequest size:1 new:0
    2009-08-02 22:48:52.414380 [46]: subch:0 OnBeforeTune
    2009-08-02 22:48:52.414380 [46]: dvb:Submit tunerequest calling put_TuneRequest
    2009-08-02 22:48:52.664740 [46]: dvb:Submit tunerequest done calling put_TuneRequest
    2009-08-02 22:48:52.664740 [46]: subch:0 OnAfterTune
    2009-08-02 22:48:52.664740 [46]: FireDTV: HW Filtering disabled.
    2009-08-02 22:48:52.674755 [46]: subch:0 OnGraphStart
    2009-08-02 22:48:52.674755 [46]: subch:0 Graph already running - skip WaitForPMT
    2009-08-02 22:48:52.674755 [46]: dvb:  RunGraph
    2009-08-02 22:48:53.235561 [46]: dvb:  LockedInOnSignal ok
    2009-08-02 22:48:53.235561 [46]: subch:0 OnGraphStarted
    2009-08-02 22:48:53.245576 [46]: subch:0 SetupPmtGrabber:pid 100 sid:5DD
    2009-08-02 22:48:53.245576 [46]: subch:0 set pmt grabber pmt:100 sid:5DD
    2009-08-02 22:48:53.245576 [46]: WaitForPMT: Waiting for PMT.
    2009-08-02 22:48:53.365748 [53]: subch:0 OnPMTReceived() True
    2009-08-02 22:48:53.365748 [46]: WaitForPMT: Found PMT after 0,1201728 seconds.
    2009-08-02 22:48:53.365748 [46]: subch:0 SendPmt:5DD 5DD FFFFFFFF 7
    2009-08-02 22:48:53.365748 [46]: Decode pmt
    2009-08-02 22:48:53.365748 [46]: descr1 len:6 9 4 b 0 e0 64 
    2009-08-02 22:48:53.365748 [46]: Set descriptor data with length 6
    2009-08-02 22:48:53.365748 [46]: Set descriptor data with length 7
    2009-08-02 22:48:53.365748 [46]: Set descriptor data with length 3
    2009-08-02 22:48:53.365748 [46]: Set descriptor data with length 3
    2009-08-02 22:48:53.365748 [46]: Set descriptor data with length 3
    2009-08-02 22:48:53.365748 [46]: subch:0 SendPMT version:7 len:180 1501
    2009-08-02 22:48:53.385777 [46]: FireDTV: #0/1 pmt data:0x0 0x2 0x0 0x0 0x0 0x0 0x0 0x0 0xB6 0x0 0x3 0x1 0x2 0xB0 0xB4 0x5 0xDD 0xCF 0x0 0x0 0xFF 0xF4 0xF0 0x6 0x9 0x4 0xB 0x0 0xE0 0x64 0x2 0xE2 0x0 0xF0 0x0 0x4 0xE2 0x80 0xF0 0x6 0xA 0x4 0x6E 0x6F 0x72 0x0 0x6 0xE2 0x40 0xF0 0x7 0x56 0x5 0x6E 0x6F 0x72 0x9 0x0 0xB 0xE8 0xFB 0xF0 0x3 0x52 0x1 0x2 0xC0 0xE3 0x50 0xF0 0x29 0xC6 0x5 0x0 0x0 0x5 0x1 0xFF 0xC2 0x20 0x53 0x43 0x41 0x5F 0x45 0x50 0x47 0x31 0x53 0x43 0x41 0x5F 0x45 0x50 0x47 0x32 0x53 0x43 0x41 0x5F 0x5F 0x43 0x48 0x4C 0x45 0x50 0x47 0x5F 0x4C 0x4F 0x41 0x44 0x5 0xEA 0x29 0xF0 0x5 0x6F 0x3 0x0 0x1 0xE0 0xB 0xEA 0x34 0xF0 0x31 0x14 0xD 0x0 0xA 0x0 0x0 0x8 0x80 0x1 0x0 0x1 0x0 0x6B 0xE 0x40 0x52 0x1 0xA 0x13 0x19 0x0 0x0 0x0 0x3 0x1 0x1 0x0 0xA 0xF 0xE2 0x0 0x0 0x0 0x76 0x0 0x0 0x0 0x0 0x76 0x3 0x4 0x53 0x47 0x57 0x0 0x66 0x2 0x0 0xF0 0xC 0xEA 0x35 0xF0 0xA 0x14 0x5 0x0 0x64 0x1 0x0 0x0 0x52 0x1 0x64 0x55 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 
    2009-08-02 22:48:53.495936 [46]: FireDTV:GetCAMStatus() finished
    2009-08-02 22:48:53.495936 [46]:   FireDTV:cam is inserted
    2009-08-02 22:48:53.495936 [46]:   FireDTV:cam is valid
    2009-08-02 22:48:53.495936 [46]:   FireDTV:cam is ready
    2009-08-02 22:48:53.495936 [46]: subch:0 cam flags:True
    2009-08-02 22:48:53.495936 [46]: subch:0 SetMpegPidMapping
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:1FF4 pcr
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:100 pmt
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:200 video type:MPEG-2
    2009-08-02 22:48:53.495936 [46]: subch:0    map pid:200 video type:MPEG-2
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:280 audio lang:nor type:MPEG-2
    2009-08-02 22:48:53.495936 [46]: subch:0    map pid:280 audio lang:nor type:MPEG-2
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:240 teletext type:6
    2009-08-02 22:48:53.495936 [46]: subch:0    map pid:240 teletext type:6
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:8FB type:B
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:350 type:C0
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:A29 type:5
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:A34 type:B
    2009-08-02 22:48:53.495936 [46]: subch:0  pid:A35 type:C
    2009-08-02 22:48:53.495936 [46]: FireDTV: HW Filtering disabled.
    2009-08-02 22:48:53.505950 [46]: subch:0 stop tif
    2009-08-02 22:48:53.505950 [46]: WaitForPMT: sending PMT to CAM took 0,1402016 seconds.
    2009-08-02 22:48:53.556022 [46]: card: Tuner locked: True
    2009-08-02 22:48:53.556022 [46]: **************************************************
    2009-08-02 22:48:53.556022 [46]: ***** SIGNAL LEVEL: 100, SIGNAL QUALITY: 100 *****
    2009-08-02 22:48:53.556022 [46]: **************************************************
    2009-08-02 22:48:53.556022 [46]: card: tuned user: HUGIN subchannel: 0
    2009-08-02 22:48:53.556022 [46]: user:HUGIN add
    2009-08-02 22:48:53.556022 [46]: card2:HUGIN 1 0
    2009-08-02 22:48:53.556022 [46]: Controller: HUGIN 1 0
    2009-08-02 22:48:53.566036 [46]: control2:HUGIN 1 0
    2009-08-02 22:48:53.566036 [46]: Controller: delete timeshift files D:\TV\live1-0.ts
    2009-08-02 22:48:53.566036 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer
    2009-08-02 22:48:53.566036 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer1.ts
    2009-08-02 22:48:53.566036 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer10.ts
    2009-08-02 22:48:53.606094 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer11.ts
    2009-08-02 22:48:53.606094 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer12.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer13.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer14.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer15.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer16.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer17.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer18.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer19.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer2.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer20.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer21.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer22.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer23.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer24.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer25.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer26.ts
    2009-08-02 22:48:53.616108 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer27.ts
    2009-08-02 22:48:53.626123 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer28.ts
    2009-08-02 22:48:53.626123 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer29.ts
    2009-08-02 22:48:53.636137 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer3.ts
    2009-08-02 22:48:53.636137 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer4.ts
    2009-08-02 22:48:53.636137 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer5.ts
    2009-08-02 22:48:53.636137 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer6.ts
    2009-08-02 22:48:53.636137 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer7.ts
    2009-08-02 22:48:53.636137 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer8.ts
    2009-08-02 22:48:53.646152 [46]: Controller:   delete D:\TV\live1-0.ts.tsbuffer9.ts
    2009-08-02 22:48:53.646152 [46]: card: StartTimeShifting 1 D:\TV\live1-0.ts 
    2009-08-02 22:48:53.646152 [46]: card: CAM enabled : True
    2009-08-02 22:48:53.646152 [46]: subch:0 SetTimeShiftFileName:D:\TV\live1-0.ts
    2009-08-02 22:48:53.646152 [46]: Set video / audio observer
    2009-08-02 22:48:53.646152 [46]: subch:0 SetTimeShiftFileName fill in pids
    2009-08-02 22:48:53.646152 [46]: subch:0-0 tswriter StartTimeshifting...
    2009-08-02 22:48:53.656166 [46]: card: WaitForTimeShiftFile - waiting _eventAudio & _eventVideo
    2009-08-02 22:48:53.666180 [53]: PID seen - type = Audio
    2009-08-02 22:48:53.666180 [53]: audioVideoEventHandler Audio
    2009-08-02 22:48:53.996656 [53]: PID seen - type = Video
    2009-08-02 22:48:53.996656 [53]: audioVideoEventHandler Video
    2009-08-02 22:48:53.996656 [46]: card: WaitForTimeShiftFile - video and audio are seen after 0,3404896 seconds
    2009-08-02 22:48:53.996656 [46]: user:HUGIN card:1 sub:0 add stream:D:\TV\live1-0.ts.tsbuffer
    2009-08-02 22:48:53.996656 [46]: RTSP: add stream stream1.0 file:D:\TV\live1-0.ts.tsbuffer
    2009-08-02 22:48:54.006670 [46]: Controller: StartTimeShifting started on card:1 to D:\TV\live1-0.ts.tsbuffer
    2009-08-02 22:48:54.337145 [Channel state thread]: Controller: DoSetChannelStates for 59 channels
    2009-08-02 22:59:05.946596 [51]: Controller: StopTimeShifting 1
    2009-08-02 22:59:05.956611 [51]: card FireDTV BDA Tuner DVBS2: StopTimeShifting user:HUGIN sub:0
    2009-08-02 22:59:05.966625 [51]: card: StopTimeShifting user:HUGIN sub:0
    2009-08-02 22:59:05.966625 [51]: card not IDLE - freeing subch: 0
    2009-08-02 22:59:05.976640 [51]: subch:0-0 tswriter StopTimeshifting...
    2009-08-02 22:59:06.056755 [51]: tvcard:FreeSubChannel: subchannels count 1 subch#0 keep graph=False
    2009-08-02 22:59:06.056755 [51]: DVB subch:0 Decompose()
    2009-08-02 22:59:06.066769 [51]: FreeSubChannel CA: freeing sub channel : 0
    2009-08-02 22:59:06.066769 [51]: tvcard:FreeSubChannel : no subchannels present, stopping graph
    2009-08-02 22:59:06.066769 [51]: dvb:StopGraph called
    2009-08-02 22:59:06.066769 [51]: tvcard:FreeAllSubChannels:
    2009-08-02 22:59:06.076784 [51]: dvb:StopGraph
    2009-08-02 22:59:06.146884 [51]: user:HUGIN remove
    2009-08-02 22:59:06.146884 [51]: Controller:Timeshifting stopped on card:1
    2009-08-02 22:59:06.146884 [51]: RTSP: remove stream stream1.0
    2009-08-02 22:59:06.176928 [Channel state thread]: Controller: DoSetChannelStates for 59 channels
    2009-08-02 22:59:21.308686 [PowerEventThread]: TV service PowerEventThread 537
    2009-08-02 22:59:21.308686 [PowerEventThread]: TV service PowerEventThread 537
    2009-08-02 22:59:26.556232 [PowerEventThread]: TV service PowerEventThread 537
    2009-08-02 22:59:26.556232 [PowerEventThread]: TV service PowerEventThread 537
    2009-08-02 22:59:26.606304 [PowerEventThread]: TV service PowerEventThread 537
     

    ronilse

    Retired Team Member
  • Premium Supporter
  • July 19, 2005
    4,422
    283
    Moss
    Home Country
    Norway Norway
    Hi,
    Do not post logs in forum posts, makes a mess, instead attach all logs to your post instead, many error related stuff it's in tswriter.log/win event logs......


    Regards
    Roy
     

    tourettes

    Retired Team Member
  • Premium Supporter
  • January 7, 2005
    17,301
    4,800
    Unfortunately those logs doesn't show why the TS buffer deletion failed. Are you timeshifting on a RAM disk? What timeshifting settings you have in use?
     

    Al_Capone

    MP Donator
  • Premium Supporter
  • September 26, 2006
    527
    19
    Home Country
    Norway Norway
    Thanks for trying to help.
    I am timeshifting to local HD , same as system drive, but another partition. (201GB free)

    TV Server timeshifting settings:
    min 6 files.
    max 20 files.
    filesize 256MB/file
    wait for unscrambled 5sek
    wait for timeshifting file 15sek.
    (20+256= max 5GB needed)
     

    tourettes

    Retired Team Member
  • Premium Supporter
  • January 7, 2005
    17,301
    4,800
    I think we need to add some additional logging to see why the file deletion is failing.
     

    Al_Capone

    MP Donator
  • Premium Supporter
  • September 26, 2006
    527
    19
    Home Country
    Norway Norway
    sounds right.
    BTW. after "tv off", no timeshift files remain, so it does manage to delete them then. - also, tvoff/tvon instantly fixed the problem, but xx minutes of the movie were lost. - so it's not a permanent error.
     

    Al_Capone

    MP Donator
  • Premium Supporter
  • September 26, 2006
    527
    19
    Home Country
    Norway Norway
    reproduced again today - this time on purpose, started TV from work when noone was home...


    2009-08-04 11:44:21.328260 (started)
    2009-08-04 15:54:29.238576 [41]: Controller: StopTimeShifting 1 (crashed)

    4 hours ? - maybe if i increase max files, or max size - it will work longer ?
     

    tourettes

    Retired Team Member
  • Premium Supporter
  • January 7, 2005
    17,301
    4,800
    Added exception logging for the file deletion failing, available in SVN builds after version 23338.
     

    medaust

    Portal Pro
    September 12, 2007
    73
    0
    Home Country
    Hi, I have no idea about the log files. However, this thing happens to me very often too, I find most of the time it is because the available space on the hard disk is too low.
     

    Users who are viewing this thread

    Top Bottom