08:54:32.582 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.18... 08:54:32.594 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Windows 7' is WINDOWS. 08:54:32.621 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory 'c:/ProgramData/OpenDCT/logs'. 08:54:32.626 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to 'c:/ProgramData/OpenDCT/logs\opendct_cling.log'. 08:54:32.626 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 08:54:32.627 [FFmpegAsyncInit-20] INFO Main - FFmpeg loading... 08:54:32.630 [FFmpegAsyncInit-20] DEBUG FFmpegUtil - Initializing FFmpegLogger... 08:54:32.696 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth3 (Realtek PCIe GBE Family Controller) 192.168.0.99 08:54:32.697 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.power.NetworkPowerEventManger' is now listening. 08:54:32.698 [FFmpegAsyncInit-20] DEBUG FFmpegUtil - Calling av_log_set_callback... 08:54:32.698 [FFmpegAsyncInit-20] DEBUG FFmpegUtil - Calling avcodec_register_all... 08:54:32.698 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.sagetv.SageTVManager' is now listening. 08:54:32.703 [DynamicAsyncInit-20] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.FFmpegTransSageTVConsumerImpl 08:54:32.703 [DynamicAsyncInit-20] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 08:54:32.703 [DynamicAsyncInit-20] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 08:54:32.703 [DynamicAsyncInit-20] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 08:54:32.718 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump started. 08:54:33.510 [FFmpegAsyncInit-20] DEBUG FFmpegUtil - Calling avfilter_register_all... 08:54:33.917 [FFmpegAsyncInit-20] DEBUG FFmpegUtil - Calling av_register_all... 08:54:33.924 [FFmpegAsyncInit-20] INFO Main - FFmpeg loaded in 1297ms. 08:54:35.382 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 08:54:35.447 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.0.99 for UPnP discovery. 08:54:35.467 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:54:35.474 [UPnPDiscovery-37] INFO UpnpManager - UPnP discovery thread has started. 08:54:35.514 [HDHomeRunDiscoverySend-38] INFO HDHomeRunDiscovery - HDHomeRun discovery sender thread started. 08:54:35.514 [HDHomeRunDiscoveryReceive-38] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.3.255:65001 broadcast started. 08:54:35.515 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.tuning.discovery.DiscoveryManager' is now listening. 08:54:35.515 [HDHomeRunDiscoverySend-38] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.3.255:65001... (startup) 08:54:35.515 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 08:54:35.522 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.525 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.531 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 74. This can be ignored. 08:54:35.532 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/hwmodel' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.152 08:54:35.534 [GenericHttpLoader-41] DEBUG DeviceLoaderImpl - Advertising new capture device 'IPTV1'. 08:54:35.534 [HDHomeRunDiscoveryReceive-38] INFO HDHomeRunDiscoverer - Discovered a new HDHomeRun device 'HDHomeRun HDHR3-US 103B29B3' with 2 tuners. 08:54:35.537 [GenericHttpLoader-41] DEBUG SageTVManager - The requested capture device 'IPTV1' did not exist. Triggering re-discovery. 08:54:35.537 [GenericHttpLoader-41] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 08:54:35.540 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.nanohttpd.NanoHTTPDManager' is now listening. 08:54:35.540 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.channel.ChannelManager' is now listening. 08:54:35.544 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 08:54:35.546 [GenericHttpLoader-41] DEBUG SageTVManager - Port 9000 is available. 08:54:35.548 [GenericHttpLoader-41] INFO SageTVManager - The capture device 'IPTV1' is ready. 08:54:35.551 [GenericHttpLoader-41] DEBUG SageTVSocketServer - Setting listening flag... 08:54:35.551 [GenericHttpLoader-41] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 08:54:35.554 [SageTVTuningMonitor-60] INFO SageTVTuningMonitor - Tuning monitor thread started. 08:54:35.559 [SageTVSocketServer-61:9000] INFO SageTVSocketServer - Started listening on port 9000... 08:54:35.598 [GenericHttpLoader-41] WARN DeviceLoaderImpl - Unable to register dependent interface using the remote IP address 'XXX-iptv.net/51.254.197.61', trying local IP address 'localhost/127.0.0.1' => 08:54:35.643 [GenericHttpLoader-41] WARN DeviceLoaderImpl - Unable to register dependent interface using the local IP address 'localhost/127.0.0.1', this may effect recovery from standby => java.io.IOException: An interface on the same subnet as '127.0.0.1' does not exist on this computer. at opendct.power.NetworkPowerEventManger.addDependentInterface(NetworkPowerEventManger.java:179) at opendct.tuning.discovery.DeviceLoaderImpl.advertiseDevice(DeviceLoaderImpl.java:135) at opendct.tuning.discovery.discoverers.GenericHttpDiscoverer.addCaptureDevice(GenericHttpDiscoverer.java:207) at opendct.tuning.http.GenericHttpLoader.run(GenericHttpLoader.java:35) at java.lang.Thread.run(Unknown Source) 08:54:35.643 [HDHomeRunDiscoveryReceive-38] DEBUG DeviceLoaderImpl - Advertising new capture device 'HDHomeRun HDHR3-US Tuner 103B29B3-0'. 08:54:35.646 [HDHomeRunDiscoveryReceive-38] DEBUG SageTVManager - The requested capture device 'HDHomeRun HDHR3-US Tuner 103B29B3-0' did not exist. Triggering re-discovery. 08:54:35.646 [HDHomeRunDiscoveryReceive-38] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 08:54:35.651 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.652 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/model' value: 'null' lockKey: '0' sendLength: 21 address: 192.168.0.152 08:54:35.653 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/version' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.152 08:54:35.653 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/features' value: 'null' lockKey: '0' sendLength: 24 address: 192.168.0.152 08:54:35.654 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun details: HDHR3-US, hdhomerun3_atsc, 20161107, HDHomeRunFeatures{channelmap=[us-bcast, us-cable, us-hrc, us-irc, kr-bcast, kr-cable], modulation=[auto, auto6t, auto6c, qam], autoModulation=[]} 08:54:35.654 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: 'help' value: 'null' lockKey: '0' sendLength: 15 address: 192.168.0.152 08:54:35.656 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun help: [Supported configuration options:, /sys/8vsb_override, /sys/copyright, /sys/debug, /sys/features, /sys/hwmodel, /sys/model, /sys/restart , /sys/version, /tuner/channel :, /tuner/channelmap , /tuner/debug, /tuner/filter "0x-0x [...]", /tuner/lockkey, /tuner/program , /tuner/streaminfo, /tuner/status, /tuner/target :] 08:54:35.656 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/card/status' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.152 08:54:35.657 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/channelmap' value: 'null' lockKey: '0' sendLength: 29 address: 192.168.0.152 08:54:35.661 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 08:54:35.661 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 08:54:35.662 [HDHomeRunDiscoveryReceive-38] INFO ChannelManager - The static channel lineup HDHomeRun HDHR3-US 103B29B3 (atsc_hdhomerun_legacy_103b29b3) will remain unchanged. 08:54:35.663 [HDHomeRunDiscoveryReceive-38] INFO HDHRNativeCaptureDevice - Encoder Manufacturer: 'Silicondust', Number: 0, Remote IP: '192.168.0.152', Local IP: '192.168.0.99', CableCARD: false, Lineup: 'atsc_hdhomerun_legacy_103b29b3', Offline Scan Enabled: false, RTP Port: 8490 08:54:35.663 [HDHomeRunDiscoveryReceive-38] INFO SageTVManager - The capture device 'HDHomeRun HDHR3-US Tuner 103B29B3-0' is ready. 08:54:35.697 [HDHomeRunDiscoveryReceive-38] DEBUG DeviceLoaderImpl - Advertising new capture device 'HDHomeRun HDHR3-US Tuner 103B29B3-1'. 08:54:35.697 [HDHomeRunDiscoveryReceive-38] DEBUG SageTVManager - The requested capture device 'HDHomeRun HDHR3-US Tuner 103B29B3-1' did not exist. Triggering re-discovery. 08:54:35.697 [HDHomeRunDiscoveryReceive-38] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 08:54:35.700 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.701 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/version' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.152 08:54:35.701 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun details: HDHR3-US, hdhomerun3_atsc, 20161107, HDHomeRunFeatures{channelmap=[us-bcast, us-cable, us-hrc, us-irc, kr-bcast, kr-cable], modulation=[auto, auto6t, auto6c, qam], autoModulation=[]} 08:54:35.701 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun help: [Supported configuration options:, /sys/8vsb_override, /sys/copyright, /sys/debug, /sys/features, /sys/hwmodel, /sys/model, /sys/restart , /sys/version, /tuner/channel :, /tuner/channelmap , /tuner/debug, /tuner/filter "0x-0x [...]", /tuner/lockkey, /tuner/program , /tuner/streaminfo, /tuner/status, /tuner/target :] 08:54:35.701 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/channelmap' value: 'null' lockKey: '0' sendLength: 29 address: 192.168.0.152 08:54:35.702 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 08:54:35.702 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 08:54:35.702 [HDHomeRunDiscoveryReceive-38] INFO ChannelManager - The static channel lineup HDHomeRun HDHR3-US 103B29B3 (atsc_hdhomerun_legacy_103b29b3) will remain unchanged. 08:54:35.703 [HDHomeRunDiscoveryReceive-38] INFO HDHRNativeCaptureDevice - Encoder Manufacturer: 'Silicondust', Number: 1, Remote IP: '192.168.0.152', Local IP: '192.168.0.99', CableCARD: false, Lineup: 'atsc_hdhomerun_legacy_103b29b3', Offline Scan Enabled: false, RTP Port: 8432 08:54:35.703 [HDHomeRunDiscoveryReceive-38] INFO SageTVManager - The capture device 'HDHomeRun HDHR3-US Tuner 103B29B3-1' is ready. 08:54:35.715 [HDHomeRunDiscoverySend-38] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.3.255:65001... (requested) 08:54:35.738 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.739 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.740 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 72. This can be ignored. 08:54:35.740 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/hwmodel' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.111 08:54:35.741 [HDHomeRunDiscoveryReceive-38] INFO HDHomeRunDiscoverer - Discovered a new HDHomeRun device 'HDHomeRun HDHR-US 101C8F83' with 2 tuners. 08:54:35.774 [HDHomeRunDiscoveryReceive-38] DEBUG DeviceLoaderImpl - Advertising new capture device 'HDHomeRun HDHR-US Tuner 101C8F83-0'. 08:54:35.774 [HDHomeRunDiscoveryReceive-38] DEBUG SageTVManager - The requested capture device 'HDHomeRun HDHR-US Tuner 101C8F83-0' did not exist. Triggering re-discovery. 08:54:35.774 [HDHomeRunDiscoveryReceive-38] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 08:54:35.778 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.779 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/model' value: 'null' lockKey: '0' sendLength: 21 address: 192.168.0.111 08:54:35.779 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/version' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.111 08:54:35.780 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/features' value: 'null' lockKey: '0' sendLength: 24 address: 192.168.0.111 08:54:35.780 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun details: HDHR-US, hdhomerun_atsc, 20161107, HDHomeRunFeatures{channelmap=[us-bcast, us-cable, us-hrc, us-irc, kr-bcast, kr-cable], modulation=[auto, auto6t, auto6c, qam], autoModulation=[]} 08:54:35.780 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: 'help' value: 'null' lockKey: '0' sendLength: 15 address: 192.168.0.111 08:54:35.781 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun help: [Supported configuration options:, /ir/target ://:, /sys/copyright, /sys/debug, /sys/features, /sys/hwmodel, /sys/model, /sys/restart , /sys/version, /tuner/channel :, /tuner/channelmap , /tuner/debug, /tuner/filter "0x-0x [...]", /tuner/lockkey, /tuner/program , /tuner/streaminfo, /tuner/status, /tuner/target :] 08:54:35.781 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/card/status' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.111 08:54:35.782 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/channelmap' value: 'null' lockKey: '0' sendLength: 29 address: 192.168.0.111 08:54:35.782 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 08:54:35.782 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 08:54:35.782 [HDHomeRunDiscoveryReceive-38] INFO ChannelManager - The static channel lineup HDHomeRun HDHR-US 101C8F83 (atsc_hdhomerun_legacy_101c8f83) will remain unchanged. 08:54:35.783 [HDHomeRunDiscoveryReceive-38] INFO HDHRNativeCaptureDevice - Encoder Manufacturer: 'Silicondust', Number: 0, Remote IP: '192.168.0.111', Local IP: '192.168.0.99', CableCARD: false, Lineup: 'atsc_hdhomerun_legacy_101c8f83', Offline Scan Enabled: false, RTP Port: 8360 08:54:35.783 [HDHomeRunDiscoveryReceive-38] INFO SageTVManager - The capture device 'HDHomeRun HDHR-US Tuner 101C8F83-0' is ready. 08:54:35.810 [SageTVSocketServer-61:9000] WARN SageTVSocketServer - IPv6 connection detected. This is an untested configuration. 08:54:35.810 [SageTVRequestHandler-82:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'VERSION' 08:54:35.811 [SageTVRequestHandler-82:Unknown] DEBUG SageTVRequestHandler - Replied: '3.0' 08:54:35.817 [HDHomeRunDiscoveryReceive-38] DEBUG DeviceLoaderImpl - Advertising new capture device 'HDHomeRun HDHR-US Tuner 101C8F83-1'. 08:54:35.817 [HDHomeRunDiscoveryReceive-38] DEBUG SageTVManager - The requested capture device 'HDHomeRun HDHR-US Tuner 101C8F83-1' did not exist. Triggering re-discovery. 08:54:35.817 [HDHomeRunDiscoveryReceive-38] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 08:54:35.820 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.821 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/sys/version' value: 'null' lockKey: '0' sendLength: 23 address: 192.168.0.111 08:54:35.821 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun details: HDHR-US, hdhomerun_atsc, 20161107, HDHomeRunFeatures{channelmap=[us-bcast, us-cable, us-hrc, us-irc, kr-bcast, kr-cable], modulation=[auto, auto6t, auto6c, qam], autoModulation=[]} 08:54:35.822 [HDHomeRunDiscoveryReceive-38] DEBUG HDHRNativeCaptureDevice - HDHomeRun help: [Supported configuration options:, /ir/target ://:, /sys/copyright, /sys/debug, /sys/features, /sys/hwmodel, /sys/model, /sys/restart , /sys/version, /tuner/channel :, /tuner/channelmap , /tuner/debug, /tuner/filter "0x-0x [...]", /tuner/lockkey, /tuner/program , /tuner/streaminfo, /tuner/status, /tuner/target :] 08:54:35.822 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/channelmap' value: 'null' lockKey: '0' sendLength: 29 address: 192.168.0.111 08:54:35.822 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 08:54:35.822 [HDHomeRunDiscoveryReceive-38] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 08:54:35.822 [HDHomeRunDiscoveryReceive-38] INFO ChannelManager - The static channel lineup HDHomeRun HDHR-US 101C8F83 (atsc_hdhomerun_legacy_101c8f83) will remain unchanged. 08:54:35.823 [HDHomeRunDiscoveryReceive-38] INFO HDHRNativeCaptureDevice - Encoder Manufacturer: 'Silicondust', Number: 1, Remote IP: '192.168.0.111', Local IP: '192.168.0.99', CableCARD: false, Lineup: 'atsc_hdhomerun_legacy_101c8f83', Offline Scan Enabled: false, RTP Port: 8410 08:54:35.823 [HDHomeRunDiscoveryReceive-38] INFO SageTVManager - The capture device 'HDHomeRun HDHR-US Tuner 101C8F83-1' is ready. 08:54:35.863 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.864 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.864 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 72. This can be ignored. 08:54:35.865 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.866 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.866 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 74. This can be ignored. 08:54:35.915 [HDHomeRunDiscoverySend-38] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.3.255:65001... (requested) 08:54:35.917 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.919 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:35.920 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 72. This can be ignored. 08:54:35.921 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.922 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:35.924 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 74. This can be ignored. 08:54:36.115 [HDHomeRunDiscoverySend-38] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.3.255:65001... (startup) 08:54:36.118 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:36.119 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.111 08:54:36.120 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 72. This can be ignored. 08:54:36.121 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner0/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:36.122 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunControl - key: '/tuner1/lockkey' value: 'null' lockKey: '0' sendLength: 26 address: 192.168.0.152 08:54:36.123 [HDHomeRunDiscoveryReceive-38] DEBUG HDHomeRunDiscovery - HDHomerun device returned an unknown tag with the length 74. This can be ignored. 08:54:39.474 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:54:39.768 [SageTVRequestHandler-82:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'STOP IPTV1 HDMI' 08:54:39.769 [SageTVRequestHandler-82:IPTV1] DEBUG GenericHttpCaptureDevice - Stopping encoding... 08:54:39.769 [SageTVRequestHandler-82:IPTV1] DEBUG BasicCaptureDevice - Consumer is was not in progress. 08:54:39.771 [SageTVRequestHandler-82:IPTV1] INFO GenericHttpCaptureDevice - Capture device is was already unlocked. 08:54:39.771 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - Replied: 'OK' 08:54:39.772 [StoppingThread-98] DEBUG GenericHttpCaptureDevice - Stopping executable will be run in 15000 milliseconds. 08:54:39.807 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - SageTV sent: 'BUFFER IPTV1 HDMI|1256743150|165|83886080|E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf|Great-H.264' 08:54:39.807 [SageTVRequestHandler-82:IPTV1] DEBUG GenericHttpCaptureDevice - Capture device is now re-locked. 08:54:39.807 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - Starting buffered network encoder via upload ID '1256743150' to file name 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf'. 08:54:39.807 [SageTVRequestHandler-82:IPTV1] DEBUG BasicCaptureDevice - Consumer is was not in progress. 08:54:39.807 [StoppingThread-98] DEBUG GenericHttpCaptureDevice - Stopping executable was cancelled. 08:54:39.808 [SageTVRequestHandler-82:IPTV1] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '165' 08:54:39.812 [SageTVRequestHandler-82:IPTV1] INFO GenericHttpCaptureDevice - Starting the encoding for the channel '165' from the device 'IPTV1' to the file 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf'... 08:54:39.812 [SageTVRequestHandler-82:IPTV1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV producer... 08:54:39.813 [SageTVRequestHandler-82:IPTV1] INFO NIOHTTPProducerImpl - Connecting to source using the URL 'http://XXX-iptv.net:4545/live/Login/Password/165.ts' 08:54:40.069 [SageTVRequestHandler-82:IPTV1] DEBUG HTTPProducerImpl - HTTP response: 'HTTP/1.1 302 Found', 'Server: nginx', 'Date: Fri, 23 Dec 2016 13:54:32 GMT', 'Content-Type: text/html; charset=UTF-8', 'Connection: close', 'Access-Control-Allow-Origin: *', 'Location: http://192.99.40.78:4545/live/Login/Password/165.ts?token=Mm8wSmxuNGUxWCtTWm5jc3ZTQ1VBYitEN3ptQVUzb01HVHREUStuLzE1YTFRSm5HUC9EZFlQVURtMDFHc1NVbVprT0Nqdk9waitsaHROUlhjRUx3M3lNY2ZUNXVFZmx1b0tkQ21uTlc3aUlZTTJXa0hJcFV4SFZORS9uUkgwbEJVcmVWSXQvbUtleEZHYjlmQ2lOV01UbzBuWUx1TkVtMmxqVUdDcDdObGpmckE1aUNybEdCR2lveFZyZmt5aWIybzhzMFB0bTgzWnB6VE9sS2kwUy9kTmd3NUlNNFRMTlc4N3J5cU9QaUp0NU1RTlVxSEtENFV0ZEhvZkdxS2REbk9Qc1dRM3EzU21KMzZaNWZ0ejNJZ3RPMXo0RkhOSVpYdUVYZjRqQllEZFIxcVh6NWZ5d0dUbFljUk1mbnpPdFc2MVRSQ2NjckVjTVJkRVN3dzFiMzZpOTdCSDMyVTF5RkMwTk9sR0p4RGVSMkNIWS9HNlBoZzNoZXQ4UXpTSHE5TWFWNjZOQk1IcHMzL3lvSFRqYmRsTE1iNFQ0QkdLeHZNcEl4TWJBbjJ5ODB0OVFYVy80VWdrSHI4eHFEaW9CRmJLZG5wMmFWbHU1NjZIU3RMeVBVMXM5eU1LWEhBMktVclZuV05UaW0xQUNMN1Q4bFFOUkV4T0U5Ti9BQlJvcEF8dC9WREsyRW55UHBWMm1KZE5xQnRrNnR0a3JxWUlJTkR0cEQ5eVNWR1lsUT0=', 08:54:40.069 [SageTVRequestHandler-82:IPTV1] INFO HTTPProducerImpl - HTTP redirect: http://192.99.40.78:4545/live/Login/Password/165.ts?token=Mm8wSmxuNGUxWCtTWm5jc3ZTQ1VBYitEN3ptQVUzb01HVHREUStuLzE1YTFRSm5HUC9EZFlQVURtMDFHc1NVbVprT0Nqdk9waitsaHROUlhjRUx3M3lNY2ZUNXVFZmx1b0tkQ21uTlc3aUlZTTJXa0hJcFV4SFZORS9uUkgwbEJVcmVWSXQvbUtleEZHYjlmQ2lOV01UbzBuWUx1TkVtMmxqVUdDcDdObGpmckE1aUNybEdCR2lveFZyZmt5aWIybzhzMFB0bTgzWnB6VE9sS2kwUy9kTmd3NUlNNFRMTlc4N3J5cU9QaUp0NU1RTlVxSEtENFV0ZEhvZkdxS2REbk9Qc1dRM3EzU21KMzZaNWZ0ejNJZ3RPMXo0RkhOSVpYdUVYZjRqQllEZFIxcVh6NWZ5d0dUbFljUk1mbnpPdFc2MVRSQ2NjckVjTVJkRVN3dzFiMzZpOTdCSDMyVTF5RkMwTk9sR0p4RGVSMkNIWS9HNlBoZzNoZXQ4UXpTSHE5TWFWNjZOQk1IcHMzL3lvSFRqYmRsTE1iNFQ0QkdLeHZNcEl4TWJBbjJ5ODB0OVFYVy80VWdrSHI4eHFEaW9CRmJLZG5wMmFWbHU1NjZIU3RMeVBVMXM5eU1LWEhBMktVclZuV05UaW0xQUNMN1Q4bFFOUkV4T0U5Ti9BQlJvcEF8dC9WREsyRW55UHBWMm1KZE5xQnRrNnR0a3JxWUlJTkR0cEQ5eVNWR1lsUT0= 08:54:40.443 [SageTVRequestHandler-82:IPTV1] DEBUG HTTPProducerImpl - HTTP response: 'HTTP/1.1 200 OK', 'Server: nginx', 'Date: Fri, 23 Dec 2016 13:54:41 GMT', 'Content-Type: video/mp2t', 'Connection: close', 'Access-Control-Allow-Origin: *', 08:54:40.444 [NIOHTTPProducerImpl-99:IPTV1] INFO NIOHTTPProducerImpl - Producer thread is running. 08:54:40.444 [NIOHTTPProducerImpl-99:IPTV1] DEBUG NIOHTTPProducerImpl - Thread priority is 9. 08:54:40.543 [SageTVRequestHandler-82:IPTV1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV consumer... 08:54:40.547 [SageTVRequestHandler-82:IPTV1] DEBUG BasicCaptureDevice - Consumer is was not in progress. 08:54:40.548 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegTransSageTVConsumerImpl - FFmpeg Transcoder consumer thread is now running. 08:54:40.548 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegTransSageTVConsumerImpl - Thread priority is 8. 08:54:40.559 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegStreamDetection - Calling avformat_open_input 08:54:40.563 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegStreamDetection - Before avformat_find_stream_info() pos=132860 bytes_read=132860 seek_count=0. probesize: 165628 analyzeduration: 2000000. 08:54:40.587 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 132860 08:54:40.587 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 132860, returnValue = 398581 08:54:40.587 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 132860 08:54:40.587 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 132860, returnValue = 398581 08:54:40.587 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 148581, readIndex = 132860 08:54:40.587 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 148581, readIndex = 148581, returnValue = 148581 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 660724 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 660724, returnValue = 801541 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 660724 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0, returnValue = 801541 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegStreamDetection - After avformat_find_stream_info() pos=0 bytes_read=645003 seek_count=2. probesize: 165628 analyzeduration: 2000000. 08:54:40.613 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegStreamDetection - current container duration = 3.232456 seconds 08:54:40.618 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegStreamDetection - Primary program has been detected: 1. 08:54:40.618 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegStreamDetection - FFmpeg stream detection done in 60ms, 08:54:40.618 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegTranscoder - Initializing FFmpeg transcoder stream output. 08:54:40.625 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegContext - Primary: Input #0, mpegts, from 'input-mpeg-ts.ts': Duration: 00:00:03.23, start: 3794.394000, bitrate: 1983 kb/s Program 1 Metadata: service_name : Service01 service_provider: FFmpeg Stream #0:0[0x100], 21, 1/90000: Video: h264 (Main) ([27][0][0][0] / 0x001B), yuv420p, 720x480 [SAR 10:11 DAR 15:11], 29.97 fps, 60 tbr, 90k tbn, 59.94 tbc Stream #0:1[0x101], 14, 1/90000: Audio: mp2 ([3][0][0][0] / 0x0003), 48000 Hz, stereo, s16p, 128 kb/s 08:54:40.626 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegContext - Calling avformat_alloc_output_context2 08:54:40.632 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegContext - Primary: Output #0, mpegts, to 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf': Stream #0:0, 0, 1/90000: Video: h264, yuv420p, 720x480 [SAR 10:11 DAR 15:11], q=2-31, 90k tbn, 59.94 tbc Stream #0:1, 0, 1/90000: Audio: mp2, 48000 Hz, stereo, s16p, 128 kb/s 08:54:40.632 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegTranscoder - Writing header 08:54:40.633 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegTranscoder - Initialized FFmpeg transcoder stream output. 08:54:40.635 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG NULL - [3a95ed40] Current profile doesn't provide more RBSP data in PPS, skipping 08:54:40.639 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - Replied: 'OK' 08:54:43.475 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:54:47.475 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:54:51.475 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:54:55.475 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:54:59.476 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:03.476 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:07.476 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:07.476 [UPnPDiscovery-37] DEBUG UpnpManager - Stopping broadcast. 08:55:07.476 [UPnPDiscovery-37] DEBUG DiscoveryRegistryListener - Before shutdown, the registry has 1 device(s). 08:55:07.476 [UPnPDiscovery-37] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 08:55:13.477 [UPnPDiscovery-37] DEBUG UpnpManager - Broadcast requested. 08:55:13.528 [UPnPDiscovery-37] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.0.99 for UPnP discovery. 08:55:17.530 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:21.530 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:25.531 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:29.531 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:33.531 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:37.532 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:41.532 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:45.532 [UPnPDiscovery-37] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 08:55:45.532 [UPnPDiscovery-37] DEBUG UpnpManager - Stopping broadcast. 08:55:45.532 [UPnPDiscovery-37] WARN DiscoveryRegistryListener - Before UPnP shutdown, the registry did not contain any devices. 08:55:45.532 [UPnPDiscovery-37] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 08:56:05.546 [ChannelManager-58] INFO ChannelManager - The static channel lineup HDHomeRun HDHR3-US 103B29B3 (atsc_hdhomerun_legacy_103b29b3) will remain unchanged. 08:56:05.546 [ChannelManager-58] INFO ChannelManager - The static channel lineup IPTV1 (generic_http) will remain unchanged. 08:56:05.546 [ChannelManager-58] INFO ChannelManager - The static channel lineup HDHomeRun HDHR-US 101C8F83 (atsc_hdhomerun_legacy_101c8f83) will remain unchanged. 08:56:08.140 [NIOHTTPProducerImpl-99:IPTV1] INFO NIOHTTPProducerImpl - We have reached the end of the stream. Stopping thread. 08:56:08.140 [NIOHTTPProducerImpl-99:IPTV1] INFO NIOHTTPProducerImpl - Producer thread has stopped. 08:57:17.919 [SageTVRequestHandler-82:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'STOP IPTV1 HDMI' 08:57:17.919 [SageTVRequestHandler-82:IPTV1] DEBUG GenericHttpCaptureDevice - Stopping encoding... 08:57:17.919 [SageTVRequestHandler-82:IPTV1] DEBUG BasicCaptureDevice - Stopping consumer thread... 08:57:17.919 [SageTVRequestHandler-82:IPTV1] DEBUG BasicCaptureDevice - Waiting for consumer thread to stop... 08:57:17.920 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegContext - FFmpeg consumer was interrupted while reading. 08:57:17.920 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegContext - Returning AVERROR_EOF in readCallback.call() 08:57:17.921 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegTranscoder - FFmpeg transcoder ended with code 0 08:57:17.921 [AsyncWriter-100:IPTV1on1270019000HDMI-0.mpgbuf] INFO FFmpegTransSageTVConsumerImpl - Closing the file 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf' 08:57:18.421 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegContext - avcodec_close 08:57:18.421 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegContext - avio_closep 08:57:18.421 [FFmpegTransSageTVConsumerImpl-101:IPTV1] DEBUG FFmpegContext - avformat_free_context 08:57:18.421 [FFmpegTransSageTVConsumerImpl-101:IPTV1] INFO FFmpegTransSageTVConsumerImpl - FFmpeg Transcoder consumer thread stopped. 08:57:18.421 [SageTVRequestHandler-82:IPTV1] DEBUG GenericHttpCaptureDevice - Capture device is now re-unlocked. 08:57:18.422 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - Replied: 'OK' 08:57:18.422 [StoppingThread-103] DEBUG GenericHttpCaptureDevice - Stopping executable will be run in 15000 milliseconds. 08:57:18.444 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - SageTV sent: 'BUFFER IPTV1 HDMI|1311988847|287|83886080|E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf|Great-H.264' 08:57:18.444 [SageTVRequestHandler-82:IPTV1] DEBUG GenericHttpCaptureDevice - Capture device is now re-locked. 08:57:18.444 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - Starting buffered network encoder via upload ID '1311988847' to file name 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf'. 08:57:18.444 [SageTVRequestHandler-82:IPTV1] DEBUG BasicCaptureDevice - Consumer is was not in progress. 08:57:18.444 [StoppingThread-103] DEBUG GenericHttpCaptureDevice - Stopping executable was cancelled. 08:57:18.445 [SageTVRequestHandler-82:IPTV1] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '287' 08:57:18.448 [SageTVRequestHandler-82:IPTV1] INFO GenericHttpCaptureDevice - Starting the encoding for the channel '287' from the device 'IPTV1' to the file 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf'... 08:57:18.449 [SageTVRequestHandler-82:IPTV1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV producer... 08:57:18.449 [SageTVRequestHandler-82:IPTV1] INFO NIOHTTPProducerImpl - Connecting to source using the URL 'http://XXX-iptv.net:4545/live/Login/Password/287.ts' 08:57:18.687 [SageTVRequestHandler-82:IPTV1] DEBUG HTTPProducerImpl - HTTP response: 'HTTP/1.1 302 Found', 'Server: nginx', 'Date: Fri, 23 Dec 2016 13:57:11 GMT', 'Content-Type: text/html; charset=UTF-8', 'Connection: close', 'Access-Control-Allow-Origin: *', 'Location: http://192.99.40.78:4545/live/Login/Password/287.ts?token=UEZUSjFkMXYrNWwvSU4zMnM5RkdiTk5XeWJTbFZ3RVBBdWNURW5IUmlVbGdQU1JLY0VydC9BZUEwbXZZQ24yR3ZwVE1JUlBWYm81OUR4SjA4WFRrdnVrNFRmbXNYeDdVVVh3T3lpU3pIMjFocVM1aFJQdjJFQWtJOTZ1OXh4djlsZXFGejllZC9RRERPdUZVZ3VSSVZ5K2JybFlxSXVrd203Z293Qll1L1cyQjh2ZVNBMjJyTmFWOFBTWjg4dDdTR25vMDhvTjdIbDcvR2k5MFNSUXZPTTFuQWZqUnZtdWJFcS8vSlpFZFJXTkxXMTN6a0xCU1p3Zi9XVHRMT2hOaW01ZURsbTR5NVlVbkJJSDhadFYvdmNqeGtLdEhHOHRnamY2RG9rQ1czT1BPaGprUTFpV3pzcHl5d083NDc2OWFMSUVkczI5cVVHN0ZGRTl2a2F0djJVU0cwdHozV0pyL3pUOGtrcUdFOXdVS1o0MjF3ZWMzYTZxeFlvb1hhOHJid1BWVGRrSTF4dnBqdVc3Z3VRRHFjVFFVQ1I0NjNSazA0UzhaSVVibVc0TmFtM2tLaGNPYXU1R0RoajVnNnhFOXlxb3FNNFh5S1ZBbXhIK0lsb2haajEwY1pTTzNMZGNVcWNBMjlRNlJLaTdSZmIvaDJWZUhkNHdrbEVUd0Fkdk18QldGaTF6SlkrYlQrV2MxeXhWL3pFYjBWNndUUzJNNnRRSmMxT3FTRUZmUT0=', 08:57:18.687 [SageTVRequestHandler-82:IPTV1] INFO HTTPProducerImpl - HTTP redirect: http://192.99.40.78:4545/live/Login/Password/287.ts?token=UEZUSjFkMXYrNWwvSU4zMnM5RkdiTk5XeWJTbFZ3RVBBdWNURW5IUmlVbGdQU1JLY0VydC9BZUEwbXZZQ24yR3ZwVE1JUlBWYm81OUR4SjA4WFRrdnVrNFRmbXNYeDdVVVh3T3lpU3pIMjFocVM1aFJQdjJFQWtJOTZ1OXh4djlsZXFGejllZC9RRERPdUZVZ3VSSVZ5K2JybFlxSXVrd203Z293Qll1L1cyQjh2ZVNBMjJyTmFWOFBTWjg4dDdTR25vMDhvTjdIbDcvR2k5MFNSUXZPTTFuQWZqUnZtdWJFcS8vSlpFZFJXTkxXMTN6a0xCU1p3Zi9XVHRMT2hOaW01ZURsbTR5NVlVbkJJSDhadFYvdmNqeGtLdEhHOHRnamY2RG9rQ1czT1BPaGprUTFpV3pzcHl5d083NDc2OWFMSUVkczI5cVVHN0ZGRTl2a2F0djJVU0cwdHozV0pyL3pUOGtrcUdFOXdVS1o0MjF3ZWMzYTZxeFlvb1hhOHJid1BWVGRrSTF4dnBqdVc3Z3VRRHFjVFFVQ1I0NjNSazA0UzhaSVVibVc0TmFtM2tLaGNPYXU1R0RoajVnNnhFOXlxb3FNNFh5S1ZBbXhIK0lsb2haajEwY1pTTzNMZGNVcWNBMjlRNlJLaTdSZmIvaDJWZUhkNHdrbEVUd0Fkdk18QldGaTF6SlkrYlQrV2MxeXhWL3pFYjBWNndUUzJNNnRRSmMxT3FTRUZmUT0= 08:57:19.067 [SageTVRequestHandler-82:IPTV1] DEBUG HTTPProducerImpl - HTTP response: 'HTTP/1.1 200 OK', 'Server: nginx', 'Date: Fri, 23 Dec 2016 13:57:20 GMT', 'Content-Type: video/mp2t', 'Connection: close', 'Access-Control-Allow-Origin: *', 08:57:19.067 [NIOHTTPProducerImpl-104:IPTV1] INFO NIOHTTPProducerImpl - Producer thread is running. 08:57:19.067 [NIOHTTPProducerImpl-104:IPTV1] DEBUG NIOHTTPProducerImpl - Thread priority is 9. 08:57:19.167 [SageTVRequestHandler-82:IPTV1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV consumer... 08:57:19.168 [SageTVRequestHandler-82:IPTV1] DEBUG BasicCaptureDevice - Consumer is was not in progress. 08:57:19.168 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegTransSageTVConsumerImpl - FFmpeg Transcoder consumer thread is now running. 08:57:19.169 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegTransSageTVConsumerImpl - Thread priority is 8. 08:57:19.169 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegStreamDetection - Calling avformat_open_input 08:57:19.194 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegStreamDetection - Before avformat_find_stream_info() pos=262144 bytes_read=262144 seek_count=0. probesize: 165628 analyzeduration: 2000000. 08:57:19.234 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144 08:57:19.234 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144, returnValue = 821981 08:57:19.234 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144 08:57:19.234 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144, returnValue = 821981 08:57:19.234 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 571981, readIndex = 262144 08:57:19.234 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 571981, readIndex = 571981, returnValue = 571981 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1084124 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1084124, returnValue = 1222021 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 1084124 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0, returnValue = 1222021 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegStreamDetection - After avformat_find_stream_info() pos=0 bytes_read=774287 seek_count=2. probesize: 165628 analyzeduration: 2000000. 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegStreamDetection - current container duration = 4.161034 seconds 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegStreamDetection - Primary program has been detected: 1. 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegStreamDetection - FFmpeg stream detection done in 91ms, 08:57:19.260 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegTranscoder - Initializing FFmpeg transcoder stream output. 08:57:19.261 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegContext - Primary: Input #0, mpegts, from 'input-mpeg-ts.ts': Duration: 00:00:04.16, start: 1374.180333, bitrate: 2349 kb/s Program 1 Metadata: service_name : Service01 service_provider: FFmpeg Stream #0:0[0x100], 21, 1/90000: Video: h264 (Main) ([27][0][0][0] / 0x001B), yuv420p(tv), 1280x720 [SAR 1:1 DAR 16:9], 29.97 fps, 29.97 tbr, 90k tbn, 59.94 tbc Stream #0:1[0x101], 40, 1/90000: Audio: aac (LC) ([15][0][0][0] / 0x000F), 48000 Hz, stereo, fltp, 136 kb/s 08:57:19.261 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegContext - Calling avformat_alloc_output_context2 08:57:19.262 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegContext - Primary: Output #0, mpegts, to 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf': Stream #0:0, 0, 1/90000: Video: h264, yuv420p(tv), 1280x720 [SAR 1:1 DAR 16:9], q=2-31, 90k tbn, 59.94 tbc Stream #0:1, 0, 1/90000: Audio: aac, 48000 Hz, stereo, fltp, 136 kb/s 08:57:19.262 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegTranscoder - Writing header 08:57:19.262 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegTranscoder - Initialized FFmpeg transcoder stream output. 08:57:19.263 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG NULL - Repeated 295 times: [3a95ed40] Current profile doesn't provide more RBSP data in PPS, skipping. 08:57:19.263 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG NULL - [4098ba20] Current profile doesn't provide more RBSP data in PPS, skipping 08:57:19.263 [SageTVRequestHandler-82:IPTV1] DEBUG SageTVRequestHandler - Replied: 'OK' 08:59:51.835 [SageTVRequestHandler-107:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'STOP IPTV1 HDMI' 08:59:51.835 [SageTVRequestHandler-107:IPTV1] DEBUG GenericHttpCaptureDevice - Stopping encoding... 08:59:51.835 [SageTVRequestHandler-107:IPTV1] DEBUG HTTPCaptureDeviceServices - Stopping producer thread... 08:59:51.835 [SageTVRequestHandler-107:IPTV1] DEBUG HTTPCaptureDeviceServices - Waiting for producer thread to stop... 08:59:51.836 [NIOHTTPProducerImpl-104:IPTV1] DEBUG NIOHTTPProducerImpl - The socket has been closed. 08:59:51.836 [NIOHTTPProducerImpl-104:IPTV1] INFO NIOHTTPProducerImpl - Producer thread has stopped. 08:59:51.836 [SageTVRequestHandler-107:IPTV1] DEBUG BasicCaptureDevice - Stopping consumer thread... 08:59:51.836 [SageTVRequestHandler-107:IPTV1] DEBUG BasicCaptureDevice - Waiting for consumer thread to stop... 08:59:51.836 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegContext - FFmpeg consumer was interrupted while reading. 08:59:51.836 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegContext - Returning AVERROR_EOF in readCallback.call() 08:59:51.837 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegTranscoder - FFmpeg transcoder ended with code 0 08:59:51.837 [AsyncWriter-105:IPTV1on1270019000HDMI-0.mpgbuf] INFO FFmpegTransSageTVConsumerImpl - Closing the file 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf' 08:59:52.337 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegContext - avcodec_close 08:59:52.337 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegContext - avio_closep 08:59:52.337 [FFmpegTransSageTVConsumerImpl-106:IPTV1] DEBUG FFmpegContext - avformat_free_context 08:59:52.337 [FFmpegTransSageTVConsumerImpl-106:IPTV1] INFO FFmpegTransSageTVConsumerImpl - FFmpeg Transcoder consumer thread stopped. 08:59:52.337 [SageTVRequestHandler-107:IPTV1] DEBUG GenericHttpCaptureDevice - Capture device is now re-unlocked. 08:59:52.337 [SageTVRequestHandler-107:IPTV1] DEBUG SageTVRequestHandler - Replied: 'OK' 08:59:52.337 [StoppingThread-108] DEBUG GenericHttpCaptureDevice - Stopping executable will be run in 15000 milliseconds. 08:59:52.358 [SageTVRequestHandler-107:IPTV1] DEBUG SageTVRequestHandler - SageTV sent: 'BUFFER IPTV1 HDMI|1757580111|287|83886080|E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf|Great-H.264' 08:59:52.358 [SageTVRequestHandler-107:IPTV1] DEBUG GenericHttpCaptureDevice - Capture device is now re-locked. 08:59:52.358 [SageTVRequestHandler-107:IPTV1] DEBUG SageTVRequestHandler - Starting buffered network encoder via upload ID '1757580111' to file name 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf'. 08:59:52.358 [SageTVRequestHandler-107:IPTV1] DEBUG BasicCaptureDevice - Consumer is was not in progress. 08:59:52.358 [StoppingThread-108] DEBUG GenericHttpCaptureDevice - Stopping executable was cancelled. 08:59:52.358 [SageTVRequestHandler-107:IPTV1] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '287' 08:59:52.362 [SageTVRequestHandler-107:IPTV1] INFO GenericHttpCaptureDevice - Starting the encoding for the channel '287' from the device 'IPTV1' to the file 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf'... 08:59:52.362 [SageTVRequestHandler-107:IPTV1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV producer... 08:59:52.362 [SageTVRequestHandler-107:IPTV1] INFO NIOHTTPProducerImpl - Connecting to source using the URL 'http://XXX-iptv.net:4545/live/Login/Password/287.ts' 08:59:52.598 [SageTVRequestHandler-107:IPTV1] DEBUG HTTPProducerImpl - HTTP response: 'HTTP/1.1 302 Found', 'Server: nginx', 'Date: Fri, 23 Dec 2016 13:59:45 GMT', 'Content-Type: text/html; charset=UTF-8', 'Connection: close', 'Access-Control-Allow-Origin: *', 'Location: http://192.99.40.78:4545/live/Login/Password/287.ts?token=cnNXQTVrUHREelRKWDE5YkZMampQd0pUTmtpeXBJM3pmY1V1UmZMYkN6bnVsZWhPeFZlVVBMaCtoYnpIbFVhODFCRG9CSmVjdElMY0kyYWI0SXViRUQrUHptRldCNUR5dkxaQ0gvbzdlazR5ZHkwRW9MMTkrSlllcmZ1TlZ4TFFQOXM1alNhNFFVbkVTSjJZMHpHUmI5cFVKd05EQmh0eGxtY1NZVkp5cjFJTEFQVXM1bWVzMy8rVGR3ck5OWWxCVnI2VElCaTVaTk1NOThUTkViSjRjL0dCR0RpNDl6UXZZb3ZVcGZ4dlVDMTZjSVVHRExsVUVJOGZHWUFGNktxV2sxNGp3ZkVxK084aHBvTStJS3FaYU1ZanBxRFBvZmlEd3gvQkZSM3d3aWtHcDJiTWgxOXBSYlpqZTJKTkNGZ0tZbk9PczJiV3dyZkFJQWkvdmZVZWFkSk1DVG8wbzVVSWNtVjNQVTVsS21Pa1BiZDNiUCt4cWVQVTJwcGNIaE1DbDJIZmxGamYyMndlazJTMm8vbUdmTUY5Q3ozR2EyZEJlVjAyalp2RU1wQWgxYnR2UTQ0Wml3VzB3eDExYzA1Umw1UW52ZU1LNGJjbGc1L2dPZlo4MnFGN1RGSmliZkNObmp1NzZGZlBkYzRYdk0wK1Q2Wnl2a0MxYmpLNUNTL2R8VmdPRGlRSFpRNGhuSW9idDFCZlI5YStxZkROZGEwS3NHOHN4cHFiT3h6RT0=', 08:59:52.598 [SageTVRequestHandler-107:IPTV1] INFO HTTPProducerImpl - HTTP redirect: http://192.99.40.78:4545/live/Login/Password/287.ts?token=cnNXQTVrUHREelRKWDE5YkZMampQd0pUTmtpeXBJM3pmY1V1UmZMYkN6bnVsZWhPeFZlVVBMaCtoYnpIbFVhODFCRG9CSmVjdElMY0kyYWI0SXViRUQrUHptRldCNUR5dkxaQ0gvbzdlazR5ZHkwRW9MMTkrSlllcmZ1TlZ4TFFQOXM1alNhNFFVbkVTSjJZMHpHUmI5cFVKd05EQmh0eGxtY1NZVkp5cjFJTEFQVXM1bWVzMy8rVGR3ck5OWWxCVnI2VElCaTVaTk1NOThUTkViSjRjL0dCR0RpNDl6UXZZb3ZVcGZ4dlVDMTZjSVVHRExsVUVJOGZHWUFGNktxV2sxNGp3ZkVxK084aHBvTStJS3FaYU1ZanBxRFBvZmlEd3gvQkZSM3d3aWtHcDJiTWgxOXBSYlpqZTJKTkNGZ0tZbk9PczJiV3dyZkFJQWkvdmZVZWFkSk1DVG8wbzVVSWNtVjNQVTVsS21Pa1BiZDNiUCt4cWVQVTJwcGNIaE1DbDJIZmxGamYyMndlazJTMm8vbUdmTUY5Q3ozR2EyZEJlVjAyalp2RU1wQWgxYnR2UTQ0Wml3VzB3eDExYzA1Umw1UW52ZU1LNGJjbGc1L2dPZlo4MnFGN1RGSmliZkNObmp1NzZGZlBkYzRYdk0wK1Q2Wnl2a0MxYmpLNUNTL2R8VmdPRGlRSFpRNGhuSW9idDFCZlI5YStxZkROZGEwS3NHOHN4cHFiT3h6RT0= 08:59:52.968 [SageTVRequestHandler-107:IPTV1] DEBUG HTTPProducerImpl - HTTP response: 'HTTP/1.1 200 OK', 'Server: nginx', 'Date: Fri, 23 Dec 2016 13:59:54 GMT', 'Content-Type: video/mp2t', 'Connection: close', 'Access-Control-Allow-Origin: *', 08:59:52.968 [NIOHTTPProducerImpl-109:IPTV1] INFO NIOHTTPProducerImpl - Producer thread is running. 08:59:52.968 [NIOHTTPProducerImpl-109:IPTV1] DEBUG NIOHTTPProducerImpl - Thread priority is 9. 08:59:53.068 [SageTVRequestHandler-107:IPTV1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV consumer... 08:59:53.068 [SageTVRequestHandler-107:IPTV1] DEBUG BasicCaptureDevice - Consumer is was not in progress. 08:59:53.069 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegTransSageTVConsumerImpl - FFmpeg Transcoder consumer thread is now running. 08:59:53.069 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegTransSageTVConsumerImpl - Thread priority is 8. 08:59:53.069 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegStreamDetection - Calling avformat_open_input 08:59:53.094 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - Before avformat_find_stream_info() pos=262144 bytes_read=262144 seek_count=0. probesize: 165628 analyzeduration: 2000000. 08:59:53.101 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO mpegts - Repeated 189 times: [4098ba20] Current profile doesn't provide more RBSP data in PPS, skipping. 08:59:53.101 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO mpegts - [40a81020] decoding for stream 0 failed 08:59:53.102 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144 08:59:53.102 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144, returnValue = 417561 08:59:53.102 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144 08:59:53.103 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 262144, returnValue = 417561 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288, returnValue = 560641 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 524288 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0, returnValue = 560641 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - After avformat_find_stream_info() pos=0 bytes_read=524288 seek_count=1. probesize: 165628 analyzeduration: 2000000. 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - current container duration = 1.843367 seconds 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - Could not find a video stream. Trying again with an extended probe. 08:59:53.128 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegStreamDetection - Calling avformat_open_input 08:59:53.129 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - Before avformat_find_stream_info() pos=262144 bytes_read=262144 seek_count=0. probesize: 560828 analyzeduration: 2843367. 08:59:53.147 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288 08:59:53.147 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288, returnValue = 832201 08:59:53.147 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288 08:59:53.147 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 524288, returnValue = 832201 08:59:53.147 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 582201, readIndex = 524288 08:59:53.147 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 582201, readIndex = 582201, returnValue = 582201 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1094344 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 1094344, returnValue = 1109601 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 1094344 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 0, offset = 0, readIndex = 0, returnValue = 0 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegCircularBufferNIO - Seek: wence = 65536, offset = 0, readIndex = 0, returnValue = 1109601 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - After avformat_find_stream_info() pos=0 bytes_read=1036431 seek_count=2. probesize: 560828 analyzeduration: 2843367. 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - current container duration = 3.644367 seconds 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegStreamDetection - Primary program has been detected: 1. 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegStreamDetection - FFmpeg stream detection done in 104ms, 08:59:53.173 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegTranscoder - Initializing FFmpeg transcoder stream output. 08:59:53.174 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegContext - Primary: Input #0, mpegts, from 'input-mpeg-ts.ts': Duration: 00:00:03.64, start: 1522.511000, bitrate: 2435 kb/s Program 1 Metadata: service_name : Service01 service_provider: FFmpeg Stream #0:0[0x100], 35, 1/90000: Video: h264 (Main) ([27][0][0][0] / 0x001B), yuv420p(tv), 1280x720 [SAR 1:1 DAR 16:9], 29.97 tbr, 90k tbn, 59.94 tbc Stream #0:1[0x101], 56, 1/90000: Audio: aac (LC) ([15][0][0][0] / 0x000F), 48000 Hz, stereo, fltp, 130 kb/s 08:59:53.174 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegContext - Calling avformat_alloc_output_context2 08:59:53.174 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegContext - Primary: Output #0, mpegts, to 'E:\E Recordings\IPTV1on1270019000HDMI-0.mpgbuf': Stream #0:0, 0, 1/90000: Video: h264, yuv420p(tv), 1280x720 [SAR 1:1 DAR 16:9], q=2-31, 90k tbn, 59.94 tbc Stream #0:1, 0, 1/90000: Audio: aac, 48000 Hz, stereo, fltp, 130 kb/s 08:59:53.174 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG FFmpegTranscoder - Writing header 08:59:53.175 [FFmpegTransSageTVConsumerImpl-111:IPTV1] INFO FFmpegTranscoder - Initialized FFmpeg transcoder stream output. 08:59:53.176 [FFmpegTransSageTVConsumerImpl-111:IPTV1] DEBUG NULL - [4098ba20] Current profile doesn't provide more RBSP data in PPS, skipping 08:59:53.177 [SageTVRequestHandler-107:IPTV1] DEBUG SageTVRequestHandler - Replied: 'OK'