Mon 10/9 17:23:25.492 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.492 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.492 Event: 0x8065 Mon 10/9 17:23:25.494 VF processing job null nPlayin=true Mon 10/9 17:23:25.494 isRec=false rd=5388192 base=5202291 Mon 10/9 17:23:25.495 VF thread is now waiting for 0:03:05.651 Mon 10/9 17:23:25.493 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.495 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.494 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.494 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.494 Event: 0x8065 Mon 10/9 17:23:25.494 VF processing job null nPlayin=true Mon 10/9 17:23:25.494 isRec=false rd=5388192 base=5202291 Mon 10/9 17:23:25.496 VF thread is now waiting for 0:03:05.651 Mon 10/9 17:23:25.820 VF.submitJob(VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null]) Mon 10/9 17:23:25.822 VF processing job VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.821 VF processing on UI Thread VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] Mon 10/9 17:23:25.821 VideoFrame.timeSelected(Mon 10/9 4:27:23.988, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] Mon 10/9 17:23:25.821 VideoFrame.timeSelected2(Mon 10/9 4:27:23.988, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] realDur=5388192 Mon 10/9 17:23:25.821 About to perform media time selection for 5232515 Mon 10/9 17:23:25.938 VF processing job null nPlayin=true Mon 10/9 17:23:25.938 isRec=false rd=5388192 base=5232515 Mon 10/9 17:23:25.940 VF thread is now waiting for 0:02:35.427 Mon 10/9 17:23:25.960 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.960 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.959 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.959 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.959 Event: 0x8065 Mon 10/9 17:23:25.961 VF processing job null nPlayin=true Mon 10/9 17:23:25.962 isRec=false rd=5388192 base=5232527 Mon 10/9 17:23:25.960 VF thread is now waiting for 0:02:35.415 Mon 10/9 17:23:25.961 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.963 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.962 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.962 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.962 Event: 0x8065 Mon 10/9 17:23:25.964 VF processing job null nPlayin=true Mon 10/9 17:23:25.963 isRec=false rd=5388192 base=5232529 Mon 10/9 17:23:25.963 VF thread is now waiting for 0:02:35.412 Mon 10/9 17:23:25.965 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.967 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.965 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.966 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.966 Event: 0x8065 Mon 10/9 17:23:25.968 VF processing job null nPlayin=true Mon 10/9 17:23:25.968 isRec=false rd=5388192 base=5232533 Mon 10/9 17:23:25.968 VF thread is now waiting for 0:02:35.409 Mon 10/9 17:23:25.969 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.971 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.969 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.971 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.971 Event: 0x8065 Mon 10/9 17:23:25.970 VF processing job null nPlayin=true Mon 10/9 17:23:25.970 isRec=false rd=5388192 base=5232537 Mon 10/9 17:23:25.970 VF thread is now waiting for 0:02:35.405 Mon 10/9 17:23:25.972 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.973 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.975 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.975 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.975 Event: 0x8065 Mon 10/9 17:23:25.974 VF processing job null nPlayin=true Mon 10/9 17:23:25.974 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.974 isRec=false rd=5388192 base=5232541 Mon 10/9 17:23:25.974 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.976 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.977 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.977 Event: 0x8065 Mon 10/9 17:23:25.975 VF processing job null nPlayin=true Mon 10/9 17:23:25.975 isRec=false rd=5388192 base=5232543 Mon 10/9 17:23:25.976 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.977 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.977 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.978 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.978 Event: 0x8065 Mon 10/9 17:23:25.978 VF processing job null nPlayin=true Mon 10/9 17:23:25.978 isRec=false rd=5388192 base=5232545 Mon 10/9 17:23:25.978 VF thread is now waiting for 0:02:35.397 Mon 10/9 17:23:25.984 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.984 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.987 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.987 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.987 Event: 0x8065 Mon 10/9 17:23:25.985 VF processing job null nPlayin=true Mon 10/9 17:23:25.987 isRec=false rd=5388192 base=5232553 Mon 10/9 17:23:25.988 VF thread is now waiting for 0:02:35.389 Mon 10/9 17:23:25.989 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:25.987 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:25.988 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:25.988 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:25.988 Event: 0x8065 Mon 10/9 17:23:25.990 VF processing job null nPlayin=true Mon 10/9 17:23:25.990 isRec=false rd=5388192 base=5232554 Mon 10/9 17:23:25.990 VF thread is now waiting for 0:02:35.388 Mon 10/9 17:23:26.385 VF.submitJob(VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null]) Mon 10/9 17:23:26.384 VF processing job VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.386 VF processing on UI Thread VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] Mon 10/9 17:23:26.386 VideoFrame.timeSelected(Mon 10/9 4:27:54.370, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] Mon 10/9 17:23:26.387 VideoFrame.timeSelected2(Mon 10/9 4:27:54.370, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] realDur=5388192 Mon 10/9 17:23:26.387 About to perform media time selection for 5262831 Mon 10/9 17:23:26.503 VF processing job null nPlayin=true Mon 10/9 17:23:26.502 isRec=false rd=5388192 base=5262831 Mon 10/9 17:23:26.502 VF thread is now waiting for 0:02:05.111 Mon 10/9 17:23:26.517 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.519 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.519 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.519 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.520 Event: 0x8065 Mon 10/9 17:23:26.518 VF processing job null nPlayin=true Mon 10/9 17:23:26.518 isRec=false rd=5388192 base=5262838 Mon 10/9 17:23:26.518 VF thread is now waiting for 0:02:05.103 Mon 10/9 17:23:26.522 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.521 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.523 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.523 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.521 Event: 0x8065 Mon 10/9 17:23:26.523 VF processing job null nPlayin=true Mon 10/9 17:23:26.523 isRec=false rd=5388192 base=5262842 Mon 10/9 17:23:26.524 VF thread is now waiting for 0:02:05.100 Mon 10/9 17:23:26.524 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.526 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.526 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.526 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.527 Event: 0x8065 Mon 10/9 17:23:26.525 VF processing job null nPlayin=true Mon 10/9 17:23:26.525 isRec=false rd=5388192 base=5262846 Mon 10/9 17:23:26.527 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.526 VF thread is now waiting for 0:02:05.096 Mon 10/9 17:23:26.526 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.528 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.528 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.528 Event: 0x8065 Mon 10/9 17:23:26.527 VF processing job null nPlayin=true Mon 10/9 17:23:26.527 isRec=false rd=5388192 base=5262847 Mon 10/9 17:23:26.527 VF thread is now waiting for 0:02:05.095 Mon 10/9 17:23:26.528 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.530 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.530 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.530 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.530 Event: 0x8065 Mon 10/9 17:23:26.529 VF processing job null nPlayin=true Mon 10/9 17:23:26.529 isRec=false rd=5388192 base=5262849 Mon 10/9 17:23:26.529 VF thread is now waiting for 0:02:05.092 Mon 10/9 17:23:26.529 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.531 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.530 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.530 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.530 Event: 0x8065 Mon 10/9 17:23:26.532 VF processing job null nPlayin=true Mon 10/9 17:23:26.533 isRec=false rd=5388192 base=5262851 Mon 10/9 17:23:26.531 VF thread is now waiting for 0:02:05.090 Mon 10/9 17:23:26.532 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.534 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.532 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.532 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.533 Event: 0x8065 Mon 10/9 17:23:26.534 VF processing job null nPlayin=true Mon 10/9 17:23:26.535 isRec=false rd=5388192 base=5262853 Mon 10/9 17:23:26.533 VF thread is now waiting for 0:02:05.088 Mon 10/9 17:23:26.535 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.533 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.535 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.536 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.536 Event: 0x8065 Mon 10/9 17:23:26.536 VF processing job null nPlayin=true Mon 10/9 17:23:26.535 isRec=false rd=5388192 base=5262855 Mon 10/9 17:23:26.535 VF thread is now waiting for 0:02:05.087 Mon 10/9 17:23:26.535 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.537 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.536 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.536 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.536 Event: 0x8065 Mon 10/9 17:23:26.538 VF processing job null nPlayin=true Mon 10/9 17:23:26.538 isRec=false rd=5388192 base=5262856 Mon 10/9 17:23:26.539 VF thread is now waiting for 0:02:05.086 Mon 10/9 17:23:26.539 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.541 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.540 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.540 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.540 Event: 0x8065 Mon 10/9 17:23:26.542 VF processing job null nPlayin=true Mon 10/9 17:23:26.542 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.542 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.541 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.541 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.543 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.544 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.543 Event: 0x8065 Mon 10/9 17:23:26.543 VF processing job null nPlayin=true Mon 10/9 17:23:26.543 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.543 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.545 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.544 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.546 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.546 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.546 Event: 0x8065 Mon 10/9 17:23:26.545 VF processing job null nPlayin=true Mon 10/9 17:23:26.545 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.545 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.547 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.546 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.546 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.546 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.546 Event: 0x8065 Mon 10/9 17:23:26.546 VF processing job null nPlayin=true Mon 10/9 17:23:26.548 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.547 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.549 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.549 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.548 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.548 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.548 Event: 0x8065 Mon 10/9 17:23:26.550 VF processing job null nPlayin=true Mon 10/9 17:23:26.549 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.549 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.550 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.553 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.553 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.553 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.553 Event: 0x8065 Mon 10/9 17:23:26.552 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.554 Event: 0x8065 Mon 10/9 17:23:26.552 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.554 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.554 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.553 VF processing job null nPlayin=true Mon 10/9 17:23:26.553 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.553 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.555 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.557 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.555 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.555 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.556 Event: 0x8065 Mon 10/9 17:23:26.557 VF processing job null nPlayin=true Mon 10/9 17:23:26.558 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.558 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.557 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.559 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.559 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.558 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.558 Event: 0x8065 Mon 10/9 17:23:26.558 VF processing job null nPlayin=true Mon 10/9 17:23:26.558 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.558 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.559 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.561 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.559 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.559 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.560 Event: 0x8065 Mon 10/9 17:23:26.560 VF processing job null nPlayin=true Mon 10/9 17:23:26.560 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.560 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.561 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.563 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.561 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.561 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.562 Event: 0x8065 Mon 10/9 17:23:26.562 VF processing job null nPlayin=true Mon 10/9 17:23:26.562 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.562 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.563 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.565 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.565 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.565 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.566 Event: 0x8065 Mon 10/9 17:23:26.564 VF processing job null nPlayin=true Mon 10/9 17:23:26.564 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.564 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.566 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.568 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.567 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.567 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.567 Event: 0x8065 Mon 10/9 17:23:26.569 VF processing job null nPlayin=true Mon 10/9 17:23:26.567 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.569 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.570 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.568 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.569 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.569 Event: 0x8065 Mon 10/9 17:23:26.569 VF processing job null nPlayin=true Mon 10/9 17:23:26.569 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.569 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.572 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.572 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.570 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.571 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.571 Event: 0x8065 Mon 10/9 17:23:26.573 VF processing job null nPlayin=true Mon 10/9 17:23:26.573 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.572 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.573 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.575 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.575 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.574 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.575 Event: 0x8065 Mon 10/9 17:23:26.577 VF processing job null nPlayin=true Mon 10/9 17:23:26.577 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.575 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:26.582 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.584 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.583 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.584 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.584 Event: 0x8065 Mon 10/9 17:23:26.584 VF processing job null nPlayin=true Mon 10/9 17:23:26.586 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:26.585 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.585 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:26.585 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:26.585 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:26.585 Event: 0x8065 Mon 10/9 17:23:26.587 VF processing job null nPlayin=true Mon 10/9 17:23:26.586 isRec=false rd=5388192 base=5262859 Mon 10/9 17:23:26.586 VF thread is now waiting for 0:02:05.083 Mon 10/9 17:23:28.309 VF.submitJob(VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null]) Mon 10/9 17:23:28.311 VF processing job VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.310 VF processing on UI Thread VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] Mon 10/9 17:23:28.310 VideoFrame.timeSelected(Mon 10/9 4:28:26.118, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] Mon 10/9 17:23:28.310 VideoFrame.timeSelected2(Mon 10/9 4:28:26.118, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] realDur=5388192 Mon 10/9 17:23:28.310 About to perform media time selection for 5294511 Mon 10/9 17:23:28.423 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.423 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.423 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.424 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.424 Event: 0x8065 Mon 10/9 17:23:28.424 VF processing job null nPlayin=true Mon 10/9 17:23:28.424 isRec=false rd=5388192 base=5294511 Mon 10/9 17:23:28.424 VF thread is now waiting for 0:01:33.431 Mon 10/9 17:23:28.437 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.437 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.436 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.436 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.436 Event: 0x8065 Mon 10/9 17:23:28.436 Event: 0x8065 Mon 10/9 17:23:28.438 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.438 VF processing job null nPlayin=true Mon 10/9 17:23:28.438 isRec=false rd=5388192 base=5294515 Mon 10/9 17:23:28.439 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.437 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.437 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.439 VF processing job null nPlayin=true Mon 10/9 17:23:28.440 isRec=false rd=5388192 base=5294516 Mon 10/9 17:23:28.440 VF thread is now waiting for 0:01:33.426 Mon 10/9 17:23:28.438 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.439 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.439 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.439 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.441 Event: 0x8065 Mon 10/9 17:23:28.441 VF processing job null nPlayin=true Mon 10/9 17:23:28.442 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.440 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.440 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.440 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.441 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.441 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.441 Event: 0x8065 Mon 10/9 17:23:28.441 VF processing job null nPlayin=true Mon 10/9 17:23:28.441 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.442 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.442 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.442 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.443 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.443 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.443 Event: 0x8065 Mon 10/9 17:23:28.445 VF processing job null nPlayin=true Mon 10/9 17:23:28.445 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.445 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.445 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.447 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.446 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.446 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.446 Event: 0x8065 Mon 10/9 17:23:28.447 VF processing job null nPlayin=true Mon 10/9 17:23:28.447 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.447 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.447 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.449 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.448 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.449 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.449 Event: 0x8065 Mon 10/9 17:23:28.449 VF processing job null nPlayin=true Mon 10/9 17:23:28.451 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.450 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.450 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.450 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.450 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.450 Event: 0x8065 Mon 10/9 17:23:28.450 VF processing job null nPlayin=true Mon 10/9 17:23:28.451 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.451 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.453 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.452 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.454 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.454 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.454 Event: 0x8065 Mon 10/9 17:23:28.452 VF processing job null nPlayin=true Mon 10/9 17:23:28.453 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.453 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.455 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.455 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.454 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.454 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.454 Event: 0x8065 Mon 10/9 17:23:28.454 VF processing job null nPlayin=true Mon 10/9 17:23:28.454 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.454 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.455 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.457 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.456 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.456 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.456 Event: 0x8065 Mon 10/9 17:23:28.458 VF processing job null nPlayin=true Mon 10/9 17:23:28.458 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.458 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.457 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.457 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.458 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.458 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.458 Event: 0x8065 Mon 10/9 17:23:28.458 VF processing job null nPlayin=true Mon 10/9 17:23:28.458 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.458 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.459 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.461 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.459 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.459 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.460 Event: 0x8065 Mon 10/9 17:23:28.461 VF processing job null nPlayin=true Mon 10/9 17:23:28.462 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.462 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.463 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.461 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.463 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.463 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.463 Event: 0x8065 Mon 10/9 17:23:28.462 VF processing job null nPlayin=true Mon 10/9 17:23:28.462 isRec=false rd=5388192 base=5294518 Mon 10/9 17:23:28.462 VF thread is now waiting for 0:01:33.424 Mon 10/9 17:23:28.464 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.465 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.465 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.465 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.464 Event: 0x8065 Mon 10/9 17:23:28.465 VF processing job null nPlayin=true Mon 10/9 17:23:28.466 isRec=false rd=5388192 base=5294519 Mon 10/9 17:23:28.466 VF thread is now waiting for 0:01:33.423 Mon 10/9 17:23:28.465 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.467 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.465 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.465 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.465 Event: 0x8065 Mon 10/9 17:23:28.467 VF processing job null nPlayin=true Mon 10/9 17:23:28.468 isRec=false rd=5388192 base=5294521 Mon 10/9 17:23:28.468 VF thread is now waiting for 0:01:33.421 Mon 10/9 17:23:28.467 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.469 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.467 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.467 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.467 Event: 0x8065 Mon 10/9 17:23:28.469 VF processing job null nPlayin=true Mon 10/9 17:23:28.469 isRec=false rd=5388192 base=5294523 Mon 10/9 17:23:28.470 VF thread is now waiting for 0:01:33.419 Mon 10/9 17:23:28.469 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.471 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.469 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.470 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.470 Event: 0x8065 Mon 10/9 17:23:28.472 VF processing job null nPlayin=true Mon 10/9 17:23:28.472 isRec=false rd=5388192 base=5294525 Mon 10/9 17:23:28.472 VF thread is now waiting for 0:01:33.417 Mon 10/9 17:23:28.472 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.471 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.473 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.473 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.473 Event: 0x8065 Mon 10/9 17:23:28.472 VF processing job null nPlayin=true Mon 10/9 17:23:28.472 isRec=false rd=5388192 base=5294527 Mon 10/9 17:23:28.472 VF thread is now waiting for 0:01:33.415 Mon 10/9 17:23:28.472 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.474 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.473 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.473 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.473 Event: 0x8065 Mon 10/9 17:23:28.475 VF processing job null nPlayin=true Mon 10/9 17:23:28.475 isRec=false rd=5388192 base=5294529 Mon 10/9 17:23:28.475 VF thread is now waiting for 0:01:33.413 Mon 10/9 17:23:28.475 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.477 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.475 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.476 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.476 Event: 0x8065 Mon 10/9 17:23:28.478 VF processing job null nPlayin=true Mon 10/9 17:23:28.478 isRec=false rd=5388192 base=5294531 Mon 10/9 17:23:28.476 VF thread is now waiting for 0:01:33.411 Mon 10/9 17:23:28.476 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.478 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.477 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.477 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.477 Event: 0x8065 Mon 10/9 17:23:28.479 VF processing job null nPlayin=true Mon 10/9 17:23:28.479 isRec=false rd=5388192 base=5294533 Mon 10/9 17:23:28.479 VF thread is now waiting for 0:01:33.409 Mon 10/9 17:23:28.480 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.479 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.481 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.481 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.479 Event: 0x8065 Mon 10/9 17:23:28.481 VF processing job null nPlayin=true Mon 10/9 17:23:28.480 isRec=false rd=5388192 base=5294535 Mon 10/9 17:23:28.480 VF thread is now waiting for 0:01:33.407 Mon 10/9 17:23:28.487 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.486 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.488 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.488 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.489 Event: 0x8065 Mon 10/9 17:23:28.487 VF processing job null nPlayin=true Mon 10/9 17:23:28.489 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:28.487 isRec=false rd=5388192 base=5294543 Mon 10/9 17:23:28.488 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:28.490 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:28.490 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:28.490 Event: 0x8065 Mon 10/9 17:23:28.488 VF processing job null nPlayin=true Mon 10/9 17:23:28.488 isRec=false rd=5388192 base=5294544 Mon 10/9 17:23:28.489 VF thread is now waiting for 0:01:33.398 Mon 10/9 17:23:30.580 VF.submitJob(VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null]) Mon 10/9 17:23:30.581 VF processing job VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] nPlayin=true Mon 10/9 17:23:30.581 VF processing on UI Thread VFJob[TimeAdjust r=0.0 t=30000 file=null ifn=null] Mon 10/9 17:23:30.583 VideoFrame.timeSelected(Mon 10/9 4:28:58.250, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] Mon 10/9 17:23:30.583 VideoFrame.timeSelected2(Mon 10/9 4:28:58.250, true) currFile=MediaFile[id=1963648 A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] host=sage encodedBy=DISH411-100227C on 127.0.0.1:5555 MPEG2 Max Quality format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 12000 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\Thoughtcrimes-1866736-0.mpg, Seg0[Mon 10/9 3:00:00.191-Mon 10/9 4:30:00.001]] realDur=5388192 Mon 10/9 17:23:30.584 About to perform media time selection for 5326574 Mon 10/9 17:23:30.696 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:30.696 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:30.697 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:30.697 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:30.697 Event: 0x8065 Mon 10/9 17:23:30.697 VF processing job null nPlayin=true Mon 10/9 17:23:30.697 isRec=false rd=5388192 base=5326574 Mon 10/9 17:23:30.700 VF thread is now waiting for 0:01:01.368 Mon 10/9 17:23:30.770 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:30.773 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:30.771 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:30.771 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:30.771 Event: 0x8065 Mon 10/9 17:23:30.773 VF processing job null nPlayin=true Mon 10/9 17:23:30.774 isRec=false rd=5388192 base=5326639 Mon 10/9 17:23:30.774 VF thread is now waiting for 0:01:01.303 Mon 10/9 17:23:30.772 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:30.774 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:30.775 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:30.773 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:30.773 Event: 0x8065 Mon 10/9 17:23:30.773 VF processing job null nPlayin=true Mon 10/9 17:23:30.775 isRec=false rd=5388192 base=5326641 Mon 10/9 17:23:30.776 VF thread is now waiting for 0:01:01.301 Mon 10/9 17:23:30.778 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:30.780 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:30.778 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:30.779 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:30.779 Event: 0x8065 Mon 10/9 17:23:30.781 VF processing job null nPlayin=true Mon 10/9 17:23:30.779 isRec=false rd=5388192 base=5326647 Mon 10/9 17:23:30.779 VF thread is now waiting for 0:01:01.295 Mon 10/9 17:23:30.787 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:30.786 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:30.788 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:30.788 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:30.788 Event: 0x8065 Mon 10/9 17:23:30.786 VF processing job null nPlayin=true Mon 10/9 17:23:30.787 isRec=false rd=5388192 base=5326654 Mon 10/9 17:23:30.789 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:30.787 VF thread is now waiting for 0:01:01.288 Mon 10/9 17:23:30.787 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:30.788 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:30.788 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:30.788 Event: 0x8065 Mon 10/9 17:23:30.788 VF processing job null nPlayin=true Mon 10/9 17:23:30.789 isRec=false rd=5388192 base=5326655 Mon 10/9 17:23:30.789 VF thread is now waiting for 0:01:01.286 Mon 10/9 17:23:33.514 VF.submitJob(VFJob[Pause r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:33.517 VF processing job VFJob[Pause r=0.0 t=0 file=null ifn=null] nPlayin=true Mon 10/9 17:23:33.517 processOptionsMenu optionsMenu=default:null|OptionsMenu:StopPopup Mon 10/9 17:23:33.546 VF processing on UI Thread VFJob[Pause r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:33.546 Pausing the playback graph. Mon 10/9 17:23:33.546 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:33.547 VF processing job null nPlayin=false Mon 10/9 17:23:33.547 isRec=false rd=5388192 base=5329303 Mon 10/9 17:23:33.547 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=false Mon 10/9 17:23:33.548 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:33.548 DShowMediaPlayer is consuming the events... Mon 10/9 17:23:33.548 Event: 0xe Mon 10/9 17:23:33.548 VF processing job null nPlayin=false Mon 10/9 17:23:33.548 isRec=false rd=5388192 base=5329303 Mon 10/9 17:23:33.548 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:23:33.550 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\logo_stop.png Mon 10/9 17:23:33.553 ImageUtils creating BI copy sun.awt.windows.WImage@de537 Mon 10/9 17:23:33.554 Premultiplying alpha for BuffImage... Mon 10/9 17:23:33.555 Creating DirectX9 Texture from memory w=65 h=65 Mon 10/9 17:23:34.201 VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:34.201 VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=false Mon 10/9 17:23:34.201 CloseAndWait is executing the close job synchronously now Mon 10/9 17:23:34.201 VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:34.206 VF logFileWatch doneAir=A[1866736,389185,"Thoughtcrimes",34763@1009.03:00,90] theTime=Mon 10/9 4:29:00.985 recTime=Mon 10/9 3:00:00.191 Mon 10/9 17:23:34.206 Stopping the playback graph. Mon 10/9 17:23:34.229 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Mon 10/9 17:23:34.230 Tearing down playback graph Mon 10/9 17:23:34.230 NATIVE Deallocating the CPlayerData object Mon 10/9 17:23:34.398 NATIVE Finished destroying the playback graph Mon 10/9 17:23:34.398 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=false Mon 10/9 17:23:34.398 VF discarding job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Mon 10/9 17:23:34.398 VF processing job null nPlayin=false Mon 10/9 17:23:34.398 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:23:34.403 setUI(sage.b2@7fc620[Program Info]) histIdx=2 uiHistory=[sage.b2@1e12e2c[Main Menu], sage.b2@1ca029b[My TV], sage.b2@7fc620[Program Info], sage.b2@15b9f9a[MC MediaPlayer OSD]] Mon 10/9 17:23:35.662 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=143] numGlyphs=1674 numCachedGlyphs=234 numImages=88 Mon 10/9 17:23:35.674 Premultiplying alpha for BuffImage... Mon 10/9 17:23:35.687 Creating DirectX9 Texture from memory w=256 h=256 Mon 10/9 17:23:35.688 Premultiplying alpha for BuffImage... Mon 10/9 17:23:35.698 AWTThread Hang Detected - hang time = 750 Mon 10/9 17:23:35.699 Creating DirectX9 Texture from memory w=256 h=256 Mon 10/9 17:23:35.700 Premultiplying alpha for BuffImage... Mon 10/9 17:23:35.716 Creating DirectX9 Texture from memory w=256 h=256 Mon 10/9 17:23:35.717 Premultiplying alpha for BuffImage... Mon 10/9 17:23:35.730 Creating DirectX9 Texture from memory w=256 h=256 Mon 10/9 17:23:36.066 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=56] numGlyphs=1674 numCachedGlyphs=235 numImages=11 Mon 10/9 17:23:36.067 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.081 Creating DirectX9 Texture from memory w=256 h=256 Mon 10/9 17:23:36.081 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.093 Creating DirectX9 Texture from memory w=256 h=256 Mon 10/9 17:23:36.093 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.109 Creating DirectX9 Texture from memory w=256 h=256 Mon 10/9 17:23:36.108 VF processing job null nPlayin=false Mon 10/9 17:23:36.109 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:23:36.112 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim1.gif Mon 10/9 17:23:36.114 ImageUtils creating BI copy sun.awt.windows.WImage@f95821 Mon 10/9 17:23:36.115 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.116 Creating DirectX9 Texture from memory w=32 h=32 Mon 10/9 17:23:36.123 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\ShowIcons\watched.png Mon 10/9 17:23:36.123 ImageUtils creating BI copy sun.awt.windows.WImage@144f47b Mon 10/9 17:23:36.123 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.125 Creating DirectX9 Texture from memory w=60 h=60 Mon 10/9 17:23:36.130 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim2.gif Mon 10/9 17:23:36.132 ImageUtils creating BI copy sun.awt.windows.WImage@1257d30 Mon 10/9 17:23:36.132 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.133 Creating DirectX9 Texture from memory w=32 h=32 Mon 10/9 17:23:36.143 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim3.gif Mon 10/9 17:23:36.144 ImageUtils creating BI copy sun.awt.windows.WImage@c2b246 Mon 10/9 17:23:36.145 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.145 Creating DirectX9 Texture from memory w=32 h=32 Mon 10/9 17:23:36.160 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim0.gif Mon 10/9 17:23:36.162 ImageUtils creating BI copy sun.awt.windows.WImage@1ab4586 Mon 10/9 17:23:36.163 Premultiplying alpha for BuffImage... Mon 10/9 17:23:36.163 Creating DirectX9 Texture from memory w=32 h=32 Mon 10/9 17:23:36.404 VF processing job null nPlayin=false Mon 10/9 17:23:36.404 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:23:37.546 setUI(sage.b2@1ca029b[My TV]) histIdx=1 uiHistory=[sage.b2@1e12e2c[Main Menu], sage.b2@1ca029b[My TV], sage.b2@7fc620[Program Info], sage.b2@15b9f9a[MC MediaPlayer OSD]] Mon 10/9 17:23:39.055 setUI(sage.b2@1e12e2c[Main Menu]) histIdx=0 uiHistory=[sage.b2@1e12e2c[Main Menu], sage.b2@1ca029b[My TV], sage.b2@7fc620[Program Info], sage.b2@15b9f9a[MC MediaPlayer OSD]] Mon 10/9 17:23:39.994 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_settings.png Mon 10/9 17:23:40.000 ImageUtils creating BI copy sun.awt.windows.WImage@205144 Mon 10/9 17:23:40.001 Premultiplying alpha for BuffImage... Mon 10/9 17:23:40.009 Creating DirectX9 Texture from memory w=162 h=225 Mon 10/9 17:23:40.422 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_custom3.png Mon 10/9 17:23:40.426 ImageUtils creating BI copy sun.awt.windows.WImage@19d2de4 Mon 10/9 17:23:40.427 Premultiplying alpha for BuffImage... Mon 10/9 17:23:40.437 Creating DirectX9 Texture from memory w=162 h=225 Mon 10/9 17:23:40.856 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_custom2.png Mon 10/9 17:23:40.862 ImageUtils creating BI copy sun.awt.windows.WImage@466f1d Mon 10/9 17:23:40.862 Premultiplying alpha for BuffImage... Mon 10/9 17:23:40.871 Creating DirectX9 Texture from memory w=162 h=225 Mon 10/9 17:23:41.598 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_custom1.png Mon 10/9 17:23:41.604 ImageUtils creating BI copy sun.awt.windows.WImage@1d688e7 Mon 10/9 17:23:41.605 Premultiplying alpha for BuffImage... Mon 10/9 17:23:41.613 Creating DirectX9 Texture from memory w=162 h=225 Mon 10/9 17:24:39.467 VF processing job null nPlayin=false Mon 10/9 17:24:39.465 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:29:05.322 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=false Mon 10/9 17:29:05.345 setUI(sage.b2@1202a06[Screen Saver]) histIdx=1 uiHistory=[sage.b2@1e12e2c[Main Menu], sage.b2@1202a06[Screen Saver]] Mon 10/9 17:29:05.366 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageLogo256.png Mon 10/9 17:29:05.373 ImageUtils creating BI copy sun.awt.windows.WImage@a71c9a Mon 10/9 17:29:05.373 Premultiplying alpha for BuffImage... Mon 10/9 17:29:05.379 Creating DirectX9 Texture from memory w=256 h=78 Mon 10/9 17:29:39.490 VF processing job null nPlayin=false Mon 10/9 17:29:39.487 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:34:05.334 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=true Mon 10/9 17:34:39.503 VF processing job null nPlayin=false Mon 10/9 17:34:39.498 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:34:40.061 Seeker invoking System.gc() Mon 10/9 17:34:40.412 Seeker System.gc() Mon 10/9 17:34:40.407 Saving properties file to C:\Program Files\SageTV\SageTV\SageClient.properties Mon 10/9 17:39:05.320 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=true Mon 10/9 17:39:39.511 VF processing job null nPlayin=false Mon 10/9 17:39:39.511 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:42:05.046 Setting the system clock to be Mon 10/9 17:42:05.152 Mon 10/9 17:44:05.413 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=true Mon 10/9 17:44:39.657 VF processing job null nPlayin=false Mon 10/9 17:44:39.649 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:49:05.399 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=true Mon 10/9 17:49:39.675 VF processing job null nPlayin=false Mon 10/9 17:49:39.675 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:49:40.502 Seeker invoking System.gc() Mon 10/9 17:49:40.900 Seeker System.gc() Mon 10/9 17:49:40.918 Saving properties file to C:\Program Files\SageTV\SageTV\SageClient.properties Mon 10/9 17:54:05.384 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=true Mon 10/9 17:54:39.700 VF processing job null nPlayin=false Mon 10/9 17:54:39.689 VF thread is now waiting for 0:00:00.000 Mon 10/9 17:59:05.370 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=true Mon 10/9 17:59:39.713 VF processing job null nPlayin=false Mon 10/9 17:59:39.701 VF thread is now waiting for 0:00:00.000 Mon 10/9 18:04:05.355 Screen Saver Timeout expired....tv=false playin=false fs=true sleepy=false currSS=true Mon 10/9 18:04:39.726 VF processing job null nPlayin=false Mon 10/9 18:04:39.712 VF thread is now waiting for 0:00:00.000 Mon 10/9 18:04:40.873 Seeker invoking System.gc()