home
products
contribute
download
documentation
forum
Home
Forums
New posts
Search forums
What's new
New posts
All posts
Latest activity
Members
Registered members
Current visitors
Donate
Log in
Register
What's new
Search
Search
Search titles only
By:
New posts
Search forums
Search titles only
By:
Menu
Log in
Register
Navigation
Install the app
Install
More options
Contact us
Close Menu
Forums
MediaPortal 1
Support
Watch / Listen Media
Television (MyTV frontend and TV-Server)
MP1.16 RecordingFileHandler: Error while deleting a recording from disk.
Contact us
RSS
JavaScript is disabled. For a better experience, please enable JavaScript in your browser before proceeding.
You are using an out of date browser. It may not display this or other websites correctly.
You should upgrade or use an
alternative browser
.
Reply to thread
Message
<blockquote data-quote="RonD" data-source="post: 1220148" data-attributes="member: 117536"><p>Updated from MP1.12 to MP1.16 over the weekend. No major install problems, just usual grumpiness getting new install working. On main tv server MePoTVS, did full uninstall, new install, channel scan setup etc.</p><p></p><p>Seeing problems with tv recording and episode management. Never had this problem with MP1.12. MP is setup to record the afternoon local news on several channels from 5:00PM to 5:30PM and then the national news from 5:30PM to 6:00PM. Use Episode Management to keep 1 episode so each day MP deletes yesterdays news, recordings have 1 minute pre/post-store.</p><p></p><p>On 3 or 4 nights tvserver gets hung up trying to delete the “yesterday NEWS.ts” file, tvserver spins forever trying/failing to delete the file and filling log files with the same error messages. When I use setuptv.exe I can do a manual server “stop” then “start”, and things start working again. This happens about 50% of time, some nights everything runs normal/clean, other nights I see the same type of problem, always with the evening news shows that use episode management.</p><p></p><p>Tvserver system is MP1.16 tvserver/client, 4 core I5 CPU 12 GB ram, Win10 with all updates. The “K-drive” is dedicated 3 GB MP1.16 tvserver recording drive. Windows Defender is set to exclude the recording folder, nothing else on the drive. No other virus scan programs. Two MP1.16 clients have windows remote file access to recording folder to use TV-Series.</p><p></p><p>When the problem happens I’m using a living room MP1.16 client to watch the recordings while the tvserver is recording the shows. Remote client recording access uses “MP RTSP streaming” does not do direct windows remote file access. TV-Series is setup to access recordings on the “k-drive” using windows file sharing. Had same recordings setup with MP1.12 and never saw this problem.</p><p></p><p>The main error message is following. Once tvserver gets into error/spinning loop, fills 5MB log files over and over again with the same error messages.</p><p>[2017-04-30 18:01:02,951] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: Error while deleting a recording from disk: The process cannot access the file 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' because it is being used by another process.</p><p></p><p>Also see the following, but this message happens without the “cannot access file” problem.</p><p>[2017-04-30 18:01:02,938] [Log ] [scheduler thread] [ERROR] - Exception in Program.Persist() with Message The number of returned rows 0 did not match the expected count of 1+.</p><p>If concurrency control is enabled this may indicate that the record was updated or deleted by another process</p><p></p><p>The attached zip file has log files from the hang on Sunday 20170430. The key error log files are “TVService.6.log (6:01PM)”, since it shows the starting error event and TVService-Error.2.log (6:02PM). The other logs are just 5MB repeats of the file delete problem.</p><p></p><p>[SPOILER="Spoiler has some gory details"]</p><p>4:59 PM, start recording local news</p><p>StartRecording K:\MePo1\recordings\KNTV HD\NBC Bay Area News at 5\NBC Bay Area News at 5 - 2017-04-30.ts</p><p>StartRecording K:\MePo1\recordings\KGO-HD\ABC7 News 5_00PM\ABC7 News 5_00PM - 2017-04-30.ts</p><p></p><p>5:29 PM, start recording national news</p><p>StartRecording K:\MePo1\recordings\KGO-HD\ABC World News Tonight\ABC World News Tonight - 2017-04-30.ts</p><p>StartRecording K:\MePo1\recordings\KPIX-TV\CBS Weekend News\CBS Weekend News - 2017-04-30.ts</p><p>StartRecording K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-30.ts</p><p></p><p>5:31 PM, stop recording local news, delete 2017-04-29 files (ts, xml, comskip, others)</p><p>stop record KGO-HD 4/30/2017 4:59:11 PM-4/30/2017 5:30:00 PM ABC7 News 5:00PM</p><p>deleting 'K:\MePo1\recordings\KGO-HD\ABC7 News 5_00PM\ABC7 News 5_00PM - 2017-04-29.ts'</p><p>stop record KNTV HD 4/30/2017 4:59:09 PM-4/30/2017 5:30:00 PM NBC Bay Area News at 5</p><p>deleting 'K:\MePo1\recordings\KNTV HD\NBC Bay Area News at 5\NBC Bay Area News at 5 - 2017-04-28.ts'</p><p></p><p>To make life interesting, xmltv does epg import, don’t think this triggers problem</p><p>17:41:20 plugin:xmltv importing L:\MePo\xmltv\meposd\tvguide.xml</p><p>17:48:06 plugin:xmltv import done</p><p></p><p>6:01 PM, stop recording national news, delete 2017-04-29 files (ts, xml, comskip others)</p><p></p><p>stop record KPIX-TV 4/30/2017 5:29:08 PM-4/30/2017 6:00:00 PM CBS Weekend News</p><p>deleting 'K:\MePo1\recordings\KPIX-TV\CBS Weekend News\CBS Weekend News - 2017-04-29.ts’</p><p></p><p>then stuff happens when tvserver tries to delete “yesterday” it can’t delete file and spins forever on “NBC Nightly News With Lester Holt - 2017-04-29.ts'”</p><p></p><p>[2017-04-30 18:01:02,912] [Log ] [scheduler thread] [INFO ] - Scheduler: stop record KNTV HD 4/30/2017 5:29:06 PM-4/30/2017 6:00:00 PM NBC Nightly News With Lester Holt</p><p>[2017-04-30 18:01:02,938] [Log ] [scheduler thread] [ERROR] - Exception in Program.Persist() with Message The number of returned rows 0 did not match the expected count of 1+.</p><p>If concurrency control is enabled this may indicate that the record was updated or deleted by another process.</p><p>[2017-04-30 18:01:02,940] [Log ] [scheduler thread] [INFO ] - diskmanagement: recording NBC Nightly News With Lester Holt ended. type:Once max episodes:1</p><p>[2017-04-30 18:01:02,944] [Log ] [scheduler thread] [INFO ] - diskmanagement: Delete episode TvDatabase.Channel NBC Nightly News With Lester Holt Saturday, April 29, 2017 3:59:07 PM</p><p>[2017-04-30 18:01:02,945] [Log ] [scheduler thread] [DEBUG] - DeleteRecordingOnDisk: 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts'</p><p>[2017-04-30 18:01:02,945] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.edl'</p><p>[2017-04-30 18:01:02,947] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.log'</p><p>[2017-04-30 18:01:02,949] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.logo.txt'</p><p>[2017-04-30 18:01:02,950] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts'</p><p>[2017-04-30 18:01:02,951] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: Error while deleting a recording from disk: The process cannot access the file 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' because it is being used by another process.</p><p>[2017-04-30 18:01:02,958] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: adding filename to list of pending deletions: K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts</p><p>[2017-04-30 18:01:02,967] [Log ] [scheduler thread] [INFO ] - diskmanagement: Delete episode TvDatabase.Channel NBC Nightly News With Lester Holt Saturday, April 29, 2017 3:59:07 PM</p><p>[2017-04-30 18:01:02,967] [Log ] [scheduler thread] [DEBUG] - DeleteRecordingOnDisk: 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts'</p><p>[2017-04-30 18:01:02,968] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts'</p><p>[2017-04-30 18:01:02,968] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: Error while deleting a recording from disk: The process cannot access the file 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' because it is being used by another process.</p><p></p><p>tvserver spins forever filling log files with the same error messages</p><p>[/SPOILER]</p></blockquote><p></p>
[QUOTE="RonD, post: 1220148, member: 117536"] Updated from MP1.12 to MP1.16 over the weekend. No major install problems, just usual grumpiness getting new install working. On main tv server MePoTVS, did full uninstall, new install, channel scan setup etc. Seeing problems with tv recording and episode management. Never had this problem with MP1.12. MP is setup to record the afternoon local news on several channels from 5:00PM to 5:30PM and then the national news from 5:30PM to 6:00PM. Use Episode Management to keep 1 episode so each day MP deletes yesterdays news, recordings have 1 minute pre/post-store. On 3 or 4 nights tvserver gets hung up trying to delete the “yesterday NEWS.ts” file, tvserver spins forever trying/failing to delete the file and filling log files with the same error messages. When I use setuptv.exe I can do a manual server “stop” then “start”, and things start working again. This happens about 50% of time, some nights everything runs normal/clean, other nights I see the same type of problem, always with the evening news shows that use episode management. Tvserver system is MP1.16 tvserver/client, 4 core I5 CPU 12 GB ram, Win10 with all updates. The “K-drive” is dedicated 3 GB MP1.16 tvserver recording drive. Windows Defender is set to exclude the recording folder, nothing else on the drive. No other virus scan programs. Two MP1.16 clients have windows remote file access to recording folder to use TV-Series. When the problem happens I’m using a living room MP1.16 client to watch the recordings while the tvserver is recording the shows. Remote client recording access uses “MP RTSP streaming” does not do direct windows remote file access. TV-Series is setup to access recordings on the “k-drive” using windows file sharing. Had same recordings setup with MP1.12 and never saw this problem. The main error message is following. Once tvserver gets into error/spinning loop, fills 5MB log files over and over again with the same error messages. [2017-04-30 18:01:02,951] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: Error while deleting a recording from disk: The process cannot access the file 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' because it is being used by another process. Also see the following, but this message happens without the “cannot access file” problem. [2017-04-30 18:01:02,938] [Log ] [scheduler thread] [ERROR] - Exception in Program.Persist() with Message The number of returned rows 0 did not match the expected count of 1+. If concurrency control is enabled this may indicate that the record was updated or deleted by another process The attached zip file has log files from the hang on Sunday 20170430. The key error log files are “TVService.6.log (6:01PM)”, since it shows the starting error event and TVService-Error.2.log (6:02PM). The other logs are just 5MB repeats of the file delete problem. [SPOILER="Spoiler has some gory details"] 4:59 PM, start recording local news StartRecording K:\MePo1\recordings\KNTV HD\NBC Bay Area News at 5\NBC Bay Area News at 5 - 2017-04-30.ts StartRecording K:\MePo1\recordings\KGO-HD\ABC7 News 5_00PM\ABC7 News 5_00PM - 2017-04-30.ts 5:29 PM, start recording national news StartRecording K:\MePo1\recordings\KGO-HD\ABC World News Tonight\ABC World News Tonight - 2017-04-30.ts StartRecording K:\MePo1\recordings\KPIX-TV\CBS Weekend News\CBS Weekend News - 2017-04-30.ts StartRecording K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-30.ts 5:31 PM, stop recording local news, delete 2017-04-29 files (ts, xml, comskip, others) stop record KGO-HD 4/30/2017 4:59:11 PM-4/30/2017 5:30:00 PM ABC7 News 5:00PM deleting 'K:\MePo1\recordings\KGO-HD\ABC7 News 5_00PM\ABC7 News 5_00PM - 2017-04-29.ts' stop record KNTV HD 4/30/2017 4:59:09 PM-4/30/2017 5:30:00 PM NBC Bay Area News at 5 deleting 'K:\MePo1\recordings\KNTV HD\NBC Bay Area News at 5\NBC Bay Area News at 5 - 2017-04-28.ts' To make life interesting, xmltv does epg import, don’t think this triggers problem 17:41:20 plugin:xmltv importing L:\MePo\xmltv\meposd\tvguide.xml 17:48:06 plugin:xmltv import done 6:01 PM, stop recording national news, delete 2017-04-29 files (ts, xml, comskip others) stop record KPIX-TV 4/30/2017 5:29:08 PM-4/30/2017 6:00:00 PM CBS Weekend News deleting 'K:\MePo1\recordings\KPIX-TV\CBS Weekend News\CBS Weekend News - 2017-04-29.ts’ then stuff happens when tvserver tries to delete “yesterday” it can’t delete file and spins forever on “NBC Nightly News With Lester Holt - 2017-04-29.ts'” [2017-04-30 18:01:02,912] [Log ] [scheduler thread] [INFO ] - Scheduler: stop record KNTV HD 4/30/2017 5:29:06 PM-4/30/2017 6:00:00 PM NBC Nightly News With Lester Holt [2017-04-30 18:01:02,938] [Log ] [scheduler thread] [ERROR] - Exception in Program.Persist() with Message The number of returned rows 0 did not match the expected count of 1+. If concurrency control is enabled this may indicate that the record was updated or deleted by another process. [2017-04-30 18:01:02,940] [Log ] [scheduler thread] [INFO ] - diskmanagement: recording NBC Nightly News With Lester Holt ended. type:Once max episodes:1 [2017-04-30 18:01:02,944] [Log ] [scheduler thread] [INFO ] - diskmanagement: Delete episode TvDatabase.Channel NBC Nightly News With Lester Holt Saturday, April 29, 2017 3:59:07 PM [2017-04-30 18:01:02,945] [Log ] [scheduler thread] [DEBUG] - DeleteRecordingOnDisk: 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' [2017-04-30 18:01:02,945] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.edl' [2017-04-30 18:01:02,947] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.log' [2017-04-30 18:01:02,949] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.logo.txt' [2017-04-30 18:01:02,950] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' [2017-04-30 18:01:02,951] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: Error while deleting a recording from disk: The process cannot access the file 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' because it is being used by another process. [2017-04-30 18:01:02,958] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: adding filename to list of pending deletions: K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts [2017-04-30 18:01:02,967] [Log ] [scheduler thread] [INFO ] - diskmanagement: Delete episode TvDatabase.Channel NBC Nightly News With Lester Holt Saturday, April 29, 2017 3:59:07 PM [2017-04-30 18:01:02,967] [Log ] [scheduler thread] [DEBUG] - DeleteRecordingOnDisk: 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' [2017-04-30 18:01:02,968] [Log ] [scheduler thread] [DEBUG] - - deleting 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' [2017-04-30 18:01:02,968] [Log ] [scheduler thread] [ERROR] - RecordingFileHandler: Error while deleting a recording from disk: The process cannot access the file 'K:\MePo1\recordings\KNTV HD\NBC Nightly News With Lester Holt\NBC Nightly News With Lester Holt - 2017-04-29.ts' because it is being used by another process. tvserver spins forever filling log files with the same error messages [/SPOILER] [/QUOTE]
Insert quotes…
Verification
Post reply
Forums
MediaPortal 1
Support
Watch / Listen Media
Television (MyTV frontend and TV-Server)
MP1.16 RecordingFileHandler: Error while deleting a recording from disk.
Contact us
RSS
Top
Bottom
