Opened 14 years ago

Closed 14 years ago

Last modified 14 years ago

#864 closed defect (invalid)

Frontend segfaults when changing cards

Reported by: markus.heikkila@… Owned by: danielk
Priority: minor Milestone: unknown
Component: mythtv Version: head
Severity: medium Keywords:
Cc: Ticket locked: no

Description

SVN 8371: When I try to change DVB-card during LiveTV by pressing Y, frontend segfaults.

Frontend and backend logs below.

FE log:
2005-12-23 21:39:12.298 Using runtime prefix = /usr/local
2005-12-23 21:39:12.325 XScreenSaver support enabled
2005-12-23 21:39:12.349 New DB connection, total: 1
2005-12-23 21:39:12.474 Total desktop dim: 800x600, with 1 screen[s].
2005-12-23 21:39:12.480 Using screen 0, 800x600 at 0,0
2005-12-23 21:39:12.486 Enabling Settings Cache.
2005-12-23 21:39:12.486 Clearing Settings Cache.
2005-12-23 21:39:12.486 user: 1000 effective user: 1000 before privileged thread
2005-12-23 21:39:12.487 user: 1000 effective user: 1000 after privileged thread
2005-12-23 21:39:12.487 user: 1000 effective user: 1000 run_priv_thread
2005-12-23 21:39:12.488 Current Schema Version: 1120
2005-12-23 21:39:12.489 mythfrontend version: 0.19.20051208-1 www.mythtv.org
2005-12-23 21:39:12.489 Enabled verbose msgs: all noaudio nodatabase
2005-12-23 21:39:13.024 max_width: 800 max_height: 600
2005-12-23 21:39:13.026 lang0: fin
2005-12-23 21:39:13.027 lang: fin
2005-12-23 21:39:13.046 lang1: eng
2005-12-23 21:39:13.046 lang: eng
2005-12-23 21:39:13.200 Total desktop dim: 800x600, with 1 screen[s].
2005-12-23 21:39:13.202 Using screen 0, 800x600 at 0,0
2005-12-23 21:39:13.204 Switching to square mode (blue)
2005-12-23 21:39:13.634 /home/filou/.mythtv/joystickmenurc not found.
2005-12-23 21:39:13.635 Joystick disabled.
2005-12-23 21:39:13.636 New DB connection, total: 2
2005-12-23 21:39:13.682 Clearing Settings Cache for 'Language'.
2005-12-23 21:39:13.682 Clearing Settings Cache.
2005-12-23 21:39:13.762 Registering Internal as a media playback plugin.
2005-12-23 21:39:13.802 Registering MythDVD DVD Media Handler as a media handler
2005-12-23 21:39:13.803 Registering MythDVD VCD Media Handler as a media handler
2005-12-23 21:39:24.834 Registering MythMusic Media Handler as a media handler
2005-12-23 21:39:24.897 Mediamonitor: Adding /dev/hdd
2005-12-23 21:39:24.919 Starting media monitor.
2005-12-23 21:39:25.704 Media status changed...  New status is: MEDIASTAT_OPEN old status was MEDIASTAT_NOTMOUNTED
2005-12-23 21:39:27.151 Connecting to backend server: 192.168.1.3:6543 (try 1 of 5)
2005-12-23 21:39:27.152 write -> 12 21      MYTH_PROTO_VERSION 22
2005-12-23 21:39:27.165 read  <- 12 13      ACCEPT[]:[]22
2005-12-23 21:39:27.165 Using protocol version 22
2005-12-23 21:39:27.165 write -> 12 19      ANN Monitor neuvo 0
2005-12-23 21:39:27.179 read  <- 12 2       OK
2005-12-23 21:39:27.184 write -> 12 29      GET_NEXT_FREE_RECORDER[]:[]-1
2005-12-23 21:39:27.203 read  <- 12 26      1[]:[]192.168.1.3[]:[]6543
2005-12-23 21:39:27.206 TV: Attempting to change from None to WatchingLiveTV
2005-12-23 21:39:27.207 write -> 14 19      ANN Monitor neuvo 1
2005-12-23 21:39:27.208 write -> 15 21      MYTH_PROTO_VERSION 22
2005-12-23 21:39:27.222 read  <- 14 2       OK
2005-12-23 21:39:27.226 read  <- 15 13      ACCEPT[]:[]22
2005-12-23 21:39:27.226 Using protocol version 22
2005-12-23 21:39:27.226 write -> 15 20      ANN Playback neuvo 0
2005-12-23 21:39:27.253 read  <- 15 2       OK
2005-12-23 21:39:27.254 write -> 15 74      QUERY_RECORDER 1[]:[]SPAWN_LIVETV[]:[]live-neuvo-2005-12-23T21:39...
2005-12-23 21:39:27.518 read  <- 14 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:39:27.802 read  <- 15 2       ok
2005-12-23 21:39:27.805 LiveTVChain(live-neuvo-2005-12-23T21:39:27): ReloadAll(): Added new recording
2005-12-23 21:39:27.811 read  <- 14 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
2005-12-23 21:39:27.812 RingBuf(myth://192.168.1.3:6543/1017_20051223213656.mpg): OpenFile(myth://192.168.1.3:6543/1017_20051223213656.mpg, 6)
2005-12-23 21:39:27.815 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:27.818 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:27.823 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:27.826 write -> 15 33      QUERY_RECORDER 1[]:[]IS_RECORDING
2005-12-23 21:39:27.844 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:27.904 read  <- 15 1       1
2005-12-23 21:39:27.905 write -> 15 33      QUERY_RECORDER 1[]:[]IS_RECORDING
2005-12-23 21:39:27.918 read  <- 15 1       1
2005-12-23 21:39:27.918 TV: StartRecorder(): took 92 ms to start recorder.
2005-12-23 21:39:27.921 TV: GetLockTimeout(1): Set lock timeout to 6000 ms
2005-12-23 21:39:27.921 write -> 15 34      QUERY_RECORDER 1[]:[]GET_FRAMERATE
2005-12-23 21:39:27.921 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:27.936 read  <- 15 2       -1
2005-12-23 21:39:27.949 write -> 12 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:39:27.951 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:27.960 read  <- 12 2       OK
2005-12-23 21:39:27.968 read  <- 14 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:39:27.981 NVP: SetCommBreakIter @ framesPlayed = 0
2005-12-23 21:39:27.982 NVP: new commBreakIter = 17 @ frame 137438953472
2005-12-23 21:39:27.985 TV: Output filters for this channel are: ''
2005-12-23 21:39:27.997 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:28.050 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:28.103 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:28.157 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:28.222 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:28.275 read  <- 14 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:39:28.989 read  <- 14 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
mpegts_add_stream: at pid 0x21 with type 2
mpegts_add_stream: stream #0, has id 0x21 and codec MPEG2VIDEO, type Video at 0x83471f0
2005-12-23 21:39:29.128 read  <- 14 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:39:29.184 read  <- 14 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
2005-12-23 21:39:29.187 LiveTVChain(live-neuvo-2005-12-23T21:39:27): ReloadAll(): Added new recording
2005-12-23 21:39:29.188 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
2005-12-23 21:39:29.190 Position map filled from DB to: 99
2005-12-23 21:39:29.190 SyncPositionMap watchingrecording, from DB: 10 entries
2005-12-23 21:39:29.190 SyncPositionMap watchingrecording no entries from encoder, try DB
2005-12-23 21:39:29.192 Position map filled from DB to: 99
2005-12-23 21:39:29.192 SyncPositionMap watchingrecording total: 10 entries
2005-12-23 21:39:29.192 SyncPositionMap, new totframes: 99, new length: 3, posMap size: 10
0: start_time: -9223372036854.775 duration: -9223372036854.775
stream: start_time: -9223372036854.775 duration: -9223372036854.775 bitrate=0 kb/s
2005-12-23 21:39:32.569 AFD: Stream #0, has id 0x33 codec id MPEG1VIDEO, type Video at 0x0x83471f0
2005-12-23 21:39:32.571 detectInterlace(Detect Scan, Detect Scan, 50, 576) ->Progressive Scan
2005-12-23 21:39:32.572 Interlaced: Progressive Scan  video_height: 576  fps: 50
2005-12-23 21:39:32.574 AFD: Looking for decoder for MPEG1VIDEO
2005-12-23 21:39:32.574 AFD: Opened codec 0x8343e50, id(MPEG1VIDEO) type(Video)
2005-12-23 21:39:32.574 RingBuf:CalcReadAheadThresh(1152 KB) -> threshhold(0 KB) readblocksize(125 KB)
2005-12-23 21:39:32.575 NVP: Disabling Audio, params(-1,-1,-1)
2005-12-23 21:39:32.575 AFD: Initializing audio parms from audio track #0
2005-12-23 21:39:32.575 AFD: Audio format changed 
			from id(NONE)    -1Hz -1ch   0bps    ; id(NONE)    -1Hz -1ch   0bps   
			to   id(NONE)    -1Hz -1ch   0bps    ; id(NONE)    -1Hz -1ch   0bps   
2005-12-23 21:39:32.575 NVP: Disabling Audio, params(0,-1,-1)
Input #0, mpegts, from '/home/mythtv/programs/1017_20051223213656.mpg':
  Duration: N/A, bitrate: N/A
  Stream #0.0[0x21], 1/90000, 50.00 fps: Video: mpeg1video, yuv420p, 768x576, 1/50, 1152 kb/s
2005-12-23 21:39:32.575 AFD: Partial position map found
2005-12-23 21:39:32.576 AFD: Successfully opened decoder for file: "/home/mythtv/programs/1017_20051223213656.mpg". novideo(0)
2005-12-23 21:39:32.586 VideoOutputXv: ctor
2005-12-23 21:39:32.608 Over/underscan. V: 0.05, H: 0.05, XOff: 15, YOff: 0
2005-12-23 21:39:32.618 Image size. dispxoff 0, dispyoff: 0, dispwoff: 800, disphoff: 600
2005-12-23 21:39:32.618 Image size. imgx 23, imgy: 29, imgw: 691, imgh: 518
2005-12-23 21:39:32.618 VideoOutputXv: Pixel dimensions: Screen 800x600, window 800x600
2005-12-23 21:39:32.619 VideoOutputXv: Estimated display dimensions: 271x203 mm Aspect: 1.33498
2005-12-23 21:39:32.619 VideoOutputXv: Estimated window dimensions: 271x203 mm Aspect: 1.33498
2005-12-23 21:39:32.623 VideoOutputXv: @ j=3 Looking for flag[s]: XvInputMask XvImageMask 
2005-12-23 21:39:32.623 VideoOutputXv: Adaptor: 0 has flag[s]: XvInputMask XvImageMask 
2005-12-23 21:39:32.623 VideoOutputXv: XVideo surface found on port 240
2005-12-23 21:39:32.624 VideoOutputXv: XVideo Format #0 is 'YUY2'
2005-12-23 21:39:32.624 VideoOutputXv: XVideo Format #1 is 'YV12'
2005-12-23 21:39:32.624 VideoOutputXv: XVideo Format #2 is 'UYVY'
2005-12-23 21:39:32.624 VideoOutputXv: XVideo Format #3 is 'I420'
2005-12-23 21:39:32.625 VideoOutputXv: Using XVideo Format 'I420'
2005-12-23 21:39:32.705 Image size. dispxoff 0, dispyoff: 0, dispwoff: 800, disphoff: 600
2005-12-23 21:39:32.705 Image size. imgx 23, imgy: 29, imgw: 691, imgh: 518
2005-12-23 21:39:33.606 NVP: ClearAfterSeek()
2005-12-23 21:39:33.606 VideoOutputXv: ClearAfterSeek()
2005-12-23 21:39:33.606 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:33.606 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:33.606 NVP: SetCommBreakIter @ framesPlayed = 0
2005-12-23 21:39:33.606 NVP: new commBreakIter = 17 @ frame 137438953472
2005-12-23 21:39:33.607 TV: StartPlayer(): took 5620 ms to start player.
2005-12-23 21:39:33.608 TV: Changing from None to WatchingLiveTV
2005-12-23 21:39:33.611 New DB connection, total: 3
2005-12-23 21:39:33.614 New DB connection, total: 4
2005-12-23 21:39:33.615 write -> 15 35      QUERY_RECORDER 1[]:[]FRONTEND_READY
2005-12-23 21:39:33.615 NVP: SetCommBreakIter @ framesPlayed = 0
2005-12-23 21:39:33.615 NVP: new commBreakIter = 17 @ frame 137438953472
2005-12-23 21:39:33.617 VideoOutputXv: InputChanged(768,576,1.21766)
2005-12-23 21:39:33.618 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:33.618 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:33.656 Image size. dispxoff 0, dispyoff: 0, dispwoff: 800, disphoff: 600
2005-12-23 21:39:33.656 Image size. imgx 23, imgy: 29, imgw: 691, imgh: 518
2005-12-23 21:39:33.684 read  <- 15 2       ok
2005-12-23 21:39:33.730 Realtime priority would require SUID as root.
2005-12-23 21:39:34.080 NVP: ClearAfterSeek()
2005-12-23 21:39:34.080 VideoOutputXv: ClearAfterSeek()
2005-12-23 21:39:34.080 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:34.080 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:34.080 NVP: SetCommBreakIter @ framesPlayed = 0
2005-12-23 21:39:34.080 NVP: new commBreakIter = 17 @ frame 137438953472
2005-12-23 21:39:34.081 detectInterlace(Detect Scan, Progressive Scan, 50, 576) ->Progressive Scan
2005-12-23 21:39:34.081 Interlaced: Progressive Scan  video_height: 576  fps: 50
2005-12-23 21:39:34.086 TV: CommitQueuedInput() livetv(1) qchannum() qchanid(0)
2005-12-23 21:39:34.087 write -> 15 39      QUERY_RECORDER 1[]:[]CHECK_CHANNEL[]:[]
2005-12-23 21:39:34.108 read  <- 15 1       0
2005-12-23 21:39:34.109 TV: ChangeChannel(0, '') 
2005-12-23 21:39:34.109 write -> 15 46      QUERY_RECORDER 1[]:[]CHECK_CHANNEL_PREFIX[]:[]
2005-12-23 21:39:34.129 read  <- 15 7       1[]:[]0
2005-12-23 21:39:34.129 write -> 15 39      QUERY_RECORDER 1[]:[]CHECK_CHANNEL[]:[]
2005-12-23 21:39:34.146 read  <- 15 1       0
2005-12-23 21:39:34.368 write -> 12 19      QUERY_GETALLPENDING
2005-12-23 21:39:34.380 read  <- 12 977     0[]:[]2[]:[]Shield - Lain varjolla (K15)[]:[][]:[]Danten helvetti...
2005-12-23 21:39:34.747 nVidiaVideoSync: VBlank ioctl did not work, unimplemented in this driver?
2005-12-23 21:39:34.747 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2005-12-23 21:39:34.747 RTCVideoSync: Could not open /dev/rtc, No such file or directory.
2005-12-23 21:39:34.748 Using audio as timebase
2005-12-23 21:39:34.748 Video timing method: USleep with busy wait
2005-12-23 21:39:34.749 Refresh rate: 16579, frame interval: 20000
2005-12-23 21:39:34.841 Image size. dispxoff 540, dispyoff: 20, dispwoff: 240, disphoff: 180
2005-12-23 21:39:34.842 Image size. imgx 23, imgy: 29, imgw: 691, imgh: 518
2005-12-23 21:39:36.112 AFD: positionMap[ 99 ] == 7482400.
[mpeg1video @ 0xb74640a4]invalid mb type in P Frame at 47 17
[mpeg1video @ 0xb74640a4]Warning MVs not available
[mpeg1video @ 0xb74640a4]concealing 912 DC, 912 AC, 912 MV errors
2005-12-23 21:39:36.152 LiveTVChain(live-neuvo-2005-12-23T21:39:27): SwitchTo(1)
2005-12-23 21:39:36.152 LiveTVChain(live-neuvo-2005-12-23T21:39:27): Entry@1: '1017_20051223213658'
2005-12-23 21:39:36.160 write -> 12 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:39:36.172 read  <- 12 2       OK
2005-12-23 21:39:36.176 write -> 12 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:39:36.186 read  <- 14 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:39:36.187 read  <- 12 2       OK
2005-12-23 21:39:36.187 RingBuf(/home/mythtv/programs/1017_20051223213656.mpg): OpenFile(myth://192.168.1.3:6543/1017_20051223213658.mpg, 4)
2005-12-23 21:39:36.198 NVP: ClearAfterSeek()
2005-12-23 21:39:36.198 VideoOutputXv: ClearAfterSeek()
2005-12-23 21:39:36.199 VideoBuffers::DiscardFrames(): UUUUUUULAAAUUUUUUUUUUUUUUUUUUUU
2005-12-23 21:39:36.199 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:36.199 NVP: SetCommBreakIter @ framesPlayed = 72
2005-12-23 21:39:36.199 NVP: new commBreakIter = 17 @ frame 137438953472
2005-12-23 21:39:36.199 AFD: SeekReset(0, do flush, do discard)
2005-12-23 21:39:36.199 AFD: SeekReset() flushing
2005-12-23 21:39:36.199 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.200 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:36.200 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
2005-12-23 21:39:36.202 Position map filled from DB to: 120
2005-12-23 21:39:36.203 SyncPositionMap watchingrecording, from DB: 11 entries
2005-12-23 21:39:36.203 write -> 15 39      QUERY_RECORDER 1[]:[]GET_FRAMES_WRITTEN
2005-12-23 21:39:36.203 read  <- 14 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:39:36.211 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.215 read  <- 15 9       0[]:[]140
2005-12-23 21:39:36.215 Filling position map from 121 to 140
2005-12-23 21:39:36.215 write -> 15 54      QUERY_RECORDER 1[]:[]FILL_POSITION_MAP[]:[]121[]:[]140
2005-12-23 21:39:36.228 read  <- 15 27      0[]:[]132[]:[]0[]:[]2022880
2005-12-23 21:39:36.228 Position map filled from Encoder to: 132
2005-12-23 21:39:36.228 SyncPositionMap watchingrecording total: 12 entries
2005-12-23 21:39:36.228 SyncPositionMap, new totframes: 132, new length: 2, posMap size: 12
av_remove_stream 0x21
av_remove_stream: no change to cur_st
av_remove_stream: removing... s->nb_streams=1 i=0
av_remove_stream: mpegts_remove_stream
mpegts_remove_stream 0x21
closing filter for pid 0x21
av_remove_stream: renumbering streams
mpegts_add_stream: at pid 0x200 with type 2
mpegts_add_stream: stream #0, has id 0x200 and codec MPEG2VIDEO, type Video at 0x8358a90
mpegts_add_stream: at pid 0x28a with type 4
mpegts_add_stream: stream #1, has id 0x28a and codec MP3, type Audio at 0x8a7ea90
mpegts_add_stream: at pid 0x28b with type 4
mpegts_add_stream: stream #2, has id 0x28b and codec MP3, type Audio at 0x8c7c840
mpegts_add_stream: at pid 0x28c with type 4
mpegts_add_stream: stream #3, has id 0x28c and codec MP3, type Audio at 0x838d1b0
mpegts_add_stream: at pid 0x911 with type 6
mpegts_add_stream: stream #4, has id 0x911 and codec Unknown Codec ID, type Data at 0x89baa20
mpegts_add_stream: at pid 0x403 with type 256
mpegts_add_stream: stream #5, has id 0x403 and codec DVB_SUBTITLE, type Subtitle at 0x89baaf0
mpegts_add_stream: at pid 0x404 with type 256
mpegts_add_stream: stream #6, has id 0x404 and codec DVB_SUBTITLE, type Subtitle at 0x8c06fe0
streams_changed()
2005-12-23 21:39:36.248 AFD: HandleStreamChange(): streams_changed 0x8342df8 -- stream count 7
2005-12-23 21:39:36.248 AFD: SeekReset(0, do flush, do discard)
2005-12-23 21:39:36.249 AFD: SeekReset() flushing
2005-12-23 21:39:36.249 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.249 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:36.249 AFD: Stream #0, has id 0x512 codec id MPEG2VIDEO, type Video at 0x0x8358a90
2005-12-23 21:39:36.249 detectInterlace(Detect Scan, Progressive Scan, 29.97, 480) ->Interlaced Scan
2005-12-23 21:39:36.249 Interlaced: Interlaced Scan  video_height: 480  fps: 29.97
2005-12-23 21:39:36.249 AFD: Looking for decoder for MPEG2VIDEO
2005-12-23 21:39:36.249 AFD: Opened codec 0x89bf790, id(MPEG2VIDEO) type(Video)
2005-12-23 21:39:36.250 AFD: Stream #1, has id 0x650 codec id MP3, type Audio at 0x0x8a7ea90
2005-12-23 21:39:36.250 AFD: Looking for decoder for MP3
2005-12-23 21:39:36.271 AFD: Opened codec 0x89b8b20, id(MP3) type(Audio)
2005-12-23 21:39:36.272 AFD: Audio Track #1 is A/V stream #1 and has 0 channels in the Finnish language(6711662).
2005-12-23 21:39:36.272 AFD: Stream #2, has id 0x651 codec id MP3, type Audio at 0x0x8c7c840
2005-12-23 21:39:36.272 AFD: Looking for decoder for MP3
2005-12-23 21:39:36.272 AFD: Opened codec 0x8c057d0, id(MP3) type(Audio)
2005-12-23 21:39:36.272 AFD: Audio Track #2 is A/V stream #2 and has 0 channels in the Swedish language(7567205).
2005-12-23 21:39:36.272 AFD: Stream #3, has id 0x652 codec id MP3, type Audio at 0x0x838d1b0
2005-12-23 21:39:36.272 AFD: Looking for decoder for MP3
2005-12-23 21:39:36.273 AFD: Opened codec 0x8c3bc00, id(MP3) type(Audio)
2005-12-23 21:39:36.273 AFD: Audio Track #3 is A/V stream #3 and has 0 channels in the Dutch; Flemish language(6583668).
2005-12-23 21:39:36.273 AFD: Stream #4, has id 0x2321 codec id Unknown Codec ID, type Data at 0x0x89baa20
2005-12-23 21:39:36.273 AFD: data codec (Data)
2005-12-23 21:39:36.273 AFD: Stream #5, has id 0x1027 codec id DVB_SUBTITLE, type Subtitle at 0x0x89baaf0
2005-12-23 21:39:36.273 AFD: subtitle codec (Subtitle)
2005-12-23 21:39:36.273 AFD: Looking for decoder for DVB_SUBTITLE
2005-12-23 21:39:36.273 AFD: Opened codec 0x8c498c0, id(DVB_SUBTITLE) type(Subtitle)
2005-12-23 21:39:36.273 AFD: Subtitle track #1 is A/V stream #5 and is in the Finnish language(6711662).
2005-12-23 21:39:36.274 AFD: Stream #6, has id 0x1028 codec id DVB_SUBTITLE, type Subtitle at 0x0x8c06fe0
2005-12-23 21:39:36.274 AFD: subtitle codec (Subtitle)
2005-12-23 21:39:36.274 AFD: Looking for decoder for DVB_SUBTITLE
2005-12-23 21:39:36.274 AFD: Opened codec 0x8309a60, id(DVB_SUBTITLE) type(Subtitle)
2005-12-23 21:39:36.274 AFD: Subtitle track #2 is A/V stream #6 and is in the Swedish language(7567205).
[mpegts @ 0xb7556760]Parser not found for Codec Id: 94211 !
2005-12-23 21:39:36.293 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.341 VideoOutputXv: InputChanged(704,576,1.77778)
2005-12-23 21:39:36.342 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.342 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:36.342 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.342 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:36.423 Image size. dispxoff 540, dispyoff: 42, dispwoff: 240, disphoff: 135
2005-12-23 21:39:36.423 Image size. imgx 20, imgy: 29, imgw: 634, imgh: 518
2005-12-23 21:39:36.428 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.590 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.752 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.914 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.923 NVP: ClearAfterSeek()
2005-12-23 21:39:36.923 VideoOutputXv: ClearAfterSeek()
2005-12-23 21:39:36.923 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:36.923 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:36.923 NVP: SetCommBreakIter @ framesPlayed = 0
2005-12-23 21:39:36.923 NVP: new commBreakIter = 17 @ frame 137438953472
2005-12-23 21:39:36.923 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2005-12-23 21:39:36.924 Interlaced: Interlaced Scan  video_height: 576  fps: 25
2005-12-23 21:39:36.938 AFD: Trying to select audio track (w/lang)
2005-12-23 21:39:36.939 AFD: Selected track 1: Finnish MP2 2ch (A/V Stream #1)
2005-12-23 21:39:36.939 AFD: Initializing audio parms from audio track #1
2005-12-23 21:39:36.939 AFD: Audio format changed 
			from id(NONE)    -1Hz -1ch   0bps    ; id(NONE)    -1Hz -1ch   0bps   
			to   id( MP3) 48000Hz  2ch  16bps    ; id( MP3) 48000Hz  2ch  16bps   
2005-12-23 21:39:36.942 Opening audio device 'default'.
2005-12-23 21:39:37.045 NVP: Enabling Audio
2005-12-23 21:39:37.046 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.046 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.052 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.052 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.052 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.076 NVP: Waiting for prebuffer.. 6 AAAAAAAAULUUAAAAAAAAAAAAAAAAAAA
2005-12-23 21:39:37.091 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.091 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.091 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.097 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.097 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.098 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.107 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.108 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.108 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.116 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.116 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.116 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.124 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.124 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.124 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.131 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.132 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.132 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.141 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.141 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.141 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.153 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.153 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.153 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.161 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.161 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.161 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.172 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.173 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.173 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.179 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.179 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.179 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.187 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.188 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.188 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.195 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.195 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.196 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.203 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.203 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.203 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.217 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.218 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.218 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.228 NVP: Audio is 5.26875 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.231 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.231 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.231 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.240 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.240 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.240 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.252 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.253 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.253 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.264 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.265 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.265 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.271 NVP: Audio is 7.10155 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.291 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.291 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.292 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.304 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.304 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.304 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.314 NVP: Audio is 8.46365 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.319 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.319 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.320 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.326 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.326 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.326 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.337 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.337 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.337 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.351 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.351 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.351 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.357 NVP: Audio is 9.46647 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.364 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.364 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.365 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.376 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.376 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.377 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.385 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.386 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.386 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.393 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.393 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.393 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.400 NVP: Audio is 10.1999 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.409 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.409 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.409 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.418 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.418 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.418 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.427 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.427 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.427 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.436 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.436 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.436 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.443 NVP: Audio is 10.7311 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.450 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.451 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.451 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.456 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.457 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.457 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.486 NVP: Audio is 11.1233 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.487 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.487 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.488 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.529 NVP: Audio is 11.3925 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.530 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.530 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.530 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.572 NVP: Audio is 11.5756 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.573 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.573 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.573 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.615 NVP: Audio is 11.7004 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.616 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.616 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.616 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.658 NVP: Audio is 11.7753 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.658 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.659 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.659 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.701 NVP: Audio is 11.8065 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.702 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.702 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.702 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.744 NVP: Audio is 11.8174 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.744 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.745 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.745 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.787 NVP: Audio is 11.8005 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.788 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.788 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.788 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.830 NVP: Audio is 11.7754 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.831 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.831 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.831 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.878 NVP: Audio is 11.7378 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.879 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.879 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.879 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.921 NVP: Audio is 11.6658 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.921 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.921 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.922 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:37.964 NVP: Audio is 11.5931 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:37.964 AFD: Trying to reselect subtitle track
2005-12-23 21:39:37.965 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:37.965 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.007 NVP: Audio is 11.5198 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.007 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.008 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.008 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.050 NVP: Audio is 11.4461 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.051 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.051 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.051 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.093 NVP: Audio is 11.3658 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.094 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.094 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.094 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.135 NVP: Audio is 11.2993 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.136 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.136 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.136 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.179 NVP: Audio is 11.2308 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.180 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.180 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.180 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.222 NVP: Audio is 11.1606 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.222 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.222 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.223 AFD: Selected subtitle track #0 in the Unknown language(2)
'video_output' mean = '34983.82', std. dev. = '94147.23', fps = '28.58'
2005-12-23 21:39:38.265 NVP: Audio is 11.0829 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.266 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.266 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.266 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.307 NVP: Audio is 11.0122 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.308 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.308 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.308 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.350 NVP: Audio is 10.9404 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.351 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.351 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.351 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.393 NVP: Audio is 10.874 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.394 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.394 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.394 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.436 NVP: Audio is 10.8055 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.436 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.436 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.437 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.478 NVP: Audio is 10.7416 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.479 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.480 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.480 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.521 NVP: Audio is 10.6749 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.522 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.522 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.522 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.564 NVP: Audio is 10.6124 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.565 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.565 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.565 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.607 NVP: Audio is 10.5468 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.607 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.608 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.608 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.650 NVP: Audio is 10.4789 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.651 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.651 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.651 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.693 NVP: Audio is 10.4154 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.693 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.693 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.693 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.736 NVP: Audio is 10.349 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.736 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.736 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.736 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.778 NVP: Audio is 10.2743 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.779 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.779 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.779 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.821 NVP: Audio is 10.2057 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.821 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.821 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.822 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.863 NVP: Audio is 10.1418 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.864 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.864 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.865 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.906 NVP: Audio is 10.0751 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.906 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.906 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.906 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.949 NVP: Audio is 10.0125 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.949 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.949 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.949 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:38.991 NVP: Audio is 9.94687 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:38.992 AFD: Trying to reselect subtitle track
2005-12-23 21:39:38.992 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:38.993 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.035 NVP: Audio is 9.8789 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.035 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.035 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.035 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.078 NVP: Audio is 9.80917 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.078 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.078 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.078 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.120 NVP: Audio is 9.74438 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.121 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.121 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.121 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.163 NVP: Audio is 9.67702 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.163 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.164 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.164 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.205 NVP: Audio is 9.614 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.206 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.206 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.206 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.248 NVP: Audio is 9.54175 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.249 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.249 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.249 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.291 NVP: Audio is 9.4813 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.291 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.291 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.291 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.334 NVP: Audio is 9.41722 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.335 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.335 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.335 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.378 NVP: Audio is 9.34415 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.378 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.378 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.378 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.420 NVP: Audio is 9.2706 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.421 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.422 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.422 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.464 NVP: Audio is 9.1967 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.465 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.465 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.465 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.506 NVP: Audio is 9.12253 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.507 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.507 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.507 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.549 NVP: Audio is 9.04813 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.550 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.550 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.550 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.591 NVP: Audio is 8.97983 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.592 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.592 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.592 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.634 NVP: Audio is 8.90985 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.635 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.635 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.635 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.678 NVP: Audio is 8.83862 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.678 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.678 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.678 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.720 NVP: Audio is 8.76645 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.721 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.721 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.721 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.763 NVP: Audio is 8.69357 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.764 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.764 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.764 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.805 NVP: Audio is 8.62642 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.806 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.806 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.806 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.848 NVP: Audio is 8.5573 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.849 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.849 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.849 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.891 NVP: Audio is 8.48672 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.892 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.892 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.892 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.934 NVP: Audio is 8.41502 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.935 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.935 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.935 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:39.977 NVP: Audio is 8.3425 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:39.978 AFD: Trying to reselect subtitle track
2005-12-23 21:39:39.978 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:39.978 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.020 NVP: Audio is 8.26937 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.021 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.022 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.022 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.063 NVP: Audio is 8.19578 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.064 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.064 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.064 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.106 NVP: Audio is 8.13433 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.106 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.107 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.107 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.149 NVP: Audio is 8.06948 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.149 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.149 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.149 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.191 NVP: Audio is 8.0021 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.191 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.191 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.192 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.212 Image size. dispxoff 0, dispyoff: 75, dispwoff: 800, disphoff: 450
2005-12-23 21:39:40.212 Image size. imgx 20, imgy: 29, imgw: 634, imgh: 518
2005-12-23 21:39:40.254 NVP: Audio is 7.93283 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.264 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.264 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.265 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.661 NVP: Audio is 7.7371 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.662 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.662 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.662 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.672 NVP: Audio is 5.29658 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.673 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.673 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.674 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.685 NVP: Audio is 3.64742 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.688 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.689 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.689 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.701 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.701 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.701 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.710 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.710 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.711 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.723 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.723 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.723 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.734 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.734 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.735 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.743 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.743 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.744 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.757 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.757 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.757 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.769 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.769 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.769 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.778 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.779 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.779 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.789 NVP: Audio is 3.47905 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.791 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.792 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.792 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.800 NVP: Audio is 4.05302 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.801 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.802 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.802 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.822 NVP: Audio is 4.66475 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.824 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.824 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.824 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:40.986 NVP: Audio is 5.23605 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:40.987 AFD: Trying to reselect subtitle track
2005-12-23 21:39:40.987 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:40.987 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.325 NVP: Audio is 4.88952 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.325 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.326 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.326 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.338 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.338 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.338 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.350 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.350 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.350 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.358 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.358 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.358 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.370 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.370 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.370 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.382 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.382 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.382 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.394 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.394 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.394 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.405 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.406 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.406 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.419 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.420 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.420 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.432 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.433 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.433 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.445 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.446 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.446 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.451 NVP: Audio is 3.44585 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.458 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.458 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.458 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.459 AFD: positionMap[ 132 ] == 2258068.
2005-12-23 21:39:41.464 NVP: Audio is 4.15312 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.467 NVP: Audio is 4.85232 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.475 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.475 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.475 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.480 NVP: Audio is 5.60798 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.489 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.490 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.490 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.505 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.505 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.505 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.512 NVP: Audio is 6.34972 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.516 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.517 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.517 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.527 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.528 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.528 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.539 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.539 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.540 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.559 NVP: Audio is 6.94978 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.560 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.560 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.561 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.603 NVP: Audio is 7.35607 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.604 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.604 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.604 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.646 NVP: Audio is 7.6358 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.647 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.647 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.647 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.689 NVP: Audio is 7.82685 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.690 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.690 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.690 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.732 NVP: Audio is 7.95138 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.733 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.733 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.733 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.775 NVP: Audio is 8.02602 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.776 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.776 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.776 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.776 AFD: positionMap[ 144 ] == 2516380.
2005-12-23 21:39:41.818 NVP: Audio is 8.06325 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.818 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.818 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.818 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.860 NVP: Audio is 8.07242 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.861 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.861 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.861 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.903 NVP: Audio is 8.0668 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.903 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.904 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.904 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.946 NVP: Audio is 8.04385 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.947 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.947 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.947 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:41.989 NVP: Audio is 8.00788 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:41.989 AFD: Trying to reselect subtitle track
2005-12-23 21:39:41.989 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:41.990 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.032 NVP: Audio is 7.9684 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.033 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.033 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.033 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.075 NVP: Audio is 7.9263 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.075 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.075 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.075 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.117 NVP: Audio is 7.88223 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.118 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.118 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.118 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.160 NVP: Audio is 7.8304 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.160 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.160 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.160 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.202 NVP: Audio is 7.77905 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.203 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.203 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.203 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.245 NVP: Audio is 7.72802 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.245 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.245 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.246 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.288 NVP: Audio is 7.671 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.289 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.289 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.289 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.289 AFD: positionMap[ 156 ] == 2771684.
2005-12-23 21:39:42.331 NVP: Audio is 7.622 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.332 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.332 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.332 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.374 NVP: Audio is 7.5665 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.375 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.375 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.375 AFD: Selected subtitle track #0 in the Unknown language(2)
'video_output' mean = '41516.63', std. dev. = '51757.54', fps = '24.09'
2005-12-23 21:39:42.417 NVP: Audio is 7.50612 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.418 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.418 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.418 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.460 NVP: Audio is 7.44207 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.461 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.461 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.461 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.503 NVP: Audio is 7.3753 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.504 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.504 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.504 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.546 NVP: Audio is 7.31273 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.547 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.547 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.547 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.589 NVP: Audio is 7.24703 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.590 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.590 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.590 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.632 NVP: Audio is 7.179 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.633 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.633 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.633 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.674 NVP: Audio is 7.1155 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.675 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.675 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.675 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.717 NVP: Audio is 7.05538 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.718 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.718 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.718 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.760 NVP: Audio is 6.99153 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.761 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.761 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.761 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.803 NVP: Audio is 6.92487 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.804 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.804 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.804 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.804 AFD: positionMap[ 168 ] == 3025860.
2005-12-23 21:39:42.846 NVP: Audio is 6.85615 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.847 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.847 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.847 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.889 NVP: Audio is 6.78585 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.890 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.890 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.890 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.931 NVP: Audio is 6.71438 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.932 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.932 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.932 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:42.974 NVP: Audio is 6.64827 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:42.974 AFD: Trying to reselect subtitle track
2005-12-23 21:39:42.975 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:42.975 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.017 NVP: Audio is 6.57995 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.017 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.017 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.018 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.060 NVP: Audio is 6.50995 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.061 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.061 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.061 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.103 NVP: Audio is 6.4387 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.103 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.104 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.104 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.146 NVP: Audio is 6.37278 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.146 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.147 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.147 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.188 NVP: Audio is 6.31707 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.189 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.189 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.189 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.231 NVP: Audio is 6.2628 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.232 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.232 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.232 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.274 NVP: Audio is 6.20335 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.274 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.274 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.274 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.316 NVP: Audio is 6.14 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.316 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.317 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.317 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.317 AFD: positionMap[ 180 ] == 3272140.
2005-12-23 21:39:43.359 NVP: Audio is 6.08 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.359 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.359 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.359 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.402 NVP: Audio is 6.01625 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.403 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.403 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.403 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.445 NVP: Audio is 5.94968 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.445 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.445 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.446 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.488 NVP: Audio is 5.881 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.489 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.489 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.489 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.531 NVP: Audio is 5.81075 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.532 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.532 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.532 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.574 NVP: Audio is 5.74555 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.574 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.574 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.575 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.617 NVP: Audio is 5.6779 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.618 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.618 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.618 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.659 NVP: Audio is 5.60843 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.660 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.660 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.660 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.703 NVP: Audio is 5.5438 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.703 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.703 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.704 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.746 NVP: Audio is 5.47035 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.747 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.747 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.747 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.789 NVP: Audio is 5.3965 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.789 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.789 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.789 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.831 NVP: Audio is 5.32237 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.832 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.832 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.832 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.832 AFD: positionMap[ 192 ] == 3540792.
2005-12-23 21:39:43.874 NVP: Audio is 5.25427 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.875 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.875 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.875 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.917 NVP: Audio is 5.1907 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.918 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.918 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.918 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:43.960 NVP: Audio is 5.12428 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:43.960 AFD: Trying to reselect subtitle track
2005-12-23 21:39:43.960 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:43.960 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.003 NVP: Audio is 5.0557 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.004 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.004 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.004 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.047 NVP: Audio is 4.98553 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.047 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.047 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.048 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.090 NVP: Audio is 4.90788 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.090 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.091 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.091 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.133 NVP: Audio is 4.8309 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.134 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.134 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.134 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.175 NVP: Audio is 4.75443 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.176 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.176 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.176 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.218 NVP: Audio is 4.68455 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.218 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.218 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.218 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.260 NVP: Audio is 4.6134 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.261 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.261 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.261 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.304 NVP: Audio is 4.54755 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.305 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.305 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.305 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.347 NVP: Audio is 4.47315 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.348 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.348 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.348 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.348 AFD: positionMap[ 204 ] == 3807752.
2005-12-23 21:39:44.391 NVP: Audio is 4.3986 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.391 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.392 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.392 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.434 NVP: Audio is 4.3177 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.434 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.434 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.435 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.477 NVP: Audio is 4.24452 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.478 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.478 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.478 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.520 NVP: Audio is 4.17088 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.521 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.521 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.521 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.562 NVP: Audio is 4.0969 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.563 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.563 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.563 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.605 NVP: Audio is 4.02892 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.606 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.606 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.606 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.648 NVP: Audio is 3.96543 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.649 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.649 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.649 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.691 NVP: Audio is 3.89905 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.692 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.692 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.692 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.733 NVP: Audio is 3.83052 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.734 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.735 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.735 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.777 NVP: Audio is 3.76662 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.778 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.778 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.778 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.820 NVP: Audio is 3.7062 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.821 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.821 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.821 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.864 NVP: Audio is 3.64215 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.864 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.864 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.864 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.865 AFD: positionMap[ 216 ] == 4069448.
2005-12-23 21:39:44.907 NVP: Audio is 3.5691 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.907 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.907 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.907 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.950 NVP: Audio is 3.49557 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.950 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.950 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.951 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:44.993 NVP: Audio is 3.42793 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:44.993 AFD: Trying to reselect subtitle track
2005-12-23 21:39:44.993 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:44.994 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.036 NVP: Audio is 3.35842 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.036 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.036 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.036 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.079 NVP: Audio is 3.28755 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.079 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.079 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.079 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.121 NVP: Audio is 3.21565 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.121 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.122 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.122 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.163 NVP: Audio is 3.14922 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.164 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.164 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.165 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.206 NVP: Audio is 3.0869 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.207 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.207 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.207 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.250 NVP: Audio is 3.02767 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.250 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.251 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.251 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.293 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.293 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.293 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.329 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.329 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.330 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.349 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.349 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.349 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.350 AFD: positionMap[ 228 ] == 4317984.
2005-12-23 21:39:45.386 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.386 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.386 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.405 NVP: Audio is 3.08325 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.406 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.406 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.406 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.448 NVP: Audio is 3.28743 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.449 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.449 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.449 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.491 NVP: Audio is 3.4343 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.491 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.491 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.491 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.533 NVP: Audio is 3.52572 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.534 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.534 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.534 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.576 NVP: Audio is 3.58177 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.577 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.577 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.577 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.619 NVP: Audio is 3.60507 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.620 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.621 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.621 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.663 NVP: Audio is 3.59755 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.663 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.663 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.663 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.705 NVP: Audio is 3.57315 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.706 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.706 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.707 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.748 NVP: Audio is 3.54235 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.749 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.749 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.749 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.768 TV: SwitchCards(0,'')
2005-12-23 21:39:45.768 write -> 12 28      GET_NEXT_FREE_RECORDER[]:[]1
2005-12-23 21:39:45.791 NVP: Audio is 3.5005 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.791 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.791 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.791 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.800 read  <- 12 26      2[]:[]192.168.1.3[]:[]6543
2005-12-23 21:39:45.801 TV: Attempting to change from WatchingLiveTV to None
2005-12-23 21:39:45.801 TV: StopStuff() -- begin
2005-12-23 21:39:45.801 TV: StopStuff(): stopping ring buffer[s]
2005-12-23 21:39:45.833 NVP: Audio is 3.45038 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.834 AFD: Trying to reselect subtitle track
2005-12-23 21:39:45.834 AFD: Trying to select subtitle track (w/lang)
2005-12-23 21:39:45.834 AFD: Selected subtitle track #0 in the Unknown language(2)
2005-12-23 21:39:45.834 AFD: positionMap[ 240 ] == 4580244.
2005-12-23 21:39:45.846 TV: StopStuff(): stopping player[s] (1/2)
2005-12-23 21:39:45.847 TV: StopStuff(): stopping recorder[s]
2005-12-23 21:39:45.847 write -> 15 32      QUERY_RECORDER 1[]:[]STOP_LIVETV
2005-12-23 21:39:45.853 NVP: Exited decoder loop.
2005-12-23 21:39:45.876 NVP: Audio is 3.40027 frames ahead of video,
			doubling video frame interval.
2005-12-23 21:39:45.877 VideoOutputXv: dtor
2005-12-23 21:39:45.877 VideoBuffers::DiscardFrames(): UUUUUUAUUUUUUUULUUUUUUUUUUUUUUU
2005-12-23 21:39:45.877 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:39:45.923 read  <- 14 49      BACKEND_MESSAGE[]:[]DONE_RECORDING 1 15[]:[]empty
2005-12-23 21:39:46.087 read  <- 15 2       ok
2005-12-23 21:39:46.088 TV: StopStuff(): stopping player[s] (2/2)
2005-12-23 21:39:46.091 write -> 12 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:39:46.108 read  <- 14 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
2005-12-23 21:39:46.153 read  <- 14 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:39:46.176 read  <- 12 2       OK
2005-12-23 21:39:46.183 TV: StopStuff() -- end
2005-12-23 21:39:46.185 TV: Changing from WatchingLiveTV to None
2005-12-23 21:39:46.187 read  <- 14 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:39:46.201 TV: Attempting to change from None to WatchingLiveTV
2005-12-23 21:39:46.201 write -> 15 21      MYTH_PROTO_VERSION 22
2005-12-23 21:39:46.213 read  <- 15 13      ACCEPT[]:[]22
2005-12-23 21:39:46.213 Using protocol version 22
2005-12-23 21:39:46.213 write -> 15 20      ANN Playback neuvo 0
2005-12-23 21:39:46.227 read  <- 15 2       
and BE log from same session:

2005-12-23 21:36:36.884 Using runtime prefix = /usr/local
2005-12-23 21:36:36.948 New DB connection, total: 1
2005-12-23 21:36:36.960 Enabling Settings Cache.
2005-12-23 21:36:36.962 Clearing Settings Cache.
2005-12-23 21:36:36.969 Current Schema Version: 1120
Starting up as the master server.
2005-12-23 21:36:36.991 New DB connection, total: 2
2005-12-23 21:36:37.002 DVB#0 Opening DVB channel
2005-12-23 21:36:37.004 DVB#0 Using DVB card 0, with frontend 'ST STV0297 DVB-C'.
2005-12-23 21:36:37.007 DVB#0 Input #1: 'DVBInput' schan(17)
2005-12-23 21:36:37.009 DVB#0 Current Input #1: 'DVBInput'
2005-12-23 21:36:37.011 DVB#0 SetChannelByString(17)
2005-12-23 21:36:37.016 New DB connection, total: 3
2005-12-23 21:36:37.023 DVB#0 Frequency: 418000000 Symbol Rate: 6900000 Inversion: Auto Inner FEC: None
2005-12-23 21:36:37.024 DVB#0 Old Params: freq(0) type(QAM)
2005-12-23 21:36:37.027 DVB#0 New Params: freq(418000000) type(QAM)
2005-12-23 21:36:37.029 dvbchannel.cpp:wait_for_backend: Status: 
2005-12-23 21:36:37.051 DVB#0 DVBChannel::Tune: Frequency tuning successful.
2005-12-23 21:36:37.053 DVB#0 Tuned to frequency for channel 17.
2005-12-23 21:36:37.076 TVRec(1): SetFlags(RunMainLoop,) -> RunMainLoop,
2005-12-23 21:36:37.078 TVRec(1): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop,
2005-12-23 21:36:37.084 DVB#1 Opening DVB channel
2005-12-23 21:36:37.086 DVB#1 Using DVB card 1, with frontend 'ST STV0297 DVB-C'.
2005-12-23 21:36:37.089 DVB#1 Input #2: 'DVBInput' schan(17)
2005-12-23 21:36:37.091 DVB#1 Current Input #2: 'DVBInput'
2005-12-23 21:36:37.093 DVB#1 SetChannelByString(17)
2005-12-23 21:36:37.098 DVB#1 Frequency: 418000000 Symbol Rate: 6900000 Inversion: Auto Inner FEC: None
2005-12-23 21:36:37.100 DVB#1 Old Params: freq(0) type(QAM)
2005-12-23 21:36:37.102 DVB#1 New Params: freq(418000000) type(QAM)
2005-12-23 21:36:37.104 dvbchannel.cpp:wait_for_backend: Status: 
2005-12-23 21:36:37.127 DVB#1 DVBChannel::Tune: Frequency tuning successful.
2005-12-23 21:36:37.128 DVB#1 Tuned to frequency for channel 17.
2005-12-23 21:36:37.133 TVRec(2): SetFlags(RunMainLoop,) -> RunMainLoop,
2005-12-23 21:36:37.135 TVRec(2): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop,
2005-12-23 21:36:37.141 New DB scheduler connection
DVB-2 is defined, but isn't attached to a cardinput.
2005-12-23 21:36:37.160 JobQueue::RecoverQueue: Checking for unfinished jobs to recover.
2005-12-23 21:36:37.161 mythbackend version: 0.19.20051208-1 www.mythtv.org
2005-12-23 21:36:37.164 Enabled verbose msgs: all nodatabase
2005-12-23 21:36:37.167 AutoExpire: Found 2 recorders w/max rate of 277 MiB/min
2005-12-23 21:36:37.170 JobQueue::GetJobsInQueue: findJobs search bitmask 4, found 1 total jobs
2005-12-23 21:36:37.173 AutoExpire: Required Free Space: 3.2 GB w/freq: 5 min
2005-12-23 21:36:37.176 JobQueue::GetJobsInQueue: Ignore 'Flag Commercials' Job for 1097 @ 20051220220000 in Finished state.
2005-12-23 21:36:39.161 Reschedule requested for id -1.
Query 0: /record.search = :NRST AND (record.recordid = :NRRECORDID OR :NRRECORDID = -1) AND program.manualid = 0 AND program.title = record.title 
2005-12-23 21:36:39.193  |-- Start DB Query 0...
2005-12-23 21:36:39.268  |-- -1 results in 0.073552 sec.
2005-12-23 21:36:39.275  +-- Done.
2005-12-23 21:36:39.281 PruneOldRecords...
2005-12-23 21:36:39.283 AddNewRecords...
2005-12-23 21:36:39.289  |-- Start DB Query...
2005-12-23 21:36:39.304  |-- 4 results in 0.012861 sec. Processing...
2005-12-23 21:36:39.314  +-- Cleanup...
2005-12-23 21:36:39.316 AddNotListed...
2005-12-23 21:36:39.319  |-- Start DB Query...
2005-12-23 21:36:39.325  |-- 0 results in 0.002736 sec. Processing...
2005-12-23 21:36:39.327 Sort by time...
2005-12-23 21:36:39.329 PruneOverlaps...
2005-12-23 21:36:39.331 Sort by priority...
2005-12-23 21:36:39.333 BuildListMaps...
2005-12-23 21:36:39.335 SchedNewRecords...
2005-12-23 21:36:39.337 Scheduling:
  +Shield - Lain varjolla (K15)          65 1065  27 21:00-22:00  1 1 1  w 1  -1
  +C.S.I.                                49 1049  28 21:00-21:55  1 1 1  w 1  -1
2005-12-23 21:36:39.343 ClearListMaps...
2005-12-23 21:36:39.345 Sort by time...
2005-12-23 21:36:39.347 PruneRedundants...
2005-12-23 21:36:39.349 Sort by time...
--- print list start ---
Title - Subtitle                    Chan ChID Day Start  End   S C I  T N Pri
Shield - Lain varjolla (K15)          65 1065  27 21:00-22:00  1 1 1  w 1  -1
C.S.I.                                49 1049  28 21:00-21:55  1 1 1  w 1  -1
---  print list end  ---
2005-12-23 21:36:39.356 Scheduled 2 items in 0.2 = 0.12 match + 0.07 place
2005-12-23 21:36:39.369 Seem to be woken up by USER
2005-12-23 21:36:47.187 JobQueue::ProcessQueue() started
2005-12-23 21:36:47.201 JobQueue currently set at 4 job(s) max and to run new jobs from 00:00 to 23:59
2005-12-23 21:36:47.204 JobQueue::GetJobsInQueue: findJobs search bitmask 4, found 1 total jobs
2005-12-23 21:36:47.207 JobQueue::GetJobsInQueue: Ignore 'Flag Commercials' Job for 1097 @ 20051220220000 in Finished state.
2005-12-23 21:36:56.607 read  <- 14 21      MYTH_PROTO_VERSION 22
2005-12-23 21:36:56.609 write -> 14 13      ACCEPT[]:[]22
2005-12-23 21:36:56.617 read  <- 14 19      ANN Monitor neuvo 0
2005-12-23 21:36:56.619 MainServer::HandleAnnounce Monitor
2005-12-23 21:36:56.621 adding: neuvo as a client (events: 0)
2005-12-23 21:36:56.623 write -> 14 2       OK
2005-12-23 21:36:56.637 read  <- 14 29      GET_NEXT_FREE_RECORDER[]:[]-1
2005-12-23 21:36:56.639 Getting next free recorder after : -1
2005-12-23 21:36:56.645 Card 1 is local.
2005-12-23 21:36:56.647 write -> 14 26      1[]:[]192.168.1.3[]:[]6543
2005-12-23 21:36:56.660 read  <- 15 19      ANN Monitor neuvo 1
2005-12-23 21:36:56.662 MainServer::HandleAnnounce Monitor
2005-12-23 21:36:56.664 adding: neuvo as a client (events: 1)
2005-12-23 21:36:56.667 write -> 15 2       OK
2005-12-23 21:36:56.665 read  <- 16 21      MYTH_PROTO_VERSION 22
2005-12-23 21:36:56.670 write -> 16 13      ACCEPT[]:[]22
2005-12-23 21:36:56.677 read  <- 16 20      ANN Playback neuvo 0
2005-12-23 21:36:56.679 MainServer::HandleAnnounce Playback
2005-12-23 21:36:56.681 adding: neuvo as a client (events: 0)
2005-12-23 21:36:56.683 write -> 16 2       OK
2005-12-23 21:36:56.706 read  <- 16 74      QUERY_RECORDER 1[]:[]SPAWN_LIVETV[]:[]live-neuvo-2005-12-23T21:39...
2005-12-23 21:36:56.711 TVRec(1): Changing from None to WatchingLiveTV
2005-12-23 21:36:56.715 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
2005-12-23 21:36:56.717 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,
2005-12-23 21:36:56.719 TVRec(1): Request: Program(no) channel() input() flags(LiveTV,)
2005-12-23 21:36:56.721 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,
2005-12-23 21:36:56.725 DVB#0 Opening DVB channel
2005-12-23 21:36:56.727 DVB#0 SetChannelByString(17)
2005-12-23 21:36:56.729 DVB#0 SetChannelByString(17): already on channel
2005-12-23 21:36:56.731 TVRec(1): CreateLiveTVRingBuffer()
2005-12-23 21:36:56.733 TVRec(1): GetProgramRingBufferForLiveTV()
2005-12-23 21:36:56.927 TVRec(1): StartedRecording(0x81d4820) fn(/home/mythtv/programs/1017_20051223213656.mpg)
2005-12-23 21:36:56.933 write -> 15 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:36:56.957 Chain: Appended@0 '1017_20051223213656'
2005-12-23 21:36:56.984 RecBase(/dev/video): SetRingBuffer(0x81f3a70) '/home/mythtv/programs/1017_20051223213656.mpg'
2005-12-23 21:36:56.986 RecBase(/dev/video): SetRecording(0x81d4820) title(: Matti Salminen med vänner)
2005-12-23 21:36:56.988 TVRec(1): Starting Signal Monitor
2005-12-23 21:36:56.990 TVRec(1): SetupSignalMonitor(1, 1)
2005-12-23 21:36:56.992 DVB#0 Opening DVB channel
2005-12-23 21:36:56.999 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,BER,UB,)
2005-12-23 21:36:57.000 DVBSM(0)::constructor(): initial flags 0x7400000
2005-12-23 21:36:57.002 TVRec(1): Signal monitor successfully created
2005-12-23 21:36:57.004 TVRec(1): Setting up table monitoring.
2005-12-23 21:36:57.006 TVRec(1): MPEG program number: 17
2005-12-23 21:36:57.010 DTVSM(0)::SetProgramNumber(17): 
2005-12-23 21:36:57.012 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
2005-12-23 21:36:57.014 SM(0)::AddFlags: Seen() Match() Wait(PMT,)
2005-12-23 21:36:57.016 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,)
2005-12-23 21:36:57.090 TVRec(1): Successfully set up MPEG table monitoring.
2005-12-23 21:36:57.092 SM(0)::Start: begin
2005-12-23 21:36:57.095 SM(0)::Start: end
2005-12-23 21:36:57.099 TVRec(1): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,
2005-12-23 21:36:57.101 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,
2005-12-23 21:36:57.104 TVRec(1): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,
2005-12-23 21:36:57.100 DVBSM(0)::UpdateValues: Signal Locked
2005-12-23 21:36:57.107 DVBSM(0)::UpdateValues: Waiting for table monitor to start
2005-12-23 21:36:57.109 DVBSM(0)::UpdateValues: Table monitor started
2005-12-23 21:36:57.111 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0)
2005-12-23 21:36:57.109 DVBSM(0)::AddPIDFilter(0x0): 
2005-12-23 21:36:57.105 DummyDTVRecorder::StartRecording -- begin
2005-12-23 21:36:57.116 DVBSM(0)::RemovePIDFilter(0x0): 
2005-12-23 21:36:57.165 AutoExpire: Adding Programs to 'Do Not Expire' List
2005-12-23 21:36:57.169     1017 @ Fri Dec 23 21:36:56 2005 in use by recorder on neuvo
2005-12-23 21:36:57.172 AutoExpire: ExpireLiveTV(10000)
2005-12-23 21:36:57.178 AutoExpire: SendDeleteMessages. Nothing to expire.
2005-12-23 21:36:57.219 DVBSM(0): RunTableMonitorTS(): begin (# of pids 2)
2005-12-23 21:36:57.230 DVBSM(0)::AddPIDFilter(0x0): 
2005-12-23 21:36:57.231 DVBSM(0)::AddPIDFilter(0x1ffb): 
2005-12-23 21:36:57.233 TVRec(1): SetFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,
2005-12-23 21:36:57.235 DummyDTVRecorder -- started
2005-12-23 21:36:57.237 TVRec(1): SetFlags(RingBufferReset,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset,
2005-12-23 21:36:57.239 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset,
2005-12-23 21:36:57.241 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset,
2005-12-23 21:36:57.243 write -> 16 2       ok
2005-12-23 21:36:57.246 write -> 15 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
2005-12-23 21:36:57.250 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.254 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.259 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.272 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.273 SM(0)::AddFlags: Seen(PAT,) Match() Wait()
2005-12-23 21:36:57.282 read  <- 16 33      QUERY_RECORDER 1[]:[]IS_RECORDING
2005-12-23 21:36:57.346 write -> 16 1       1
2005-12-23 21:36:57.349 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.276 SM(0)::AddFlags: Seen() Match(PAT,) Wait()
2005-12-23 21:36:57.353 CreatePATSingleProgram()
2005-12-23 21:36:57.355 PAT in input stream
2005-12-23 21:36:57.356 read  <- 16 33      QUERY_RECORDER 1[]:[]IS_RECORDING
2005-12-23 21:36:57.359 write -> 16 1       1
2005-12-23 21:36:57.358 Program Association Table
 PSIP prefix(0x0) tableID(0x0) length(77) extension(0x3)
      version(26) current(1) section(0) last_section(0)
         tsid: 3
 programCount: 17
  program number 0 has PID 0x  10   data  0x0 0x0 0x224 0x16
  program number 17 has PID 0x189c   data  0x0 0x17 0x248 0x156
  program number 33 has PID 0x189d   data  0x0 0x33 0x248 0x157
  program number 81 has PID 0x189e   data  0x0 0x81 0x248 0x158
  program number 129 has PID 0x189f   data  0x0 0x129 0x248 0x159
  program number 145 has PID 0x18a0   data  0x0 0x145 0x248 0x160
  program number 4369 has PID 0x18b0   data  0x17 0x17 0x248 0x176
  program number 4385 has PID 0x18b1   data  0x17 0x33 0x248 0x177
  program number 4401 has PID 0x18b2   data  0x17 0x49 0x248 0x178
  program number 4417 has PID 0x18b3   data  0x17 0x65 0x248 0x179
  program number 4433 has PID 0x18b4   data  0x17 0x81 0x248 0x180
  program number 4481 has PID 0x18b5   data  0x17 0x129 0x248 0x181
  program number 8212 has PID 0x1af4   data  0x32 0x20 0x250 0x244
  program number 61440 has PID 0x18bb   data  0x240 0x0 0x248 0x187
  program number 7095 has PID 0x18c0   data  0x27 0x183 0x248 0x192
  program number 7098 has PID 0x18c3   data  0x27 0x186 0x248 0x195
  program number 7100 has PID 0x18c5   data  0x27 0x188 0x248 0x197

2005-12-23 21:36:57.364 desired_program(17) pid(0x189c)
2005-12-23 21:36:57.367 pmt_pid(0x189c)
2005-12-23 21:36:57.369 PAT for output stream
2005-12-23 21:36:57.370 read  <- 16 34      QUERY_RECORDER 1[]:[]GET_FRAMERATE
2005-12-23 21:36:57.373 write -> 16 2       -1
2005-12-23 21:36:57.372 Program Association Table
 PSIP prefix(0x0) tableID(0x0) length(13) extension(0x3)
      version(26) current(1) section(0) last_section(0)
         tsid: 3
 programCount: 1
  program number 1 has PID 0x189c   data  0x0 0x1 0x248 0x156

2005-12-23 21:36:57.375 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.379 DVBSM(0)::AddPIDFilter(0x189c): 
2005-12-23 21:36:57.387 DummyRec: Restart! Frames seen 11
2005-12-23 21:36:57.398 read  <- 14 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:36:57.401 write -> 14 2       OK
2005-12-23 21:36:57.403 write -> 15 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:36:57.428 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.481 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.534 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.552 DummyRec: Restart! Frames seen 22
2005-12-23 21:36:57.586 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.587 Parsed PMT(0x0x81f5438) Program Map Table ver(22) pid(0x189c) pnum(17)

 Stream #0 pid(0x200) type(video-mpeg2  0x2)
 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(fin) canonical(fin) eng(Finnish)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #2 pid(0x28b) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(swe) canonical(swe) eng(Swedish)
 Stream #3 pid(0x28c) type(audio-mp2-layer[1,2,3]  0x4)
  Audio Descriptor (0x3) length(1)
  ISO-639 Language: code(dut) canonical(dut) eng(Dutch; Flemish)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #4 pid(0x911) type(private-data  0x6)
  Teletext Descriptor (0x56) length(5)
 Stream #5 pid(0x403) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)
 Stream #6 pid(0x404) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)
 Stream #7 pid(0xc30) type(private-sec  0x5)
  Application Signalling Descriptor (0x6f) length(0)
 Stream #8 pid(0xc26) type(dsmcc-b std data  0x11)
  Stream Identifier Descriptor (0x52) length(1)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #9 pid(0xc27) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #10 pid(0xc28) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #11 pid(0xc29) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #12 pid(0xc2a) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #13 pid(0xc2b) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #14 pid(0xc2c) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)

2005-12-23 21:36:57.593 SM(0)::AddFlags: Seen(PMT,) Match() Wait()
2005-12-23 21:36:57.595 SM(0)::AddFlags: Seen() Match(PMT,) Wait()
2005-12-23 21:36:57.597 CreatePMTSingleProgram()
2005-12-23 21:36:57.599 PMT in input stream
2005-12-23 21:36:57.601 Program Map Table ver(22) pid(0x189c) pnum(17)

 Stream #0 pid(0x200) type(video-mpeg2  0x2)
 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(fin) canonical(fin) eng(Finnish)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #2 pid(0x28b) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(swe) canonical(swe) eng(Swedish)
 Stream #3 pid(0x28c) type(audio-mp2-layer[1,2,3]  0x4)
  Audio Descriptor (0x3) length(1)
  ISO-639 Language: code(dut) canonical(dut) eng(Dutch; Flemish)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #4 pid(0x911) type(private-data  0x6)
  Teletext Descriptor (0x56) length(5)
 Stream #5 pid(0x403) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)
 Stream #6 pid(0x404) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)
 Stream #7 pid(0xc30) type(private-sec  0x5)
  Application Signalling Descriptor (0x6f) length(0)
 Stream #8 pid(0xc26) type(dsmcc-b std data  0x11)
  Stream Identifier Descriptor (0x52) length(1)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #9 pid(0xc27) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #10 pid(0xc28) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #11 pid(0xc29) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #12 pid(0xc2a) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #13 pid(0xc2b) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #14 pid(0xc2c) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)

2005-12-23 21:36:57.605 Parsed PMT(0x0x81f5438) Program Map Table ver(22) pid(0x189c) pnum(17)

 Stream #0 pid(0x200) type(video-mpeg2  0x2)
 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(fin) canonical(fin) eng(Finnish)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #2 pid(0x28b) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(swe) canonical(swe) eng(Swedish)
 Stream #3 pid(0x28c) type(audio-mp2-layer[1,2,3]  0x4)
  Audio Descriptor (0x3) length(1)
  ISO-639 Language: code(dut) canonical(dut) eng(Dutch; Flemish)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #4 pid(0x911) type(private-data  0x6)
  Teletext Descriptor (0x56) length(5)
 Stream #5 pid(0x403) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)
 Stream #6 pid(0x404) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)
 Stream #7 pid(0xc30) type(private-sec  0x5)
  Application Signalling Descriptor (0x6f) length(0)
 Stream #8 pid(0xc26) type(dsmcc-b std data  0x11)
  Stream Identifier Descriptor (0x52) length(1)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #9 pid(0xc27) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #10 pid(0xc28) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #11 pid(0xc29) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #12 pid(0xc2a) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #13 pid(0xc2b) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
 Stream #14 pid(0xc2c) type(dsmcc-b std data  0x11)
  Maximum Bitrate Descriptor (0xe) length(3)
  Unknown(19) Descriptor (0x13) length(5)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)

2005-12-23 21:36:57.609 Parsed PMT(0x0x81cfbc0) Program Map Table ver(0) pid(0x0) pnum(0)


2005-12-23 21:36:57.611 PMT for output stream
2005-12-23 21:36:57.613 Program Map Table ver(22) pid(0x189c) pnum(1)

 Stream #0 pid(0x200) type(video-mpeg2  0x2)
 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3]  0x4)
 Stream #2 pid(0x28b) type(audio-mp2-layer[1,2,3]  0x4)
 Stream #3 pid(0x28c) type(audio-mp2-layer[1,2,3]  0x4)

