[SOLVED] Reboot required periodically

Have a MythTV related problem? Ask for help from other MythTV users here.

Moderator: Forum Moderators

Post Reply
pinnerite
Senior
Posts: 146
Joined: Mon Apr 07, 2014 2:34 pm
Great Britain

[SOLVED] Reboot required periodically

Post by pinnerite » Mon Aug 31, 2020 12:12 pm

Sometimes when starting up will report that it is timing out from live TV.
It always requires a reboot of the back-end server to remedy this.
Both machines are running Mint 20.

When I inspected the backend log I found some odd items like references to expired recordings that were never knowingly recorded. It also refers to several .ts files that do not exist.
I would like advice on how to remedy this.
I attach a copy of an extract of the log which covers the periods before and after the reboot.

Code: Select all

Aug 31 11:35:18 origen mythbackend: mythbackend[1121]: I CoreContext bonjourregister.cpp:115 (BonjourCallback) Bonjour: Service registration complete: name 'Mythbackend on origen.aandco' type '_mythbackend._tcp.' domain: 'local.'
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I CoreContext housekeeper.cpp:754 (Run) Queueing HouseKeeperTask 'DBCleanup'.
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I CoreContext housekeeper.cpp:754 (Run) Queueing HouseKeeperTask 'JobQueueRecover'.
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I CoreContext housekeeper.cpp:754 (Run) Queueing HouseKeeperTask 'LogClean'.
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:144 (Run) Running HouseKeeperTask 'HardwareProfiler'.
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:159 (Run) HouseKeeperTask 'HardwareProfiler' Failed.
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:144 (Run) Running HouseKeeperTask 'ThemeUpdateNotifications'.
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I HouseKeeping backendhousekeeper.cpp:427 (DoRun) Loading themes for 31
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:164 (Run) HouseKeeperTask 'ThemeUpdateNotifications' Finished Successfully.
Aug 31 11:36:11 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:144 (Run) Running HouseKeeperTask 'DBCleanup'.
Aug 31 11:36:15 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:164 (Run) HouseKeeperTask 'DBCleanup' Finished Successfully.
Aug 31 11:36:15 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:144 (Run) Running HouseKeeperTask 'JobQueueRecover'.
Aug 31 11:36:15 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:164 (Run) HouseKeeperTask 'JobQueueRecover' Finished Successfully.
Aug 31 11:36:15 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:144 (Run) Running HouseKeeperTask 'LogClean'.
Aug 31 11:36:15 origen mythbackend: mythbackend[1121]: I HouseKeeping housekeeper.cpp:164 (Run) HouseKeeperTask 'LogClean' Finished Successfully.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 1.0 GB w/freq: 15 min
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 526 MB for 1020 at 2020-07-07T15:20:00Z => Dangerfield:"Peeping Tom"
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 383 MB for 1020 at 2020-07-07T16:20:00Z => "Birds of a Feather":Bang
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 368 MB for 1020 at 2020-07-07T17:00:00Z => "Waiting for God":"The Christening"
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 344 MB for 1020 at 2020-07-07T17:40:01Z => "'Allo 'Allo!":"The Fallen Madonna"
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 375 MB for 1021 at 2020-07-07T18:16:01Z => NCIS
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 334 MB for 1021 at 2020-07-07T19:00:00Z => NCIS
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707152000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707152000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707162000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707162000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707170000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707170000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707174001.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707174001.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1021_20200707181601.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1021_20200707181601.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1021_20200707190000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:36:30 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1021_20200707190000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:37:13 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Frontend
Aug 31 11:37:13 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4104a40) as a client (events: 0)
Aug 31 11:37:13 origen mythbackend: mythbackend[1121]: I ProcessRequest backendcontext.cpp:63 (SetFrontendConnected) BackendContext: Frontend '192.168.1.4' connected.
Aug 31 11:37:13 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Monitor
Aug 31 11:37:13 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f41aa480) as a client (events: 1)
Aug 31 11:37:13 origen mythbackend: mythbackend[1121]: I MythSocketThread(51) backendcontext.cpp:97 (SetFrontendDisconnected) BackendContext: Frontend '192.168.1.4' disconnected.
Aug 31 11:37:13 origen mythbackend: mythbackend[1121]: I MythSocketThread(51) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f4104a40) '192.168.1.4' disconnected
Aug 31 11:37:14 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Frontend
Aug 31 11:37:14 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f41b2b30) as a client (events: 0)
Aug 31 11:37:14 origen mythbackend: mythbackend[1121]: I ProcessRequest backendcontext.cpp:51 (SetFrontendConnected) BackendContext: Frontend '192.168.1.4' connected.
Aug 31 11:37:25 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:37:25 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4104a40) as a client (events: 0)
Aug 31 11:37:25 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:1057 (HandleStateChange) TVRec[1]: Changing from None to WatchingLiveTV
Aug 31 11:37:25 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:3662 (TuningFrequency) TVRec[1]: TuningFrequency
Aug 31 11:37:25 origen mythbackend: mythbackend[1121]: I TVRecEvent cardutil.cpp:1170 (SetDeliverySystem) CardUtil[1]: Set delivery system: DVB-T2
Aug 31 11:37:25 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:37:25 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:37:26 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:37:26 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:37:26 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:4242 (TuningNewRecorder) TVRec[1]: TuningNewRecorder - CreateRecorder()
Aug 31 11:37:27 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:37:27 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4151a30) as a client (events: 0)
Aug 31 11:37:27 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:2032 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f41a8d30) as a file transfer
Aug 31 11:37:36 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:1057 (HandleStateChange) TVRec[1]: Changing from WatchingLiveTV to None
Aug 31 11:37:37 origen mythbackend: mythbackend[1121]: N RecThread recorders/recorderbase.cpp:490 (FinishRecording) Finished Recording: Container: MPEG2-TS Video Codec: mpeg2video (544x576 A/R: 3 25fps) Audio Codec: mp2
Aug 31 11:37:37 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:826 (FinishedRecording) TVRec[1]: FinishedRecording(1031_2020-08-31T10:37:26Z) damaged recq:<RecordingQuality overall_score="0" key="1031_2020-08-31T10:37:26Z" continuity_error_count="3" packet_count="12861">#012    <Gap start="2020-08-31T10:00:00Z" end="2020-08-31T10:37:26Z" duration="2246" />#012    <Gap start="2020-08-31T10:37:36Z" end="2020-08-31T11:05:00Z" duration="1643" />#012</RecordingQuality>
Aug 31 11:37:37 origen mythbackend: mythbackend[1121]: I MythSocketThread(57) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f4104a40) '192.168.1.4' disconnected
Aug 31 11:37:37 origen mythbackend: mythbackend[1121]: I MythSocketThread(122) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f4151a30) '192.168.1.4' disconnected
Aug 31 11:37:37 origen mythbackend: mythbackend[1121]: I MythSocketThread(124) mainserver.cpp:7896 (connectionClosed) FileTransfer sock(5602f41a8d30) disconnected
Aug 31 11:37:43 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:37:43 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4121e30) as a client (events: 0)
Aug 31 11:37:43 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:1057 (HandleStateChange) TVRec[1]: Changing from None to WatchingLiveTV
Aug 31 11:37:43 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:3662 (TuningFrequency) TVRec[1]: TuningFrequency
Aug 31 11:37:43 origen mythbackend: mythbackend[1121]: I TVRecEvent cardutil.cpp:1170 (SetDeliverySystem) CardUtil[1]: Set delivery system: DVB-T2
Aug 31 11:37:44 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:37:44 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:37:45 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:37:45 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:37:45 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:4242 (TuningNewRecorder) TVRec[1]: TuningNewRecorder - CreateRecorder()
Aug 31 11:37:48 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:37:48 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4152820) as a client (events: 0)
Aug 31 11:37:48 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:2032 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f41ad950) as a file transfer
Aug 31 11:41:31 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2308 (HandleReschedule) Reschedule requested for MATCH 0 1 0 2020-09-07T23:40:00Z EITScanner
Aug 31 11:41:31 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2425 (HandleReschedule) Scheduled 41 items in 0.1 = 0.02 match + 0.09 check + 0.01 place
Aug 31 11:41:40 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:3662 (TuningFrequency) TVRec[1]: TuningFrequency
Aug 31 11:41:41 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:41:41 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:41:42 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:41:42 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:41:42 origen mythbackend: mythbackend[1121]: I MythSocketThread(125) mainserver.cpp:7896 (connectionClosed) FileTransfer sock(5602f41ad950) disconnected
Aug 31 11:41:42 origen mythbackend: mythbackend[1121]: I MythSocketThread(123) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f4152820) '192.168.1.4' disconnected
Aug 31 11:41:42 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:41:42 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f40c1e60) as a client (events: 0)
Aug 31 11:41:42 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:2032 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4152820) as a file transfer
Aug 31 11:42:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 0 MB for 1031 at 2020-08-31T10:37:25Z => "Knight Rider"
Aug 31 11:42:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2495 (DeleteRecordedFiles) DeleteRecordedFiles - recording id 2539 filename /home/mythtv/live_tv/1031_20200831103725.ts
Aug 31 11:42:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2569 (DoDeleteInDB) DoDeleteINDB - recording id 2539 (chanid 1031 at 2020-08-31T10:37:25Z)
Aug 31 11:44:07 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2308 (HandleReschedule) Reschedule requested for MATCH 0 1 0 2020-09-07T23:55:00Z EITScanner
Aug 31 11:44:07 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2425 (HandleReschedule) Scheduled 41 items in 0.1 = 0.02 match + 0.09 check + 0.01 place
Aug 31 11:44:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 2 MB for 1031 at 2020-08-31T10:37:26Z => "Knight Rider"
Aug 31 11:44:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 0 MB for 1031 at 2020-08-31T10:37:44Z => "Knight Rider"
Aug 31 11:44:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2495 (DeleteRecordedFiles) DeleteRecordedFiles - recording id 2540 filename /home/mythtv/live_tv/1031_20200831103726.ts
Aug 31 11:44:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2569 (DoDeleteInDB) DoDeleteINDB - recording id 2540 (chanid 1031 at 2020-08-31T10:37:26Z)
Aug 31 11:44:39 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2495 (DeleteRecordedFiles) DeleteRecordedFiles - recording id 2541 filename /home/mythtv/live_tv/1031_20200831103744.ts
Aug 31 11:44:39 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2569 (DoDeleteInDB) DoDeleteINDB - recording id 2541 (chanid 1031 at 2020-08-31T10:37:44Z)
Aug 31 11:44:43 origen mythbackend: mythbackend[1121]: I MythSocketThread(94) mainserver.cpp:7896 (connectionClosed) FileTransfer sock(5602f4152820) disconnected
Aug 31 11:44:43 origen mythbackend: mythbackend[1121]: I MythSocketThread(95) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f40c1e60) '192.168.1.4' disconnected
Aug 31 11:44:43 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:44:43 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4183330) as a client (events: 0)
Aug 31 11:44:43 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:2032 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4152820) as a file transfer
Aug 31 11:45:08 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:3662 (TuningFrequency) TVRec[1]: TuningFrequency
Aug 31 11:45:10 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:45:10 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:45:11 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:45:12 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:45:17 origen mythbackend: mythbackend[1121]: I MythSocketThread(94) mainserver.cpp:7896 (connectionClosed) FileTransfer sock(5602f4152820) disconnected
Aug 31 11:45:17 origen mythbackend: mythbackend[1121]: I MythSocketThread(95) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f4183330) '192.168.1.4' disconnected
Aug 31 11:45:17 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:45:17 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4104a40) as a client (events: 0)
Aug 31 11:45:17 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:2032 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f41a76b0) as a file transfer
Aug 31 11:47:34 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2308 (HandleReschedule) Reschedule requested for MATCH 0 1 0 2020-09-07T23:45:00Z EITScanner
Aug 31 11:47:34 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2425 (HandleReschedule) Scheduled 41 items in 0.1 = 0.02 match + 0.09 check + 0.01 place
Aug 31 11:48:27 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 0 MB for 1102 at 2020-08-31T10:41:41Z => "BBC News"
Aug 31 11:48:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2495 (DeleteRecordedFiles) DeleteRecordedFiles - recording id 2543 filename /home/mythtv/live_tv/1102_20200831104141.ts
Aug 31 11:48:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2569 (DoDeleteInDB) DoDeleteINDB - recording id 2543 (chanid 1102 at 2020-08-31T10:41:41Z)
Aug 31 11:50:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 0 MB for 1233 at 2020-08-31T10:45:10Z => "A Week In Interviews"
Aug 31 11:50:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2495 (DeleteRecordedFiles) DeleteRecordedFiles - recording id 2545 filename /home/mythtv/live_tv/1233_20200831104510.ts
Aug 31 11:50:33 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2569 (DoDeleteInDB) DoDeleteINDB - recording id 2545 (chanid 1233 at 2020-08-31T10:45:10Z)
Aug 31 11:51:05 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2308 (HandleReschedule) Reschedule requested for MATCH 0 1 0 2020-08-31T13:00:00Z EITScanner
Aug 31 11:51:05 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2425 (HandleReschedule) Scheduled 41 items in 0.0 = 0.02 match + 0.01 check + 0.01 place
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 526 MB for 1020 at 2020-07-07T15:20:00Z => Dangerfield:"Peeping Tom"
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 383 MB for 1020 at 2020-07-07T16:20:00Z => "Birds of a Feather":Bang
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 368 MB for 1020 at 2020-07-07T17:00:00Z => "Waiting for God":"The Christening"
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 344 MB for 1020 at 2020-07-07T17:40:01Z => "'Allo 'Allo!":"The Fallen Madonna"
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 375 MB for 1021 at 2020-07-07T18:16:01Z => NCIS
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 334 MB for 1021 at 2020-07-07T19:00:00Z => NCIS
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707152000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707152000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707162000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707162000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707170000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707170000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1020_20200707174001.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1020_20200707174001.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1021_20200707181601.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1021_20200707181601.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: C CoreContext mythcorecontext.cpp:776 (GenMythURL) MythCoreContext::GenMythURL(): (192.168.1.5/1021_20200707190000.ts): Given IP address instead of hostname (ID). This is invalid.
Aug 31 11:52:28 origen mythbackend: mythbackend[1121]: E CoreContext mainserver.cpp:3101 (DoHandleDeleteRecording) MainServer: ERROR when trying to delete file: myth://192.168.1.5/1021_20200707190000.ts. File doesn't exist.  Database metadata will not be removed.
Aug 31 11:52:40 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2308 (HandleReschedule) Reschedule requested for MATCH 0 1 0 2020-08-31T11:00:00Z EITScanner
Aug 31 11:52:41 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:1335 (TryAnotherShowing) Moved "The Bill" on chanid: 1020 from card: 1 to 1 at Tue Sep 1 01:55:00 2020 to avoid LiveTV conflict
Aug 31 11:52:41 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2425 (HandleReschedule) Scheduled 41 items in 0.0 = 0.02 match + 0.01 check + 0.02 place
Aug 31 11:53:26 origen mythbackend: mythbackend[1121]: I TVRecEvent tv_rec.cpp:3662 (TuningFrequency) TVRec[1]: TuningFrequency
Aug 31 11:53:28 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:53:28 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:53:29 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 11:53:29 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 11:53:31 origen mythbackend: mythbackend[1121]: I MythSocketThread(95) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f4104a40) '192.168.1.4' disconnected
Aug 31 11:53:31 origen mythbackend: mythbackend[1121]: I MythSocketThread(94) mainserver.cpp:7896 (connectionClosed) FileTransfer sock(5602f41a76b0) disconnected
Aug 31 11:53:31 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 11:53:31 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f4131c40) as a client (events: 0)
Aug 31 11:53:31 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:2032 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f40c2cf0) as a file transfer
Aug 31 11:56:05 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2308 (HandleReschedule) Reschedule requested for MATCH 0 1 0 2020-09-05T20:00:00Z EITScanner
Aug 31 11:56:05 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2425 (HandleReschedule) Scheduled 41 items in 0.1 = 0.02 match + 0.07 check + 0.01 place
Aug 31 12:00:00 origen mythbackend: mythbackend[1121]: N CoreContext autoexpire.cpp:242 (CalcParams) AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
Aug 31 12:00:00 origen mythbackend: mythbackend[1121]: N TVRecEvent recordinginfo.cpp:678 (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
Aug 31 12:00:00 origen mythbackend: mythbackend[1121]: N DVBRead recorders/recorderbase.cpp:490 (FinishRecording) Finished Recording: Container: MPEG2-TS Video Codec: mpeg2video (544x576 A/R: 3 25fps) Audio Codec: mp2
Aug 31 12:00:00 origen mythbackend: mythbackend[1121]: I DVBRead tv_rec.cpp:3386 (RingBufferChanged) TVRec[1]: RingBufferChanged()
Aug 31 12:00:00 origen mythbackend: mythbackend[1121]: I DVBRead tv_rec.cpp:826 (FinishedRecording) TVRec[1]: FinishedRecording(1235_2020-08-31T10:53:29Z) damaged recq:<RecordingQuality overall_score="0" key="1235_2020-08-31T10:53:29Z" continuity_error_count="1" packet_count="472862">#012    <Gap start="2020-08-31T10:00:00Z" end="2020-08-31T10:53:30Z" duration="3210" />#012</RecordingQuality>
Aug 31 12:00:27 origen mythbackend: mythbackend[1121]: N Expire autoexpire.cpp:634 (SendDeleteMessages) Expiring 0 MB for 1235 at 2020-08-31T10:53:28Z => Newshour
Aug 31 12:00:27 origen mythbackend: mythbackend[1121]: I MythSocketThread(96) mainserver.cpp:7896 (connectionClosed) FileTransfer sock(5602f40c2cf0) disconnected
Aug 31 12:00:27 origen mythbackend: mythbackend[1121]: I MythSocketThread(94) mainserver.cpp:7856 (connectionClosed) Playback sock(5602f4131c40) '192.168.1.4' disconnected
Aug 31 12:00:27 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1768 (HandleAnnounce) MainServer: MainServer::ANN Playback
Aug 31 12:00:27 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:1770 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f40c2890) as a client (events: 0)
Aug 31 12:00:27 origen mythbackend: mythbackend[1121]: I ProcessRequest mainserver.cpp:2032 (HandleAnnounce) MainServer: adding: 192.168.1.4(5602f41326c0) as a file transfer
Aug 31 12:00:32 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2495 (DeleteRecordedFiles) DeleteRecordedFiles - recording id 2547 filename /home/mythtv/live_tv/1235_20200831105328.ts
Aug 31 12:00:32 origen mythbackend: mythbackend[1121]: N DeleteThread mainserver.cpp:2569 (DoDeleteInDB) DoDeleteINDB - recording id 2547 (chanid 1235 at 2020-08-31T10:53:28Z)
Aug 31 12:02:14 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2308 (HandleReschedule) Reschedule requested for MATCH 0 1 0 2020-08-31T17:00:00Z EITScanner
Aug 31 12:02:14 origen mythbackend: mythbackend[1121]: I Scheduler scheduler.cpp:2425 (HandleReschedule) Scheduled 41 items in 0.0 = 0.02 match + 0.01 check + 0.01 place
Last edited by pinnerite on Tue Sep 08, 2020 7:00 pm, edited 1 time in total.

