02:12:44.870 [WrapperSimpleAppMain] INFO Config - Removed log file 'opendct.2018-07-07-1.log.gz' because it is over 30 days old. 07:42:46.561 [ChannelManager-56] INFO ChannelManager - Updating the HDHomeRun channel lineup HDHomeRun DRI Tuner 13120FB9 (dct_hdhomerun). 07:42:46.561 [ChannelManager-56] INFO HDHomeRunChannels - Connecting to HDHomeRun using the URL 'http://192.168.1.107:80/lineup.xml' 07:42:46.587 [ChannelManager-56] INFO ChannelManager - The static channel lineup HDHomeRun HDHR-US 1010066D (qam_hdhomerun_legacy) will remain unchanged. 07:42:46.587 [ChannelManager-56] INFO ChannelManager - The static channel lineup BM3000-1 (generic_http) will remain unchanged. 11:21:46.016 [SageTVRequestHandler-1524:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'START HDHomeRun HDHR-US Tuner 1010066D-0 Digital TV Tuner|1168709667|24-5-1|3067317812032|J:\SageTV_Recordings\NBC5Todayat11am-7460227-0.ts|Great' 11:21:46.016 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHRNativeCaptureDevice - Capture device is now re-locked. 11:21:46.017 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG SageTVRequestHandler - Starting network encoder via upload ID '1168709667' to file name 'J:\SageTV_Recordings\NBC5Todayat11am-7460227-0.ts'. 11:21:46.017 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO ChannelLineup - '24-5-1' was remapped to '5.1'. 11:21:46.017 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'force' lockKey: '-1' sendLength: 40 address: 192.168.1.105 11:21:46.018 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.105 11:21:46.018 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.105 11:21:46.019 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: '1062731514' lockKey: '1062731514' sendLength: 45 address: 192.168.1.105 11:21:46.020 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO HDHRNativeCaptureDevice - HDHomeRun is now locked. 11:21:46.020 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG RTPCaptureDeviceServices - Producer was not running. 11:21:46.020 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG BasicCaptureDevice - Consumer is not in progress. 11:21:46.024 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO HDHRNativeCaptureDevice - Starting the encoding for the channel '24-5-1' from the device 'HDHomeRun HDHR-US Tuner 1010066D-0' to the file 'J:\SageTV_Recordings\NBC5Todayat11am-7460227-0.ts'... 11:21:46.025 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO ChannelLineup - '24-5-1' was remapped to '5.1'. 11:21:46.025 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO HDHRNativeCaptureDevice - legacyTuneChannel: Using the frequency 533000000. 11:21:46.025 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/channel' value: 'auto:533000000' lockKey: '1062731514' sendLength: 49 address: 192.168.1.105 11:21:46.529 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/streaminfo' value: 'null' lockKey: '0' sendLength: 29 address: 192.168.1.105 11:21:46.529 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunTuner - streaminfo returned: 3: 5.1 KXAS-DT 4: 5.2 COZI-TV tsid=0x0B15 11:21:46.530 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHRNativeCaptureDevice - Searching for channel '5.1' program in '[3: 5.1 KXAS-DT, 4: 5.2 COZI-TV]'... 11:21:46.530 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO HDHRNativeCaptureDevice - Found '5.1' in 'HDHomeRunProgram{PROGRAM='3', CHANNEL='5.1', CALLSIGN='KXAS-DT', ENCRYPTED=false, CONTROL=false, NO_DATA=false}' out of '[3: 5.1 KXAS-DT, 4: 5.2 COZI-TV]'. 11:21:46.530 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/program' value: '3' lockKey: '1062731514' sendLength: 36 address: 192.168.1.105 11:21:46.531 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO HDHRNativeCaptureDevice - Configuring and starting the new RTP producer... 11:21:46.531 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG RTPCaptureDeviceServices - Producer was not running. 11:21:46.531 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/target' value: 'rtp://192.168.1.6:8406' lockKey: '1062731514' sendLength: 56 address: 192.168.1.105 11:21:46.531 [NIORTPProducerImpl-1536:HDHomeRun HDHR-US Tuner 1010066D-0] INFO NIORTPProducerImpl - Producer thread is running. 11:21:46.531 [NIORTPProducerImpl-1536:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG NIORTPProducerImpl - Thread priority is 9. 11:21:46.532 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/program' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.105 11:21:46.533 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] INFO HDHRNativeCaptureDevice - Configuring and starting the new SageTV consumer... 11:21:46.533 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG BasicCaptureDevice - Consumer is not in progress. 11:21:46.534 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegTransSageTVConsumerImpl - FFmpeg Transcoder consumer thread is now running. 11:21:46.534 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegTransSageTVConsumerImpl - Thread priority is 8. 11:21:46.534 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegStreamDetection - Calling avformat_open_input 11:21:46.585 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - Before avformat_find_stream_info() pos=64484 bytes_read=64484 seek_count=0. probesize: 165628 analyzeduration: 2000000. 11:21:46.762 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO mpegts - Repeated 1 time: [42e11720] PES packet size mismatch. 11:21:46.762 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO mpegts - [42e746e0] decoding for stream 0 failed 11:21:46.768 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 459284 11:21:46.768 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 459284, returnValue = 473761 11:21:46.769 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 459284 11:21:46.769 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 459284, returnValue = 475077 11:21:46.769 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 123704, readIndex = 459284 11:21:46.769 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 123704, readIndex = 123704, returnValue = 123704 11:21:46.844 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 639576 11:21:46.844 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 11:21:46.847 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288 11:21:46.847 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288, returnValue = 648789 11:21:46.848 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 524288 11:21:46.848 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 11:21:46.848 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0 11:21:46.848 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0, returnValue = 650105 11:21:46.849 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - After avformat_find_stream_info() pos=0 bytes_read=1499444 seek_count=2. probesize: 165628 analyzeduration: 2000000. 11:21:46.850 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - current container duration = 0.3003 seconds 11:21:46.850 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - avformat_find_stream_info() failed with error code 1. Trying again with more data. 11:21:46.851 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegStreamDetection - Calling avformat_open_input 11:21:46.853 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - Before avformat_find_stream_info() pos=262144 bytes_read=262144 seek_count=0. probesize: 656872 analyzeduration: 1300300. 11:21:46.967 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 908040 11:21:46.967 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 908040, returnValue = 914621 11:21:46.968 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 908040 11:21:46.968 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 908040, returnValue = 915937 11:21:46.968 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 665937, readIndex = 908040 11:21:46.968 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 665937, readIndex = 665937, returnValue = 665937 11:21:47.068 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 415937, readIndex = 1135708 11:21:47.068 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 415937, readIndex = 415937, returnValue = 415937 11:21:47.071 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 940225 11:21:47.071 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 940225, returnValue = 1143605 11:21:47.071 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 940225 11:21:47.071 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 11:21:47.071 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0 11:21:47.071 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0, returnValue = 1144921 11:21:47.072 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - After avformat_find_stream_info() pos=0 bytes_read=1902099 seek_count=3. probesize: 656872 analyzeduration: 1300300. 11:21:47.072 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - current container duration = 0.641356 seconds 11:21:47.072 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegUtil - Video stream 0 has no width or no height. 11:21:47.073 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - Desired program set. Stream details unavailable for one or more streams. Trying again with an extended probe. 11:21:47.073 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegStreamDetection - Calling avformat_open_input 11:21:47.075 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - Before avformat_find_stream_info() pos=262144 bytes_read=262144 seek_count=0. probesize: 1149056 analyzeduration: 1641356. 11:21:47.250 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1505504 11:21:47.250 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1505504, returnValue = 1542353 11:21:47.250 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1505504 11:21:47.250 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1505504, returnValue = 1543669 11:21:47.376 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 1043669, readIndex = 1826608 11:21:47.376 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 1043669, readIndex = 1043669, returnValue = 1043669 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1567957 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1567957, returnValue = 1829241 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 1567957 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0, returnValue = 1829241 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - After avformat_find_stream_info() pos=0 bytes_read=2350896 seek_count=2. probesize: 1149056 analyzeduration: 1641356. 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegStreamDetection - current container duration = 0.941656 seconds 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegStreamDetection - FFmpeg stream detection done in 843ms, 11:21:47.377 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegTranscoder - Initializing FFmpeg transcoder stream output. 11:21:47.379 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegContext - Primary: Input #0, mpegts, from 'input-mpeg-ts.ts': Duration: 00:00:00.94, start: 84680.362300, bitrate: 15540 kb/s Program 3 Stream #0:0[0x31], 15, 1/90000: Video: mpeg2video (Main) ([2][0][0][0] / 0x0002), yuv420p(tv), 1920x1080 [SAR 1:1 DAR 16:9], Closed Captions, max. 24000 kb/s, 29.97 fps, 29.97 tbr, 90k tbn, 59.94 tbc Stream #0:1[0x34](eng), 15, 1/90000: Audio: ac3 ([129][0][0][0] / 0x0081), 48000 Hz, 5.1(side), fltp, 384 kb/s Stream #0:2[0x35](spa), 15, 1/90000: Audio: ac3 ([129][0][0][0] / 0x0081), 48000 Hz, stereo, fltp, 192 kb/s 11:21:47.379 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegContext - Calling avformat_alloc_output_context2 11:21:47.379 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegContext - Primary: Output #0, mpegts, to 'J:\SageTV_Recordings\NBC5Todayat11am-7460227-0.ts': Stream #0:0, 0, 1/90000: Video: mpeg2video, yuv420p(tv), 1920x1080 [SAR 1:1 DAR 16:9], q=2-31, max. 24000 kb/s, 90k tbn, 59.94 tbc Stream #0:1(eng), 0, 1/90000: Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s Stream #0:2(spa), 0, 1/90000: Audio: ac3, 48000 Hz, stereo, fltp, 192 kb/s 11:21:47.380 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegTranscoder - Writing header 11:21:47.380 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegTranscoder - Initialized FFmpeg transcoder stream output. 11:21:48.778 [SageTVRequestHandler-1524:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG SageTVRequestHandler - Replied: 'OK' 11:22:01.861 [SageTVRequestHandler-1522:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'START HDHomeRun HDHR-US Tuner 10105AC2-1 Digital TV Tuner|527603431|19-11-1|3067317843722|J:\SageTV_Recordings\CBS11at11-7459300-0.ts|Great' 11:22:01.861 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHRNativeCaptureDevice - Capture device is now re-locked. 11:22:01.861 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG SageTVRequestHandler - Starting network encoder via upload ID '527603431' to file name 'J:\SageTV_Recordings\CBS11at11-7459300-0.ts'. 11:22:01.861 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO ChannelLineup - '19-11-1' was remapped to '11.1'. 11:22:01.861 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'force' lockKey: '-1' sendLength: 40 address: 192.168.1.108 11:22:02.863 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.108 11:22:02.864 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.108 11:22:02.864 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: '1062731514' lockKey: '1062731514' sendLength: 45 address: 192.168.1.108 11:22:02.865 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO HDHRNativeCaptureDevice - HDHomeRun is now locked. 11:22:02.865 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG RTPCaptureDeviceServices - Producer was not running. 11:22:02.865 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG BasicCaptureDevice - Consumer is not in progress. 11:22:02.871 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO HDHRNativeCaptureDevice - Starting the encoding for the channel '19-11-1' from the device 'HDHomeRun HDHR-US Tuner 10105AC2-1' to the file 'J:\SageTV_Recordings\CBS11at11-7459300-0.ts'... 11:22:02.871 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] ERROR HDHRNativeCaptureDevice - The channel '19-11-1' does not have a program on the lineup 'qam_hdhomerun_legacy'. 11:22:02.871 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] ERROR SageTVRequestHandler - SageTV sent: 'START HDHomeRun HDHR-US Tuner 10105AC2-1 Digital TV Tuner|527603431|19-11-1|3067317843722|J:\SageTV_Recordings\CBS11at11-7459300-0.ts|Great', Replied: 'ERROR Device Start Failed' 11:22:02.871 [SageTVRequestHandler-1522:HDHomeRun HDHR-US Tuner 10105AC2-1] ERROR SageTVRequestHandler - Encoder device is unable to start. 11:22:09.081 [SageTVTuningMonitor-52] INFO SageTVTuningMonitor - 'HDHomeRun HDHR-US Tuner 1010066D-0' produced first 37968 packets. 11:22:09.081 [SageTVTuningMonitor-52] INFO SageTVTuningMonitor - 'HDHomeRun HDHR-US Tuner 1010066D-0' recorded first 47493500 bytes. 11:23:15.758 [SageTVRequestHandler-1551:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'STOP HDHomeRun HDHR-US Tuner 10105AC2-1 Digital TV Tuner' 11:23:15.759 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHRNativeCaptureDevice - Stopping encoding... 11:23:15.759 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG RTPCaptureDeviceServices - Producer was not running. 11:23:15.759 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG BasicCaptureDevice - Consumer is not in progress. 11:23:15.759 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/channel' value: 'none' lockKey: '1062731514' sendLength: 39 address: 192.168.1.108 11:23:15.759 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] ERROR HDHRNativeCaptureDevice - Unable to stop HDHomeRun capture device because the command did not work => opendct.tuning.hdhomerun.GetSetException: ERROR: lock no longer held at opendct.tuning.hdhomerun.HDHomeRunControl.setVariable(HDHomeRunControl.java:238) at opendct.tuning.hdhomerun.HDHomeRunControl.setVariable(HDHomeRunControl.java:111) at opendct.tuning.hdhomerun.HDHomeRunTuner.set(HDHomeRunTuner.java:152) at opendct.tuning.hdhomerun.HDHomeRunTuner.clearChannel(HDHomeRunTuner.java:287) at opendct.capture.HDHRNativeCaptureDevice.stopEncoding(HDHRNativeCaptureDevice.java:1623) at opendct.sagetv.SageTVRequestHandler.run(SageTVRequestHandler.java:163) at java.lang.Thread.run(Unknown Source) 11:23:15.760 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'force' lockKey: '1062731514' sendLength: 40 address: 192.168.1.108 11:23:15.760 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.108 11:23:15.761 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO HDHRNativeCaptureDevice - HDHomeRun is now unlocked. 11:23:15.761 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHRNativeCaptureDevice - Capture device is now re-unlocked. 11:23:15.761 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG SageTVRequestHandler - Replied: 'OK' 11:23:15.788 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG SageTVRequestHandler - SageTV sent: 'START HDHomeRun HDHR-US Tuner 10105AC2-1 Digital TV Tuner|932282157|19-11-1|3067317991576|J:\SageTV_Recordings\CBS11at11-7459300-1.ts|Great' 11:23:15.788 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHRNativeCaptureDevice - Capture device is now re-locked. 11:23:15.788 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG SageTVRequestHandler - Starting network encoder via upload ID '932282157' to file name 'J:\SageTV_Recordings\CBS11at11-7459300-1.ts'. 11:23:15.789 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO ChannelLineup - '19-11-1' was remapped to '11.1'. 11:23:15.789 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'force' lockKey: '-1' sendLength: 40 address: 192.168.1.108 11:23:15.790 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.108 11:23:15.790 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.108 11:23:15.791 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: '1062731514' lockKey: '1062731514' sendLength: 45 address: 192.168.1.108 11:23:15.791 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO HDHRNativeCaptureDevice - HDHomeRun is now locked. 11:23:15.791 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG RTPCaptureDeviceServices - Producer was not running. 11:23:15.792 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG BasicCaptureDevice - Consumer is not in progress. 11:23:15.797 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO HDHRNativeCaptureDevice - Starting the encoding for the channel '19-11-1' from the device 'HDHomeRun HDHR-US Tuner 10105AC2-1' to the file 'J:\SageTV_Recordings\CBS11at11-7459300-1.ts'... 11:23:15.797 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] ERROR HDHRNativeCaptureDevice - The channel '19-11-1' does not have a program on the lineup 'qam_hdhomerun_legacy'. 11:23:15.797 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] ERROR SageTVRequestHandler - SageTV sent: 'START HDHomeRun HDHR-US Tuner 10105AC2-1 Digital TV Tuner|932282157|19-11-1|3067317991576|J:\SageTV_Recordings\CBS11at11-7459300-1.ts|Great', Replied: 'ERROR Device Start Failed' 11:23:15.797 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] ERROR SageTVRequestHandler - Encoder device is unable to start. 11:23:35.494 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG SageTVRequestHandler - SageTV sent: 'STOP HDHomeRun HDHR-US Tuner 10105AC2-1 Digital TV Tuner' 11:23:35.495 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHRNativeCaptureDevice - Stopping encoding... 11:23:35.495 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG RTPCaptureDeviceServices - Producer was not running. 11:23:35.495 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG BasicCaptureDevice - Consumer is not in progress. 11:23:35.495 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/channel' value: 'none' lockKey: '1062731514' sendLength: 39 address: 192.168.1.108 11:23:35.495 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/target' value: 'none' lockKey: '1062731514' sendLength: 38 address: 192.168.1.108 11:23:35.496 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'force' lockKey: '1062731514' sendLength: 40 address: 192.168.1.108 11:23:35.497 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.108 11:23:35.497 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] INFO HDHRNativeCaptureDevice - HDHomeRun is now unlocked. 11:23:35.497 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG HDHRNativeCaptureDevice - Capture device is now re-unlocked. 11:23:35.498 [SageTVRequestHandler-1551:HDHomeRun HDHR-US Tuner 10105AC2-1] DEBUG SageTVRequestHandler - Replied: 'OK' 11:24:26.694 [SageTVRequestHandler-1552:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'STOP HDHomeRun HDHR-US Tuner 1010066D-0 Digital TV Tuner' 11:24:26.694 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHRNativeCaptureDevice - Stopping encoding... 11:24:26.694 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG RTPCaptureDeviceServices - Stopping producer thread... 11:24:26.695 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG RTPCaptureDeviceServices - Waiting for producer thread to stop... 11:24:26.695 [NIORTPProducerImpl-1536:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG NIORTPProducerImpl - Producer was closed by an asynchronous close exception => null 11:24:26.695 [NIORTPProducerImpl-1536:HDHomeRun HDHR-US Tuner 1010066D-0] INFO NIORTPProducerImpl - Producer thread has disconnected. 11:24:26.695 [NIORTPProducerImpl-1536:HDHomeRun HDHR-US Tuner 1010066D-0] INFO NIORTPProducerImpl - Producer thread has stopped. 11:24:26.695 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG BasicCaptureDevice - Stopping consumer thread... 11:24:26.695 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG BasicCaptureDevice - Waiting for consumer thread to stop... 11:24:26.695 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] ERROR FFmpegTransSageTVConsumerImpl - Interrupted while waiting for the buffer => java.lang.InterruptedException at java.lang.Object.wait(Native Method) at opendct.consumer.FFmpegTransSageTVConsumerImpl$FFmpegDirectWriter.write(FFmpegTransSageTVConsumerImpl.java:790) at opendct.video.ffmpeg.FFmpegContext$WriteCallback.call(FFmpegContext.java:454) at org.bytedeco.javacpp.avformat.av_interleaved_write_frame(Native Method) at opendct.video.ffmpeg.FFmpegTranscoder.streamOutput(FFmpegTranscoder.java:1070) at opendct.consumer.FFmpegTransSageTVConsumerImpl.run(FFmpegTransSageTVConsumerImpl.java:162) at java.lang.Thread.run(Unknown Source) 11:24:26.696 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegContext - Returning AVERROR_EOF in readCallback.call() 11:24:26.696 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] WARN mpegts - Repeated 1 time: [42e746e0] decoding for stream 0 failed. 11:24:26.696 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] WARN mpegts - [42e746e0] PES packet size mismatch 11:24:26.698 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegTranscoder - FFmpeg transcoder ended with code 0 11:24:26.698 [AsyncWriter-1539:NBC5Todayat11am-7460227-0.ts] INFO FFmpegTransSageTVConsumerImpl - Closing the file 'J:\SageTV_Recordings\NBC5Todayat11am-7460227-0.ts' 11:24:27.198 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegContext - avcodec_close 11:24:27.198 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegContext - avio_closep 11:24:27.198 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG FFmpegContext - avformat_free_context 11:24:27.198 [FFmpegTransSageTVConsumerImpl-1540:HDHomeRun HDHR-US Tuner 1010066D-0] INFO FFmpegTransSageTVConsumerImpl - FFmpeg Transcoder consumer thread stopped. 11:24:27.198 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/channel' value: 'none' lockKey: '1062731514' sendLength: 39 address: 192.168.1.105 11:24:27.200 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/target' value: 'none' lockKey: '1062731514' sendLength: 38 address: 192.168.1.105 11:24:27.200 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'force' lockKey: '1062731514' sendLength: 40 address: 192.168.1.105 11:24:27.201 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.1.105 11:24:27.202 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] INFO HDHRNativeCaptureDevice - HDHomeRun is now unlocked. 11:24:27.202 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG HDHRNativeCaptureDevice - Capture device is now re-unlocked. 11:24:27.202 [SageTVRequestHandler-1552:HDHomeRun HDHR-US Tuner 1010066D-0] DEBUG SageTVRequestHandler - Replied: 'OK'