[mythtv-commits] Ticket #11067: deadlock in backend

MythTV noreply at mythtv.org
Tue Sep 4 03:54:08 UTC 2012


#11067: deadlock in backend
------------------------+--------------------------------------------
 Reporter:  brian@…     |           Type:  Bug Report - Hang/Deadlock
   Status:  new         |       Priority:  minor
Milestone:  unknown     |      Component:  MythTV - General
  Version:  0.25-fixes  |       Severity:  medium
 Keywords:              |  Ticket locked:  0
------------------------+--------------------------------------------
 After having both recordings on a single mux of a multirec fail my backend
 seems to be at least partially deadlocked.  The symptom is that the
 Backend Status function of mythweb fails with:

 {{{
 Warning at /usr/share/mythtv/mythweb/modules/status/handler.php, line 32:
 !!NoTrans: file_get_contents(http://10.75.22.2:6544/Status/GetStatusHTML):
 failed to open stream: HTTP request failed! !!
 }}}

 It's not clear whether the failed recordings:

 Grimm with a file size of 376B
 Hawaii Five-0 with a file size of 0B

 Both recorded at 22:00:00

 are a result of the backend being deadlocked or whether the deadlock is a
 result of the failed recordings.

 The backend log at 22:00 had:

 {{{
 Sep  3 22:00:00 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:1029
 (HandleStateChange) TVRec(11): Changing from None to RecordingOnly
 Sep  3 22:00:00 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:3495
 (TuningCheckForHWChange) TVRec(11): HW Tuner: 11->11
 Sep  3 22:00:00 pvr mythbackend[1759]: E CoreContext programinfo.cpp:2278
 (GetPlaybackURL) ProgramInfo(3095_20120903220000.mpg): GetPlaybackURL:
 '3095_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:00:00 pvr mythbackend[1759]: I TVRecEvent v4lchannel.cpp:661
 (SetInputAndFormat) V4LChannel(/dev/pvr_mpeg0): SetInputAndFormat(11,
 NTSC) (v4l v2) input_switch: 0 mode_switch: 0
 Sep  3 22:00:01 pvr mythbackend[1759]: N Scheduler autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 2.0 GB
 w/freq: 15 min
 Sep  3 22:00:01 pvr mythbackend[1759]: I Scheduler scheduler.cpp:2514
 (HandleRecordingStatusChange) Tuning recording: "Storage Wars Texas":
 channel 3095 on cardid 11, sourceid 3
 Sep  3 22:00:02 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:1029
 (HandleStateChange) TVRec(2): Changing from None to RecordingOnly
 Sep  3 22:00:02 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:3495
 (TuningCheckForHWChange) TVRec(2): HW Tuner: 2->2
 Sep  3 22:00:02 pvr mythbackend[1759]: E CoreContext programinfo.cpp:2278
 (GetPlaybackURL) ProgramInfo(4097_20120903220000.mpg): GetPlaybackURL:
 '4097_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:00:02 pvr mythbackend[1759]: I CoreContext scheduler.cpp:637
 (UpdateRecStatus) Updating status for "Storage Wars Texas" on cardid 11
 (Tuning => Recording)
 Sep  3 22:00:02 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:3989
 (TuningNewRecorder) TVRec(11): rec->GetPathname():
 '/storage1/3095_20120903220000.mpg'
 Sep  3 22:00:04 pvr mythbackend[1759]: N Scheduler autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 9 min
 Sep  3 22:00:04 pvr mythbackend[1759]: I Scheduler scheduler.cpp:2514
 (HandleRecordingStatusChange) Tuning recording: Grimm:Quill: channel 4097
 on cardid 2, sourceid 2
 Sep  3 22:00:04 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:1029
 (HandleStateChange) TVRec(1): Changing from None to RecordingOnly
 Sep  3 22:00:04 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:3495
 (TuningCheckForHWChange) TVRec(1): HW Tuner: 1->1
 Sep  3 22:00:04 pvr mythbackend[1759]: E CoreContext programinfo.cpp:2278
 (GetPlaybackURL) ProgramInfo(2917_20120903220000.mpg): GetPlaybackURL:
 '2917_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:00:04 pvr mythbackend[1759]: N Scheduler autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 5 min
 Sep  3 22:00:04 pvr mythbackend[1759]: I Scheduler scheduler.cpp:2514
 (HandleRecordingStatusChange) Tuning recording: "Hawaii Five-0":"Ka Iwi
 Kapu": channel 2917 on cardid 1, sourceid 2
 Sep  3 22:00:05 pvr mythbackend[1759]: I CoreContext scheduler.cpp:637
 (UpdateRecStatus) Updating status for Grimm:Quill on cardid 2 (Tuning =>
 Recording)
 Sep  3 22:00:05 pvr mythbackend[1759]: I CoreContext scheduler.cpp:637
 (UpdateRecStatus) Updating status for "Hawaii Five-0":"Ka Iwi Kapu" on
 cardid 1 (Tuning => Recording)
 Sep  3 22:00:05 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:3989
 (TuningNewRecorder) TVRec(2): rec->GetPathname():
 '/video/mythtv/4097_20120903220000.mpg'
 Sep  3 22:00:33 pvr mythbackend[1759]: I Metadata_9775 jobqueue.cpp:2151
 (DoMetadataLookupThread) JobQueue: Metadata Lookup Starting for "Storage
 Wars Texas" recorded from channel 3095 at 2012-09-03T22:00:00
 Sep  3 22:00:37 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:00:37 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:00:37 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:00:37 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:00:38 pvr mythbackend[1759]: I Metadata_9777 jobqueue.cpp:2151
 (DoMetadataLookupThread) JobQueue: Metadata Lookup Starting for
 Grimm:Quill recorded from channel 4097 at 2012-09-03T22:00:00
 Sep  3 22:00:39 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:00:39 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:00:39 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:00:39 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:00:43 pvr mythbackend[1759]: I Commflag_9776 jobqueue.cpp:2276
 (DoFlagCommercialsThread) JobQueue: Commercial Detection Starting for
 "Storage Wars Texas" recorded from channel 3095 at 2012-09-03T22:00:00
 Sep  3 22:00:43 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:00:43 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:00:43 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:00:43 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:00:45 pvr mythbackend[1759]: I HouseKeeping housekeeper.cpp:225
 (RunHouseKeeping) Running housekeeping thread
 Sep  3 22:00:48 pvr mythbackend[1759]: I Commflag_9778 jobqueue.cpp:2276
 (DoFlagCommercialsThread) JobQueue: Commercial Detection Starting for
 Grimm:Quill recorded from channel 4097 at 2012-09-03T22:00:00
 Sep  3 22:00:48 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:00:48 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:00:48 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:00:48 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:00:53 pvr mythbackend[1759]: E JobQueue programinfo.cpp:2278
 (GetPlaybackURL) ProgramInfo(2917_20120903220000.mpg): GetPlaybackURL:
 '2917_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:00:53 pvr mythbackend[1759]: E JobQueue programinfo.cpp:2278
 (GetPlaybackURL) ProgramInfo(2917_20120903220000.mpg): GetPlaybackURL:
 '2917_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:00:53 pvr mythbackend[1759]: I Metadata_9779 jobqueue.cpp:2151
 (DoMetadataLookupThread) JobQueue: Metadata Lookup Starting for "Hawaii
 Five-0":"Ka Iwi Kapu" recorded from channel 2917 at 2012-09-03T22:00:00
 Sep  3 22:00:54 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:00:54 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:00:54 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:00:54 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:01:13 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:01:13 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:01:13 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:01:13 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:01:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (934 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:01:19 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (934 errors)#012#011#011#011starts with: 86
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_DISCONNECTED...
 Sep  3 22:01:19 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:01:19 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:01:19 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:01:19 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:01:20 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 83
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_CONNECTED HO...
 Sep  3 22:01:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (934 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:01:29 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (934 errors)#012#011#011#011starts with: 86
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_DISCONNECTED...
 Sep  3 22:01:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (934 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:01:43 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:01:43 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:01:44 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (907 errors)#012#011#011#011starts with: 586
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:01:45 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (908 errors)#012#011#011#011starts with: 69
 BACKEND_MESSAGE[]:[]COMMFLAG_START 3095_2012-09-03T2...
 Sep  3 22:01:46 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (918 errors)#012#011#011#011starts with: 586
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:01:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:01:49 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:01:49 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:01:50 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (930 errors)#012#011#011#011starts with: 674
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:01:51 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 69
 BACKEND_MESSAGE[]:[]COMMFLAG_START 4097_2012-09-03T2...
 Sep  3 22:01:52 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (929 errors)#012#011#011#011starts with: 674
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:01:53 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 674
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:01:54 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (914 errors)#012#011#011#011starts with: 674
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:01:55 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 86
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_DISCONNECTED...
 Sep  3 22:01:56 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 86
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_DISCONNECTED...
 Sep  3 22:01:57 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 674
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:01:57 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:01:57 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:01:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:01:58 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:01:58 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:01:59 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 83
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_CONNECTED HO...
 Sep  3 22:01:59 pvr mythbackend[1759]: E Commflag_9778
 previewgenerator.cpp:254 (Run) Preview: Encountered problems running
 '/usr/bin/mythpreviewgen --size 0x0 --chanid 4097 --starttime
 20120903220000 --verbose general --loglevel info --syslog local7 --quiet'
 (128)
 Sep  3 22:01:59 pvr mythbackend[1759]: E JobQueue programinfo.cpp:2278
 (GetPlaybackURL) ProgramInfo(2917_20120903220000.mpg): GetPlaybackURL:
 '2917_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:01:59 pvr mythbackend[1759]: E JobQueue programinfo.cpp:2278
 (GetPlaybackURL) ProgramInfo(2917_20120903220000.mpg): GetPlaybackURL:
 '2917_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:01:59 pvr mythbackend[1759]: I Commflag_9780 jobqueue.cpp:2276
 (DoFlagCommercialsThread) JobQueue: Commercial Detection Starting for
 "Hawaii Five-0":"Ka Iwi Kapu" recorded from channel 2917 at
 2012-09-03T22:00:00
 Sep  3 22:01:59 pvr mythbackend[1759]: E Commflag_9780
 programinfo.cpp:2278 (GetPlaybackURL)
 ProgramInfo(2917_20120903220000.mpg): GetPlaybackURL:
 '2917_20120903220000.mpg' should be local, but it can not be found.
 Sep  3 22:02:00 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (910 errors)#012#011#011#011starts with: 674
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:02:01 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 86
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_DISCONNECTED...
 Sep  3 22:02:02 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 86
 BACKEND_MESSAGE[]:[]SYSTEM_EVENT CLIENT_DISCONNECTED...
 Sep  3 22:02:03 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 649
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:02:04 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 674
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:02:05 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 649
 BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE UPDATE[]:[...
 Sep  3 22:02:08 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:02:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:02:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:02:58  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:02:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:03:08 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:03:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:03:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:03:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:03:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:03:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:04:28  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:04:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:04:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 80
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:04:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (930 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:04:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:05:28  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:05:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:05:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:05:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:05:51 pvr mythbackend[1759]: I HouseKeeping housekeeper.cpp:225
 (RunHouseKeeping) Running housekeeping thread
 Sep  3 22:05:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:06:28  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:06:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:07:18  mythbackend[1759]: last message repeated 4 times
 Sep  3 22:07:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:07:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:07:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:08:05  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:08:05 pvr mythbackend[1759]: N Expire autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 5 min
 Sep  3 22:08:08 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (913 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:08:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:08:48  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:08:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:08:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:09:08 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:09:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:09:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:09:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:09:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:09:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:10:08 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:10:38  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:10:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:10:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:10:56 pvr mythbackend[1759]: I HouseKeeping housekeeper.cpp:225
 (RunHouseKeeping) Running housekeeping thread
 Sep  3 22:10:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:11:08 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:11:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:11:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:11:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:11:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:12:18  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:12:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:12:28 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:12:38 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:12:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:12:58 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:13:08 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (933 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:13:18 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (932 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:13:48  mythbackend[1759]: last message repeated 2 times
 Sep  3 22:13:48 pvr mythbackend[1759]: E CoreContext mythsocket.cpp:389
 (writeStringList) MythSocket(8cdc998:72): writeStringList: Error, No data
 written on writeBlock (931 errors)#012#011#011#011starts with: 81
 BACKEND_MESSAGE[]:[]UPDATE_FILE_SIZE 3095 2012-09-03...
 Sep  3 22:14:05 pvr mythbackend[1759]: N Expire autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 5 min
 Sep  3 22:16:03 pvr mythbackend[1759]: I HouseKeeping housekeeper.cpp:225
 (RunHouseKeeping) Running housekeeping thread
 Sep  3 22:20:05 pvr mythbackend[1759]: N Expire autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 5 min
 Sep  3 22:21:08 pvr mythbackend[1759]: I HouseKeeping housekeeper.cpp:225
 (RunHouseKeeping) Running housekeeping thread
 Sep  3 22:25:05 pvr mythbackend[1759]: N Expire autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 5 min
 Sep  3 22:26:11 pvr mythbackend[1759]: I HouseKeeping housekeeper.cpp:225
 (RunHouseKeeping) Running housekeeping thread
 Sep  3 22:29:29 pvr mythbackend[1759]: I TVRecEvent tv_rec.cpp:1536
 (HandlePendingRecordings) TVRec(11): ASK_RECORDING 11 29 0 0
 Sep  3 22:30:00 pvr mythbackend[1759]: I PreviewGeneratorQueue
 mythdbcon.cpp:395 (PurgeIdleConnections) New DB connection, total: 15
 Sep  3 22:30:00 pvr mythbackend[1759]: N Scheduler autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 5 min
 Sep  3 22:30:00 pvr mythbackend[1759]: I Scheduler scheduler.cpp:2514
 (HandleRecordingStatusChange) Started recording: "Storage Wars Texas":
 channel 3095 on cardid 11, sourceid 3
 Sep  3 22:30:00 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:30:00 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:30:00 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:30:00 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:30:00 pvr mythbackend[1759]: I RecThread tv_rec.cpp:3292
 (RingBufferChanged) TVRec(11): RingBufferChanged()
 Sep  3 22:30:00 pvr mythbackend[1759]: I CoreContext scheduler.cpp:637
 (UpdateRecStatus) Updating status for "Storage Wars Texas" on cardid 11
 (Recording => Recorded)
 Sep  3 22:30:00 pvr mythbackend[1759]: I RecThread recordinginfo.cpp:1113
 (FinishedRecording) Finished recording Storage Wars Texas: channel 3095
 Sep  3 22:30:00 pvr mythbackend[1759]: I Scheduler scheduler.cpp:2033
 (HandleReschedule) Reschedule requested for id 0.
 Sep  3 22:30:04 pvr mythbackend[1759]: I Metadata_9781 jobqueue.cpp:2151
 (DoMetadataLookupThread) JobQueue: Metadata Lookup Starting for "Storage
 Wars Texas" recorded from channel 3095 at 2012-09-03T22:30:00
 Sep  3 22:30:25 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:30:25 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:30:25 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:30:25 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:30:28 pvr mythbackend[1759]: I Scheduler scheduler.cpp:2093
 (HandleReschedule) Scheduled 1362 items in 28.0 = 0.00 match + 28.02 place
 Sep  3 22:30:30 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:30:30 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:30:30 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:30:30 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:31:05 pvr mythbackend[1759]: N Expire autoexpire.cpp:263
 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB
 w/freq: 5 min
 Sep  3 22:31:09 pvr mythbackend[1759]: I Commflag_9782 jobqueue.cpp:2276
 (DoFlagCommercialsThread) JobQueue: Commercial Detection Starting for
 "Storage Wars Texas" recorded from channel 3095 at 2012-09-03T22:30:00
 Sep  3 22:31:10 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 Sep  3 22:31:10 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 0)
 Sep  3 22:31:10 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Monitor
 Sep  3 22:31:10 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1362 (HandleAnnounce) adding: pvr as a client (events: 1)
 Sep  3 22:31:11 pvr mythbackend[1759]: I HouseKeeping housekeeper.cpp:225
 (RunHouseKeeping) Running housekeeping thread
 Sep  3 22:31:40 pvr mythbackend[1759]: I ProcessRequest
 mainserver.cpp:1360 (HandleAnnounce) MainServer::ANN Playback
 ...
 }}}

 I will attach the threaded stacktrace of the server at the deadlock time.

-- 
Ticket URL: <http://code.mythtv.org/trac/ticket/11067>
MythTV <http://code.mythtv.org/trac>
MythTV Media Center


More information about the mythtv-commits mailing list