Inconsistent backend behavior
Inconsistent backend behavior
So with Craig's help I was able to install MythTV and, using Kodi as a frontend, was even able to do my first PVR recordings. However, the MythTV backend seems to go in and out. Right now I get "Channel not available" error messages. I've attached the most recent MythTV log if that helps solve the problem -- I see that there are some error messages relating to files not found -- these are files that I deleted just by using Finder -- if that's a "no-no" let me know.
Re: Inconsistent backend behavior
Had trouble uploading the log, so just copied it below.
2016-07-28 09:03:08.428970 C [551/3087] thread_unknown mythcommandlineparser.cpp:2595 (ConfigureLogging) - mythbackend version: fixes/0.27 [v0.27.4-f1115fcd-MacPorts] www.mythtv.org
2016-07-28 09:03:08.429060 C [551/3087] thread_unknown mythcommandlineparser.cpp:2597 (ConfigureLogging) - Qt version: compile: 4.8.6, runtime: 4.8.6
2016-07-28 09:03:08.429079 N [551/3087] thread_unknown mythcommandlineparser.cpp:2599 (ConfigureLogging) - Enabled verbose msgs: general
2016-07-28 09:03:08.889538 N [551/3087] thread_unknown logging.cpp:907 (logStart) - Setting Log Level to LOG_INFO
2016-07-28 09:03:09.219087 I [551/8451] Logger logging.cpp:308 (run) - Added logging to the console
2016-07-28 09:03:09.219853 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Interrupt: 2 handler
2016-07-28 09:03:09.219868 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Terminated: 15 handler
2016-07-28 09:03:09.219879 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Segmentation fault: 11 handler
2016-07-28 09:03:09.219899 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Abort trap: 6 handler
2016-07-28 09:03:09.219913 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Bus error: 10 handler
2016-07-28 09:03:09.219925 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Floating point exception: 8 handler
2016-07-28 09:03:09.219943 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Illegal instruction: 4 handler
2016-07-28 09:03:09.404395 N [551/3087] thread_unknown mythdirs.cpp:55 (InitializeMythDirs) - Using runtime prefix = /opt/dvr
2016-07-28 09:03:09.404435 N [551/3087] thread_unknown mythdirs.cpp:68 (InitializeMythDirs) - Using configuration directory = /opt/dvr/var/mythtvuser/.mythtv
2016-07-28 09:03:09.526215 I [551/3087] CoreContext mythcorecontext.cpp:257 (Init) - Assumed character encoding:
2016-07-28 09:03:09.526254 W [551/3087] CoreContext mythcorecontext.cpp:264 (Init) - This application expects to be running a locale that specifies a UTF-8 codeset, and many features may behave improperly with your current language settings. Please set the LC_ALL or LC_CTYPE, and LANG variable(s) in the environment in which this program is executed to include a UTF-8 codeset (such as 'en_US.UTF-8').
2016-07-28 09:03:10.165576 I [551/6667] LogForward loggingserver.cpp:1373 (forwardMessage) - New Client: (#1)
2016-07-28 09:03:11.423884 I [551/6667] LogForward loggingserver.cpp:142 (FileLogger) - Added logging to /opt/dvr/var/log/mythtv.27/mythbackend.20160728130308.551.log
2016-07-28 09:03:11.984680 N [551/3087] CoreContext mythcontext.cpp:504 (LoadDatabaseSettings) - Empty LocalHostName.
2016-07-28 09:03:11.984696 I [551/3087] CoreContext mythcontext.cpp:512 (LoadDatabaseSettings) - Using localhost value of 2012-Mac-mini.home
2016-07-28 09:03:15.033098 N [551/3087] CoreContext mythcorecontext.cpp:1634 (InitLocale) - Setting QT default locale to en_US
2016-07-28 09:03:15.033115 I [551/3087] CoreContext mythcorecontext.cpp:1667 (SaveLocaleDefaults) - Current locale en_US
2016-07-28 09:03:15.707642 N [551/3087] CoreContext mythlocale.cpp:121 (LoadDefaultsFromXML) - Reading locale defaults from /opt/dvr/share/mythtv//locales/en_us.xml
2016-07-28 09:03:17.018913 I [551/3087] CoreContext schemawizard.cpp:118 (Compare) - Current MythTV Schema Version (DBSchemaVer): 1317
2016-07-28 09:03:17.665721 I [551/3087] CoreContext mythtranslation.cpp:65 (load) - Loading en_us translation for module mythfrontend
2016-07-28 09:03:17.937923 N [551/3087] CoreContext main_helpers.cpp:582 (run_backend) - MythBackend: Starting up as the master server.
2016-07-28 09:05:39.634918 I [551/3087] CoreContext programinfo.cpp:2136 (CheckProgramIDAuthorities) - Found 1 distinct programid authorities
2016-07-28 09:05:39.635260 I [551/4871] Scheduler mythdbcon.cpp:436 (getStaticCon) - New static DB connectionSchedCon
2016-07-28 09:05:39.821416 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'LogClean'.
2016-07-28 09:05:39.821486 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'DBCleanup'.
2016-07-28 09:05:39.821544 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'ThemeUpdateNotifications'.
2016-07-28 09:05:39.821609 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'RecordedArtworkUpdate'.
2016-07-28 09:05:39.824033 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'MythFillDB'.
2016-07-28 09:05:39.824099 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'JobQueueRecover'.
2016-07-28 09:05:40.042031 I [551/3087] CoreContext housekeeper.cpp:655 (Start) - Starting HouseKeeper.
2016-07-28 09:05:41.720077 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP 127.0.0.1:6544
2016-07-28 09:05:41.720363 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [::1]:6544
2016-07-28 09:05:41.720641 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::1%lo0]:6544
2016-07-28 09:05:41.720902 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::aa20:66ff:fe23:dcfa%en0]:6544
2016-07-28 09:05:41.721166 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::7400:c954:11de:4b3c%utun0]:6544
2016-07-28 09:05:42.261887 N [551/3087] CoreContext mediaserver.cpp:168 (Init) - MediaServer:: Loopback address specified - 127.0.0.1. Disabling UPnP
2016-07-28 09:05:42.261900 I [551/3087] CoreContext main_helpers.cpp:668 (run_backend) - Main::Registering HttpStatus Extension
2016-07-28 09:05:42.414026 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP 127.0.0.1:6543
2016-07-28 09:05:42.414285 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [::1]:6543
2016-07-28 09:05:42.414516 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::1%lo0]:6543
2016-07-28 09:05:42.414785 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::aa20:66ff:fe23:dcfa%en0]:6543
2016-07-28 09:05:42.415037 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::7400:c954:11de:4b3c%utun0]:6543
2016-07-28 09:05:43.227079 E [551/3087] CoreContext autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:05:43.707510 I [551/4871] Scheduler scheduler.cpp:2140 (HandleReschedule) - Reschedule requested for MATCH 0 0 0 - SchedulerInit
2016-07-28 09:05:51.265138 I [551/4871] Scheduler scheduler.cpp:2253 (HandleReschedule) - Scheduled 1 items in 4.3 = 3.24 match + 0.36 check + 0.69 place
2016-07-28 09:05:51.303045 I [551/4871] Scheduler scheduler.cpp:2320 (HandleRunSchedulerStartup) - Scheduler: Seem to be woken up by USER
2016-07-28 09:06:59.357044 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:06:59.587304 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:06:59.587362 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:06:59.592180 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:06:59.674473 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:06:59.674595 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:06:59.676920 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:06:59.676974 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:22:00.875021 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:22:00.932486 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:22:00.932534 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:22:00.932559 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1076 MB for 1101 at 2016-07-26T14:04:57Z => Michaela
2016-07-28 09:22:00.932581 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1122 MB for 1101 at 2016-07-26T15:00:02Z => Michaela
2016-07-28 09:22:00.932603 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 427 MB for 1101 at 2016-07-26T16:00:04Z => Michaela
2016-07-28 09:22:00.934556 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:22:00.934633 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:22:00.936856 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:22:00.936875 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:22:00.936914 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:22:00.938171 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1101_20160726140457.mpg): GetPlaybackURL: '1101_20160726140457.mpg' should be local, but it can not be found.
2016-07-28 09:22:00.938205 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1101_20160726140457.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.625854 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:37:02.952713 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:37:02.952769 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:37:02.955042 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.955101 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.957071 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.957115 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.957193 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:37:02.958518 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1101_20160726140457.mpg): GetPlaybackURL: '1101_20160726140457.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.958556 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1101_20160726140457.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.964232 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1052_20160725191600.mpg): GetPlaybackURL: '1052_20160725191600.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.964264 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1052_20160725191600.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:43:58.151730 C [551/13059] ProcessRequest mainserver.cpp:1345 (HandleVersion) - MainServer::HandleVersion - Client speaks protocol version 88 but we speak 77!
2016-07-28 09:43:58.206496 I [551/13571] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:43:58.206507 I [551/13571] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:43:58.323579 I [551/13059] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:43:58.323585 I [551/13059] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:44:00.885176 I [551/13059] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:44:00.885186 I [551/13059] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 1)
2016-07-28 09:44:06.370077 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:44:06.373288 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:52:03.804929 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:52:03.808779 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:52:03.808821 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:52:03.812571 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:52:03.848914 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:52:03.848974 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:52:03.850750 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:52:03.850790 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:53:12.571028 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:53:12.571034 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:53:12.750731 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Playback
2016-07-28 09:53:12.750739 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:53:12.919774 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from None to WatchingLiveTV
2016-07-28 09:53:13.038065 I [551/9751] TVRecEvent tv_rec.cpp:3603 (TuningCheckForHWChange) - TVRec[1]: HW Tuner: 1->1
2016-07-28 09:53:13.125491 E [551/3087] CoreContext autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:53:14.103334 E [551/9751] TVRecEvent threadedfilewriter.cpp:129 (Open) - TFW(/Volumes/downloads/Mythtv/1107_20160728135313.mpg:-1): Opening file '/Volumes/downloads/Mythtv/1107_20160728135313.mpg'.
eno: No such file or directory (2)
2016-07-28 09:53:14.103425 E [551/9751] TVRecEvent tv_rec.cpp:4522 (GetProgramRingBufferForLiveTV) - TVRec[1]: RingBuffer '/Volumes/downloads/Mythtv/1107_20160728135313.mpg' not open...
2016-07-28 09:53:14.103493 E [551/9751] TVRecEvent tv_rec.cpp:4559 (CreateLiveTVRingBuffer) - TVRec[1]: CreateLiveTVRingBuffer(107) failed
2016-07-28 09:53:14.103508 E [551/9751] TVRecEvent tv_rec.cpp:3832 (TuningFrequency) - TVRec[1]: Failed to create RingBuffer 1
2016-07-28 09:53:14.103529 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from WatchingLiveTV to None
2016-07-28 09:54:27.758569 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:27.758583 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:54:27.759978 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:27.759988 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 1)
2016-07-28 09:54:59.852919 C [551/15619] ProcessRequest mainserver.cpp:1345 (HandleVersion) - MainServer::HandleVersion - Client speaks protocol version 88 but we speak 77!
2016-07-28 09:54:59.853938 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:59.853948 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:54:59.867047 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:59.867053 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:54:59.958953 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:59.958962 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 1)
2016-07-28 09:55:03.220908 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:03.224412 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:55:05.802991 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:05.806454 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:55:16.869248 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:16.882858 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:55:21.602645 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:55:21.602653 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:55:21.611639 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Playback
2016-07-28 09:55:21.611649 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:55:21.660337 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from None to WatchingLiveTV
2016-07-28 09:55:21.664037 I [551/9751] TVRecEvent tv_rec.cpp:3603 (TuningCheckForHWChange) - TVRec[1]: HW Tuner: 1->1
2016-07-28 09:55:21.676820 E [551/3087] CoreContext autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:55:21.896638 E [551/9751] TVRecEvent threadedfilewriter.cpp:129 (Open) - TFW(/Volumes/downloads/Mythtv/1111_20160728135521.mpg:-1): Opening file '/Volumes/downloads/Mythtv/1111_20160728135521.mpg'.
eno: No such file or directory (2)
2016-07-28 09:55:21.896665 E [551/9751] TVRecEvent tv_rec.cpp:4522 (GetProgramRingBufferForLiveTV) - TVRec[1]: RingBuffer '/Volumes/downloads/Mythtv/1111_20160728135521.mpg' not open...
2016-07-28 09:55:21.896701 E [551/9751] TVRecEvent tv_rec.cpp:4559 (CreateLiveTVRingBuffer) - TVRec[1]: CreateLiveTVRingBuffer(111) failed
2016-07-28 09:55:21.896709 E [551/9751] TVRecEvent tv_rec.cpp:3832 (TuningFrequency) - TVRec[1]: Failed to create RingBuffer 1
2016-07-28 09:55:21.896731 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from WatchingLiveTV to None
2016-07-28 09:55:39.640009 E [551/12303] HttpServer78 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:39.644827 E [551/12303] HttpServer78 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:03:08.428970 C [551/3087] thread_unknown mythcommandlineparser.cpp:2595 (ConfigureLogging) - mythbackend version: fixes/0.27 [v0.27.4-f1115fcd-MacPorts] www.mythtv.org
2016-07-28 09:03:08.429060 C [551/3087] thread_unknown mythcommandlineparser.cpp:2597 (ConfigureLogging) - Qt version: compile: 4.8.6, runtime: 4.8.6
2016-07-28 09:03:08.429079 N [551/3087] thread_unknown mythcommandlineparser.cpp:2599 (ConfigureLogging) - Enabled verbose msgs: general
2016-07-28 09:03:08.889538 N [551/3087] thread_unknown logging.cpp:907 (logStart) - Setting Log Level to LOG_INFO
2016-07-28 09:03:09.219087 I [551/8451] Logger logging.cpp:308 (run) - Added logging to the console
2016-07-28 09:03:09.219853 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Interrupt: 2 handler
2016-07-28 09:03:09.219868 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Terminated: 15 handler
2016-07-28 09:03:09.219879 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Segmentation fault: 11 handler
2016-07-28 09:03:09.219899 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Abort trap: 6 handler
2016-07-28 09:03:09.219913 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Bus error: 10 handler
2016-07-28 09:03:09.219925 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Floating point exception: 8 handler
2016-07-28 09:03:09.219943 I [551/3087] thread_unknown signalhandling.cpp:194 (SetHandlerPrivate) - Setup Illegal instruction: 4 handler
2016-07-28 09:03:09.404395 N [551/3087] thread_unknown mythdirs.cpp:55 (InitializeMythDirs) - Using runtime prefix = /opt/dvr
2016-07-28 09:03:09.404435 N [551/3087] thread_unknown mythdirs.cpp:68 (InitializeMythDirs) - Using configuration directory = /opt/dvr/var/mythtvuser/.mythtv
2016-07-28 09:03:09.526215 I [551/3087] CoreContext mythcorecontext.cpp:257 (Init) - Assumed character encoding:
2016-07-28 09:03:09.526254 W [551/3087] CoreContext mythcorecontext.cpp:264 (Init) - This application expects to be running a locale that specifies a UTF-8 codeset, and many features may behave improperly with your current language settings. Please set the LC_ALL or LC_CTYPE, and LANG variable(s) in the environment in which this program is executed to include a UTF-8 codeset (such as 'en_US.UTF-8').
2016-07-28 09:03:10.165576 I [551/6667] LogForward loggingserver.cpp:1373 (forwardMessage) - New Client: (#1)
2016-07-28 09:03:11.423884 I [551/6667] LogForward loggingserver.cpp:142 (FileLogger) - Added logging to /opt/dvr/var/log/mythtv.27/mythbackend.20160728130308.551.log
2016-07-28 09:03:11.984680 N [551/3087] CoreContext mythcontext.cpp:504 (LoadDatabaseSettings) - Empty LocalHostName.
2016-07-28 09:03:11.984696 I [551/3087] CoreContext mythcontext.cpp:512 (LoadDatabaseSettings) - Using localhost value of 2012-Mac-mini.home
2016-07-28 09:03:15.033098 N [551/3087] CoreContext mythcorecontext.cpp:1634 (InitLocale) - Setting QT default locale to en_US
2016-07-28 09:03:15.033115 I [551/3087] CoreContext mythcorecontext.cpp:1667 (SaveLocaleDefaults) - Current locale en_US
2016-07-28 09:03:15.707642 N [551/3087] CoreContext mythlocale.cpp:121 (LoadDefaultsFromXML) - Reading locale defaults from /opt/dvr/share/mythtv//locales/en_us.xml
2016-07-28 09:03:17.018913 I [551/3087] CoreContext schemawizard.cpp:118 (Compare) - Current MythTV Schema Version (DBSchemaVer): 1317
2016-07-28 09:03:17.665721 I [551/3087] CoreContext mythtranslation.cpp:65 (load) - Loading en_us translation for module mythfrontend
2016-07-28 09:03:17.937923 N [551/3087] CoreContext main_helpers.cpp:582 (run_backend) - MythBackend: Starting up as the master server.
2016-07-28 09:05:39.634918 I [551/3087] CoreContext programinfo.cpp:2136 (CheckProgramIDAuthorities) - Found 1 distinct programid authorities
2016-07-28 09:05:39.635260 I [551/4871] Scheduler mythdbcon.cpp:436 (getStaticCon) - New static DB connectionSchedCon
2016-07-28 09:05:39.821416 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'LogClean'.
2016-07-28 09:05:39.821486 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'DBCleanup'.
2016-07-28 09:05:39.821544 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'ThemeUpdateNotifications'.
2016-07-28 09:05:39.821609 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'RecordedArtworkUpdate'.
2016-07-28 09:05:39.824033 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'MythFillDB'.
2016-07-28 09:05:39.824099 I [551/3087] CoreContext housekeeper.cpp:582 (RegisterTask) - Registering HouseKeeperTask 'JobQueueRecover'.
2016-07-28 09:05:40.042031 I [551/3087] CoreContext housekeeper.cpp:655 (Start) - Starting HouseKeeper.
2016-07-28 09:05:41.720077 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP 127.0.0.1:6544
2016-07-28 09:05:41.720363 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [::1]:6544
2016-07-28 09:05:41.720641 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::1%lo0]:6544
2016-07-28 09:05:41.720902 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::aa20:66ff:fe23:dcfa%en0]:6544
2016-07-28 09:05:41.721166 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::7400:c954:11de:4b3c%utun0]:6544
2016-07-28 09:05:42.261887 N [551/3087] CoreContext mediaserver.cpp:168 (Init) - MediaServer:: Loopback address specified - 127.0.0.1. Disabling UPnP
2016-07-28 09:05:42.261900 I [551/3087] CoreContext main_helpers.cpp:668 (run_backend) - Main::Registering HttpStatus Extension
2016-07-28 09:05:42.414026 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP 127.0.0.1:6543
2016-07-28 09:05:42.414285 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [::1]:6543
2016-07-28 09:05:42.414516 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::1%lo0]:6543
2016-07-28 09:05:42.414785 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::aa20:66ff:fe23:dcfa%en0]:6543
2016-07-28 09:05:42.415037 I [551/3087] CoreContext serverpool.cpp:404 (listen) - Listening on TCP [fe80::7400:c954:11de:4b3c%utun0]:6543
2016-07-28 09:05:43.227079 E [551/3087] CoreContext autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:05:43.707510 I [551/4871] Scheduler scheduler.cpp:2140 (HandleReschedule) - Reschedule requested for MATCH 0 0 0 - SchedulerInit
2016-07-28 09:05:51.265138 I [551/4871] Scheduler scheduler.cpp:2253 (HandleReschedule) - Scheduled 1 items in 4.3 = 3.24 match + 0.36 check + 0.69 place
2016-07-28 09:05:51.303045 I [551/4871] Scheduler scheduler.cpp:2320 (HandleRunSchedulerStartup) - Scheduler: Seem to be woken up by USER
2016-07-28 09:06:59.357044 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:06:59.587304 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:06:59.587362 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:06:59.592180 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:06:59.674473 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:06:59.674595 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:06:59.676920 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:06:59.676974 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:22:00.875021 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:22:00.932486 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:22:00.932534 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:22:00.932559 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1076 MB for 1101 at 2016-07-26T14:04:57Z => Michaela
2016-07-28 09:22:00.932581 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1122 MB for 1101 at 2016-07-26T15:00:02Z => Michaela
2016-07-28 09:22:00.932603 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 427 MB for 1101 at 2016-07-26T16:00:04Z => Michaela
2016-07-28 09:22:00.934556 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:22:00.934633 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:22:00.936856 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:22:00.936875 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:22:00.936914 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:22:00.938171 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1101_20160726140457.mpg): GetPlaybackURL: '1101_20160726140457.mpg' should be local, but it can not be found.
2016-07-28 09:22:00.938205 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1101_20160726140457.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.625854 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:37:02.952713 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:37:02.952769 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:37:02.955042 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.955101 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.957071 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.957115 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.957193 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:37:02.958518 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1101_20160726140457.mpg): GetPlaybackURL: '1101_20160726140457.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.958556 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1101_20160726140457.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:37:02.964232 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1052_20160725191600.mpg): GetPlaybackURL: '1052_20160725191600.mpg' should be local, but it can not be found.
2016-07-28 09:37:02.964264 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1052_20160725191600.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:43:58.151730 C [551/13059] ProcessRequest mainserver.cpp:1345 (HandleVersion) - MainServer::HandleVersion - Client speaks protocol version 88 but we speak 77!
2016-07-28 09:43:58.206496 I [551/13571] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:43:58.206507 I [551/13571] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:43:58.323579 I [551/13059] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:43:58.323585 I [551/13059] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:44:00.885176 I [551/13059] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:44:00.885186 I [551/13059] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 1)
2016-07-28 09:44:06.370077 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:44:06.373288 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:52:03.804929 E [551/6407] Expire autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:52:03.808779 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 1 MB for 1630 at 2016-07-25T21:04:31Z => "Mud Lovin' Rednecks":"Muddy Marriage Proposal"
2016-07-28 09:52:03.808821 N [551/6407] Expire autoexpire.cpp:641 (SendDeleteMessages) - Expiring 0 MB for 1010 at 2016-07-25T21:11:48Z => "Family Guy":"The Old Man and the Big `C'"
2016-07-28 09:52:03.812571 E [551/6407] Expire autoexpire.cpp:422 (ExpireRecordings) - AutoExpire: Filesystem Info cache is empty, unable to determine what Recordings to expire
2016-07-28 09:52:03.848914 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1630_20160725210431.mpg): GetPlaybackURL: '1630_20160725210431.mpg' should be local, but it can not be found.
2016-07-28 09:52:03.848974 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1630_20160725210431.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:52:03.850750 E [551/3087] CoreContext programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1010_20160725211148.mpg): GetPlaybackURL: '1010_20160725211148.mpg' should be local, but it can not be found.
2016-07-28 09:52:03.850790 E [551/3087] CoreContext mainserver.cpp:2698 (DoHandleDeleteRecording) - ERROR when trying to delete file: GetPlaybackURL/UNABLE/TO/FIND/LOCAL/FILE/ON/2012-Mac-mini.home/1010_20160725211148.mpg. File doesn't exist. Database metadata will not be removed.
2016-07-28 09:53:12.571028 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:53:12.571034 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:53:12.750731 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Playback
2016-07-28 09:53:12.750739 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:53:12.919774 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from None to WatchingLiveTV
2016-07-28 09:53:13.038065 I [551/9751] TVRecEvent tv_rec.cpp:3603 (TuningCheckForHWChange) - TVRec[1]: HW Tuner: 1->1
2016-07-28 09:53:13.125491 E [551/3087] CoreContext autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:53:14.103334 E [551/9751] TVRecEvent threadedfilewriter.cpp:129 (Open) - TFW(/Volumes/downloads/Mythtv/1107_20160728135313.mpg:-1): Opening file '/Volumes/downloads/Mythtv/1107_20160728135313.mpg'.
eno: No such file or directory (2)
2016-07-28 09:53:14.103425 E [551/9751] TVRecEvent tv_rec.cpp:4522 (GetProgramRingBufferForLiveTV) - TVRec[1]: RingBuffer '/Volumes/downloads/Mythtv/1107_20160728135313.mpg' not open...
2016-07-28 09:53:14.103493 E [551/9751] TVRecEvent tv_rec.cpp:4559 (CreateLiveTVRingBuffer) - TVRec[1]: CreateLiveTVRingBuffer(107) failed
2016-07-28 09:53:14.103508 E [551/9751] TVRecEvent tv_rec.cpp:3832 (TuningFrequency) - TVRec[1]: Failed to create RingBuffer 1
2016-07-28 09:53:14.103529 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from WatchingLiveTV to None
2016-07-28 09:54:27.758569 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:27.758583 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:54:27.759978 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:27.759988 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 1)
2016-07-28 09:54:59.852919 C [551/15619] ProcessRequest mainserver.cpp:1345 (HandleVersion) - MainServer::HandleVersion - Client speaks protocol version 88 but we speak 77!
2016-07-28 09:54:59.853938 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:59.853948 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:54:59.867047 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:59.867053 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:54:59.958953 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:54:59.958962 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 1)
2016-07-28 09:55:03.220908 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:03.224412 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:55:05.802991 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:05.806454 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:55:16.869248 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:16.882858 E [551/12303] HttpServer62 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
2016-07-28 09:55:21.602645 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Monitor
2016-07-28 09:55:21.602653 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:55:21.611639 I [551/15619] ProcessRequest mainserver.cpp:1446 (HandleAnnounce) - MainServer::ANN Playback
2016-07-28 09:55:21.611649 I [551/15619] ProcessRequest mainserver.cpp:1448 (HandleAnnounce) - adding: 2012-Mac-mini.home as a client (events: 0)
2016-07-28 09:55:21.660337 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from None to WatchingLiveTV
2016-07-28 09:55:21.664037 I [551/9751] TVRecEvent tv_rec.cpp:3603 (TuningCheckForHWChange) - TVRec[1]: HW Tuner: 1->1
2016-07-28 09:55:21.676820 E [551/3087] CoreContext autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
2016-07-28 09:55:21.896638 E [551/9751] TVRecEvent threadedfilewriter.cpp:129 (Open) - TFW(/Volumes/downloads/Mythtv/1111_20160728135521.mpg:-1): Opening file '/Volumes/downloads/Mythtv/1111_20160728135521.mpg'.
eno: No such file or directory (2)
2016-07-28 09:55:21.896665 E [551/9751] TVRecEvent tv_rec.cpp:4522 (GetProgramRingBufferForLiveTV) - TVRec[1]: RingBuffer '/Volumes/downloads/Mythtv/1111_20160728135521.mpg' not open...
2016-07-28 09:55:21.896701 E [551/9751] TVRecEvent tv_rec.cpp:4559 (CreateLiveTVRingBuffer) - TVRec[1]: CreateLiveTVRingBuffer(111) failed
2016-07-28 09:55:21.896709 E [551/9751] TVRecEvent tv_rec.cpp:3832 (TuningFrequency) - TVRec[1]: Failed to create RingBuffer 1
2016-07-28 09:55:21.896731 I [551/9751] TVRecEvent tv_rec.cpp:1050 (HandleStateChange) - TVRec[1]: Changing from WatchingLiveTV to None
2016-07-28 09:55:39.640009 E [551/12303] HttpServer78 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010000.mpg): GetPlaybackURL: '1185_20160728010000.mpg' should be local, but it can not be found.
2016-07-28 09:55:39.644827 E [551/12303] HttpServer78 programinfo.cpp:2358 (GetPlaybackURL) - ProgramInfo(1185_20160728010001.mpg): GetPlaybackURL: '1185_20160728010001.mpg' should be local, but it can not be found.
Re: Inconsistent backend behavior
since you are using kodi , will live tv work with mythfrontend? check /Volumes/downloads/Mythtv/ is it a valid folder/mounted correctly/file permissions set to mythtv user(mythtv user needs read/write access).
Deleting mythtv files outside of mythtv software can cause Database issues.
Deleting mythtv files outside of mythtv software can cause Database issues.
Re: Inconsistent backend behavior
Yes, it appears you are using a folder on your system drive (~/Downloads/Mythtv) but trying to refer to it as /Volumes/downloads/Mythtv. Using the system drive is A BAD IDEA, as I've written before.
Craig
Craig
Formerly the MacPorts guy.
Re: Inconsistent backend behavior
I do think the problem is that I deleted files using finder as opposed to mythtv. I went back and deleted the already deleted files using myth tv, and mythtv started to work again. We'll see if it lasts.
Craig, not sure what you're seeing regarding the system folder. There is no folder /Downloads/Mythtv. In the error log I attached I don't see any reference to such a folder either. As far as I know, all recordings are in /Volume/Downloads/Mythtv, where /Volume/Downloads is on my NAS.
Craig, not sure what you're seeing regarding the system folder. There is no folder /Downloads/Mythtv. In the error log I attached I don't see any reference to such a folder either. As far as I know, all recordings are in /Volume/Downloads/Mythtv, where /Volume/Downloads is on my NAS.
Re: Inconsistent backend behavior
The deleted files cause a lot of noise in the log but they should not stop Myth from creating new recordings or playing existing ones.csgnyc wrote:I do think the problem is that I deleted files using finder as opposed to mythtv. I went back and deleted the already deleted files using myth tv, and mythtv started to work again. We'll see if it lasts.
Craig, not sure what you're seeing regarding the system folder. There is no folder /Downloads/Mythtv. In the error log I attached I don't see any reference to such a folder either. As far as I know, all recordings are in /Volume/Downloads/Mythtv, where /Volume/Downloads is on my NAS.
The more serious error is the path for new recordings:
Code: Select all
2016-07-28 09:53:14.103334 E [551/9751] TVRecEvent threadedfilewriter.cpp:129 (Open) - TFW(/Volumes/downloads/Mythtv/1107_20160728135313.mpg:-1): Opening file '/Volumes/downloads/Mythtv/1107_20160728135313.mpg'.
eno: No such file or directory (2)
BTW, I presume your NAS mounts at boot time?
Craig
Formerly the MacPorts guy.
Re: Inconsistent backend behavior
Yes, NAS mounts at boot time. And yes, by executing 'ls -l /Volumes/downloads/Mythtv/', I get the list of recording files.
Craig, I may be missing something, but the part of the log you cited refers to /Volumes/downloads/Mythtv, which is what I intended as the recording directory. You had said that I erred by using /Volumes/Mythtv, but such a folder doesn't exist and I don't see any reference to it in the log I included. If I execute either "ls -l /downloads/Mythtv" or "ls -l ~/Downloads/Mythtv/" I get "No such file or directory"
Craig, I may be missing something, but the part of the log you cited refers to /Volumes/downloads/Mythtv, which is what I intended as the recording directory. You had said that I erred by using /Volumes/Mythtv, but such a folder doesn't exist and I don't see any reference to it in the log I included. If I execute either "ls -l /downloads/Mythtv" or "ls -l ~/Downloads/Mythtv/" I get "No such file or directory"
Re: Inconsistent backend behavior
I thought you were trying to use the standard Downloads folder from your home directory for Myth. Naming your NAS volume "downloads" seemed less likely. Nonetheless, mythbackend (running as root, I would expect) errored while trying to write a file there, so something is not kosher. Your log also says:csgnyc wrote:Yes, NAS mounts at boot time. And yes, by executing 'ls -l /Volumes/downloads/Mythtv/', I get the list of recording files.
Craig, I may be missing something, but the part of the log you cited refers to /Volumes/downloads/Mythtv, which is what I intended as the recording directory. You had said that I erred by using /Volumes/Mythtv, but such a folder doesn't exist and I don't see any reference to it in the log I included. If I execute either "ls -l /downloads/Mythtv" or "ls -l ~/Downloads/Mythtv/" I get "No such file or directory"
Code: Select all
2016-07-28 09:55:21.676820 E [551/3087] CoreContext autoexpire.cpp:161 (CalcParams) - AutoExpire: Filesystem Info cache is empty, unable to calculate necessary parameters.
Craig
Formerly the MacPorts guy.