ERROR::[postproc] Error removing workdir

[uzenet]

since upgrading to 0.4.4 (Windows) last week, i've noticed that my post-processing queue always stalls when trying to move files. i have a htpc that's dedicated to grabbing episodes via rss, verify/repair any errors, and then move the files to their respective folders based upon tv folder sorting. however, after verification, post-processing stalls when sabnzbd+ tries to move the files to their new directory. the proper subdirectories are created (show name >> S01E03 >> temporary UNPACK folder), but the files remain in the UNPACK folder when they should have been moved to the S01E03 folder. i must manually shutdown sabnzbd in order to progress in the post-processing queue (of course, the next set still has this same problem). afterward, the UNPACK folder is renamed to FAILED and i must manually move the files. the error message displayed is:

ERROR::[postproc] Error removing workdir

i've pasted an excerpt from my log file below. (the post-processing starts, but then stalls. i finally manually shutdown sabnzbd+, and then restart it)

Code: Select all

2008-09-24 18:35:19,875::INFO::[postproc] Starting PostProcessing on SHOW_NAME.S01E03.nzb => Repair:True, Unpack:False, Delete:False, Script:None
2008-09-24 18:35:19,875::INFO::[postproc] Par2 check starting on SHOW_NAME.S01E03.nzb
2008-09-24 18:35:19,875::INFO::[postproc] Running repair on set SHOW_NAME.s01e03
2008-09-24 18:35:26,467::INFO::[newsunpack] Verified in 6.6s, all files correct
2008-09-24 18:35:26,467::INFO::[newsunpack] Par verify finished ok on D:\nntp\temp\SHOW_NAME.S01E03\SHOW_NAME.s01e03.vol01+02.par2!
2008-09-24 18:35:26,467::INFO::[newsunpack] Deleting D:\nntp\temp\SHOW_NAME.S01E03\SHOW_NAME.s01e03.par2
2008-09-24 18:35:26,467::INFO::[newsunpack] Deleting D:\nntp\temp\SHOW_NAME.S01E03\SHOW_NAME.s01e03.vol01+02.par2
2008-09-24 18:35:26,467::INFO::[postproc] Par2 check finished on SHOW_NAME.S01E03.nzb
2008-09-24 18:35:26,467::INFO::[sabnzbd.misc] Creating directories: D:\video\tv\SHOW_NAME\S01E03
2008-09-24 18:35:26,467::INFO::[sabnzbd.misc] Creating directories: D:\video\tv\SHOW_NAME\S01E03\_UNPACK_SHOW_NAME.S01E03
2008-09-24 18:35:26,483::INFO::[postproc] Removing unwanted file D:\video\tv\SHOW_NAME\S01E03\_UNPACK_SHOW_NAME.S01E03\SHOW_NAME.s01e03.sfv
2008-09-24 18:46:00,015::INFO::[sabnzbd] Saving data for rss_data.sab in C:\Program Files\SABnzbd\cache\rss_data.sab
2008-09-24 19:29:38,796::INFO::SABnzbd shutting down...
2008-09-24 19:29:38,796::INFO::[sabnzbd.misc] URLGrabber shutting down
2008-09-24 19:29:38,796::INFO::[sabnzbd] Saving data for watched_data.sab in C:\Program Files\SABnzbd\cache\watched_data.sab
2008-09-24 19:29:38,796::INFO::[sabnzbd.misc] Dirscanner shutting down
2008-09-24 19:29:39,171::INFO::[downloader] Shutting down
2008-09-24 19:29:39,171::INFO::[assembler] Shutting down
2008-09-24 19:29:39,171::INFO::[nzbqueue] Saving queue
2008-09-24 19:29:39,171::INFO::[sabnzbd] Saving data for queue7.sab in C:\Program Files\SABnzbd\cache\queue7.sab
2008-09-24 19:29:39,187::INFO::[sabnzbd] Saving data for bytes7.sab in C:\Program Files\SABnzbd\cache\bytes7.sab
2008-09-24 19:29:39,187::INFO::[sabnzbd] Saving data for rss_data.sab in C:\Program Files\SABnzbd\cache\rss_data.sab
2008-09-24 19:29:39,203::INFO::[sabnzbd] Saving data for watched_data.sab in C:\Program Files\SABnzbd\cache\watched_data.sab
2008-09-24 19:29:40,015::INFO::All processes stopped
2008-09-24 19:29:57,703::INFO::--------------------------------
2008-09-24 19:29:57,703::INFO::SABnzbd.exe-0.4.4 (rev=unknown)
2008-09-24 19:29:57,703::INFO::Platform=Windows-XP-5.1.2600-SP3 Class=nt
2008-09-24 19:29:57,703::INFO::Python-version = 2.5.2 (r252:60911, Mar 27 2008, 17:57:18) [MSC v.1310 32 bit (Intel)]
2008-09-24 19:29:57,703::INFO::[sabnzbd] Loading data for rss_data.sab from C:\Program Files\SABnzbd\cache\rss_data.sab
2008-09-24 19:29:57,703::INFO::[sabnzbd] Loading data for bytes7.sab from C:\Program Files\SABnzbd\cache\bytes7.sab
2008-09-24 19:29:57,703::INFO::[sabnzbd] Loading data for queue7.sab from C:\Program Files\SABnzbd\cache\queue7.sab
2008-09-24 19:29:57,733::INFO::[sabnzbd] Loading data for watched_data.sab from C:\Program Files\SABnzbd\cache\watched_data.sab
2008-09-24 19:29:57,733::INFO::All processes started
2008-09-24 19:29:57,733::INFO::_yenc module... found!
2008-09-24 19:29:57,733::INFO::celementtree module... found!
2008-09-24 19:29:57,733::INFO::par2 binary... found (C:\Program Files\SABnzbd\win\par2\par2.exe)
2008-09-24 19:29:57,733::INFO::rar binary... found (C:\Program Files\SABnzbd\win\unrar\UnRAR.exe)
2008-09-24 19:29:57,733::INFO::unzip binary... found (C:\Program Files\SABnzbd\win\unzip\unzip.exe)
2008-09-24 19:29:57,733::INFO::pyOpenSSL... found (True)
2008-09-24 19:29:57,733::INFO::Web dir is C:\Program Files\SABnzbd\interfaces\smpl
2008-09-24 19:29:57,733::INFO::Web dir is C:\Program Files\SABnzbd\interfaces\Plush
2008-09-24 19:29:57,750::INFO::Starting SABnzbd.exe-0.4.4
2008-09-24 19:29:57,750::INFO::[postproc] Starting PostProcessing on SHOW_NAME.S01E03.nzb => Repair:False, Unpack:False, Delete:False, Script:None
2008-09-24 19:29:57,750::INFO::[sabnzbd.misc] Dirscanner starting up
2008-09-24 19:29:57,750::INFO::[sabnzbd.misc] URLGrabber starting up
2008-09-24 19:29:57,750::INFO::Starting web-interface on :8082
2008-09-24 19:29:57,765::ERROR::[postproc] Error removing workdir (D:\nntp\temp\SHOW_NAME.S01E03)
2008-09-24 19:29:57,765::INFO::[postproc] Cleaning up SHOW_NAME.S01E03.nzb

