18:57:44.571 [WrapperSimpleAppMain] INFO Main - Starting OpenDCT 0.5.29... 18:57:44.869 [WrapperSimpleAppMain] DEBUG Config - OSVersion determined that 'Linux' is LINUX. 18:57:44.877 [WrapperSimpleAppMain] INFO Config - Current directory is '/opt/opendct' 18:57:45.058 [WrapperSimpleAppMain] INFO Main - OpenDCT logging to the directory '/var/log/opendct'. 18:57:46.870 [WrapperSimpleAppMain] INFO UpnpManager - Logging Cling UPnP to '/var/log/opendct/opendct_cling.log'. 18:57:46.871 [WrapperSimpleAppMain] DEBUG UpnpManager - Logging level for Cling UPnP is set to 'severe'. 18:57:47.031 [WrapperSimpleAppMain] WARN LinuxPowerMessagePump - System power state messages are currently not implemented for Linux. 18:57:47.031 [FFmpegAsyncInit-21] INFO Main - FFmpeg loading... 18:57:47.070 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Initializing FFmpegLogger... 18:57:47.531 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_log_set_callback... 18:57:47.532 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avcodec_register_all... 18:57:48.060 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling avfilter_register_all... 18:57:48.393 [FFmpegAsyncInit-21] DEBUG FFmpegUtil - Calling av_register_all... 18:57:48.393 [FFmpegAsyncInit-21] INFO Main - FFmpeg loaded in 1372ms. 18:58:41.268 [WrapperSimpleAppMain] INFO NetworkPowerEventManger - Network interfaces which are up and have an IP4 address are: name:eth0 (eth0) 192.168.1.12 18:58:49.314 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer default set to use opendct.consumer.MediaServerConsumerImpl 18:58:49.314 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.FFmpegTransSageTVConsumerImpl for [] 18:58:49.315 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.MediaServerConsumerImpl for [] 18:58:49.315 [DynamicAsyncInit-21] INFO DynamicConsumerImpl - Dynamic consumer set to use opendct.consumer.RawSageTVConsumerImpl for [] 18:59:01.493 [WrapperSimpleAppMain] INFO UpnpManager - Starting UPnP services... 18:59:01.643 [WrapperSimpleAppMain] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth0' with IP address 192.168.1.12 for UPnP discovery. 18:59:04.236 [WrapperSimpleAppMain] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:04.311 [UPnPDiscovery-34] INFO UpnpManager - UPnP discovery thread has started. 18:59:04.326 [WrapperSimpleAppMain] INFO NanoHTTPDManager - Starting webserver on port 9091... 18:59:04.326 [GenericPipeLoader-36] DEBUG DeviceLoaderImpl - Advertising new capture device 'f'. 18:59:04.740 [GenericPipeLoader-36] DEBUG SageTVManager - The requested capture device 'f' did not exist. Triggering re-discovery. 18:59:04.740 [GenericPipeLoader-36] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.080 [GenericPipeLoader-36] DEBUG SageTVManager - Port 9000 is available. 18:59:05.124 [GenericPipeLoader-36] INFO SageTVManager - The capture device 'f' is ready. 18:59:05.126 [GenericPipeLoader-36] DEBUG SageTVSocketServer - Setting listening flag... 18:59:05.126 [SageTVTuningMonitor-42] INFO SageTVTuningMonitor - Tuning monitor thread started. 18:59:05.126 [GenericPipeLoader-36] INFO SageTVSocketServer - Opening ServerSocket on port 9000... 18:59:05.126 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'virgin1'. 18:59:05.127 [SageTVSocketServer-43:9000] INFO SageTVSocketServer - Started listening on port 9000... 18:59:05.128 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'virgin1' did not exist. Triggering re-discovery. 18:59:05.128 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.129 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'virgin1' is ready. 18:59:05.130 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'virgin2'. 18:59:05.130 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'virgin2' did not exist. Triggering re-discovery. 18:59:05.130 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.131 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'virgin2' is ready. 18:59:05.131 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'virgin3'. 18:59:05.131 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'virgin3' did not exist. Triggering re-discovery. 18:59:05.131 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.132 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'virgin3' is ready. 18:59:05.133 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview1'. 18:59:05.133 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview1' did not exist. Triggering re-discovery. 18:59:05.133 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.135 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview1' is ready. 18:59:05.135 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview2'. 18:59:05.135 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview2' did not exist. Triggering re-discovery. 18:59:05.135 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.136 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview2' is ready. 18:59:05.137 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview3'. 18:59:05.137 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview3' did not exist. Triggering re-discovery. 18:59:05.137 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.138 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview3' is ready. 18:59:05.138 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview4'. 18:59:05.139 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview4' did not exist. Triggering re-discovery. 18:59:05.139 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.140 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview4' is ready. 18:59:05.140 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'vmstb'. 18:59:05.140 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'vmstb' did not exist. Triggering re-discovery. 18:59:05.140 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.141 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'vmstb' is ready. 18:59:05.141 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'vmstb2'. 18:59:05.142 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'vmstb2' did not exist. Triggering re-discovery. 18:59:05.142 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.143 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'vmstb2' is ready. 18:59:05.170 [WrapperSimpleAppMain] INFO Main - Running in daemon mode... 18:59:05.180 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview5'. 18:59:05.180 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview5' did not exist. Triggering re-discovery. 18:59:05.180 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.181 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview5' is ready. 18:59:05.181 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview6'. 18:59:05.181 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview6' did not exist. Triggering re-discovery. 18:59:05.181 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.182 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview6' is ready. 18:59:05.183 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview7'. 18:59:05.183 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview7' did not exist. Triggering re-discovery. 18:59:05.183 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.184 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview7' is ready. 18:59:05.184 [GenericHttpLoader-35] DEBUG DeviceLoaderImpl - Advertising new capture device 'freeview8'. 18:59:05.227 [GenericHttpLoader-35] DEBUG SageTVManager - The requested capture device 'freeview8' did not exist. Triggering re-discovery. 18:59:05.227 [GenericHttpLoader-35] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '' 18:59:05.228 [GenericHttpLoader-35] INFO SageTVManager - The capture device 'freeview8' is ready. 18:59:08.311 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:10.506 [SageTVRequestHandler-52:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'START freeview1 HDMI|1375305533|102|3102933500890|/var/media/Live European Indoor Championship Athletics - 26793885-2.ts|Great-H.264' 18:59:12.399 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:13.078 [SageTVRequestHandler-52:freeview1] DEBUG GenericHttpCaptureDevice - Capture device is now re-locked. 18:59:13.078 [SageTVRequestHandler-52:freeview1] DEBUG SageTVRequestHandler - Starting network encoder via upload ID '1375305533' to file name '/var/media/Live European Indoor Championship Athletics - 26793885-2.ts'. 18:59:13.079 [SageTVRequestHandler-52:freeview1] DEBUG BasicCaptureDevice - Consumer is not in progress. 18:59:13.081 [SageTVRequestHandler-52:freeview1] DEBUG DynamicConsumerImpl - Using default consumer 'opendct.consumer.MediaServerConsumerImpl' for channel '102' 18:59:13.082 [SageTVRequestHandler-52:freeview1] INFO GenericHttpCaptureDevice - Starting the encoding for the channel '102' from the device 'freeview1' to the file '/var/media/Live European Indoor Championship Athletics - 26793885-2.ts' via the upload id '1375305533'... 18:59:13.086 [SageTVRequestHandler-52:freeview1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV producer... 18:59:13.086 [SageTVRequestHandler-52:freeview1] INFO HTTPProducerImpl - Connecting to source using the URL 'http://192.168.1.11:9981/stream/channelnumber/102' 18:59:16.672 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:17.291 [HTTPProducerImpl-64:freeview1] INFO HTTPProducerImpl - Producer thread is running. 18:59:17.291 [SageTVRequestHandler-52:freeview1] INFO GenericHttpCaptureDevice - Configuring and starting the new SageTV consumer... 18:59:17.291 [HTTPProducerImpl-64:freeview1] DEBUG HTTPProducerImpl - Thread priority is 9. 18:59:17.291 [SageTVRequestHandler-52:freeview1] DEBUG BasicCaptureDevice - Consumer is not in progress. 18:59:18.236 [MediaServerConsumerImpl-65:freeview1] INFO MediaServerConsumerImpl - MediaServer thread started. 18:59:18.236 [MediaServerConsumerImpl-65:freeview1] DEBUG MediaServerConsumerImpl - Thread priority is 8. 18:59:18.236 [MediaServerConsumerImpl-65:freeview1] INFO MediaServerConsumerImpl - Opening file via MediaServer... 18:59:18.237 [MediaServerConsumerImpl-65:freeview1] INFO NIOSageTVMediaServer - Connecting to SageTV server on socket /192.168.1.13:7818... 18:59:18.836 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2087176 bytes left to be read, has only 9975 bytes left for writing and 19364 bytes cannot be added. Deferring bytes to queue buffer. 18:59:20.807 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:25.232 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:30.034 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:31.233 [SageTVRequestHandler-73:Unknown] DEBUG SageTVRequestHandler - SageTV sent: 'START freeview1 HDMI|1375305533|102|3102933500890|/var/media/Live European Indoor Championship Athletics - 26793885-2.ts|Great-H.264' 18:59:31.233 [SageTVRequestHandler-73:freeview1] INFO GenericHttpCaptureDevice - Capture device was already locked. 18:59:31.233 [SageTVRequestHandler-73:freeview1] DEBUG SageTVRequestHandler - Starting network encoder via upload ID '1375305533' to file name '/var/media/Live European Indoor Championship Athletics - 26793885-2.ts'. 18:59:31.239 [MediaServerConsumerImpl-65:freeview1] INFO NIOSageTVMediaServer - Sending 'WRITEOPEN /var/media/Live European Indoor Championship Athletics - 26793885-2.ts 1375305533' to SageTV server... 18:59:31.247 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2087176 bytes left to be read, has only 9975 bytes left for writing and 19928 bytes cannot be added. The queue buffer is full at 8391004 bytes. 18:59:34.236 [SageTVRequestHandler-52:freeview1] DEBUG SageTVRequestHandler - Replied: 'OK' 18:59:34.236 [SageTVRequestHandler-73:freeview1] INFO GenericHttpCaptureDevice - Re-tune came back too fast. Skipping. 18:59:34.380 [MediaServerConsumerImpl-65:freeview1] INFO MediaServerConsumerImpl - Setting up remuxing on MediaServer... 18:59:34.380 [SageTVRequestHandler-73:freeview1] DEBUG SageTVRequestHandler - Replied: 'OK' 18:59:34.380 [MediaServerConsumerImpl-65:freeview1] INFO NIOSageTVMediaServer - Sending 'REMUX_SETUP AUTO TS TRUE' to SageTV server... 18:59:34.610 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:34.610 [UPnPDiscovery-34] DEBUG UpnpManager - Stopping broadcast. 18:59:35.170 [WrapperSimpleAppMain] INFO Main - Saving config... 18:59:35.685 [UPnPDiscovery-34] DEBUG DiscoveryRegistryListener - Before shutdown, the registry has 2 device(s). 18:59:35.686 [UPnPDiscovery-34] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 18:59:36.284 [MediaServerConsumerImpl-65:freeview1] INFO MediaServerConsumerImpl - Media Server consumer is now streaming... 18:59:40.941 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 640704 bytes from the queue buffer. 18:59:40.941 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Lost 5141424 bytes that could not be queued in the queue buffer. 18:59:46.940 [UPnPDiscovery-34] DEBUG UpnpManager - Broadcast requested. 18:59:47.487 [UPnPDiscovery-34] INFO DCTDefaultUpnpServiceConfiguration - Using the interface 'eth0' with IP address 192.168.1.12 for UPnP discovery. 18:59:55.337 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 18:59:57.737 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 18:59:58.189 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 23 bytes from SageTV server. 18:59:58.189 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 23 18:59:58.189 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '19773840 900000000013' 18:59:58.189 [SageTVTuningMonitor-42] INFO SageTVTuningMonitor - 'freeview1' produced first 25144624 packets. 18:59:58.190 [SageTVTuningMonitor-42] INFO SageTVTuningMonitor - 'freeview1' recorded first 19773840 bytes. 18:59:59.634 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 19:00:10.013 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 19:00:14.138 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 19:00:15.024 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:00:15.025 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 23 bytes from SageTV server. 19:00:15.025 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 23 19:00:15.025 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '30207840 900000000013' 19:00:19.072 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 19:00:24.847 [UPnPDiscovery-34] DEBUG UpnpManager - Sending a SecureContainer search message for 'schemas-cetoncorp-com' devices... 19:00:26.664 [UPnPDiscovery-34] DEBUG UpnpManager - Stopping broadcast. 19:00:26.894 [UPnPDiscovery-34] WARN DiscoveryRegistryListener - Before UPnP shutdown, the registry did not contain any devices. 19:00:26.894 [UPnPDiscovery-34] DEBUG DiscoveryRegistryListener - Shutdown of UPnP registry complete. 19:00:35.443 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:00:45.374 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 23 bytes from SageTV server. 19:00:45.374 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 23 19:00:45.374 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '38126400 900000000013' 19:00:44.628 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1835824 bytes left to be read, has only 261329 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:00:50.981 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:00:51.241 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1835108 bytes left to be read, has only 262045 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:00:51.242 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:01:03.870 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:01:07.172 [ChannelManager-46] INFO ChannelManager - The static channel lineup virgin1 (generic_http) will remain unchanged. 19:01:07.172 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 23 bytes from SageTV server. 19:01:07.172 [ChannelManager-46] INFO ChannelManager - The static channel lineup f (generic_pipe) will remain unchanged. 19:01:07.172 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 23 19:01:07.172 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '53726640 900000000013' 19:01:25.384 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:01:25.385 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 23 bytes from SageTV server. 19:01:25.385 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 23 19:01:25.385 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '67070880 900000000013' 19:01:41.944 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:01:41.945 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 23 bytes from SageTV server. 19:01:41.945 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 23 19:01:41.945 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '76534800 900000000013' 19:01:58.369 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:01:58.369 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 23 bytes from SageTV server. 19:01:58.491 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 23 19:01:58.491 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '88796160 900000000013' 19:02:14.651 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:02:14.651 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:02:14.651 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:02:14.651 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '100324320 900000000013' 19:02:30.762 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:02:30.822 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:02:30.822 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:02:30.822 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '109619040 900000000013' 19:02:46.868 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:02:46.876 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:02:46.876 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:02:46.876 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '121575840 900000000013' 19:03:03.078 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:03:03.078 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:03:03.078 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:03:03.256 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '132212880 900000000013' 19:03:19.312 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:03:19.326 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:03:19.326 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:03:19.326 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '147982320 900000000013' 19:03:35.394 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:03:35.394 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:03:35.394 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:03:35.394 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '155844480 900000000013' 19:03:51.494 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:03:51.496 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:03:51.497 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:03:51.497 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '162849360 900000000013' 19:04:07.616 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:04:07.617 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:04:07.635 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:04:07.636 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '174964080 900000000013' 19:04:23.765 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:04:23.766 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:04:23.767 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:04:23.767 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '185048400 900000000013' 19:04:39.966 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:04:40.015 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:04:40.015 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:04:40.015 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '194512320 900000000013' 19:04:56.016 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:04:56.018 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:04:56.018 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:04:56.018 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '203604000 900000000013' 19:05:12.136 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:05:12.137 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:05:12.137 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:05:12.137 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '212537760 900000000013' 19:05:28.409 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:05:28.409 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:05:28.409 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:05:28.410 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '223941840 900000000013' 19:05:44.508 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:05:44.511 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:05:44.511 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:05:44.511 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '231386640 900000000013' 19:06:00.598 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:06:00.599 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:06:00.599 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:06:00.599 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '240421920 900000000013' 19:06:16.613 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:06:16.614 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:06:16.615 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:06:16.615 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '248757840 900000000013' 19:06:32.636 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:06:32.636 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:06:32.636 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:06:32.636 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '260421360 900000000013' 19:06:48.994 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:06:49.089 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:06:49.089 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:06:49.102 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '272863200 900000000013' 19:07:05.105 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:07:05.112 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:07:05.112 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:07:05.112 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '283003920 900000000013' 19:07:21.218 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:07:21.523 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:07:21.523 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:07:21.523 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '295197600 900000000013' 19:07:37.558 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:07:37.583 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:07:37.583 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:07:37.583 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '308090640 900000000013' 19:07:53.647 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:07:53.687 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:07:53.687 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:07:53.687 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '317656080 900000000013' 19:08:09.763 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:08:09.887 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:08:09.969 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:08:09.969 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '327887040 900000000013' 19:08:25.971 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:08:26.044 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:08:26.044 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:08:26.044 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '339900240 900000000013' 19:08:42.062 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:08:42.077 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:08:42.077 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:08:42.077 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '350424480 900000000013' 19:08:58.133 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:08:58.135 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:08:58.135 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:08:58.135 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '365099760 900000000013' 19:09:14.224 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:09:14.282 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:09:14.282 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:09:14.283 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '378455280 900000000013' 19:09:30.338 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:09:30.366 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:09:30.385 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:09:30.385 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '391912320 900000000013' 19:09:46.545 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:09:46.555 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:09:46.555 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:09:46.555 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '406666560 900000000013' 19:10:02.736 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:10:02.800 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:10:02.800 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:10:02.800 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '420168720 900000000013' 19:10:18.887 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:10:18.902 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:10:18.902 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:10:18.902 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '433873920 900000000013' 19:10:34.941 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:10:34.953 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:10:34.953 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:10:34.963 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '448718400 900000000013' 19:10:51.117 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:10:51.118 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:10:51.118 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:10:51.118 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '465660960 900000000013' 19:11:07.324 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:11:07.381 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:11:07.381 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:11:07.381 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '484092480 900000000013' 19:11:23.605 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:11:23.605 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:11:23.646 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:11:23.646 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '502738320 900000000013' 19:11:39.802 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:11:39.803 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:11:39.803 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:11:39.803 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '517966320 900000000013' 19:11:55.857 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:11:55.869 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:11:55.869 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:11:55.869 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '534423840 900000000013' 19:12:11.964 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:12:12.003 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:12:12.003 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:12:12.015 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '549595440 900000000013' 19:12:28.099 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:12:28.110 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:12:28.268 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:12:28.268 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '566459040 900000000013' 19:12:44.337 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:12:44.374 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:12:44.374 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:12:44.374 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '581066640 900000000013' 19:13:00.463 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:13:00.480 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:13:00.480 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:13:00.480 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '598663440 900000000013' 19:13:16.509 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:13:16.545 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:13:16.545 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:13:16.545 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '614071920 900000000013' 19:13:32.596 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:13:32.652 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:13:32.652 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:13:32.652 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '629457840 900000000013' 19:13:48.665 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:13:48.751 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:13:48.751 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:13:48.751 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '643862400 900000000013' 19:14:05.794 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:14:06.250 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:14:06.250 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:14:06.250 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '661256160 900000000013' 19:14:23.978 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:14:25.090 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:14:25.261 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:14:25.261 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '677646000 900000000013' 19:14:26.104 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 0 bytes left to be read, has only 6853 bytes left for writing and 21620 bytes cannot be added. Deferring bytes to queue buffer. 19:14:29.030 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 283764 bytes from the queue buffer. 19:14:41.636 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1835008 bytes left to be read, has only 262143 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:14:41.816 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:14:42.365 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:14:42.365 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:14:42.977 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '688068720 900000000013' 19:14:43.611 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:15:00.028 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:15:00.597 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:15:00.597 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:15:00.597 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '700916640 900000000013' 19:15:18.867 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1838308 bytes left to be read, has only 258845 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:15:18.887 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:15:35.463 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:15:35.725 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:15:39.132 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:15:39.132 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '715422720 900000000013' 19:15:39.132 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1916268 bytes left to be read, has only 180885 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:15:45.359 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:15:50.661 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2089244 bytes left to be read, has only 7909 bytes left for writing and 20304 bytes cannot be added. Deferring bytes to queue buffer. 19:16:04.647 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:16:30.512 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:16:30.512 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:16:30.513 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '729872400 900000000013' 19:16:48.839 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:16:49.342 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:16:49.342 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:16:49.343 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '736944960 900000000013' 19:16:49.342 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1835108 bytes left to be read, has only 262045 bytes left for writing and 262144 bytes cannot be added. The queue buffer is full at 8437764 bytes. 19:16:49.627 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 1048576 bytes from the queue buffer. 19:16:49.627 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Lost 262144 bytes that could not be queued in the queue buffer. 19:16:49.630 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1835008 bytes left to be read, has only 262143 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:16:50.348 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:17:11.077 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:17:11.078 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:17:11.078 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:17:11.078 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '766250400 900000000013' 19:17:22.427 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2084284 bytes left to be read, has only 12869 bytes left for writing and 21620 bytes cannot be added. Deferring bytes to queue buffer. 19:17:30.839 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 283764 bytes from the queue buffer. 19:17:30.949 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:17:31.099 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:17:31.099 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:17:31.100 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '774078720 900000000013' 19:17:40.326 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2069232 bytes left to be read, has only 27921 bytes left for writing and 28012 bytes cannot be added. Deferring bytes to queue buffer. 19:17:49.229 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:17:49.230 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:17:49.904 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:17:49.904 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '783204240 900000000013' 19:17:51.941 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 290156 bytes from the queue buffer. 19:18:07.819 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:18:08.037 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:18:08.038 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:18:08.046 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '800440080 900000000013' 19:18:24.043 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2089320 bytes left to be read, has only 7833 bytes left for writing and 19364 bytes cannot be added. Deferring bytes to queue buffer. 19:18:28.711 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:18:31.384 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 281508 bytes from the queue buffer. 19:18:31.659 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:18:31.659 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:18:31.659 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '808742160 900000000013' 19:18:42.886 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1835008 bytes left to be read, has only 262143 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:18:48.550 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:18:48.551 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1835008 bytes left to be read, has only 262143 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:18:48.670 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:18:48.670 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:19:15.817 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:19:16.074 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '815386080 900000000013' 19:19:22.404 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 1835008 bytes from the queue buffer. 19:19:37.338 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:19:38.021 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:19:38.021 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:19:38.021 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '828425760 900000000013' 19:19:43.353 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2096520 bytes left to be read, has only 633 bytes left for writing and 20492 bytes cannot be added. Deferring bytes to queue buffer. 19:19:44.780 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 282636 bytes from the queue buffer. 19:19:55.947 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2084964 bytes left to be read, has only 12189 bytes left for writing and 20680 bytes cannot be added. Deferring bytes to queue buffer. 19:19:57.842 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 282824 bytes from the queue buffer. 19:19:57.842 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1843600 bytes left to be read, has only 253553 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:20:06.136 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:20:15.075 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1843700 bytes left to be read, has only 253453 bytes left for writing and 262144 bytes cannot be added. The queue buffer is full at 8598412 bytes. 19:20:17.656 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:20:18.320 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:20:18.320 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '843879360 900000000013' 19:20:23.456 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 2150888 bytes from the queue buffer. 19:20:23.474 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Lost 7602176 bytes that could not be queued in the queue buffer. 19:20:29.635 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2089996 bytes left to be read, has only 7157 bytes left for writing and 21808 bytes cannot be added. Deferring bytes to queue buffer. 19:20:33.174 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 283952 bytes from the queue buffer. 19:20:37.853 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:20:37.843 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2082476 bytes left to be read, has only 14677 bytes left for writing and 22184 bytes cannot be added. Deferring bytes to queue buffer. 19:20:41.825 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:20:41.826 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:20:41.826 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '865198560 900000000013' 19:20:41.884 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 284328 bytes from the queue buffer. 19:20:41.885 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 1842616 bytes left to be read, has only 254537 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer. 19:21:35.763 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 0 19:21:36.347 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - Received 24 bytes from SageTV server. 19:21:36.354 [HTTPProducerImpl-64:freeview1] INFO SeekableCircularBufferNIO - Recovered 524288 bytes from the queue buffer. 19:21:36.613 [SageTVTuningMonitor-42] DEBUG NIOSageTVMediaServer - messageInBytes = 24 19:21:36.613 [SageTVTuningMonitor-42] INFO NIOSageTVMediaServer - Received message from SageTV server '868176480 900000000013' 19:21:36.622 [HTTPProducerImpl-64:freeview1] WARN SeekableCircularBufferNIO - The buffer has 2091988 bytes left to be read, has only 5165 bytes left for writing and 262144 bytes cannot be added. Deferring bytes to queue buffer.