[mythtv-users] Log file mystery

Yan Seiner yan at seiner.com
Sat Aug 9 18:03:50 UTC 2008


Yan Seiner wrote:
> My mythbackend log files are filling up with this message, every few 
> seconds:
>
> 2008-08-09 08:27:08.641 RemoteFile::openSocket(file data socket):
>                         Could not connect to server "" @ port -1
> 2008-08-09 08:27:08.642 RingBuffer::RingBuffer(): Failed to open remote 
> file ()
>
> AFAICT this just started yesterday.  Here's the first occurence:
>
> 2008-08-08 15:52:09.172 Preview Error: Previewer file 
> '/data/mythtv/recordings/1284_20080808155200.mpg' is not valid.
> 2008-08-08 15:52:09.205 Preview Error: Run() file not local: 
> '/data/mythtv/recordings/1284_20080808155200.mpg'
> 2008-08-08 15:52:09.256 Preview Error: Preview process not ok.
>                         
> fileinfo(/data/mythtv/recordings/1284_20080808155200.mpg.png) exists: 0 
> readable: 0 size: 0
> 2008-08-08 15:52:13.345 DB Error (change_program):
> Query was:
> UPDATE program SET starttime = '2008-08-09T11:30:00',     endtime   = 
> '2008-08-09T12:00:00' WHERE chanid    = 1284 AND       starttim
> e = '2008-08-09T11:00:00'
> Driver error was [2/1062]:
> QMYSQL3: Unable to execute query
> Database error was:
> Duplicate entry '1284-2008-08-09 11:30:00-0' for key 1
>
> 2008-08-08 15:52:22.874 TVRec(1): HW Tuner: 1->1
>
> .......
>
> 2008-08-08 15:54:24.211 AFD: Opened codec 0x908b80, id(AC3) type(Audio)
> 2008-08-08 15:54:24.467 Preview: Grabbed preview 
> '/data/mythtv/recordings/1131_20080808155407.mpg' 1920x1088 at 64s
> 2008-08-08 15:54:34.051 Expiring 0 MBytes for 1284 @ Fri Aug 8 15:30:00 
> 2008 => Thomas & Friends
> 2008-08-08 15:54:34.063 Expiring 2 MBytes for 1284 @ Fri Aug 8 15:30:00 
> 2008 => Thomas & Friends
> 2008-08-08 15:54:34.064 Expiring 0 MBytes for 1161 @ Fri Aug 8 15:29:46 
> 2008 => DTV Program
> 2008-08-08 15:54:34.066 Expiring 12 MBytes for 1161 @ Fri Aug 8 15:29:46 
> 2008 => DTV Program
> 2008-08-08 15:54:34.068 Expiring 0 MBytes for 1162 @ Fri Aug 8 15:29:46 
> 2008 => DTV Program
> 2008-08-08 15:54:34.072 Expiring 15 MBytes for 1162 @ Fri Aug 8 15:29:46 
> 2008 => DTV Program
> 2008-08-08 15:54:34.074 Expiring 0 MBytes for 1282 @ Fri Aug 8 15:30:00 
> 2008 => Clifford The Big Red Dog
> 2008-08-08 15:54:43.137 TVRec(1): Changing from WatchingLiveTV to None
> 2008-08-08 15:54:43.554 Finished recording DTV Program: channel 1161
> 2008-08-08 15:54:48.439 MainServer::HandleAnnounce Playback
> 2008-08-08 15:54:48.508 adding: yan as a client (events: 0)
> 2008-08-08 15:54:48.527 MainServer::HandleAnnounce FileTransfer
> 2008-08-08 15:54:48.536 adding: yan as a remote file transfer
> 2008-08-08 15:54:48.548 RemoteFile::openSocket(control socket):
>                         Could not connect to server "" @ port -1
> 2008-08-08 15:54:48.558 RemoteFile::openSocket(file data socket):
>                         Could not connect to server "" @ port -1
> 2008-08-08 15:54:48.578 RingBuffer::RingBuffer(): Failed to open remote 
> file ()
>
>
> Anyone have a clue what it might mean?
>
> Myth works fine.
>
>   
OK, so now I'm seeing this:

2008-08-09 10:58:00.350 DB Error (change_program):
Query was:
UPDATE program SET starttime = '2008-08-09T13:29:46',     endtime   = 
'2008-08-09T14:00:00' WHERE chanid    = 1162 AND       starttime = 
'2008-08-09T13:00:00'
Driver error was [2/1062]:
QMYSQL3: Unable to execute query
Database error was:
Duplicate entry '1162-2008-08-09 13:29:46-0' for key 1

2008-08-09 10:58:00.518 DB Error (change_program):
Query was:
UPDATE program SET starttime = '2008-08-09T16:29:46',     endtime   = 
'2008-08-09T18:00:00' WHERE chanid    = 1162 AND       starttime = 
'2008-08-09T16:00:00'
Driver error was [2/1062]:
QMYSQL3: Unable to execute query
Database error was:
Duplicate entry '1162-2008-08-09 16:29:46-0' for key 1

2008-08-09 10:58:00.963 DB Error (change_program):
Query was:
UPDATE program SET starttime = '2008-08-09T15:29:46',     endtime   = 
'2008-08-09T15:59:46' WHERE chanid    = 1162 AND       starttime = 
'2008-08-09T14:59:46'
Driver error was [2/1062]:
QMYSQL3: Unable to execute query
Database error was:
Duplicate entry '1162-2008-08-09 15:29:46-0' for key 1

2008-08-09 10:58:02.038 DB Error (change_program):
Query was:
UPDATE program SET starttime = '2008-08-09T20:29:46',     endtime   = 
'2008-08-10T00:00:00' WHERE chanid    = 1161 AND       starttime = 
'2008-08-09T20:00:00'
Driver error was [2/1062]:
QMYSQL3: Unable to execute query
Database error was:
Duplicate entry '1161-2008-08-09 20:29:46-0' for key 1

2008-08-09 10:59:02.924 Reschedule requested for id -1.
2008-08-09 10:59:03.377 Scheduled 234 items in 0.4 = 0.09 match + 0.36 place

After this, I get channel 16_1 and 16_2 showing DTV program instead of 
the actual programming.  Then if I rerun mythfilldatabase 
--refresh-today it clears up for a while - 10 minutes or so....

it only affects channel 16_[12].  Any ideas?

-- 
  o__
  ,>/'_          o__
  (_)\(_)        ,>/'_        o__
Yan Seiner      (_)\(_)       ,>/'_     o__
       Personal Trainer      (_)\(_)    ,>/'_        o__
             Professional Engineer     (_)\(_)       ,>/'_
Who says engineers have to be pencil necked geeks?  (_)\(_)

"I worry about my child and the Internet all the time, even though she's too young to have logged on yet. Here's what I worry about. I worry that 10 or 15 years from now, she will come to me and say 'Daddy, where were you when they took freedom of the press away from the Internet?'"
--Mike Godwin, Electronic Frontier Foundation 



More information about the mythtv-users mailing list