2005-12-23 21:36:57.651 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1)
2005-12-23 21:36:57.653 TVRec(1): Got good signal
2005-12-23 21:36:57.655 TVRec(1): MPEG program num(17)
2005-12-23 21:36:57.658 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.659 TVRec(1): TeardownSignalMonitor() -- begin
2005-12-23 21:36:57.663 DVBSM(0)::Stop: begin
2005-12-23 21:36:57.668 SM(0)::Stop: begin
2005-12-23 21:36:57.669 DummyRec: Restart! Frames seen 33
2005-12-23 21:36:57.713 write -> 15 449     BACKEND_MESSAGE[]:[]SIGNAL 1[]:[]Signal Lock[]:[]slock 1 1 0 1 30...
2005-12-23 21:36:57.713 SM(0)::Stop: end
2005-12-23 21:36:57.717 DVBSM(0): RunTableMonitorTS(): shutdown
2005-12-23 21:36:57.719 DVBSM(0)::RemovePIDFilter(0x0): 
2005-12-23 21:36:57.724 DVBSM(0)::RemovePIDFilter(0x189c): 
2005-12-23 21:36:57.728 DVBSM(0)::RemovePIDFilter(0x1ffb): 
2005-12-23 21:36:57.733 DVBSM(0): RunTableMonitorTS(): end
2005-12-23 21:36:57.735 DVBSM(0)::Stop: end
2005-12-23 21:36:57.738 DVBSM(0)::Stop: begin
2005-12-23 21:36:57.734 DummyRec: Restart! Frames seen 44
2005-12-23 21:36:57.740 SM(0)::Stop: begin
2005-12-23 21:36:57.743 SM(0)::Stop: end
2005-12-23 21:36:57.750 DVBSM(0)::Stop: end
2005-12-23 21:36:57.754 DVBSM(0)::Stop: begin
2005-12-23 21:36:57.757 SM(0)::Stop: begin
2005-12-23 21:36:57.761 SM(0)::Stop: end
2005-12-23 21:36:57.764 DVBSM(0)::Stop: end
2005-12-23 21:36:57.774 DVBSM(0)::Stop: begin
2005-12-23 21:36:57.792 TVRec(1): TeardownSignalMonitor() -- end
2005-12-23 21:36:57.816 TVRec(1): ClearFlags(WaitingForSignal,SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReset,
2005-12-23 21:36:57.814 SM(0)::Stop: begin
2005-12-23 21:36:57.822 SM(0)::Stop: end
2005-12-23 21:36:57.821 TVRec(1): prog_num(17) vs. dvbc->srv_id(17)
2005-12-23 21:36:57.825 DVBSM(0)::Stop: end
2005-12-23 21:36:57.829 SM(0)::Stop: begin
2005-12-23 21:36:57.827 SIParser: About to do a reset
2005-12-23 21:36:57.837 SIParser: Descriptor Stats -- begin
2005-12-23 21:36:57.836 SM(0)::Stop: end
2005-12-23 21:36:57.841 SIParser: Descriptor Stats -- end
2005-12-23 21:36:57.844 SIParser: Closing all PIDs
2005-12-23 21:36:57.846 SIParser: DelAllPids does nothing
2005-12-23 21:36:57.848 SIParser: Resetting all Table Handlers
2005-12-23 21:36:57.850 SIParser: SIParser Reset due to channel change
2005-12-23 21:36:57.842 DummyRec: Restart! Frames seen 55
2005-12-23 21:36:57.859 SIParser: Added initial preferred language 'fin' with priority 1
2005-12-23 21:36:57.864 SIParser: Added initial preferred language 'eng' with priority 2
2005-12-23 21:36:57.885 DVB#0 DVB SI Table Parser Started
2005-12-23 21:36:57.891 SIParser: ReinitSIParser(std dvb, service #17)
2005-12-23 21:36:57.896 FillPMap(str dvb)
2005-12-23 21:36:57.917 FillPMap(SIS dvb)
2005-12-23 21:36:57.919 SIParser: Requesting PAT
2005-12-23 21:36:57.928 SIParser: Adding PMT program number #17 to the request list
2005-12-23 21:36:57.937 TVRec(1): SetFlags(WaitingForSIParser,SIParserRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSIParser,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReset,
2005-12-23 21:36:57.936 DummyRec: Restart! Frames seen 66
2005-12-23 21:36:57.892 DVBSIParser: Starting DVB Section Reader thread
2005-12-23 21:36:57.943 SIParser: Table[0]->RequirePIDs() == true
2005-12-23 21:36:57.953 DVBSIParser: Adding PID 0x   0 Filter 0x 0 Mask 0xff Buffer 40960
2005-12-23 21:36:57.976 SIParser: Table[2]->RequirePIDs() == true
2005-12-23 21:36:57.979 DVBSIParser: Adding PID 0x1ffb Filter 0xff Mask 0x 0 Buffer 40960
2005-12-23 21:36:57.987 SIParser: Table[3]->RequirePIDs() == true
2005-12-23 21:36:57.994 DummyRec: Restart! Frames seen 77
2005-12-23 21:36:57.995 DVBSIParser: Adding PID 0x1ffb Filter 0xff Mask 0x 0 Buffer 40960
2005-12-23 21:36:58.000 SIParser: Table[6]->RequirePIDs() == true
2005-12-23 21:36:58.046 DVBSIParser: Adding PID 0x  10 Filter 0x40 Mask 0xff Buffer 40960
2005-12-23 21:36:58.069 DummyRec: Restart! Frames seen 88
2005-12-23 21:36:58.085 SIParser: PAT Version = 26
2005-12-23 21:36:58.108 SIParser: Tuned to TransportID: 3
2005-12-23 21:36:58.111 SIParser: NIT Present on this transport on PID 0x10
2005-12-23 21:36:58.113 SIParser: PMT pn(17) on PID 0x189c
2005-12-23 21:36:58.115 SIParser: PMT pn(33) on PID 0x189d
2005-12-23 21:36:58.117 SIParser: PMT pn(81) on PID 0x189e
2005-12-23 21:36:58.119 SIParser: PMT pn(129) on PID 0x189f
2005-12-23 21:36:58.121 SIParser: PMT pn(145) on PID 0x18a0
2005-12-23 21:36:58.123 SIParser: PMT pn(4369) on PID 0x18b0
2005-12-23 21:36:58.125 SIParser: PMT pn(4385) on PID 0x18b1
2005-12-23 21:36:58.127 SIParser: PMT pn(4401) on PID 0x18b2
2005-12-23 21:36:58.129 SIParser: PMT pn(4417) on PID 0x18b3
2005-12-23 21:36:58.131 SIParser: PMT pn(4433) on PID 0x18b4
2005-12-23 21:36:58.133 SIParser: PMT pn(4481) on PID 0x18b5
2005-12-23 21:36:58.135 SIParser: PMT pn(8212) on PID 0x1af4
2005-12-23 21:36:58.138 SIParser: PMT pn(61440) on PID 0x18bb
2005-12-23 21:36:58.140 SIParser: PMT pn(7095) on PID 0x18c0
2005-12-23 21:36:58.142 SIParser: PMT pn(7098) on PID 0x18c3
2005-12-23 21:36:58.144 SIParser: PMT pn(7100) on PID 0x18c5
2005-12-23 21:36:58.146 SIParser: Services on this Transport: 17 33 81 129 145 4369 4385 4401 4417 4433 4481 7095 7098 7100 8212 61440 
2005-12-23 21:36:58.148 SIParser: Table[0]->Complete() == true
2005-12-23 21:36:58.150 SIParser: Table[1]->RequirePIDs() == true
2005-12-23 21:36:58.152 DVBSIParser: Adding PID 0x189c Filter 0x 2 Mask 0xff Buffer 40960
2005-12-23 21:36:58.252 SIParser: PMT pn(17) version(22)
2005-12-23 21:36:58.254 SIParser: PID: 0x200
2005-12-23 21:36:58.256 SIParser: PID: 0x28a
2005-12-23 21:36:58.258 SIParser: PID: 0x28b
2005-12-23 21:36:58.260 SIParser: PID: 0x28c
2005-12-23 21:36:58.262 SIParser: PID: 0x911
2005-12-23 21:36:58.264 SIParser: Teletext Descriptor
2005-12-23 21:36:58.266 SIParser: ParseDescTT(): lang: fin, type: 1, mag: 1, page: 0
2005-12-23 21:36:58.268 SIParser: PID: 0x403
2005-12-23 21:36:58.270 SIParser: Subtitling Descriptor
2005-12-23 21:36:58.273 SIParser: ParseDescSub(): lang: fin, type: 17, comp: 1, anc: 50
2005-12-23 21:36:58.277 SIParser: PID: 0x404
2005-12-23 21:36:58.280 SIParser: Subtitling Descriptor
2005-12-23 21:36:58.282 SIParser: ParseDescSub(): lang: swe, type: 17, comp: 2, anc: 50
2005-12-23 21:36:58.285 SIParser: PID: 0xc30
2005-12-23 21:36:58.287 SIParser: PID: 0xc26
2005-12-23 21:36:58.293 SIParser: PID: 0xc27
2005-12-23 21:36:58.295 SIParser: PID: 0xc28
2005-12-23 21:36:58.298 SIParser: PID: 0xc29
2005-12-23 21:36:58.301 SIParser: PID: 0xc2a
2005-12-23 21:36:58.304 SIParser: PID: 0xc2b
2005-12-23 21:36:58.306 SIParser: PID: 0xc2c
2005-12-23 21:36:58.309 SIParser: Table[1]->EmitRequired() == true
2005-12-23 21:36:58.326 DummyRec: Restart! Frames seen 99
2005-12-23 21:36:58.330 DVB#0 SetPMT  ServiceID=17, PCRPID=128 (0x80)
2005-12-23 21:36:58.356 TVRec(1): Got SIParser PMT
2005-12-23 21:36:58.358 TVRec(1): ClearFlags(WaitingForSIParser,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReset,
2005-12-23 21:36:58.362 TVRec(1): Starting Recorder
2005-12-23 21:36:58.360 SIParser: No Private Types defined for NetworkID 0
2005-12-23 21:36:58.365 DummyDTVRecorder::StopRecordingThread(void)
2005-12-23 21:36:58.370 SIParser: Table[6]->Complete() == true
2005-12-23 21:36:58.374 SIParser: Table[5]->RequirePIDs() == true
2005-12-23 21:36:58.376 DVBSIParser: Adding PID 0x  11 Filter 0x46 Mask 0xfb Buffer 40960
2005-12-23 21:36:58.378 DummyDTVRecorder::FinishRecording()
2005-12-23 21:36:58.406 DummyDTVRecorder::StartRecording -- end
2005-12-23 21:36:58.407 TVRec(1): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReset,
2005-12-23 21:36:58.416 Chain: Updated endtime for '1017_20051223213656' to 20051223213658
2005-12-23 21:36:58.425 Finished recording : Matti Salminen med vänner: channel 1017
2005-12-23 21:36:58.426 write -> 15 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
2005-12-23 21:36:58.445 TVRec(1): Using profile 'Live TV' to record
2005-12-23 21:36:58.451 TVRec(1): SwitchLiveTVRingBuffer(discont 1, set_rec 0)
2005-12-23 21:36:58.453 TVRec(1): GetProgramRingBufferForLiveTV()
2005-12-23 21:36:58.539 TVRec(1): StartedRecording(0x820bfe8) fn(/home/mythtv/programs/1017_20051223213658.mpg)
2005-12-23 21:36:58.556 write -> 15 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:36:58.557 SIParser: SDT: NetworkID=0 TransportID=1
2005-12-23 21:36:58.576 SIParser: SDT: sid=202 type=1 eit_present=1 eit_requested=1 name=CNN
2005-12-23 21:36:58.578 SIParser: SDT: sid=406 type=1 eit_present=1 eit_requested=1 name=Discovery

2005-12-23 21:36:58.581 SIParser: SDT: sid=407 type=1 eit_present=1 eit_requested=1 name=Animal Planet
2005-12-23 21:36:58.585 SIParser: SDT: sid=870 type=1 eit_present=1 eit_requested=1 name=Barnkanalen
2005-12-23 21:36:58.587 SIParser: SDT: sid=1103 type=1 eit_present=1 eit_requested=1 name=BBC Prime
2005-12-23 21:36:58.571 Preview: 'myth://192.168.1.3:6543/1017_20051223213656.mpg' is not local, 
			replacing with '/home/mythtv/programs/1017_20051223213656.mpg', which is local.
2005-12-23 21:36:58.591 SIParser: SDT: sid=1010 type=1 eit_present=1 eit_requested=1 name=SVT1
2005-12-23 21:36:58.612 SIParser: SDT: sid=1040 type=1 eit_present=1 eit_requested=1 name=TV4
2005-12-23 21:36:58.616 SIParser: SDT: sid=5030 type=1 eit_present=1 eit_requested=1 name=SVT2
2005-12-23 21:36:58.613 Chain: Appended@1 '1017_20051223213658'
2005-12-23 21:36:58.619 SIParser: SDT: sid=61500 type=1 eit_present=0 eit_requested=0 name=TV7
2005-12-23 21:36:58.623 SIParser: Table[4]->RequirePIDs() == true
2005-12-23 21:36:58.621 write -> 15 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
2005-12-23 21:36:58.624 DummyDTVRecorder::StopRecordingThread(void)
2005-12-23 21:36:58.626 DVBSIParser: Adding PID 0x  12 Filter 0x7f Mask 0x80 Buffer 4096000
2005-12-23 21:36:58.632 TVRec(1): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReset,
2005-12-23 21:36:58.632 DummyDTVRecorder::StopRecordingThread(void)
2005-12-23 21:36:58.644 RingBuf(/home/mythtv/programs/1017_20051223213656.mpg): OpenFile(/home/mythtv/programs/1017_20051223213656.mpg, 0)
2005-12-23 21:36:58.661 SIParser: SDT: NetworkID=15 TransportID=3
2005-12-23 21:36:58.683 SIParser: SDT: sid=17 type=1 eit_present=1 eit_requested=1 name=YLE TV1
2005-12-23 21:36:58.715 SIParser: SDT: sid=33 type=1 eit_present=1 eit_requested=1 name=YLE TV2
2005-12-23 21:36:58.744 SIParser: SDT: sid=81 type=1 eit_present=1 eit_requested=1 name=YLE FST
2005-12-23 21:36:58.766 RecBase(0): SetRingBuffer(0x8221e58) '/home/mythtv/programs/1017_20051223213658.mpg'
2005-12-23 21:36:58.774 RecBase(0): SetRecording(0x8223708) title(: Matti Salminen med vänner)
2005-12-23 21:36:58.773 SIParser: SDT: sid=129 type=1 eit_present=1 eit_requested=1 name=YLE24
2005-12-23 21:36:58.784 SIParser: SDT: sid=145 type=1 eit_present=1 eit_requested=1 name=YLE Teema
2005-12-23 21:36:58.795 SIParser: SDT: sid=4369 type=2 eit_present=1 eit_requested=0 name=YLE PEILI
2005-12-23 21:36:58.803 SIParser: SDT: sid=4385 type=2 eit_present=1 eit_requested=0 name=YLEQ
2005-12-23 21:36:58.814 SIParser: SDT: sid=4401 type=2 eit_present=1 eit_requested=0 name=YLEN KLASSINEN
2005-12-23 21:36:58.824 SIParser: SDT: sid=4417 type=2 eit_present=1 eit_requested=0 name=YLE FSR+
2005-12-23 21:36:58.836 SIParser: SDT: sid=4433 type=2 eit_present=1 eit_requested=0 name=YLEMONDO
2005-12-23 21:36:58.845 SIParser: SDT: sid=4481 type=2 eit_present=1 eit_requested=0 name=YLE X3M
2005-12-23 21:36:58.847 SIParser: SDT: sid=61440 type=12 eit_present=0 eit_requested=0 name=Bootload Digibox
2005-12-23 21:36:58.850 SIParser: SDT: sid=7098 type=130 eit_present=0 eit_requested=0 name=Nokia SW Update
2005-12-23 21:36:58.854 SIParser: SDT: sid=7100 type=130 eit_present=0 eit_requested=0 name=Nokia SW Update
2005-12-23 21:36:58.857 SIParser: SDT: sid=7095 type=129 eit_present=0 eit_requested=0 name=Opentech bootload
2005-12-23 21:36:58.860 SIParser: Added preferred language 'swe' with priority 3
2005-12-23 21:36:58.870 SIParser: SDT: NetworkID=0 TransportID=4
2005-12-23 21:36:58.873 SIParser: SDT: sid=1140 type=1 eit_present=1 eit_requested=1 name=TV1000
2005-12-23 21:36:58.876 SIParser: SDT: sid=1150 type=1 eit_present=1 eit_requested=1 name=TV1000 Action
2005-12-23 21:36:58.878 SIParser: SDT: sid=3100 type=1 eit_present=1 eit_requested=1 name=TV1000 PlusOne
2005-12-23 21:36:58.881 SIParser: SDT: sid=3110 type=1 eit_present=1 eit_requested=1 name=TV1000 Family
2005-12-23 21:36:58.884 SIParser: SDT: sid=3120 type=1 eit_present=1 eit_requested=1 name=TV1000 Nordic
2005-12-23 21:36:58.893 SIParser: SDT: sid=3130 type=1 eit_present=1 eit_requested=1 name=TV1000 Classic
2005-12-23 21:36:58.897 SIParser: SDT: sid=7050 type=1 eit_present=1 eit_requested=1 name=Explorer
2005-12-23 21:36:58.922 SIParser: SDT: NetworkID=0 TransportID=5
2005-12-23 21:36:58.925 SIParser: SDT: sid=1609 type=1 eit_present=1 eit_requested=1 name=Star!
2005-12-23 21:36:58.929 SIParser: SDT: sid=2111 type=1 eit_present=1 eit_requested=1 name=Showtime
2005-12-23 21:36:58.932 SIParser: SDT: sid=3180 type=1 eit_present=1 eit_requested=1 name=Disney Channel
2005-12-23 21:36:58.934 SIParser: SDT: sid=3401 type=1 eit_present=1 eit_requested=1 name=RAI1
2005-12-23 21:36:58.936 SIParser: SDT: sid=3460 type=1 eit_present=1 eit_requested=1 name=Toon Disney
2005-12-23 21:36:58.940 SIParser: SDT: sid=8001 type=1 eit_present=1 eit_requested=1 name=RTL Television
2005-12-23 21:36:58.949 SIParser: SDT: sid=28007 type=1 eit_present=1 eit_requested=1 name=3sat
2005-12-23 21:36:58.970 SIParser: SDT: NetworkID=0 TransportID=8
2005-12-23 21:36:58.972 SIParser: SDT: sid=401 type=1 eit_present=1 eit_requested=1 name=Nordic TCM
2005-12-23 21:36:58.977 SIParser: SDT: sid=2 type=1 eit_present=1 eit_requested=1 name=LähiTV2
2005-12-23 21:36:58.981 SIParser: SDT: sid=402 type=1 eit_present=1 eit_requested=1 name=Cartoon Networks
2005-12-23 21:36:58.984 SIParser: SDT: sid=605 type=1 eit_present=1 eit_requested=1 name=Private Gold
2005-12-23 21:36:58.986 SIParser: SDT: sid=8212 type=1 eit_present=0 eit_requested=0 name=FinlaysonTV
2005-12-23 21:36:58.988 SIParser: SDT: sid=8213 type=1 eit_present=1 eit_requested=1 name=Kaupunkitelevisio
2005-12-23 21:36:58.991 SIParser: SDT: sid=28109 type=1 eit_present=1 eit_requested=1 name=arte
2005-12-23 21:36:59.007 SIParser: SDT: NetworkID=0 TransportID=6
2005-12-23 21:36:59.009 SIParser: SDT: sid=10 type=1 eit_present=1 eit_requested=1 name=NTV Mir
2005-12-23 21:36:59.013 SIParser: SDT: sid=25 type=1 eit_present=1 eit_requested=1 name=ORT International
2005-12-23 21:36:59.017 SIParser: SDT: sid=301 type=1 eit_present=1 eit_requested=1 name=CANAL+ Film
2005-12-23 21:36:59.020 SIParser: SDT: sid=305 type=1 eit_present=1 eit_requested=1 name=CANAL+ Sport
2005-12-23 21:36:59.022 SIParser: SDT: sid=308 type=1 eit_present=1 eit_requested=1 name=CANAL+ Film 2
2005-12-23 21:36:59.025 SIParser: SDT: sid=309 type=1 eit_present=1 eit_requested=1 name=CANAL+
2005-12-23 21:36:59.028 SIParser: SDT: sid=313 type=1 eit_present=1 eit_requested=1 name=C MORE Film
2005-12-23 21:36:59.031 SIParser: SDT: sid=8211 type=1 eit_present=1 eit_requested=1 name=EuroNews
2005-12-23 21:36:59.062 SIParser: SDT: NetworkID=0 TransportID=7
2005-12-23 21:36:59.065 SIParser: SDT: sid=1 type=1 eit_present=1 eit_requested=1 name=Toto-TV       
2005-12-23 21:36:59.068 SIParser: SDT: sid=3 type=1 eit_present=1 eit_requested=1 name=ESPN Europe
2005-12-23 21:36:59.071 SIParser: SDT: sid=201 type=1 eit_present=1 eit_requested=1 name=National Geographic
2005-12-23 21:36:59.076 SIParser: SDT: sid=906 type=1 eit_present=1 eit_requested=1 name=CNBC Nordic
2005-12-23 21:36:59.079 SIParser: SDT: sid=1013 type=1 eit_present=1 eit_requested=1 name=Sky News
2005-12-23 21:36:59.081 SIParser: SDT: sid=1802 type=1 eit_present=1 eit_requested=1 name=Adventure 1
2005-12-23 21:36:59.083 SIParser: SDT: sid=28659 type=1 eit_present=1 eit_requested=1 name=MTV 2
2005-12-23 21:36:59.161 SIParser: SDT: NetworkID=0 TransportID=2
2005-12-23 21:36:59.174 SIParser: SDT: sid=49 type=1 eit_present=1 eit_requested=1 name=MTV3
2005-12-23 21:36:59.183 SIParser: SDT: sid=65 type=1 eit_present=1 eit_requested=1 name=Nelonen
2005-12-23 21:36:59.192 SIParser: SDT: sid=97 type=1 eit_present=1 eit_requested=1 name=SubTV
2005-12-23 21:36:59.199 SIParser: SDT: sid=113 type=1 eit_present=1 eit_requested=1 name=Urheilukanava
2005-12-23 21:36:58.882 DVBRec(0): Card opened successfully fd(26) (using TS mode).
2005-12-23 21:36:59.213 DVBRec(0): SetPMTObject()
2005-12-23 21:36:59.211 SIParser: SDT: sid=209 type=1 eit_present=1 eit_requested=1 name=MTV3+
2005-12-23 21:36:59.216 DVBRec(0): AutoPID for MPEG Program Number(17), PCR PID(0x80)
2005-12-23 21:36:59.226 DVBRec(0): AutoPID recording PID 0x200, MPEG-2 Video
2005-12-23 21:36:59.228 DVBRec(0): AutoPID recording PID 0x28a, MPEG-2 Audio (fin
2005-12-23 21:36:59.230 DVBRec(0): AutoPID recording PID 0x28b, MPEG-2 Audio (swe
2005-12-23 21:36:59.233 DVBRec(0): AutoPID recording PID 0x28c, MPEG-2 Audio (dut
2005-12-23 21:36:59.236 DVBRec(0): AutoPID recording PID 0x911, Teletext
2005-12-23 21:36:59.240 DVBRec(0): AutoPID recording PID 0x403, Subtitle
2005-12-23 21:36:59.243 DVBRec(0): AutoPID recording PID 0x404, Subtitle
2005-12-23 21:36:59.245 DVBRec(0): AutoPID skipping PID 0xc30, Unknown type: 5
2005-12-23 21:36:59.248 DVBRec(0): AutoPID skipping PID 0xc26, Data
2005-12-23 21:36:59.250 DVBRec(0): AutoPID skipping PID 0xc27, Data
2005-12-23 21:36:59.253 DVBRec(0): AutoPID skipping PID 0xc28, Data
2005-12-23 21:36:59.256 DVBRec(0): AutoPID skipping PID 0xc29, Data
2005-12-23 21:36:59.226 SIParser: SDT: sid=225 type=1 eit_present=1 eit_requested=1 name=Nelonen Plus
2005-12-23 21:36:59.258 DVBRec(0): AutoPID skipping PID 0xc2a, Data
2005-12-23 21:36:59.309 DVBRec(0): AutoPID skipping PID 0xc2b, Data
2005-12-23 21:36:59.311 DVBRec(0): AutoPID skipping PID 0xc2c, Data
2005-12-23 21:36:59.307 SIParser: SDT: sid=241 type=1 eit_present=1 eit_requested=1 name=The Voice
2005-12-23 21:36:59.321 SIParser: SDT: sid=4449 type=2 eit_present=0 eit_requested=0 name=Kiss FM
2005-12-23 21:36:59.320 DVBRec(0): AutoPID Complete - PAT/PMT Loaded for service
			A/V Streams are unencrypted
2005-12-23 21:36:59.326 DVBRecorder::SetPAT(NULL)
2005-12-23 21:36:59.329 DVBRecorder::SetPMT(NULL)
2005-12-23 21:36:59.325 SIParser: SDT: sid=4465 type=2 eit_present=0 eit_requested=0 name=Iskelmä
2005-12-23 21:36:59.331 TVRec(1): SetFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RecorderRunning,RingBufferReset,
2005-12-23 21:36:59.351 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset,
2005-12-23 21:36:59.347 SIParser: SDT: NetworkID=0 TransportID=9
2005-12-23 21:36:59.368 SIParser: SDT: sid=1014 type=1 eit_present=1 eit_requested=1 name=DSC CIVILIS'N
2005-12-23 21:36:59.390 SIParser: SDT: sid=1015 type=1 eit_present=1 eit_requested=1 name=Discov Science
2005-12-23 21:36:59.412 SIParser: SDT: sid=1016 type=1 eit_present=1 eit_requested=1 name=Discov Tra&Liv
2005-12-23 21:36:59.428 SIParser: SDT: sid=1100 type=1 eit_present=1 eit_requested=1 name=TV3 Sverige
2005-12-23 21:36:59.431 SIParser: SDT: sid=3307 type=1 eit_present=1 eit_requested=1 name=CANAL+ Film 3
2005-12-23 21:36:59.434 SIParser: SDT: sid=3308 type=1 eit_present=1 eit_requested=1 name=C MORE Film 2
2005-12-23 21:36:59.438 SIParser: SDT: sid=10020 type=1 eit_present=1 eit_requested=1 name=DW-TV
2005-12-23 21:36:59.428 DevRdB(0): buffer size 9400 KB
2005-12-23 21:36:59.443 DVBRec(0): Resetting Demux Filters
2005-12-23 21:36:59.445 DVBRec(0): Adding pid 0x200 size(3600384)
2005-12-23 21:36:59.448 DVBRec(0): Set demux buffer size for pid 0x200 to 3600384,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.443 SIParser: SDT: sid=28655 type=1 eit_present=1 eit_requested=1 name=MTV Base
2005-12-23 21:36:59.457 SIParser: SDT: NetworkID=0 TransportID=10
2005-12-23 21:36:59.451 DVBRec(0): Adding pid 0x28a size(94208)
2005-12-23 21:36:59.463 DVBRec(0): Set demux buffer size for pid 0x28a to 94208,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.462 SIParser: SDT: sid=203 type=1 eit_present=1 eit_requested=1 name=Travel Channel
2005-12-23 21:36:59.467 SIParser: SDT: sid=204 type=1 eit_present=1 eit_requested=1 name=VH 1
2005-12-23 21:36:59.466 DVBRec(0): Adding pid 0x28b size(94208)
2005-12-23 21:36:59.472 DVBRec(0): Set demux buffer size for pid 0x28b to 94208,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.470 SIParser: SDT: sid=2501 type=1 eit_present=1 eit_requested=1 name=BBC Food
2005-12-23 21:36:59.475 DVBRec(0): Adding pid 0x28c size(94208)
2005-12-23 21:36:59.479 DVBRec(0): Set demux buffer size for pid 0x28c to 94208,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.478 SIParser: SDT: sid=3209 type=1 eit_present=1 eit_requested=1 name=MTV
2005-12-23 21:36:59.482 DVBRec(0): Adding pid 0x911 size(94208)
2005-12-23 21:36:59.487 DVBRec(0): Set demux buffer size for pid 0x911 to 94208,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.486 SIParser: SDT: sid=3501 type=1 eit_present=1 eit_requested=1 name=TVE INTERNACIONAL
2005-12-23 21:36:59.491 SIParser: SDT: sid=12240 type=1 eit_present=1 eit_requested=1 name=TV5 Europe
2005-12-23 21:36:59.490 DVBRec(0): Adding pid 0x403 size(94208)
2005-12-23 21:36:59.516 DVBRec(0): Set demux buffer size for pid 0x403 to 94208,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.538 DVBRec(0): Adding pid 0x404 size(94208)
2005-12-23 21:36:59.562 DVBRec(0): Set demux buffer size for pid 0x404 to 94208,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.586 DVBRec(0): Adding pid 0x80 size(94208)
2005-12-23 21:36:59.608 DVBRec(0): Set demux buffer size for pid 0x80 to 94208,
			which gives us a 1500 msec buffer.
2005-12-23 21:36:59.616 DVBRecorder::SetPAT()
Program Association Table
 PSIP prefix(0x0) tableID(0x0) length(13) extension(0x1)
      version(0) current(1) section(0) last_section(0)
         tsid: 1
 programCount: 1
  program number 1 has PID 0x  20   data  0x0 0x1 0x224 0x32

2005-12-23 21:36:59.620 Parsed PMT(0x0x8225978) Program Map Table ver(0) pid(0x0) pnum(0)


2005-12-23 21:36:59.623 DVBRecorder::SetPMT()
Program Map Table ver(1) pid(0x20) pnum(1)

 Stream #0 pid(0x200) type(video-mpeg2  0x2)
 Stream #1 pid(0x28a) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(fin) canonical(fin) eng(Finnish)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #2 pid(0x28b) type(audio-mp2-layer[1,2,3]  0x4)
  ISO-639 Language: code(swe) canonical(swe) eng(Swedish)
 Stream #3 pid(0x28c) type(audio-mp2-layer[1,2,3]  0x4)
  Audio Descriptor (0x3) length(1)
  ISO-639 Language: code(dut) canonical(dut) eng(Dutch; Flemish)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #4 pid(0x911) type(private-data  0x6)
  Teletext Descriptor (0x56) length(5)
 Stream #5 pid(0x403) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)
 Stream #6 pid(0x404) type(private-data  0x6)
  Subtitling Descriptor (0x59) length(8)

2005-12-23 21:36:59.614 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:36:59.829 New DB connection, total: 4
2005-12-23 21:36:59.866 PID 0x200 Found Payload Start
2005-12-23 21:36:59.869 PID 0x911 Found Payload Start
2005-12-23 21:36:59.902 PID 0x28a Found Payload Start
2005-12-23 21:36:59.985 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:00.002 SIParser: Table[4]->Complete() == true
2005-12-23 21:37:00.010 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:00.020 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:00.041 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:00.057 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:00.143 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:01.005 PID 0x403 Found Payload Start
mpegts_add_stream: at pid 0x21 with type 2
mpegts_add_stream: stream #0, has id 0x21 and codec MPEG2VIDEO, type Video at 0x8224e60
2005-12-23 21:37:03.092 read  <- 16 35      QUERY_RECORDER 1[]:[]FRONTEND_READY
2005-12-23 21:37:03.119 TVRec(1): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset,
2005-12-23 21:37:03.124 write -> 16 2       ok
2005-12-23 21:37:03.538 read  <- 16 39      QUERY_RECORDER 1[]:[]CHECK_CHANNEL[]:[]
2005-12-23 21:37:03.543 TVRec(1): Failed to find channel() on current input (DVBInput) of card (1).
2005-12-23 21:37:03.545 TVRec(1): Failed to find channel() on any input of card (1).
2005-12-23 21:37:03.548 write -> 16 1       0
2005-12-23 21:37:03.557 read  <- 16 46      QUERY_RECORDER 1[]:[]CHECK_CHANNEL_PREFIX[]:[]
2005-12-23 21:37:03.568 write -> 16 7       1[]:[]0
2005-12-23 21:37:03.576 read  <- 16 39      QUERY_RECORDER 1[]:[]CHECK_CHANNEL[]:[]
2005-12-23 21:37:03.580 TVRec(1): Failed to find channel() on current input (DVBInput) of card (1).
2005-12-23 21:37:03.583 TVRec(1): Failed to find channel() on any input of card (1).
2005-12-23 21:37:03.586 write -> 16 1       0
2005-12-23 21:37:03.815 read  <- 14 19      QUERY_GETALLPENDING
2005-12-23 21:37:03.819 write -> 14 987     0[]:[]2[]:[]Shield - Lain varjolla (K15)[]:[][]:[]Danten helvetti...
2005-12-23 21:37:03.880 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:04.429 SIParser: Table[4]->EmitRequired() == true
0: start_time: 857.475 duration: -9223372036854.775
stream: start_time: 9527.500 duration: -9223372036854.775 bitrate=0 kb/s
2005-12-23 21:37:04.712 AFD: Stream #0, has id 0x33 codec id MPEG1VIDEO, type Video at 0x0x8224e60
2005-12-23 21:37:04.725 detectInterlace(Detect Scan, Detect Scan, 50, 576) ->Progressive Scan
2005-12-23 21:37:04.727 Interlaced: Progressive Scan  video_height: 576  fps: 50
2005-12-23 21:37:04.729 AFD: Looking for decoder for MPEG1VIDEO
2005-12-23 21:37:04.731 AFD: Opened codec 0x8252770, id(MPEG1VIDEO) type(Video)
2005-12-23 21:37:04.733 RingBuf:CalcReadAheadThresh(1152 KB) -> threshhold(0 KB) readblocksize(125 KB)
2005-12-23 21:37:04.735 NVP: Disabling Audio, params(-1,-1,-1)
2005-12-23 21:37:04.737 AFD: Initializing audio parms from audio track #0
2005-12-23 21:37:04.739 AFD: Audio format changed 
			from id(NONE)    -1Hz -1ch   0bps    ; id(NONE)    -1Hz -1ch   0bps   
			to   id(NONE)    -1Hz -1ch   0bps    ; id(NONE)    -1Hz -1ch   0bps   
2005-12-23 21:37:04.741 NVP: Disabling Audio, params(0,-1,-1)
2005-12-23 21:37:04.743 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2005-12-23 21:37:04.749 Position map filled from DB to: 99
2005-12-23 21:37:04.751 SyncPositionMap prerecorded, from DB: 10 entries
2005-12-23 21:37:04.753 SyncPositionMap, new totframes: 99, new length: 1, posMap size: 10
Input #0, mpegts, from '/home/mythtv/programs/1017_20051223213656.mpg':
  Duration: N/A, start: 9527.499844, bitrate: N/A
  Stream #0.0[0x21], 1/90000, 50.00 fps: Video: mpeg1video, yuv420p, 768x576, 1/50, 1152 kb/s
2005-12-23 21:37:04.873 AFD: Position map found
2005-12-23 21:37:04.875 AFD: Successfully opened decoder for file: "/home/mythtv/programs/1017_20051223213656.mpg". novideo(0)
2005-12-23 21:37:04.891 VideoOutputNull()
2005-12-23 21:37:04.925 Image size. dispxoff 0, dispyoff: 0, dispwoff: 0, disphoff: 0
2005-12-23 21:37:04.927 Image size. imgx 23, imgy: 29, imgw: 691, imgh: 518
2005-12-23 21:37:04.934 Created data @0xaa7fc008->0xaa89e00a
2005-12-23 21:37:04.940 Created data @0xaa759008->0xaa7fb00a
2005-12-23 21:37:04.947 Created data @0xaa6b6008->0xaa75800a
2005-12-23 21:37:04.953 Created data @0xaa613008->0xaa6b500a
2005-12-23 21:37:04.960 Created data @0xaa570008->0xaa61200a
2005-12-23 21:37:04.966 Created data @0xaa4cd008->0xaa56f00a
2005-12-23 21:37:04.973 Created data @0xaa42a008->0xaa4cc00a
2005-12-23 21:37:04.980 Created data @0xaa387008->0xaa42900a
2005-12-23 21:37:04.986 Created data @0xaa2e4008->0xaa38600a
2005-12-23 21:37:04.993 Created data @0xaa241008->0xaa2e300a
2005-12-23 21:37:04.999 Created data @0xaa19e008->0xaa24000a
2005-12-23 21:37:05.005 Created data @0xaa0fb008->0xaa19d00a
2005-12-23 21:37:05.012 Created data @0xaa058008->0xaa0fa00a
2005-12-23 21:37:05.018 Created data @0xa9fb5008->0xaa05700a
2005-12-23 21:37:05.024 Created data @0xa9f12008->0xa9fb400a
2005-12-23 21:37:05.030 Created data @0xa9e6f008->0xa9f1100a
2005-12-23 21:37:05.036 Created data @0xa9dcc008->0xa9e6e00a
2005-12-23 21:37:05.043 Created data @0xa9d29008->0xa9dcb00a
2005-12-23 21:37:05.049 Created data @0xa9c86008->0xa9d2800a
2005-12-23 21:37:05.056 Created data @0xa9be3008->0xa9c8500a
2005-12-23 21:37:05.062 Created data @0xa9b40008->0xa9be200a
2005-12-23 21:37:05.068 Created data @0xa9a9d008->0xa9b3f00a
2005-12-23 21:37:05.076 Created data @0xa99fa008->0xa9a9c00a
2005-12-23 21:37:05.088 Created data @0xa9957008->0xa99f900a
2005-12-23 21:37:05.103 Created data @0xa98b4008->0xa995600a
2005-12-23 21:37:05.123 Created data @0xa9811008->0xa98b300a
2005-12-23 21:37:05.143 Created data @0xa976e008->0xa981000a
2005-12-23 21:37:05.154 Created data @0xa96cb008->0xa976d00a
2005-12-23 21:37:05.169 Created data @0xa9628008->0xa96ca00a
2005-12-23 21:37:05.179 Created data @0xa9585008->0xa962700a
2005-12-23 21:37:05.203 Created data @0xa94e2008->0xa958400a
2005-12-23 21:37:05.209 Created data @0xa943f008->0xa94e100a
2005-12-23 21:37:05.212 Image size. dispxoff 0, dispyoff: 0, dispwoff: 0, disphoff: 0
2005-12-23 21:37:05.214 Image size. imgx 23, imgy: 29, imgw: 691, imgh: 518
2005-12-23 21:37:05.216 NVP: ClearAfterSeek()
2005-12-23 21:37:05.218 NVP: SetCommBreakIter @ framesPlayed = 0
2005-12-23 21:37:05.220 NVP: new commBreakIter = 3014772 @ frame 7274611
2005-12-23 21:37:05.238 InputChanged(w 768, h576, a1.21766)
2005-12-23 21:37:05.240 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:37:05.242 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:37:05.244 Image size. dispxoff 0, dispyoff: 0, dispwoff: 0, disphoff: 0
2005-12-23 21:37:05.246 Image size. imgx 23, imgy: 29, imgw: 691, imgh: 518
2005-12-23 21:37:05.248 NVP: ClearAfterSeek()
2005-12-23 21:37:05.251 NVP: SetCommBreakIter @ framesPlayed = 0
2005-12-23 21:37:05.253 NVP: new commBreakIter = 3014772 @ frame 7274611
2005-12-23 21:37:05.255 detectInterlace(Detect Scan, Progressive Scan, 50, 576) ->Progressive Scan
2005-12-23 21:37:05.257 Interlaced: Progressive Scan  video_height: 576  fps: 50
2005-12-23 21:37:05.273 AFD: DoFastForward(48, do flush)
2005-12-23 21:37:05.275 Dec: DoFastForward(48, do flush)
2005-12-23 21:37:05.277 AFD: SeekReset(0, do flush, do discard)
2005-12-23 21:37:05.279 AFD: SeekReset() flushing
2005-12-23 21:37:05.281 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2005-12-23 21:37:05.283 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2005-12-23 21:37:05.285 NVP: ClearAfterSeek()
2005-12-23 21:37:05.287 NVP: SetCommBreakIter @ framesPlayed = 56
2005-12-23 21:37:05.289 NVP: new commBreakIter = 3014772 @ frame 7274611
2005-12-23 21:37:05.340 ~VideoOutputNull()
2005-12-23 21:37:05.604 read  <- 14 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:37:05.608 write -> 14 2       OK
2005-12-23 21:37:05.610 write -> 15 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:37:05.620 read  <- 14 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:37:05.623 write -> 14 2       OK
2005-12-23 21:37:05.625 write -> 15 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:37:05.647 read  <- 16 39      QUERY_RECORDER 1[]:[]GET_FRAMES_WRITTEN
2005-12-23 21:37:05.650 write -> 16 9       0[]:[]140
2005-12-23 21:37:05.659 read  <- 16 54      QUERY_RECORDER 1[]:[]FILL_POSITION_MAP[]:[]121[]:[]140
2005-12-23 21:37:05.663 write -> 16 27      0[]:[]132[]:[]0[]:[]2022880
2005-12-23 21:37:06.171 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:07.209 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:07.580 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:07.890 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:08.667 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:09.480 SIParser: Table[4]->EmitRequired() == true
2005-12-23 21:37:15.210 read  <- 14 28      GET_NEXT_FREE_RECORDER[]:[]1
2005-12-23 21:37:15.213 Getting next free recorder after : 1
2005-12-23 21:37:15.214 write -> 14 26      2[]:[]192.168.1.3[]:[]6543
2005-12-23 21:37:15.270 read  <- 16 32      QUERY_RECORDER 1[]:[]STOP_LIVETV
2005-12-23 21:37:15.273 TVRec(1): Changing from WatchingLiveTV to None
2005-12-23 21:37:15.275 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset,
2005-12-23 21:37:15.276 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset,
2005-12-23 21:37:15.278 TVRec(1): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,)
2005-12-23 21:37:15.285 DVBSIParser: Stopping DVB Section Reader
2005-12-23 21:37:15.288 DVBSIParser: DVB Section Reader thread stopped
2005-12-23 21:37:15.294 SIParser: Descriptor Stats -- begin
2005-12-23 21:37:15.296 SIParser: On PID 0x10: Found 10, Service List Descriptors
2005-12-23 21:37:15.298 SIParser: On PID 0x10: Found 10, Private Data Specifier Descriptors
2005-12-23 21:37:15.300 SIParser: On PID 0x11: Found 1, Data Broadcast Descriptor
2005-12-23 21:37:15.302 SIParser: On PID 0x11: Found 77, Unknown(145) Descriptors
2005-12-23 21:37:15.304 SIParser: On PID 0x12: Found 1416, Parental Rating Descriptors
2005-12-23 21:37:15.306 SIParser: On PID 0x12: Found 1266, Private Data Specifier Descriptors
2005-12-23 21:37:15.308 SIParser: Descriptor Stats -- end
2005-12-23 21:37:15.327 TVRec(1): ClearFlags(SIParserRunning,) -> RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReset,
2005-12-23 21:37:15.330 write -> 15 49      BACKEND_MESSAGE[]:[]DONE_RECORDING 1 15[]:[]empty
2005-12-23 21:37:15.331 DVBRec(0): Close() fd(26) -- begin
2005-12-23 21:37:15.337 DVBRec(0): Close() fd(-1) -- end
2005-12-23 21:37:15.469 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReset,
2005-12-23 21:37:15.475 DVBRecorder::SetPAT(NULL)
2005-12-23 21:37:15.477 DVBRecorder::SetPMT(NULL)
2005-12-23 21:37:15.482 Chain: Updated endtime for '1017_20051223213658' to 20051223213715
2005-12-23 21:37:15.488 Finished recording : Matti Salminen med vänner: channel 1017
2005-12-23 21:37:15.495 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReset,
2005-12-23 21:37:15.497 TVRec(1): Tearing down RingBuffer
2005-12-23 21:37:15.500 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReset,
2005-12-23 21:37:15.503 write -> 16 2       ok
2005-12-23 21:37:15.506 DVBRecorder::SetPAT(NULL)
2005-12-23 21:37:15.507 DVBRecorder::SetPMT(NULL)
2005-12-23 21:37:15.511 write -> 15 80      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-neuvo-2005-12-23T21:...
2005-12-23 21:37:15.514 write -> 15 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:37:15.555 read  <- 14 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
2005-12-23 21:37:15.556 write -> 14 2       OK
2005-12-23 21:37:15.594 write -> 15 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
2005-12-23 21:37:15.626 read  <- 16 21      MYTH_PROTO_VERSION 22
2005-12-23 21:37:15.628 write -> 16 13      ACCEPT[]:[]22
2005-12-23 21:37:15.636 read  <- 16 20      ANN Playback neuvo 0
2005-12-23 21:37:15.638 MainServer::HandleAnnounce Playback
2005-12-23 21:37:15.640 adding: neuvo as a client (events: 0)
2005-12-23 21:37:15.642 write -> 16 2       OK

Change History (4)

comment:1 Changed 14 years ago by homer_simpson_loves_u@…

I had this problem on 8372, but 8406 does not have the problem.

Can you check again Markus?

Homer

comment:2 Changed 14 years ago by danielk

Owner: changed from Isaac Richards to danielk

comment:3 Changed 14 years ago by danielk

Milestone: unknown
Resolution: invalid
Status: newclosed
Version: head

Need backtrace to fix.

comment:4 Changed 14 years ago by markus.heikkila@…

I'm sorry I don't get these segfaults anymore in revision 8463 so I guess the problem, whatever it was, has been fixed somewhere.

Note: See TracTickets for help on using tickets.