[mythtv-commits] Ticket #4346: mythfilldatabase segfaulting periodically..

MythTV mythtv at cvs.mythtv.org
Thu Dec 27 23:06:04 UTC 2007


#4346: mythfilldatabase segfaulting periodically..
------------------------------+---------------------------------------------
 Reporter:  damian at linux.ie   |        Owner:  nigel   
     Type:  defect            |       Status:  assigned
 Priority:  major             |    Milestone:  0.21    
Component:  mythfilldatabase  |      Version:  head    
 Severity:  high              |   Resolution:          
  Mlocked:  0                 |  
------------------------------+---------------------------------------------

Old description:

> This is a new ticket as requested ny nigel as a follow up to
> http://svn.mythtv.org/trac/ticket/4249#comment:13
>
> The problem is still persisting as of latest SVN..
> Note : This is on a dual core system. Also works about 25% of time..
>
> damian at mythtv-box:~$ mythfilldatabase -v all
> 2007-12-20 16:17:39.285 Using runtime prefix = /usr/local
> 2007-12-20 16:17:39.286 Using localhost value of mythtv-box
> 2007-12-20 16:17:39.287 MCP::DefaultUPnP() - config.xml has default PIN
> '2925' and host USN: uuid:785fe75f-4cd9-470e-a19e-223f7feddbc5::urn
> :schemas-mythtv-org:device:MasterMediaServer:1
> 2007-12-20 16:17:39.287 Setting UPnP client for backend autodiscovery...
> 2007-12-20 16:17:39.287 UPnp - Constructor
> 2007-12-20 16:17:39.287 ThreadPool:AddWorkerThread - HTTP_WorkerThread
> 2007-12-20 16:17:39.287 UPnp::Initialize - Begin
> 2007-12-20 16:17:39.288 UPnp::Initialize - Starting TaskQueue
> 2007-12-20 16:17:39.288 UPnp::Initialize - Creating SSDP Thread at port
> 6549
> 2007-12-20 16:17:39.288 UPnp::Initialize - End
> 2007-12-20 16:17:39.288 UPnp::Start - Starting SSDP Thread (Multicast)
> 2007-12-20 16:17:39.288 UPnp::Start - Enabling Notifications
> 2007-12-20 16:17:39.288 SSDP::EnableNotifications() - creating new task
> 2007-12-20 16:17:39.288 SSDP::EnableNotifications() - sending NTS_byebye
> 2007-12-20 16:17:39.288 LookupUDN(urn:schemas-upnp-
> org:device:MythContextClient:1) sName=UPnP/UDN/MythContextClient, sUDN=
> 2007-12-20 16:17:39.288 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
> upnp:rootdevice : uuid:8653b81e-9ddb-4d6b-b9ed-
> eb25f4425fbd::upnp:rootdevice
> 2007-12-20 16:17:39.289 UPnpNotifyTask::SendNotifyMsg() - address:
> 192.168.1.100
> 2007-12-20 16:17:39.300 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
> uuid:8653b81e-9ddb-4d6b-b9ed-eb25f4425fbd : uuid:8653b81e-9ddb-4d6b-b9ed-
> eb25f4425fbd
> 2007-12-20 16:17:39.300 UPnpNotifyTask::SendNotifyMsg() - address:
> 192.168.1.100
> 2007-12-20 16:17:39.476 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
> urn:schemas-upnp-org:device:MythContextClient:1 : uuid:8653b81e-9ddb-
> 4d6b-b9ed-eb25f4425fbd::urn:schemas-upnp-org:device:MythContextClient:1
> 2007-12-20 16:17:39.476 UPnpNotifyTask::SendNotifyMsg() - address:
> 192.168.1.100
> 2007-12-20 16:17:39.534 SSDP::EnableNotifications() - sending NTS_alive
> 2007-12-20 16:17:39.534 SSDP::EnableNotifications() - Task added to UPnP
> queue
> 2007-12-20 16:17:39.534 UPnp::Start - Returning
> 2007-12-20 16:17:39.590 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
> upnp:rootdevice : uuid:8653b81e-9ddb-4d6b-b9ed-
> eb25f4425fbd::upnp:rootdevice
> 2007-12-20 16:17:39.590 UPnpNotifyTask::SendNotifyMsg() - address:
> 192.168.1.100
> 2007-12-20 16:17:39.603 UPnPconnect() - Trying host at
> http://192.168.1.100:6544/getDeviceDesc
> 2007-12-20 16:17:39.603 postHttp: grabbing:
> http://192.168.1.100:6544/Myth
> 2007-12-20 16:17:39.604 HttpComms::stateChanged: connecting (2)
> 2007-12-20 16:17:39.617 HttpComms::stateChanged: sending (3)
> 2007-12-20 16:17:39.627 HttpComms::stateChanged: reading (4)
> 2007-12-20 16:17:39.628 Got HTTP response: 200:OK
> 2007-12-20 16:17:39.628 Keys: accept-ranges,cache-control,connection
> ,content-length,content-type,date,ext,server
> 2007-12-20 16:17:39.628 HttpComms::stateChanged: connected (5)
> 2007-12-20 16:17:39.628 done: 759 bytes
> 2007-12-20 16:17:39.638 Got 759 bytes from url:
> 'http://192.168.1.100:6544/Myth'
> 2007-12-20 16:17:39.638 <?xml version="1.0" encoding="utf-8"?>
> <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"
> s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetConnectionInfoResponse
> xmlns:u="urn:schemas-mythtv-org:service:MythTv:1">
> <Info>&lt;Database&gt;&lt;Host&gt;localhost&lt;/Host&gt;&lt;Port&gt;0&lt;/Port&gt;&lt;UserName&gt;mythtv&lt;/UserName&gt;&lt;Password&gt;muaU8KrQ&lt;/Password&gt;&lt;Name&gt;mythconverg&lt;/Name&gt;&lt;Type&gt;QMYSQL3&lt;/Type&gt;&lt;/Database&gt;&lt;WOL&gt;&lt;Enabled&gt;0&lt;/Enabled&gt;&lt;Reconnect&gt;0&lt;/Reconnect&gt;&lt;Retry&gt;5&lt;/Retry&gt;&lt;Command&gt;echo
> &apos;WOLsqlServerCommand not
> set&apos;&lt;/Command&gt;&lt;/WOL&gt;</Info>
> </u:GetConnectionInfoResponse>
> </s:Body>
> </s:Envelope>
> 2007-12-20 16:17:39.639 UPnPconnect() - Got database hostname: localhost
> 2007-12-20 16:17:39.647 New DB connection, total: 1
> 2007-12-20 16:17:39.651 Connected to database 'mythconverg' at host:
> localhost
> 2007-12-20 16:17:39.651 Closing DB connection named 'DBManager0'
> 2007-12-20 16:17:39.652 Clearing Settings Cache.
> 2007-12-20 16:17:39.652 Deleting UPnP client...
> 2007-12-20 16:17:39.652 UPnp - Destructor
> 2007-12-20 16:17:39.652 UPnp::CleanUp() - disabling SSDP notifications
> 2007-12-20 16:17:39.652 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
> upnp:rootdevice : uuid:8653b81e-9ddb-4d6b-b9ed-
> eb25f4425fbd::upnp:rootdevice
> 2007-12-20 16:17:39.652 UPnpNotifyTask::SendNotifyMsg() - address:
> 192.168.1.100
> 2007-12-20 16:17:39.825 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
> uuid:8653b81e-9ddb-4d6b-b9ed-eb25f4425fbd : uuid:8653b81e-9ddb-4d6b-b9ed-
> eb25f4425fbd
> 2007-12-20 16:17:39.825 UPnpNotifyTask::SendNotifyMsg() - address:
> 192.168.1.100
> Segmentation fault (core dumped)