[uzenet]

hmm...no help? for the past week, i've been using 0.4.3 with the same exact config file. no problems related to moving files and post-processing. of course, i'll have to deal with the bugs in 0.4.3 that were addressed by 0.4.4, but the problem with post-processing in 0.4.4 is a complete show-stopper for me.

[uzenet]

I wasn't trying to sound like an a$$ or anything, but just pointed out that there were no replies. In the meantime, I've gone back to 0.4.3, which is working OK for my purposes. What additional information would be needed?

[shypike]

What additional information would be needed?

- An example of a failing NZB (you can email it to bugs at sabnzbd.org).
- Is the D: drive a fixed disk or a network/usb mounted one
- Does the problem occur only for TV episodes or also for any other download?

[uzenet]

I've sent an email to you with some attachments (nzb, config, log files).

This machine is a headless file server and all drives are physically attached via PATA/SATA connections. I mainly download TV episodes via this machine so I can't say whether this occurs with any other file categories. However, I can assure you that on all of these TV downloads, the queue stalls at moving the files. On another machine that is running 0.4.4, I don't seem to have these issues, but that machine does not handle any TV episodes however, it does handle some categories that involve moving the files from the default download directory once processed.

With my limited knowledge, I would suspect that there may be an issue with the TV sorting feature in 0.4.4 as going back to 0.4.3 with the same config file results in no such errors. Either that or I have an esoteric setup/config (though I think it is rather simple) as I haven't seen any other postings about any similar problem on the forums.

I hope this information can help in determining and resolving the problem.

Thank you.

[Edd--]

I can confirm that I have the exact same problem on the same version running on Debian Linux ...
Will downgrade too for now ... Please keep us posted if you find out what's causing this

Thanks, edd

[shypike]

It would help if you send us some extra info.
Like what is in the log files about this problem.

Is the problem limited to just TV episode handling?

[uzenet]

I can confirm that I have the exact same problem on the same version running on Debian Linux ...
Will downgrade too for now ... Please keep us posted if you find out what's causing this

Thanks, edd

This issue has resolved for me in 0.4.5 RC1, great job!