User avatar
bill6502
Developer
Posts: 1724
Joined: Fri Feb 07, 2014 5:28 pm
United States of America

Re: Reboot required periodically

Post by bill6502 » Mon Aug 31, 2020 4:05 pm

What does: host 192.168.1.5 return? If nothing, then I'd suggest an entry in /etc/hosts to
give it a name.

The output of this may be of interest, is the hostname really an IP?
In SQL: SELECT title,chanid,starttime,hostname FROM recorded WHERE basename='1020_20200707152000.ts';

Missing files (either because there was a disk crash/problem or they were improperly
just rm'ed) will still have metadata, by design. To really delete the metadata, see:
https://www.mythtv.org/wiki/Frequently_ ... on_disk.3F

As to the log being before and after reboot, I don't see any indication of the backend
being restarted.

pinnerite
Senior
Posts: 146
Joined: Mon Apr 07, 2014 2:34 pm
Great Britain

Re: Reboot required periodically

Post by pinnerite » Tue Sep 01, 2020 1:48 pm

Amazing. The hosts file on the remote had incorrect (old) entries for the hosts, somehow missed.
My SQL skills are legendary (non-existent) so I chose to create files using touch and see if they clear eventually.
Well the backend did restart. I used it all yesterday.
I just started the remote frontend and it is behaving.
It is bit too early to add SOLVED so I will wait for a week or so, or report back.
Thanks for your help.

pinnerite
Senior
Posts: 146
Joined: Mon Apr 07, 2014 2:34 pm
Great Britain

Re: Reboot required periodically

Post by pinnerite » Wed Sep 02, 2020 6:10 pm

Unfortunately this appears not to be a single fault:

1) When the system boots up, a crash report is generated. I have asked the Linux Mint forum to interpret the report for me.
2) The machine's wi-fi stops working intermittently.

It maybe that it there is no mythtv issue at all.

I wiil report back when these issues are resolved.

pinnerite
Senior
Posts: 146
Joined: Mon Apr 07, 2014 2:34 pm
Great Britain

Re: Reboot required periodically

Post by pinnerite » Tue Sep 08, 2020 6:59 pm

A few days ago I re-sited a wif-fi signal booster further away from the router but closer to the machine hosting mythtv.
The result is that there has been a huge improvement.
I am going mark this [SOLVED]
Thank you.

Post Reply