[mythtv-commits] Ticket #9704: backend deadlocks up with Protocol version check failure.

MythTV noreply at mythtv.org
Tue Apr 19 12:33:07 UTC 2011


#9704: backend deadlocks up with Protocol version check failure.
-----------------------------------+----------------------------
 Reporter:  brian@…                |          Owner:
     Type:  Bug Report - General   |         Status:  new
 Priority:  critical               |      Milestone:  unknown
Component:  MythTV - General       |        Version:  0.24-fixes
 Severity:  high                   |     Resolution:
 Keywords:                         |  Ticket locked:  0
-----------------------------------+----------------------------

Comment (by brian@…):

 And within 24 hours of removing the "-v most" debugging on the backend,
 the problem is back:

 {{{
 2011-04-18 22:00:03.410 TVRec(1): Changing from None to RecordingOnly
 2011-04-18 22:00:03.453 TVRec(1): HW Tuner: 1->1
 2011-04-18 22:00:04.461 TVRec(1): rec->GetPathname():
 '/storage1/2917_20110418220000.mpg'
 2011-04-18 22:00:04.861 [mpeg2video @ 0x4059ac0]ac-tex damaged at 18 18
 2011-04-18 22:00:04.884 [mpeg2video @ 0x4059ac0]Warning MVs not available
 2011-04-18 22:00:05.003 [ac3 @ 0x4059ac0]incomplete frame
 2011-04-18 22:00:09.266 Preview Error: Encountered problems running
 '/usr/bin/mythpreviewgen --size 0x0 --chanid 3824 --starttime
 20110418210000  > /dev/null'
 2011-04-18 22:00:15.800 ~MythContext waiting for threads to exit.
 2011-04-18 22:00:40.985 UPnpMedia: BuildMediaMap VIDEO scan starting in
 :/video/mythvideo:
 2011-04-18 22:00:41.239 UPnpMedia: BuildMediaMap Done. Found 118 objects
 2011-04-18 22:00:45.084 commflag: Commercial Detection Finished: "The
 Chicago Code":"St. Valentine's Day Massacre" recorded from channel 2864 at
 2011-04-18T21:00:00 (5 commercial break(s))
 2011-04-18 22:01:14.582 JobQueue: Commercial Detection Starting for
 "Cougar Town":Walls recorded from channel 3776 at 2011-04-18T21:31:00
 2011-04-18 22:01:14.589 commflag: Commercial Detection Starting: "Cougar
 Town":Walls recorded from channel 3776 at 2011-04-18T21:31:00
 2011-04-18 22:01:14.945 Using runtime prefix = /usr
 2011-04-18 22:01:14.948 Using configuration directory =
 /home/mythtv/.mythtv
 2011-04-18 22:01:14.950 Using localhost value of pvr
 2011-04-18 22:01:14.974 New DB connection, total: 1
 2011-04-18 22:01:14.990 Connected to database 'mythconverg' at host:
 localhost
 2011-04-18 22:01:15.010 Closing DB connection named 'DBManager0'
 2011-04-18 22:01:15.011 Connected to database 'mythconverg' at host:
 localhost
 2011-04-18 22:01:15.014 Current locale EN_US
 2011-04-18 22:01:15.015 Reading locale defaults from
 /usr/share/mythtv//locales/en_us.xml
 2011-04-18 22:01:15.064 Loading en_us translation for module mythfrontend
 2011-04-18 22:01:15.272 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:01:22.275 MythSocket(987fa60:11): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:01:22.276 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:01:22.277 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:01:22.368 AFD: Opened codec 0x98db0c0, id(MPEG2VIDEO)
 type(Video)
 2011-04-18 22:01:22.370 AFD: codec AC3 has 2 channels
 2011-04-18 22:01:22.373 AFD: Opened codec 0x98e5bd0, id(AC3) type(Audio)
 2011-04-18 22:01:28.174 AFD: Opened codec 0xb4d01250, id(MPEG2VIDEO)
 type(Video)
 2011-04-18 22:01:28.176 AFD: codec AC3 has 0 channels
 2011-04-18 22:01:28.177 AFD: Opened codec 0xb34e1530, id(AC3) type(Audio)
 2011-04-18 22:01:28.180 AFD: codec AC3 has 0 channels
 2011-04-18 22:01:28.182 AFD: Opened codec 0xb34e1900, id(AC3) type(Audio)
 2011-04-18 22:01:28.183 [mpeg2video @ 0x33aaac0]mpeg_decode_postinit()
 failure
 2011-04-18 22:01:28.184 AFD Error: Unknown decoding error
 2011-04-18 22:01:28.185 [mpeg2video @ 0x33aaac0]mpeg_decode_postinit()
 failure
 2011-04-18 22:01:28.186 AFD Error: Unknown decoding error
 2011-04-18 22:01:29.280 MythSocket(987fed8:11): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:01:29.281 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:01:32.145 [mpeg2video @ 0x33aaac0]ac-tex damaged at 8 16
 2011-04-18 22:01:32.148 [mpeg2video @ 0x33aaac0]Warning MVs not available
 2011-04-18 22:01:40.919 ~MythContext waiting for threads to exit.
 2011-04-18 22:02:11.231 commflag: Commercial Detection Finished: "Mike &
 Molly":"Samuel Gets Fired" recorded from channel 2917 at
 2011-04-18T21:31:00 (3 commercial break(s))
 2011-04-18 22:02:19.610 JobQueue: Commercial Detection Starting for
 "Hawaii Five-0":Ho'opa'i recorded from channel 2917 at 2011-04-18T22:00:00
 2011-04-18 22:02:19.614 commflag: Commercial Detection Starting: "Hawaii
 Five-0":Ho'opa'i recorded from channel 2917 at 2011-04-18T22:00:00
 2011-04-18 22:02:19.909 Using runtime prefix = /usr
 2011-04-18 22:02:19.917 Using configuration directory =
 /home/mythtv/.mythtv
 2011-04-18 22:02:19.919 Using localhost value of pvr
 2011-04-18 22:02:19.948 New DB connection, total: 1
 2011-04-18 22:02:19.959 Connected to database 'mythconverg' at host:
 localhost
 2011-04-18 22:02:19.978 Closing DB connection named 'DBManager0'
 2011-04-18 22:02:19.980 Connected to database 'mythconverg' at host:
 localhost
 2011-04-18 22:02:19.982 Current locale EN_US
 2011-04-18 22:02:19.985 Reading locale defaults from
 /usr/share/mythtv//locales/en_us.xml
 2011-04-18 22:02:20.007 Loading en_us translation for module mythfrontend
 2011-04-18 22:02:20.203 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:02:20.252 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:02:27.208 MythSocket(85048b0:11): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:02:27.209 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:02:27.254 MythSocket(8505050:12): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:02:27.255 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:02:27.256 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:02:34.257 MythSocket(8502ac0:11): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:02:34.257 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:02:34.258 Unable to find active recorder for this recording,
 realtime flagging will not be enabled.
 2011-04-18 22:02:34.276 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:02:41.282 MythSocket(84b6538:11): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:02:41.283 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:02:41.284 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:02:41.602 AFD: Opened codec 0x8510ea0, id(MPEG2VIDEO)
 type(Video)
 2011-04-18 22:02:41.606 AFD: codec AC3 has 2 channels
 2011-04-18 22:02:41.613 AFD: Opened codec 0x851cde0, id(AC3) type(Audio)
 2011-04-18 22:02:41.614 AFD: codec AC3 has 0 channels
 2011-04-18 22:02:41.615 AFD: Opened codec 0x851d560, id(AC3) type(Audio)
 2011-04-18 22:02:48.286 MythSocket(8504610:11): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:02:48.286 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:06:32.325 [mpeg2video @ 0x1379ac0]ac-tex damaged at 27 13
 2011-04-18 22:06:32.343 [mpeg2video @ 0x1379ac0]Warning MVs not available
 2011-04-18 22:06:32.414 [ac3 @ 0x1379ac0]incomplete frame
 2011-04-18 22:06:36.126 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:06:43.129 MythSocket(987e750:11): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:06:43.130 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:06:43.131 ~MythContext waiting for threads to exit.
 2011-04-18 22:06:43.181 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 22:06:50.183 MythSocket(9854868:8): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 22:06:50.183 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 22:07:13.269 commflag: Commercial Detection Finished: "Cougar
 Town":Walls recorded from channel 3776 at 2011-04-18T21:31:00 (2
 commercial break(s))
 2011-04-18 22:30:44.259 UPnpMedia: BuildMediaMap VIDEO scan starting in
 :/video/mythvideo:
 2011-04-18 22:30:44.446 UPnpMedia: BuildMediaMap Done. Found 118 objects
 2011-04-18 22:49:13.373 RingBuf(/storage1/2917_20110418220000.mpg): Waited
 0.2 seconds for data
                         to become available... 22524 < 32768
 2011-04-18 22:53:02.046 RingBuf(/storage1/2917_20110418220000.mpg): Waited
 0.2 seconds for data
                         to become available... 24396 < 32768
 2011-04-18 22:55:06.255 RingBuf(/storage1/2917_20110418220000.mpg): Waited
 0.2 seconds for data
                         to become available... 11468 < 32768
 2011-04-18 22:56:34.667 RingBuf(/storage1/2917_20110418220000.mpg): Waited
 0.2 seconds for data
                         to become available... 2468 < 32768
 2011-04-18 22:59:24.626 RingBuf(/storage1/2917_20110418220000.mpg): Waited
 0.5 seconds for data
                         to become available... 27868 < 32768
 2011-04-18 22:59:49.135 AFD: Opened codec 0x852e150, id(MPEG2VIDEO)
 type(Video)
 2011-04-18 22:59:49.136 AFD: codec AC3 has 0 channels
 2011-04-18 22:59:49.231 AFD: Opened codec 0x852bee0, id(AC3) type(Audio)
 2011-04-18 23:00:00.912 TVRec(1): Changing from RecordingOnly to None
 2011-04-18 23:00:00.968 Finished recording Hawaii Five-0 "Ho'opa'i":
 channel 2917
 2011-04-18 23:00:01.095 scheduler: Finished recording: Hawaii Five-0
 "Ho'opa'i": channel 2917
 2011-04-18 23:00:01.669 Finished recording Hawaii Five-0 "Ho'opa'i":
 channel 2917
 2011-04-18 23:00:04.369 [mpeg2video @ 0x133dac0]ac-tex damaged at 29 19
 2011-04-18 23:00:04.374 [mpeg2video @ 0x133dac0]Warning MVs not available
 2011-04-18 23:00:04.522 [ac3 @ 0x133dac0]incomplete frame
 2011-04-18 23:00:08.259 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 23:00:15.463 MythSocket(852b330:15): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 23:00:15.464 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 23:00:15.465 ~MythContext waiting for threads to exit.
 2011-04-18 23:00:15.515 MythCoreContext: Connecting to backend server:
 10.75.22.2:6543 (try 1 of 5)
 2011-04-18 23:00:22.517 MythSocket(852b330:8): readStringList: Error,
 timed out after 7000 ms.
 2011-04-18 23:00:22.518 Protocol version check failure.
                         The response to MYTH_PROTO_VERSION was empty.
                         This happens when the backend is too busy to
 respond,
                         or has deadlocked in due to bugs or hardware
 failure.
 2011-04-18 23:00:43.997 commflag: Commercial Detection Finished: "Hawaii
 Five-0":Ho'opa'i recorded from channel 2917 at 2011-04-18T22:00:00 (0
 commercial break(s))
 }}}

-- 
Ticket URL: <http://code.mythtv.org/trac/ticket/9704#comment:3>
MythTV <http://code.mythtv.org/trac>
MythTV Media Center


More information about the mythtv-commits mailing list