12:01:35.425 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.29... 12:01:35.460 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Windows 7' is WINDOWS. 12:01:35.460 [WrapperSimpleAppMain] INFO Config - Current directory is 'C:\Program Files\OpenDCT Authors\OpenDCT' 12:01:35.531 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory 'c:/ProgramData/OpenDCT/logs'. 12:01:35.632 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to 'c:/ProgramData/OpenDCT/logs\opendct_cling.log'. 12:01:35.632 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 12:01:35.642 [FFmpegAsyncInit-22] INFO Main - FFmpeg loading... 12:01:35.652 [FFmpegAsyncInit-22] DEBUG FFmpegUtil - Initializing FFmpegLogger... 12:01:35.784 [FFmpegAsyncInit-22] DEBUG FFmpegUtil - Calling av_log_set_callback... 12:01:35.784 [FFmpegAsyncInit-22] DEBUG FFmpegUtil - Calling avcodec_register_all... 12:01:36.079 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump started. 12:01:36.618 [FFmpegAsyncInit-22] DEBUG FFmpegUtil - Calling avfilter_register_all... 12:01:37.090 [FFmpegAsyncInit-22] DEBUG FFmpegUtil - Calling av_register_all... 12:01:37.090 [FFmpegAsyncInit-22] INFO Main - FFmpeg loaded in 1448ms. 12:01:40.831 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth3 (Realtek PCIe GBE Family Controller) 192.168.2.2 name:eth4 (Ceton InfiniTV Network Device) 192.168.200.2 12:01:40.832 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.power.NetworkPowerEventManger' is now listening. 12:01:40.833 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.sagetv.SageTVManager' is now listening. 12:01:40.843 [DynamicAsyncInit-22] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.FFmpegTransSageTVConsumerImpl 12:01:40.843 [DynamicAsyncInit-22] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 12:01:40.843 [DynamicAsyncInit-22] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 12:01:40.843 [DynamicAsyncInit-22] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 12:01:43.428 [LineupAsyncInit:qam_infinitv-28] INFO ChannelManager - Copying to the channel lineup Ceton InfiniTV PCIe (00-80-5f-8f) (qam_infinitv). 12:01:43.428 [LineupAsyncInit:qam_infinitv-28] ERROR CopyChannels - Lineup 'dct_infinitv' does not exist. Unable to update 'qam_infinitv' lineup. 12:01:47.698 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 12:01:47.850 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:01:47.850 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:01:47.920 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:01:47.940 [UPnPDiscovery-42] INFO UpnpManager - UPnP discovery thread has started. 12:01:48.260 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - HDHomeRun discovery sender thread started. 12:01:48.260 [HDHomeRunDiscoveryReceive-43] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.2.255:65001 broadcast started. 12:01:48.260 [HDHomeRunDiscoveryReceive-43] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.200.255:65001 broadcast started. 12:01:48.260 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:01:48.260 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:01:48.260 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.tuning.discovery.DiscoveryManager' is now listening. 12:01:48.260 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 12:01:48.300 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.nanohttpd.NanoHTTPDManager' is now listening. 12:01:48.300 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.channel.ChannelManager' is now listening. 12:01:48.462 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:01:48.462 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:01:48.676 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:01:48.676 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:01:48.879 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:01:48.879 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:01:48.988 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 12:01:51.952 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:01:53.362 [cling-11] DEBUG RegisterInfiniTVDevice - Checking if the schema 'schemas-cetoncorp-com' can be used... 12:01:53.432 [cling-11] DEBUG RegisterInfiniTVDevice - Creating network encoders from the embedded devices on 'Ceton InfiniTV PCIe (00-80-5f-8f)' with the namespace 'schemas-cetoncorp-com'. 12:01:53.432 [cling-11] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #1' because it is not a tuner. 12:01:53.432 [cling-11] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #2' because it is not a tuner. 12:01:53.432 [cling-11] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1'. 12:01:53.442 [cling-11] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' did not exist. Triggering re-discovery. 12:01:53.442 [cling-11] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:01:53.452 [cling-11] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:01:53.452 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=cas&v=CardStatus' 12:01:53.532 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:01:53.532 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:01:53.532 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=diag&v=Streaming_IP' 12:01:53.582 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (requested) 12:01:53.582 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (requested) 12:01:53.612 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:01:53.612 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:01:53.612 [cling-11] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:01:53.612 [cling-11] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:01:53.612 [cling-11] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 1, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8402 12:01:53.612 [cling-11] DEBUG SageTVManager - Port 9000 is available. 12:01:53.622 [cling-11] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is ready. 12:01:53.622 [cling-11] DEBUG SageTVSocketServer - Setting listening flag... 12:01:53.622 [cling-11] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 12:01:53.622 [SageTVTuningMonitor-60] INFO SageTVTuningMonitor - Tuning monitor thread started. 12:01:53.622 [SageTVSocketServer-61:9000] INFO SageTVSocketServer - Started listening on port 9000... 12:01:53.784 [cling-11] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 2'. 12:01:53.784 [cling-11] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 2' did not exist. Triggering re-discovery. 12:01:53.784 [cling-11] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:01:53.794 [cling-11] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:01:53.794 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=1&s=cas&v=CardStatus' 12:01:53.854 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:01:53.854 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:01:53.854 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=1&s=diag&v=Streaming_IP' 12:01:53.906 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:01:53.906 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:01:53.906 [cling-11] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:01:53.906 [cling-11] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:01:53.906 [cling-11] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 2, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8400 12:01:53.906 [cling-11] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 2' is ready. 12:01:54.033 [cling-11] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 3'. 12:01:54.033 [cling-11] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 3' did not exist. Triggering re-discovery. 12:01:54.033 [cling-11] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:01:54.033 [cling-11] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:01:54.033 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=2&s=cas&v=CardStatus' 12:01:54.111 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:01:54.111 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:01:54.111 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=2&s=diag&v=Streaming_IP' 12:01:54.204 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:01:54.204 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:01:54.204 [cling-11] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:01:54.204 [cling-11] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:01:54.204 [cling-11] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 3, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8384 12:01:54.204 [cling-11] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 3' is ready. 12:01:54.298 [cling-11] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 4'. 12:01:54.298 [cling-11] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 4' did not exist. Triggering re-discovery. 12:01:54.298 [cling-11] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:01:54.298 [cling-11] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:01:54.298 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=3&s=cas&v=CardStatus' 12:01:54.360 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:01:54.360 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:01:54.360 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=3&s=diag&v=Streaming_IP' 12:01:54.407 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:01:54.407 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:01:54.407 [cling-11] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:01:54.407 [cling-11] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:01:54.407 [cling-11] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 4, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8404 12:01:54.407 [cling-11] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 4' is ready. 12:01:55.374 [SageTVSocketServer-61:9000] WARN SageTVSocketServer - IPv6 connection detected. This is an untested configuration. 12:01:55.374 [SageTVRequestHandler-58:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'VERSION' 12:01:55.374 [SageTVRequestHandler-58:Unknown] DEBUG SageTVRequestHandler - Replied: '3.0' 12:01:55.390 [SageTVRequestHandler-58:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'STOP DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1 Digital TV Tuner' 12:01:55.390 [SageTVRequestHandler-58:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] DEBUG RTPCaptureDeviceServices - Producer was not running. 12:01:55.390 [SageTVRequestHandler-58:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] DEBUG BasicCaptureDevice - Consumer is not in progress. 12:01:55.390 [SageTVRequestHandler-58:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] INFO InfiniTVTuning - Stopping streaming from tuner number 1 at '192.168.200.1'. 12:01:55.390 [SageTVRequestHandler-58:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] INFO InfiniTVTuning - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/stream_request.cgi' 12:01:55.577 [SageTVRequestHandler-58:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] INFO InfiniTVCaptureDevice - Capture device was already unlocked. 12:01:55.577 [SageTVRequestHandler-58:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] DEBUG SageTVRequestHandler - Replied: 'OK' 12:01:55.593 [SageTVDiscovery-59] DEBUG SageTVDiscovery - Received discovery datagram from SageTV server '/192.168.2.2:8270' and validating... 12:01:55.593 [SageTVDiscovery-59] DEBUG SageTVDiscovery - Validated discovery datagram from SageTV server '/192.168.2.2:8270' and preparing response... 12:01:55.593 [SageTVDiscovery-59] INFO SageTVDiscovery - Sent discovery response datagram to SageTV server '/192.168.2.2:8270'. 12:01:55.983 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:01:58.285 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (requested) 12:01:58.285 [HDHomeRunDiscoverySend-43] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (requested) 12:01:58.595 [SageTVRequestHandler-63:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'PROPERTIES' 12:01:58.595 [SageTVRequestHandler-63:Unknown] INFO SageTVRequestHandler - Sent PROPERTIES. 12:01:58.595 [SageTVRequestHandler-63:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'QUIT' 12:01:59.994 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:04.004 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:08.013 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:12.022 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:16.031 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:18.995 [WrapperSimpleAppMain] INFO Main - Saving config... 12:02:20.041 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:20.041 [UPnPDiscovery-42] DEBUG UpnpManager - Stopping broadcast. 12:02:20.041 [UPnPDiscovery-42] DEBUG DiscoveryRegistryListener - Before shutdown, the registry has 1 device(s). 12:02:20.041 [UPnPDiscovery-42] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 12:02:30.441 [UPnPDiscovery-42] DEBUG UpnpManager - Broadcast requested. 12:02:30.784 [UPnPDiscovery-42] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:02:30.784 [UPnPDiscovery-42] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:02:34.809 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:38.818 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:42.818 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:46.828 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:49.901 [SageTVRequestHandler-58:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] DEBUG SageTVRequestHandler - An unhandled exception was created => java.net.SocketException: Connection reset at java.net.SocketInputStream.read(Unknown Source) at java.net.SocketInputStream.read(Unknown Source) at sun.nio.cs.StreamDecoder.readBytes(Unknown Source) at sun.nio.cs.StreamDecoder.implRead(Unknown Source) at sun.nio.cs.StreamDecoder.read(Unknown Source) at java.io.InputStreamReader.read(Unknown Source) at java.io.BufferedReader.fill(Unknown Source) at java.io.BufferedReader.readLine(Unknown Source) at java.io.BufferedReader.readLine(Unknown Source) at opendct.sagetv.SageTVRequestHandler.run(SageTVRequestHandler.java:127) at opendct.util.ThreadPool$1.run(ThreadPool.java:39) at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.util.concurrent.FutureTask.run(Unknown Source) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) 12:02:50.837 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:54.847 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:02:58.856 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:03:02.865 [UPnPDiscovery-42] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:03:02.865 [UPnPDiscovery-42] DEBUG UpnpManager - Stopping broadcast. 12:03:02.865 [UPnPDiscovery-42] WARN DiscoveryRegistryListener - Before UPnP shutdown, the registry did not contain any devices. 12:03:02.865 [UPnPDiscovery-42] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 12:03:19.042 [ChannelManager-54] INFO ChannelManager - Copying to the channel lineup Ceton InfiniTV PCIe (00-80-5f-8f) (qam_infinitv). 12:03:19.042 [ChannelManager-54] ERROR CopyChannels - Lineup 'dct_infinitv' does not exist. Unable to update 'qam_infinitv' lineup. 12:14:09.442 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.29... 12:14:09.457 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Windows 7' is WINDOWS. 12:14:09.457 [WrapperSimpleAppMain] INFO Config - Current directory is 'C:\Program Files\OpenDCT Authors\OpenDCT' 12:14:09.504 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory 'c:/ProgramData/OpenDCT/logs'. 12:14:09.566 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to 'c:/ProgramData/OpenDCT/logs\opendct_cling.log'. 12:14:09.566 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 12:14:09.582 [FFmpegAsyncInit-21] INFO Main - FFmpeg loading... 12:14:09.582 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Initializing FFmpegLogger... 12:14:09.707 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_log_set_callback... 12:14:09.707 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avcodec_register_all... 12:14:09.769 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump started. 12:14:10.393 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avfilter_register_all... 12:14:10.955 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_register_all... 12:14:10.955 [FFmpegAsyncInit-21] INFO Main - FFmpeg loaded in 1389ms. 12:14:14.699 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth3 (Realtek PCIe GBE Family Controller) 192.168.2.2 name:eth4 (Ceton InfiniTV Network Device) 192.168.200.2 12:14:14.699 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.power.NetworkPowerEventManger' is now listening. 12:14:14.699 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.sagetv.SageTVManager' is now listening. 12:14:14.714 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.FFmpegTransSageTVConsumerImpl 12:14:14.714 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 12:14:14.714 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 12:14:14.714 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 12:14:17.320 [LineupAsyncInit:qam_infinitv-27] INFO ChannelManager - Copying to the channel lineup Ceton InfiniTV PCIe (00-80-5f-8f) (qam_infinitv). 12:14:17.320 [LineupAsyncInit:qam_infinitv-27] ERROR CopyChannels - Lineup 'dct_infinitv' does not exist. Unable to update 'qam_infinitv' lineup. 12:14:17.554 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 12:14:17.663 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:14:17.663 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:14:17.756 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:14:17.756 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:14:17.788 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:14:17.803 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread has started. 12:14:17.881 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:14:17.944 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:14:17.944 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - HDHomeRun discovery sender thread started. 12:14:17.944 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.2.255:65001 broadcast started. 12:14:17.944 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.200.255:65001 broadcast started. 12:14:17.944 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.tuning.discovery.DiscoveryManager' is now listening. 12:14:17.944 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:17.944 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:17.944 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 12:14:17.975 [WrapperSimpleAppMain] ERROR NanoHTTPDManager - Unable to open webserver on port 9091 => java.net.BindException: Address already in use: JVM_Bind at java.net.DualStackPlainSocketImpl.bind0(Native Method) at java.net.DualStackPlainSocketImpl.socketBind(Unknown Source) at java.net.AbstractPlainSocketImpl.bind(Unknown Source) at java.net.PlainSocketImpl.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at fi.iki.elonen.NanoHTTPD$ServerRunnable.run(NanoHTTPD.java:1687) at java.lang.Thread.run(Unknown Source) 12:14:17.975 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.channel.ChannelManager' is now listening. 12:14:18.053 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 12:14:18.146 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:18.146 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:18.349 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:18.349 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:18.552 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:18.552 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:20.970 [cling-4] DEBUG RegisterInfiniTVDevice - Checking if the schema 'schemas-cetoncorp-com' can be used... 12:14:21.032 [cling-4] DEBUG RegisterInfiniTVDevice - Creating network encoders from the embedded devices on 'Ceton InfiniTV PCIe (00-80-5f-8f)' with the namespace 'schemas-cetoncorp-com'. 12:14:21.032 [cling-4] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #1' because it is not a tuner. 12:14:21.032 [cling-4] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #2' because it is not a tuner. 12:14:21.032 [cling-4] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1'. 12:14:21.048 [cling-4] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' did not exist. Triggering re-discovery. 12:14:21.048 [cling-4] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:14:21.048 [cling-4] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:14:21.048 [cling-4] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=cas&v=CardStatus' 12:14:21.095 [cling-4] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:14:21.095 [cling-4] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:14:21.095 [cling-4] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=diag&v=Streaming_IP' 12:14:21.126 [cling-4] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:14:21.126 [cling-4] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:14:21.142 [cling-4] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:14:21.142 [cling-4] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:14:21.142 [cling-4] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 1, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8356 12:14:21.142 [cling-4] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is ready. 12:14:21.142 [SageTVDiscovery-58] ERROR SageTVDiscovery - Unable to open the network encoder discovery broadcast port => {} java.net.BindException: Address already in use: bind at sun.nio.ch.Net.bind0(Native Method) at sun.nio.ch.Net.bind(Unknown Source) at sun.nio.ch.DatagramChannelImpl.bind(Unknown Source) at sun.nio.ch.DatagramSocketAdaptor.bind(Unknown Source) at opendct.sagetv.SageTVDiscovery.run(SageTVDiscovery.java:91) at java.lang.Thread.run(Unknown Source) 12:14:21.142 [SageTVDiscovery-58] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVDiscovery was unable to open a required listening port. 12:14:21.142 [cling-4] DEBUG SageTVSocketServer - Setting listening flag... 12:14:21.142 [cling-4] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 12:14:21.142 [SageTVTuningMonitor-59] INFO SageTVTuningMonitor - Tuning monitor thread started. 12:14:21.142 [cling-4] ERROR SageTVSocketServer - Unable to open SocketServer on port 9000 => java.net.BindException: Address already in use: JVM_Bind 12:14:21.142 [cling-4] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVManager was unable to open a required socket server listening port. 12:14:21.142 [cling-4] INFO ExitCode - Make sure you are not running the service and the console at the same time. 12:14:21.157 [SageTVManagerShutdown] INFO Main - Stopping all SageTV socket servers... 12:14:21.157 [PowerMessageManagerShutdown] INFO Main - Stopping power messages... 12:14:21.157 [PowerMessageManagerShutdown] INFO WindowsPowerMessagePump - Posting WM_QUIT message and waiting for message pump thread to exit. 12:14:21.157 [ChannelManagerShutdown] INFO Main - Stopping all channel update threads... 12:14:21.173 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump stopped. 12:14:21.173 [Shutdown] INFO Main - OpenDCT has received a signal to stop. 12:14:21.173 [Shutdown] INFO Main - Saving current configuration... 12:14:21.157 [DiscoveryManagerShutdown] INFO Main - Stopping device discovery services... 12:14:21.157 [ChannelManagerShutdown] INFO ChannelManager - Saving the channel lineup 'qam_infinitv'. 12:14:21.173 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Stopping listening thread... 12:14:21.173 [SageTVTuningMonitor-59] INFO SageTVTuningMonitor - Tuning monitor thread interrupted. 12:14:21.173 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Listening is not in progress. 12:14:21.173 [SageTVManagerShutdown] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is being unloaded. 12:14:21.173 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread was interrupted => java.lang.InterruptedException: sleep interrupted 12:14:21.173 [SageTVManagerShutdown] DEBUG InfiniTVCaptureDevice - Capture device is now re-locked. 12:14:21.173 [SageTVManagerShutdown] DEBUG RTPCaptureDeviceServices - Producer was not running. 12:14:21.173 [SageTVManagerShutdown] DEBUG BasicCaptureDevice - Consumer is not in progress. 12:14:21.173 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Before shutdown, the registry has 1 device(s). 12:14:21.173 [SageTVManagerShutdown] INFO InfiniTVTuning - Stopping streaming from tuner number 1 at '192.168.200.1'. 12:14:21.173 [SageTVManagerShutdown] INFO InfiniTVTuning - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/stream_request.cgi' 12:14:21.173 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 12:14:23.204 [DiscoveryManagerShutdown] INFO DiscoveryManager - UPnP discovery stopped. 12:14:23.204 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:14:23.204 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:14:23.204 [HDHomeRunDiscoverySend-45] DEBUG HDHomeRunDiscovery - Interrupted while waiting for next broadcast to be sent => java.lang.InterruptedException: sleep interrupted at java.lang.Thread.sleep(Native Method) at opendct.tuning.hdhomerun.HDHomeRunDiscovery.run(HDHomeRunDiscovery.java:307) at java.lang.Thread.run(Unknown Source) 12:14:23.204 [DiscoveryManagerShutdown] INFO DiscoveryManager - HDHomeRun discovery stopped. 12:14:23.204 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic HTTP discovery stopped. 12:14:23.204 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic Pipe discovery stopped. 12:14:29.291 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.29... 12:14:29.306 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Windows 7' is WINDOWS. 12:14:29.306 [WrapperSimpleAppMain] INFO Config - Current directory is 'C:\Program Files\OpenDCT Authors\OpenDCT' 12:14:29.603 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory 'c:/ProgramData/OpenDCT/logs'. 12:14:29.681 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to 'c:/ProgramData/OpenDCT/logs\opendct_cling.log'. 12:14:29.681 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 12:14:29.712 [FFmpegAsyncInit-21] INFO Main - FFmpeg loading... 12:14:29.712 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Initializing FFmpegLogger... 12:14:29.899 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_log_set_callback... 12:14:29.899 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avcodec_register_all... 12:14:29.962 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump started. 12:14:30.586 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avfilter_register_all... 12:14:31.147 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_register_all... 12:14:31.147 [FFmpegAsyncInit-21] INFO Main - FFmpeg loaded in 1435ms. 12:14:34.829 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth3 (Realtek PCIe GBE Family Controller) 192.168.2.2 name:eth4 (Ceton InfiniTV Network Device) 192.168.200.2 12:14:34.829 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.power.NetworkPowerEventManger' is now listening. 12:14:34.829 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.sagetv.SageTVManager' is now listening. 12:14:34.844 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.FFmpegTransSageTVConsumerImpl 12:14:34.844 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 12:14:34.844 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 12:14:34.844 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 12:14:37.450 [LineupAsyncInit:qam_infinitv-27] INFO ChannelManager - Copying to the channel lineup Ceton InfiniTV PCIe (00-80-5f-8f) (qam_infinitv). 12:14:37.450 [LineupAsyncInit:qam_infinitv-27] ERROR CopyChannels - Lineup 'dct_infinitv' does not exist. Unable to update 'qam_infinitv' lineup. 12:14:37.684 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 12:14:37.793 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:14:37.793 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:14:37.886 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:14:37.886 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:14:37.902 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:14:37.918 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread has started. 12:14:37.996 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:14:38.058 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:14:38.058 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - HDHomeRun discovery sender thread started. 12:14:38.058 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.200.255:65001 broadcast started. 12:14:38.058 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.2.255:65001 broadcast started. 12:14:38.058 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.tuning.discovery.DiscoveryManager' is now listening. 12:14:38.074 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:38.074 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 12:14:38.074 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:38.105 [WrapperSimpleAppMain] ERROR NanoHTTPDManager - Unable to open webserver on port 9091 => java.net.BindException: Address already in use: JVM_Bind at java.net.DualStackPlainSocketImpl.bind0(Native Method) at java.net.DualStackPlainSocketImpl.socketBind(Unknown Source) at java.net.AbstractPlainSocketImpl.bind(Unknown Source) at java.net.PlainSocketImpl.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at fi.iki.elonen.NanoHTTPD$ServerRunnable.run(NanoHTTPD.java:1687) at java.lang.Thread.run(Unknown Source) 12:14:38.105 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.channel.ChannelManager' is now listening. 12:14:38.230 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 12:14:38.276 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:38.276 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:38.479 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:38.479 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:38.682 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:38.682 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:41.911 [cling-4] DEBUG RegisterInfiniTVDevice - Checking if the schema 'schemas-cetoncorp-com' can be used... 12:14:41.927 [UPnPDiscovery-44] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:14:41.989 [cling-4] DEBUG RegisterInfiniTVDevice - Creating network encoders from the embedded devices on 'Ceton InfiniTV PCIe (00-80-5f-8f)' with the namespace 'schemas-cetoncorp-com'. 12:14:41.989 [cling-4] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #1' because it is not a tuner. 12:14:41.989 [cling-4] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #2' because it is not a tuner. 12:14:41.989 [cling-4] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1'. 12:14:41.989 [cling-4] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' did not exist. Triggering re-discovery. 12:14:41.989 [cling-4] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:14:42.005 [cling-4] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:14:42.005 [cling-4] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=cas&v=CardStatus' 12:14:42.114 [cling-4] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:14:42.114 [cling-4] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:14:42.114 [cling-4] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=diag&v=Streaming_IP' 12:14:42.176 [cling-4] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:14:42.176 [cling-4] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:14:42.176 [cling-4] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:14:42.176 [cling-4] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:14:42.176 [cling-4] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 1, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8324 12:14:42.176 [cling-4] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is ready. 12:14:42.176 [SageTVDiscovery-58] ERROR SageTVDiscovery - Unable to open the network encoder discovery broadcast port => {} java.net.BindException: Address already in use: bind at sun.nio.ch.Net.bind0(Native Method) at sun.nio.ch.Net.bind(Unknown Source) at sun.nio.ch.DatagramChannelImpl.bind(Unknown Source) at sun.nio.ch.DatagramSocketAdaptor.bind(Unknown Source) at opendct.sagetv.SageTVDiscovery.run(SageTVDiscovery.java:91) at java.lang.Thread.run(Unknown Source) 12:14:42.192 [cling-4] DEBUG SageTVSocketServer - Setting listening flag... 12:14:42.192 [SageTVDiscovery-58] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVDiscovery was unable to open a required listening port. 12:14:42.192 [cling-4] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 12:14:42.192 [SageTVTuningMonitor-59] INFO SageTVTuningMonitor - Tuning monitor thread started. 12:14:42.192 [cling-4] ERROR SageTVSocketServer - Unable to open SocketServer on port 9000 => java.net.BindException: Address already in use: JVM_Bind 12:14:42.192 [cling-4] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVManager was unable to open a required socket server listening port. 12:14:42.192 [cling-4] INFO ExitCode - Make sure you are not running the service and the console at the same time. 12:14:42.192 [PowerMessageManagerShutdown] INFO Main - Stopping power messages... 12:14:42.192 [PowerMessageManagerShutdown] INFO WindowsPowerMessagePump - Posting WM_QUIT message and waiting for message pump thread to exit. 12:14:42.192 [SageTVManagerShutdown] INFO Main - Stopping all SageTV socket servers... 12:14:42.192 [ChannelManagerShutdown] INFO Main - Stopping all channel update threads... 12:14:42.192 [DiscoveryManagerShutdown] INFO Main - Stopping device discovery services... 12:14:42.192 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Stopping listening thread... 12:14:42.192 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Listening is not in progress. 12:14:42.192 [Shutdown] INFO Main - OpenDCT has received a signal to stop. 12:14:42.192 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump stopped. 12:14:42.192 [SageTVTuningMonitor-59] INFO SageTVTuningMonitor - Tuning monitor thread interrupted. 12:14:42.192 [Shutdown] INFO Main - Saving current configuration... 12:14:42.192 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread was interrupted => java.lang.InterruptedException: sleep interrupted 12:14:42.192 [ChannelManagerShutdown] INFO ChannelManager - Saving the channel lineup 'qam_infinitv'. 12:14:42.192 [SageTVManagerShutdown] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is being unloaded. 12:14:42.192 [SageTVManagerShutdown] DEBUG InfiniTVCaptureDevice - Capture device is now re-locked. 12:14:42.192 [SageTVManagerShutdown] DEBUG RTPCaptureDeviceServices - Producer was not running. 12:14:42.192 [SageTVManagerShutdown] DEBUG BasicCaptureDevice - Consumer is not in progress. 12:14:42.192 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Before shutdown, the registry has 1 device(s). 12:14:42.192 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 12:14:42.208 [SageTVManagerShutdown] INFO InfiniTVTuning - Stopping streaming from tuner number 1 at '192.168.200.1'. 12:14:42.208 [SageTVManagerShutdown] INFO InfiniTVTuning - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/stream_request.cgi' 12:14:43.396 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (requested) 12:14:43.396 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (requested) 12:14:44.239 [DiscoveryManagerShutdown] INFO DiscoveryManager - UPnP discovery stopped. 12:14:44.239 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:14:44.239 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:14:44.239 [HDHomeRunDiscoverySend-45] DEBUG HDHomeRunDiscovery - Interrupted while waiting for next broadcast to be sent => java.lang.InterruptedException: sleep interrupted at java.lang.Thread.sleep(Native Method) at opendct.tuning.hdhomerun.HDHomeRunDiscovery.run(HDHomeRunDiscovery.java:307) at java.lang.Thread.run(Unknown Source) 12:14:44.239 [DiscoveryManagerShutdown] INFO DiscoveryManager - HDHomeRun discovery stopped. 12:14:44.239 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic HTTP discovery stopped. 12:14:44.239 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic Pipe discovery stopped. 12:14:50.731 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.29... 12:14:50.747 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Windows 7' is WINDOWS. 12:14:50.762 [WrapperSimpleAppMain] INFO Config - Current directory is 'C:\Program Files\OpenDCT Authors\OpenDCT' 12:14:50.887 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory 'c:/ProgramData/OpenDCT/logs'. 12:14:50.950 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to 'c:/ProgramData/OpenDCT/logs\opendct_cling.log'. 12:14:50.950 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 12:14:50.981 [FFmpegAsyncInit-21] INFO Main - FFmpeg loading... 12:14:50.981 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Initializing FFmpegLogger... 12:14:51.106 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_log_set_callback... 12:14:51.106 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avcodec_register_all... 12:14:51.184 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump started. 12:14:51.808 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avfilter_register_all... 12:14:52.369 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_register_all... 12:14:52.369 [FFmpegAsyncInit-21] INFO Main - FFmpeg loaded in 1388ms. 12:14:56.098 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth3 (Realtek PCIe GBE Family Controller) 192.168.2.2 name:eth4 (Ceton InfiniTV Network Device) 192.168.200.2 12:14:56.098 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.power.NetworkPowerEventManger' is now listening. 12:14:56.098 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.sagetv.SageTVManager' is now listening. 12:14:56.113 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.FFmpegTransSageTVConsumerImpl 12:14:56.113 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 12:14:56.113 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 12:14:56.113 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 12:14:58.719 [LineupAsyncInit:qam_infinitv-27] INFO ChannelManager - Copying to the channel lineup Ceton InfiniTV PCIe (00-80-5f-8f) (qam_infinitv). 12:14:58.719 [LineupAsyncInit:qam_infinitv-27] ERROR CopyChannels - Lineup 'dct_infinitv' does not exist. Unable to update 'qam_infinitv' lineup. 12:14:58.953 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 12:14:59.046 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:14:59.046 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:14:59.140 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:14:59.140 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:14:59.171 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:14:59.171 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread has started. 12:14:59.265 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:14:59.327 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:14:59.327 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.200.255:65001 broadcast started. 12:14:59.327 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - HDHomeRun discovery sender thread started. 12:14:59.327 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.2.255:65001 broadcast started. 12:14:59.327 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.tuning.discovery.DiscoveryManager' is now listening. 12:14:59.327 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:59.327 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 12:14:59.327 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:59.358 [WrapperSimpleAppMain] ERROR NanoHTTPDManager - Unable to open webserver on port 9091 => java.net.BindException: Address already in use: JVM_Bind at java.net.DualStackPlainSocketImpl.bind0(Native Method) at java.net.DualStackPlainSocketImpl.socketBind(Unknown Source) at java.net.AbstractPlainSocketImpl.bind(Unknown Source) at java.net.PlainSocketImpl.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at fi.iki.elonen.NanoHTTPD$ServerRunnable.run(NanoHTTPD.java:1687) at java.lang.Thread.run(Unknown Source) 12:14:59.358 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.channel.ChannelManager' is now listening. 12:14:59.530 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:59.530 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:59.545 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 12:14:59.733 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:59.733 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:14:59.935 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:14:59.935 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:02.353 [cling-5] DEBUG RegisterInfiniTVDevice - Checking if the schema 'schemas-cetoncorp-com' can be used... 12:15:02.416 [cling-5] DEBUG RegisterInfiniTVDevice - Creating network encoders from the embedded devices on 'Ceton InfiniTV PCIe (00-80-5f-8f)' with the namespace 'schemas-cetoncorp-com'. 12:15:02.416 [cling-5] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #1' because it is not a tuner. 12:15:02.416 [cling-5] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #2' because it is not a tuner. 12:15:02.416 [cling-5] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1'. 12:15:02.416 [cling-5] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' did not exist. Triggering re-discovery. 12:15:02.416 [cling-5] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:15:02.431 [cling-5] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:15:02.431 [cling-5] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=cas&v=CardStatus' 12:15:02.463 [cling-5] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:15:02.463 [cling-5] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:15:02.463 [cling-5] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=diag&v=Streaming_IP' 12:15:02.509 [cling-5] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:15:02.509 [cling-5] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:15:02.509 [cling-5] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:15:02.509 [cling-5] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:15:02.509 [cling-5] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 1, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8376 12:15:02.509 [cling-5] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is ready. 12:15:02.525 [SageTVDiscovery-58] ERROR SageTVDiscovery - Unable to open the network encoder discovery broadcast port => {} java.net.BindException: Address already in use: bind at sun.nio.ch.Net.bind0(Native Method) at sun.nio.ch.Net.bind(Unknown Source) at sun.nio.ch.DatagramChannelImpl.bind(Unknown Source) at sun.nio.ch.DatagramSocketAdaptor.bind(Unknown Source) at opendct.sagetv.SageTVDiscovery.run(SageTVDiscovery.java:91) at java.lang.Thread.run(Unknown Source) 12:15:02.525 [SageTVDiscovery-58] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVDiscovery was unable to open a required listening port. 12:15:02.525 [cling-5] DEBUG SageTVSocketServer - Setting listening flag... 12:15:02.525 [SageTVTuningMonitor-59] INFO SageTVTuningMonitor - Tuning monitor thread started. 12:15:02.525 [cling-5] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 12:15:02.525 [cling-5] ERROR SageTVSocketServer - Unable to open SocketServer on port 9000 => java.net.BindException: Address already in use: JVM_Bind 12:15:02.525 [cling-5] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVManager was unable to open a required socket server listening port. 12:15:02.525 [cling-5] INFO ExitCode - Make sure you are not running the service and the console at the same time. 12:15:02.541 [SageTVManagerShutdown] INFO Main - Stopping all SageTV socket servers... 12:15:02.541 [SageTVTuningMonitor-59] INFO SageTVTuningMonitor - Tuning monitor thread interrupted. 12:15:02.541 [ChannelManagerShutdown] INFO Main - Stopping all channel update threads... 12:15:02.541 [ChannelManagerShutdown] INFO ChannelManager - Saving the channel lineup 'qam_infinitv'. 12:15:02.541 [DiscoveryManagerShutdown] INFO Main - Stopping device discovery services... 12:15:02.572 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Stopping listening thread... 12:15:02.572 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Listening is not in progress. 12:15:02.572 [SageTVManagerShutdown] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is being unloaded. 12:15:02.572 [SageTVManagerShutdown] DEBUG InfiniTVCaptureDevice - Capture device is now re-locked. 12:15:02.572 [SageTVManagerShutdown] DEBUG RTPCaptureDeviceServices - Producer was not running. 12:15:02.572 [SageTVManagerShutdown] DEBUG BasicCaptureDevice - Consumer is not in progress. 12:15:02.572 [Shutdown] INFO Main - OpenDCT has received a signal to stop. 12:15:02.572 [Shutdown] INFO Main - Saving current configuration... 12:15:02.572 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Before shutdown, the registry has 1 device(s). 12:15:02.572 [SageTVManagerShutdown] INFO InfiniTVTuning - Stopping streaming from tuner number 1 at '192.168.200.1'. 12:15:02.572 [SageTVManagerShutdown] INFO InfiniTVTuning - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/stream_request.cgi' 12:15:02.572 [PowerMessageManagerShutdown] INFO Main - Stopping power messages... 12:15:02.572 [PowerMessageManagerShutdown] INFO WindowsPowerMessagePump - Posting WM_QUIT message and waiting for message pump thread to exit. 12:15:02.572 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread was interrupted => java.lang.InterruptedException: sleep interrupted 12:15:02.572 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 12:15:02.572 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump stopped. 12:15:04.615 [DiscoveryManagerShutdown] INFO DiscoveryManager - UPnP discovery stopped. 12:15:04.615 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:15:04.615 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:15:04.615 [HDHomeRunDiscoverySend-45] DEBUG HDHomeRunDiscovery - Interrupted while waiting for next broadcast to be sent => java.lang.InterruptedException: sleep interrupted at java.lang.Thread.sleep(Native Method) at opendct.tuning.hdhomerun.HDHomeRunDiscovery.run(HDHomeRunDiscovery.java:307) at java.lang.Thread.run(Unknown Source) 12:15:04.615 [DiscoveryManagerShutdown] INFO DiscoveryManager - HDHomeRun discovery stopped. 12:15:04.615 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic HTTP discovery stopped. 12:15:04.615 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic Pipe discovery stopped. 12:15:08.499 [SageTVRequestHandler-240:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'VERSION' 12:15:08.499 [SageTVRequestHandler-240:Unknown] DEBUG SageTVRequestHandler - Replied: '3.0' 12:15:08.499 [SageTVRequestHandler-240:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'STOP DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1 Digital TV Tuner' 12:15:08.499 [SageTVRequestHandler-240:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] DEBUG RTPCaptureDeviceServices - Producer was not running. 12:15:08.499 [SageTVRequestHandler-240:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] DEBUG BasicCaptureDevice - Consumer is not in progress. 12:15:08.499 [SageTVRequestHandler-240:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] INFO InfiniTVTuning - Stopping streaming from tuner number 1 at '192.168.200.1'. 12:15:08.499 [SageTVRequestHandler-240:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] INFO InfiniTVTuning - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/stream_request.cgi' 12:15:09.030 [SageTVRequestHandler-240:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] INFO InfiniTVCaptureDevice - Capture device was already unlocked. 12:15:09.030 [SageTVRequestHandler-240:DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1] DEBUG SageTVRequestHandler - Replied: 'OK' 12:15:09.030 [SageTVDiscovery-59] DEBUG SageTVDiscovery - Received discovery datagram from SageTV server '/192.168.2.2:8270' and validating... 12:15:09.030 [SageTVDiscovery-59] DEBUG SageTVDiscovery - Validated discovery datagram from SageTV server '/192.168.2.2:8270' and preparing response... 12:15:09.045 [SageTVDiscovery-59] INFO SageTVDiscovery - Sent discovery response datagram to SageTV server '/192.168.2.2:8270'. 12:15:11.185 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.29... 12:15:11.217 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Windows 7' is WINDOWS. 12:15:11.217 [WrapperSimpleAppMain] INFO Config - Current directory is 'C:\Program Files\OpenDCT Authors\OpenDCT' 12:15:12.059 [SageTVRequestHandler-241:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'PROPERTIES' 12:15:12.059 [SageTVRequestHandler-241:Unknown] INFO SageTVRequestHandler - Sent PROPERTIES. 12:15:12.059 [SageTVRequestHandler-241:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'QUIT' 12:15:12.605 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory 'c:/ProgramData/OpenDCT/logs'. 12:15:12.714 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to 'c:/ProgramData/OpenDCT/logs\opendct_cling.log'. 12:15:12.714 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 12:15:12.714 [FFmpegAsyncInit-21] INFO Main - FFmpeg loading... 12:15:12.730 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Initializing FFmpegLogger... 12:15:12.855 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_log_set_callback... 12:15:12.855 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avcodec_register_all... 12:15:13.151 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump started. 12:15:13.603 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avfilter_register_all... 12:15:14.383 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_register_all... 12:15:14.383 [FFmpegAsyncInit-21] INFO Main - FFmpeg loaded in 1669ms. 12:15:17.878 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth3 (Realtek PCIe GBE Family Controller) 192.168.2.2 name:eth4 (Ceton InfiniTV Network Device) 192.168.200.2 12:15:17.878 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.power.NetworkPowerEventManger' is now listening. 12:15:17.878 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.sagetv.SageTVManager' is now listening. 12:15:17.878 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.FFmpegTransSageTVConsumerImpl 12:15:17.878 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 12:15:17.878 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 12:15:17.878 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 12:15:20.499 [LineupAsyncInit:qam_infinitv-27] INFO ChannelManager - Copying to the channel lineup Ceton InfiniTV PCIe (00-80-5f-8f) (qam_infinitv). 12:15:20.499 [LineupAsyncInit:qam_infinitv-27] ERROR CopyChannels - Lineup 'dct_infinitv' does not exist. Unable to update 'qam_infinitv' lineup. 12:15:21.341 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 12:15:21.700 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:15:21.700 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:15:21.981 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:15:21.981 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:15:22.012 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:15:22.027 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread has started. 12:15:22.636 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:15:23.197 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:15:23.197 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - HDHomeRun discovery sender thread started. 12:15:23.197 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:23.229 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:23.229 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.200.255:65001 broadcast started. 12:15:23.244 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.2.255:65001 broadcast started. 12:15:23.244 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.tuning.discovery.DiscoveryManager' is now listening. 12:15:23.244 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 12:15:23.291 [WrapperSimpleAppMain] ERROR NanoHTTPDManager - Unable to open webserver on port 9091 => java.net.BindException: Address already in use: JVM_Bind at java.net.DualStackPlainSocketImpl.bind0(Native Method) at java.net.DualStackPlainSocketImpl.socketBind(Unknown Source) at java.net.AbstractPlainSocketImpl.bind(Unknown Source) at java.net.PlainSocketImpl.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at fi.iki.elonen.NanoHTTPD$ServerRunnable.run(NanoHTTPD.java:1687) at java.lang.Thread.run(Unknown Source) 12:15:23.291 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.channel.ChannelManager' is now listening. 12:15:23.431 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:23.431 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:23.587 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 12:15:23.634 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:23.634 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:23.837 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:23.837 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:26.037 [UPnPDiscovery-44] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:15:30.046 [UPnPDiscovery-44] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:15:30.186 [cling-10] DEBUG RegisterInfiniTVDevice - Checking if the schema 'schemas-cetoncorp-com' can be used... 12:15:30.561 [cling-10] DEBUG RegisterInfiniTVDevice - Creating network encoders from the embedded devices on 'Ceton InfiniTV PCIe (00-80-5f-8f)' with the namespace 'schemas-cetoncorp-com'. 12:15:30.561 [cling-10] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #1' because it is not a tuner. 12:15:30.561 [cling-10] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #2' because it is not a tuner. 12:15:30.561 [cling-10] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1'. 12:15:30.576 [cling-10] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' did not exist. Triggering re-discovery. 12:15:30.576 [cling-10] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:15:30.576 [cling-10] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:15:30.592 [cling-10] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=cas&v=CardStatus' 12:15:30.639 [cling-10] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:15:30.639 [cling-10] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:15:30.639 [cling-10] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=diag&v=Streaming_IP' 12:15:30.779 [cling-10] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:15:30.779 [cling-10] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:15:30.779 [cling-10] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:15:30.779 [cling-10] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:15:30.779 [cling-10] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 1, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8396 12:15:30.795 [cling-10] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is ready. 12:15:30.795 [SageTVDiscovery-61] ERROR SageTVDiscovery - Unable to open the network encoder discovery broadcast port => {} java.net.BindException: Address already in use: bind at sun.nio.ch.Net.bind0(Native Method) at sun.nio.ch.Net.bind(Unknown Source) at sun.nio.ch.DatagramChannelImpl.bind(Unknown Source) at sun.nio.ch.DatagramSocketAdaptor.bind(Unknown Source) at opendct.sagetv.SageTVDiscovery.run(SageTVDiscovery.java:91) at java.lang.Thread.run(Unknown Source) 12:15:30.795 [cling-10] DEBUG SageTVSocketServer - Setting listening flag... 12:15:30.795 [cling-10] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 12:15:30.795 [cling-10] ERROR SageTVSocketServer - Unable to open SocketServer on port 9000 => java.net.BindException: Address already in use: JVM_Bind 12:15:30.795 [SageTVDiscovery-61] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVDiscovery was unable to open a required listening port. 12:15:30.795 [cling-10] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVManager was unable to open a required socket server listening port. 12:15:30.795 [cling-10] INFO ExitCode - Make sure you are not running the service and the console at the same time. 12:15:30.795 [SageTVTuningMonitor-62] INFO SageTVTuningMonitor - Tuning monitor thread started. 12:15:30.795 [DiscoveryManagerShutdown] INFO Main - Stopping device discovery services... 12:15:30.826 [ChannelManagerShutdown] INFO Main - Stopping all channel update threads... 12:15:30.826 [ChannelManagerShutdown] INFO ChannelManager - Saving the channel lineup 'qam_infinitv'. 12:15:30.826 [Shutdown] INFO Main - OpenDCT has received a signal to stop. 12:15:30.826 [Shutdown] INFO Main - Saving current configuration... 12:15:30.826 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread was interrupted => java.lang.InterruptedException: sleep interrupted 12:15:30.826 [PowerMessageManagerShutdown] INFO Main - Stopping power messages... 12:15:30.826 [PowerMessageManagerShutdown] INFO WindowsPowerMessagePump - Posting WM_QUIT message and waiting for message pump thread to exit. 12:15:30.826 [SageTVManagerShutdown] INFO Main - Stopping all SageTV socket servers... 12:15:30.826 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Stopping listening thread... 12:15:30.826 [SageTVManagerShutdown] DEBUG SageTVSocketServer - Listening is not in progress. 12:15:30.826 [SageTVManagerShutdown] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is being unloaded. 12:15:30.826 [SageTVManagerShutdown] DEBUG InfiniTVCaptureDevice - Capture device is now re-locked. 12:15:30.826 [SageTVManagerShutdown] DEBUG RTPCaptureDeviceServices - Producer was not running. 12:15:30.826 [SageTVManagerShutdown] DEBUG BasicCaptureDevice - Consumer is not in progress. 12:15:30.826 [SageTVTuningMonitor-62] INFO SageTVTuningMonitor - Tuning monitor thread interrupted. 12:15:30.826 [SageTVManagerShutdown] INFO InfiniTVTuning - Stopping streaming from tuner number 1 at '192.168.200.1'. 12:15:30.826 [SageTVManagerShutdown] INFO InfiniTVTuning - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/stream_request.cgi' 12:15:30.826 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump stopped. 12:15:30.826 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Before shutdown, the registry has 1 device(s). 12:15:30.841 [DiscoveryManagerShutdown] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 12:15:32.889 [DiscoveryManagerShutdown] INFO DiscoveryManager - UPnP discovery stopped. 12:15:32.889 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:15:32.889 [HDHomeRunDiscoveryReceive-45] DEBUG HDHomeRunDiscovery - Channel was closed while receiving HDHomeRun discovery packets from [/192.168.200.255:65001, /192.168.2.255:65001] => java.nio.channels.ClosedByInterruptException at java.nio.channels.spi.AbstractInterruptibleChannel.end(Unknown Source) at sun.nio.ch.DatagramChannelImpl.receive(Unknown Source) at opendct.tuning.hdhomerun.HDHomeRunDiscovery$ReceiveThread.run(HDHomeRunDiscovery.java:364) at java.lang.Thread.run(Unknown Source) 12:15:32.889 [HDHomeRunDiscoverySend-45] DEBUG HDHomeRunDiscovery - Interrupted while waiting for next broadcast to be sent => java.lang.InterruptedException: sleep interrupted at java.lang.Thread.sleep(Native Method) at opendct.tuning.hdhomerun.HDHomeRunDiscovery.run(HDHomeRunDiscovery.java:307) at java.lang.Thread.run(Unknown Source) 12:15:32.889 [DiscoveryManagerShutdown] INFO DiscoveryManager - HDHomeRun discovery stopped. 12:15:32.889 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic HTTP discovery stopped. 12:15:32.889 [DiscoveryManagerShutdown] INFO DiscoveryManager - Generic Pipe discovery stopped. 12:15:39.242 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.29... 12:15:39.273 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Windows 7' is WINDOWS. 12:15:39.273 [WrapperSimpleAppMain] INFO Config - Current directory is 'C:\Program Files\OpenDCT Authors\OpenDCT' 12:15:39.413 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory 'c:/ProgramData/OpenDCT/logs'. 12:15:39.507 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to 'c:/ProgramData/OpenDCT/logs\opendct_cling.log'. 12:15:39.507 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 12:15:39.507 [FFmpegAsyncInit-21] INFO Main - FFmpeg loading... 12:15:39.522 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Initializing FFmpegLogger... 12:15:39.647 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_log_set_callback... 12:15:39.647 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avcodec_register_all... 12:15:39.866 [WindowsPowerMessagePump] INFO WindowsPowerMessagePump - Message pump started. 12:15:40.427 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avfilter_register_all... 12:15:41.067 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_register_all... 12:15:41.067 [FFmpegAsyncInit-21] INFO Main - FFmpeg loaded in 1560ms. 12:15:44.655 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth3 (Realtek PCIe GBE Family Controller) 192.168.2.2 name:eth4 (Ceton InfiniTV Network Device) 192.168.200.2 12:15:44.655 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.power.NetworkPowerEventManger' is now listening. 12:15:44.655 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.sagetv.SageTVManager' is now listening. 12:15:44.670 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.FFmpegTransSageTVConsumerImpl 12:15:44.670 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 12:15:44.670 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 12:15:44.670 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 12:15:47.276 [LineupAsyncInit:qam_infinitv-27] INFO ChannelManager - Copying to the channel lineup Ceton InfiniTV PCIe (00-80-5f-8f) (qam_infinitv). 12:15:47.276 [LineupAsyncInit:qam_infinitv-27] ERROR CopyChannels - Lineup 'dct_infinitv' does not exist. Unable to update 'qam_infinitv' lineup. 12:15:47.541 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 12:15:47.650 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:15:47.650 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:15:47.806 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth3' with IP address 192.168.2.2 for UPnP discovery. 12:15:47.806 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth4' with IP address 192.168.200.2 for UPnP discovery. 12:15:47.884 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:15:47.931 [UPnPDiscovery-44] INFO UpnpManager - UPnP discovery thread has started. 12:15:48.118 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:15:48.227 [WrapperSimpleAppMain] ERROR HDHomeRunDiscovery - Unable to use port 64998, using any port available. 12:15:48.243 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.tuning.discovery.DiscoveryManager' is now listening. 12:15:48.243 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 12:15:48.243 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - HDHomeRun discovery sender thread started. 12:15:48.368 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.200.255:65001 broadcast started. 12:15:48.368 [HDHomeRunDiscoveryReceive-45] INFO HDHomeRunDiscovery - HDHomeRun discovery receive thread for /192.168.2.255:65001 broadcast started. 12:15:48.368 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:48.368 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:48.383 [WrapperSimpleAppMain] ERROR NanoHTTPDManager - Unable to open webserver on port 9091 => java.net.BindException: Address already in use: JVM_Bind at java.net.DualStackPlainSocketImpl.bind0(Native Method) at java.net.DualStackPlainSocketImpl.socketBind(Unknown Source) at java.net.AbstractPlainSocketImpl.bind(Unknown Source) at java.net.PlainSocketImpl.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at java.net.ServerSocket.bind(Unknown Source) at fi.iki.elonen.NanoHTTPD$ServerRunnable.run(NanoHTTPD.java:1687) at java.lang.Thread.run(Unknown Source) 12:15:48.399 [WrapperSimpleAppMain] DEBUG WindowsPowerMessagePump - 'class opendct.channel.ChannelManager' is now listening. 12:15:48.570 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:48.570 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:48.602 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 12:15:48.773 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:48.773 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:48.976 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (startup) 12:15:48.976 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (startup) 12:15:51.940 [UPnPDiscovery-44] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 12:15:53.172 [cling-11] DEBUG RegisterInfiniTVDevice - Checking if the schema 'schemas-cetoncorp-com' can be used... 12:15:53.313 [cling-11] DEBUG RegisterInfiniTVDevice - Creating network encoders from the embedded devices on 'Ceton InfiniTV PCIe (00-80-5f-8f)' with the namespace 'schemas-cetoncorp-com'. 12:15:53.313 [cling-11] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #1' because it is not a tuner. 12:15:53.313 [cling-11] DEBUG RegisterInfiniTVDevice - Skipping embedded device 'Ceton Corporation Ceton InfiniTV MOCUR-OCTA (00-00-22-00-00-80-5f-8f), Unit #2' because it is not a tuner. 12:15:53.313 [cling-11] DEBUG DeviceLoaderImpl - Advertising new capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1'. 12:15:53.313 [cling-11] DEBUG SageTVManager - The requested capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' did not exist. Triggering re-discovery. 12:15:53.313 [cling-11] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.FFmpegTransSageTVConsumerImpl' for channel '' 12:15:53.328 [cling-11] DEBUG InfiniTVCaptureDevice - Determining the encoder number... 12:15:53.328 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=cas&v=CardStatus' 12:15:53.562 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Inserted' 12:15:53.562 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Inserted' 12:15:53.562 [cling-11] DEBUG InfiniTVStatus - Connecting to InfiniTV tuner using the URL 'http://192.168.200.1/get_var?i=0&s=diag&v=Streaming_IP' 12:15:53.687 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.200.255:65001... (requested) 12:15:53.687 [HDHomeRunDiscoverySend-45] INFO HDHomeRunDiscovery - Broadcasting HDHomeRun discovery packet to /192.168.2.255:65001... (requested) 12:15:53.734 [cling-11] DEBUG InfiniTVStatus - InfiniTV DCT returned the value 'Not Available' 12:15:53.734 [cling-11] DEBUG InfiniTVStatus - The returned value was trimmed to 'Not Available' 12:15:53.750 [cling-11] DEBUG RTPCaptureDeviceServices - Initializing RTSP client... 12:15:53.750 [cling-11] DEBUG RTPCaptureDeviceServices - Getting a port for incoming RTP data... 12:15:53.750 [cling-11] INFO InfiniTVCaptureDevice - Encoder Manufacturer: 'Ceton', Number: 1, Remote IP: '192.168.200.1', Local IP: '192.168.200.2', CableCARD: true, Lineup: 'qam_infinitv', Offline Scan Enabled: false, RTP Port: 8352 12:15:53.750 [cling-11] INFO SageTVManager - The capture device 'DCT-Ceton InfiniTV PCIe (00-80-5f-8f) Tuner 1' is ready. 12:15:53.750 [SageTVDiscovery-58] ERROR SageTVDiscovery - Unable to open the network encoder discovery broadcast port => {} java.net.BindException: Address already in use: bind at sun.nio.ch.Net.bind0(Native Method) at sun.nio.ch.Net.bind(Unknown Source) at sun.nio.ch.DatagramChannelImpl.bind(Unknown Source) at sun.nio.ch.DatagramSocketAdaptor.bind(Unknown Source) at opendct.sagetv.SageTVDiscovery.run(SageTVDiscovery.java:91) at java.lang.Thread.run(Unknown Source) 12:15:53.750 [cling-11] DEBUG SageTVSocketServer - Setting listening flag... 12:15:53.750 [cling-11] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 12:15:53.750 [SageTVDiscovery-58] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVDiscovery was unable to open a required listening port. 12:15:53.750 [cling-11] ERROR SageTVSocketServer - Unable to open SocketServer on port 9000 => java.net.BindException: Address already in use: JVM_Bind 12:15:53.750 [cling-11] FATAL ExitCode - OpenDCT experienced a fatal error: SageTVManager was unable to open a required socket server listening port. 12:15:53.750 [cling-11] INFO ExitCode - Make sure you are not running the service and the console at the same time. 12:15:53.750 [SageTVTuningMonitor-59] INFO SageTVTuningMonitor - Tuning monitor thread started.