New description:

 This is a new ticket as requested ny nigel as a follow up to
 http://svn.mythtv.org/trac/ticket/4249#comment:13

 The problem is still persisting as of latest SVN..
 Note : This is on a dual core system. Also works about 25% of time..

 {{{
 damian at mythtv-box:~$ mythfilldatabase -v all
 2007-12-20 16:17:39.285 Using runtime prefix = /usr/local
 2007-12-20 16:17:39.286 Using localhost value of mythtv-box
 2007-12-20 16:17:39.287 MCP::DefaultUPnP() - config.xml has default PIN
 '2925' and host USN: uuid:785fe75f-4cd9-470e-a19e-223f7feddbc5::urn
 :schemas-mythtv-org:device:MasterMediaServer:1
 2007-12-20 16:17:39.287 Setting UPnP client for backend autodiscovery...
 2007-12-20 16:17:39.287 UPnp - Constructor
 2007-12-20 16:17:39.287 ThreadPool:AddWorkerThread - HTTP_WorkerThread
 2007-12-20 16:17:39.287 UPnp::Initialize - Begin
 2007-12-20 16:17:39.288 UPnp::Initialize - Starting TaskQueue
 2007-12-20 16:17:39.288 UPnp::Initialize - Creating SSDP Thread at port
 6549
 2007-12-20 16:17:39.288 UPnp::Initialize - End
 2007-12-20 16:17:39.288 UPnp::Start - Starting SSDP Thread (Multicast)
 2007-12-20 16:17:39.288 UPnp::Start - Enabling Notifications
 2007-12-20 16:17:39.288 SSDP::EnableNotifications() - creating new task
 2007-12-20 16:17:39.288 SSDP::EnableNotifications() - sending NTS_byebye
 2007-12-20 16:17:39.288 LookupUDN(urn:schemas-upnp-
 org:device:MythContextClient:1) sName=UPnP/UDN/MythContextClient, sUDN=
 2007-12-20 16:17:39.288 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
 upnp:rootdevice : uuid:8653b81e-9ddb-4d6b-b9ed-
 eb25f4425fbd::upnp:rootdevice
 2007-12-20 16:17:39.289 UPnpNotifyTask::SendNotifyMsg() - address:
 192.168.1.100
 2007-12-20 16:17:39.300 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
 uuid:8653b81e-9ddb-4d6b-b9ed-eb25f4425fbd : uuid:8653b81e-9ddb-4d6b-b9ed-
 eb25f4425fbd
 2007-12-20 16:17:39.300 UPnpNotifyTask::SendNotifyMsg() - address:
 192.168.1.100
 2007-12-20 16:17:39.476 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
 urn:schemas-upnp-org:device:MythContextClient:1 : uuid:8653b81e-9ddb-4d6b-
 b9ed-eb25f4425fbd::urn:schemas-upnp-org:device:MythContextClient:1
 2007-12-20 16:17:39.476 UPnpNotifyTask::SendNotifyMsg() - address:
 192.168.1.100
 2007-12-20 16:17:39.534 SSDP::EnableNotifications() - sending NTS_alive
 2007-12-20 16:17:39.534 SSDP::EnableNotifications() - Task added to UPnP
 queue
 2007-12-20 16:17:39.534 UPnp::Start - Returning
 2007-12-20 16:17:39.590 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
 upnp:rootdevice : uuid:8653b81e-9ddb-4d6b-b9ed-
 eb25f4425fbd::upnp:rootdevice
 2007-12-20 16:17:39.590 UPnpNotifyTask::SendNotifyMsg() - address:
 192.168.1.100
 2007-12-20 16:17:39.603 UPnPconnect() - Trying host at
 http://192.168.1.100:6544/getDeviceDesc
 2007-12-20 16:17:39.603 postHttp: grabbing: http://192.168.1.100:6544/Myth
 2007-12-20 16:17:39.604 HttpComms::stateChanged: connecting (2)
 2007-12-20 16:17:39.617 HttpComms::stateChanged: sending (3)
 2007-12-20 16:17:39.627 HttpComms::stateChanged: reading (4)
 2007-12-20 16:17:39.628 Got HTTP response: 200:OK
 2007-12-20 16:17:39.628 Keys: accept-ranges,cache-control,connection
 ,content-length,content-type,date,ext,server
 2007-12-20 16:17:39.628 HttpComms::stateChanged: connected (5)
 2007-12-20 16:17:39.628 done: 759 bytes
 2007-12-20 16:17:39.638 Got 759 bytes from url:
 'http://192.168.1.100:6544/Myth'
 2007-12-20 16:17:39.638 <?xml version="1.0" encoding="utf-8"?>
 <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/"
 s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetConnectionInfoResponse
 xmlns:u="urn:schemas-mythtv-org:service:MythTv:1">
 <Info>&lt;Database&gt;&lt;Host&gt;localhost&lt;/Host&gt;&lt;Port&gt;0&lt;/Port&gt;&lt;UserName&gt;mythtv&lt;/UserName&gt;&lt;Password&gt;muaU8KrQ&lt;/Password&gt;&lt;Name&gt;mythconverg&lt;/Name&gt;&lt;Type&gt;QMYSQL3&lt;/Type&gt;&lt;/Database&gt;&lt;WOL&gt;&lt;Enabled&gt;0&lt;/Enabled&gt;&lt;Reconnect&gt;0&lt;/Reconnect&gt;&lt;Retry&gt;5&lt;/Retry&gt;&lt;Command&gt;echo
 &apos;WOLsqlServerCommand not set&apos;&lt;/Command&gt;&lt;/WOL&gt;</Info>
 </u:GetConnectionInfoResponse>
 </s:Body>
 </s:Envelope>
 2007-12-20 16:17:39.639 UPnPconnect() - Got database hostname: localhost
 2007-12-20 16:17:39.647 New DB connection, total: 1
 2007-12-20 16:17:39.651 Connected to database 'mythconverg' at host:
 localhost
 2007-12-20 16:17:39.651 Closing DB connection named 'DBManager0'
 2007-12-20 16:17:39.652 Clearing Settings Cache.
 2007-12-20 16:17:39.652 Deleting UPnP client...
 2007-12-20 16:17:39.652 UPnp - Destructor
 2007-12-20 16:17:39.652 UPnp::CleanUp() - disabling SSDP notifications
 2007-12-20 16:17:39.652 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
 upnp:rootdevice : uuid:8653b81e-9ddb-4d6b-b9ed-
 eb25f4425fbd::upnp:rootdevice
 2007-12-20 16:17:39.652 UPnpNotifyTask::SendNotifyMsg() - address:
 192.168.1.100
 2007-12-20 16:17:39.825 UPnpNotifyTask::SendNotifyMsg : 239.255.255.250 :
 uuid:8653b81e-9ddb-4d6b-b9ed-eb25f4425fbd : uuid:8653b81e-9ddb-4d6b-b9ed-
 eb25f4425fbd
 2007-12-20 16:17:39.825 UPnpNotifyTask::SendNotifyMsg() - address:
 192.168.1.100
 Segmentation fault (core dumped)
 }}}

--

Comment(by nigel):

 These do both look like the same problem (UPnP crashes about 25% of the
 time), but without a gdb trace of the Damian's one, I am not sure. Looks
 similar to #4243

-- 
Ticket URL: <http://svn.mythtv.org/trac/ticket/4346#comment:5>
MythTV <http://svn.mythtv.org/trac>
MythTV


More information about the mythtv-commits mailing list