2006-10-23 20:47:51.014 read  <- 16 102     BACKEND_MESSAGE[]:[]COMMFLAG_UPDATE 4742 2006-10-23T20:10:00 2403...
2006-10-23 20:47:51.057 Setting New Commercial Break List, old size 2, new 4
2006-10-23 20:47:51.057 NVP: new commBreakIter = 4 @ frame 55021
2006-10-23 20:47:51.065 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(1)
2006-10-23 20:47:51.065 write -> 23 39      QUERY_RECORDER 3[]:[]GET_FRAMES_WRITTEN
2006-10-23 20:47:51.066 read  <- 23 11      0[]:[]56626
2006-10-23 20:47:51.066 Filling position map from 34801 to 56626
2006-10-23 20:47:51.067 write -> 23 58      QUERY_RECORDER 3[]:[]FILL_POSITION_MAP[]:[]34801[]:[]56626
'video_output' mean = '39995.76', std. dev. = '197.79', fps = '25.00'
2006-10-23 20:47:51.174 read  <- 23 65548   0[]:[]34812[]:[]0[]:[]646752900[]:[]0[]:[]34824[]:[]0[]:[]6469431...
2006-10-23 20:47:52.201 NVP: prebuffering pause
2006-10-23 20:47:52.214 NVP: Waiting for prebuffer.. 0 AuAAAAALAAAAAAAAAAAAAAAAAAAAAAA
2006-10-23 20:47:52.380 NVP: Waiting for prebuffer.. 1 AuAAAAALAAAAAAAAAAAAAAAAAAAAAAA
2006-10-23 20:47:52.560 NVP: Waiting for prebuffer.. 2 AuAAAAALAAAAAAAAAAAAAAAAAAAAAAA
2006-10-23 20:47:52.740 NVP: Waiting for prebuffer.. 3 AuAAAAALAAAAAAAAAAAAAAAAAAAAAAA
2006-10-23 20:47:52.920 NVP: Waiting for prebuffer.. 4 AuAAAAALAAAAAAAAAAAAAAAAAAAAAAA
2006-10-23 20:47:53.100 NVP: Waiting for prebuffer.. 5 AuAAAAALAAAAAAAAAAAAAAAAAAAAAAA
2006-10-23 20:47:53.280 NVP: Waiting for prebuffer.. 6 AuAAAAALAAAAAAAAAAAAAAAAAAAAAAA
2006-10-23 20:47:53.390 Position map filled from Encoder to: 56616
2006-10-23 20:47:53.391 SyncPositionMap watchingrecording total: 4720 entries
2006-10-23 20:47:53.391 SyncPositionMap, new totframes: 56616, new length: 2264, posMap size: 4720
2006-10-23 20:47:53.460 NVP: Waiting for prebuffer.. 7 AULAAAAUAAAAAUAUUAUUAUUAuAAAAUL

========================================================================

2006-10-19 22:04:52.497 read  <- 18 113     BACKEND_MESSAGE[]:[]COMMFLAG_UPDATE 4740 2006-10-19T21:05:00 0:4,...
'video_output' mean = '39994.82', std. dev. = '176.81', fps = '25.00'
2006-10-19 22:04:52.582 Setting New Commercial Break List, old size 4, new 6
2006-10-19 22:04:52.582 NVP: new commBreakIter = 4 @ frame 53349
2006-10-19 22:04:52.589 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(1)
2006-10-19 22:04:52.590 write -> 23 39      QUERY_RECORDER 4[]:[]GET_FRAMES_WRITTEN
2006-10-19 22:04:52.591 read  <- 23 11      0[]:[]89610
2006-10-19 22:04:52.592 Filling position map from 64117 to 89610
2006-10-19 22:04:52.592 write -> 23 58      QUERY_RECORDER 4[]:[]FILL_POSITION_MAP[]:[]64117[]:[]89610
2006-10-19 22:04:53.069 read  <- 23 78546   0[]:[]64128[]:[]0[]:[]1391785996[]:[]0[]:[]64140[]:[]0[]:[]139209...
2006-10-19 22:04:53.420 NVP: 37200 interlaced frames seen.
2006-10-19 22:04:53.740 NVP: prebuffering pause
2006-10-19 22:04:53.740 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAuaAALAAAAAAAAAAAAA
2006-10-19 22:04:53.919 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAuaAALAAAAAAAAAAAAA
2006-10-19 22:04:54.099 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAuaAALAAAAAAAAAAAAA
2006-10-19 22:04:54.279 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAuaAALAAAAAAAAAAAAA
2006-10-19 22:04:54.459 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAuaAALAAAAAAAAAAAAA
2006-10-19 22:04:54.639 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAuaAALAAAAAAAAAAAAA
2006-10-19 22:04:54.819 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAuaAALAAAAAAAAAAAAA
2006-10-19 22:04:54.964 Position map filled from Encoder to: 89610
2006-10-19 22:04:54.965 SyncPositionMap watchingrecording total: 7466 entries
2006-10-19 22:04:54.965 SyncPositionMap, new totframes: 89610, new length: 3584, posMap size: 7466
2006-10-19 22:04:54.999 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAUUAUUUALuAALAAAAAAA