"[Error 87] The parameter is incorrect" while unpacking RAR files

[Stu1983]

Every NZB I download fails with this error:
"[Error 87] The parameter is incorrect" while unpacking RAR files

Yet if I extract them myself they extract fine

I only installed SABnzbd a week ago and it was working fine for a few days so I'm assuming I've changed something to cause it to fail every file but I don't see anything obvious

Stu

Version: 0.5.4
OS: Windows 7 x64
Install-type: Windows Installer
Skin (if applicable): Plush
Firewall Software: Windows 7
Are you using IPV6? No
Is the issue reproducible? For me yes as it happens with every NZB

[shypike]

Set logging to "debug" level on the Connections page.
Download a small job with RARs in it and wait until it's complete.
Open the log file on the Connections page, use Notepad.
Look at the end of the file for error messages.

[Stu1983]

I've downloaded a test file with logging set to debug but I still don't see what's wrong

Here's the log:

Code: Select all

2010-09-21 11:02:10,150::INFO::[postproc:134] Saving postproc queue
2010-09-21 11:04:10,150::INFO::[postproc:243] Starting PostProcessing on Retro Choice Magazine - 2010-11 => Repair:True, Unpack:True, Delete:True, Script:None
2010-09-21 11:04:10,150::DEBUG::[__init__:649] Saving data for postproc1.sab in D:\SABnzbd\cache\postproc1.sab
2010-09-21 11:04:10,150::INFO::[postproc:247] Par2 check starting on Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,150::INFO::[postproc:254] Running repair on set Retro Choice - November 2010
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part2.rar OK
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part3.rar OK
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part8.rar OK
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part4.rar OK
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part5.rar OK
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part1.rar OK
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part6.rar OK
2010-09-21 11:04:10,151::DEBUG::[newsunpack:1158] Quick-check of file Retro Choice - November 2010.part7.rar OK
2010-09-21 11:04:10,153::INFO::[newsunpack:663] Quick-check for Retro Choice - November 2010 is OK, skipping repair
2010-09-21 11:04:10,153::INFO::[newsunpack:720] Deleting D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.par2
2010-09-21 11:04:10,153::INFO::[newsunpack:734] Deleting D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.vol00+1.par2
2010-09-21 11:04:10,154::INFO::[postproc:271] Par2 check finished on Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,154::INFO::[misc:822] Creating directories: D:\Downloads\Books
2010-09-21 11:04:10,154::INFO::[misc:822] Creating directories: D:\Downloads\Books\Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,155::INFO::[postproc:315] Running unpack_magic on Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,155::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part1.rar
2010-09-21 11:04:10,157::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part2.rar
2010-09-21 11:04:10,157::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part3.rar
2010-09-21 11:04:10,157::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part4.rar
2010-09-21 11:04:10,157::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part5.rar
2010-09-21 11:04:10,157::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part6.rar
2010-09-21 11:04:10,157::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part7.rar
2010-09-21 11:04:10,157::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part8.rar
2010-09-21 11:04:10,158::DEBUG::[newsunpack:1115] build_filelists(): joinables: []
2010-09-21 11:04:10,158::DEBUG::[newsunpack:1116] build_filelists(): zips: []
2010-09-21 11:04:10,158::DEBUG::[newsunpack:1117] build_filelists(): rars: ['D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part1.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part2.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part3.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part4.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part5.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part6.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part7.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part8.rar']
2010-09-21 11:04:10,158::DEBUG::[newsunpack:1118] build_filelists(): ts: []
2010-09-21 11:04:10,158::INFO::[newsunpack:185] Unrar starting on D:\Downloads\Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,160::DEBUG::[newsunpack:370] Rar_sets: {'Retro Choice - November 2010': ['D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part1.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part2.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part3.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part4.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part5.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part6.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part7.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part8.rar']}
2010-09-21 11:04:10,160::INFO::[newsunpack:384] Extracting rarfile D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part1.rar (belonging to Retro Choice - November 2010) to D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,160::DEBUG::[newsunpack:429] RAR_Extract(): Extractionpath: D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,164::ERROR::[newsunpack:397] Error "[Error 87] The parameter is incorrect" while running rar_unpack on Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,164::INFO::[newsunpack:189] Unrar finished on D:\Downloads\Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,164::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part1.rar
2010-09-21 11:04:10,164::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part2.rar
2010-09-21 11:04:10,165::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part3.rar
2010-09-21 11:04:10,165::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part4.rar
2010-09-21 11:04:10,165::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part5.rar
2010-09-21 11:04:10,167::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part6.rar
2010-09-21 11:04:10,167::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part7.rar
2010-09-21 11:04:10,167::DEBUG::[newsunpack:1123] notrar(): testing D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part8.rar
2010-09-21 11:04:10,167::DEBUG::[newsunpack:1115] build_filelists(): joinables: []
2010-09-21 11:04:10,167::DEBUG::[newsunpack:1116] build_filelists(): zips: []
2010-09-21 11:04:10,167::DEBUG::[newsunpack:1117] build_filelists(): rars: ['D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part1.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part2.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part3.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part4.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part5.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part6.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part7.rar', 'D:\\Downloads\\Retro Choice Magazine - 2010-11\\Retro Choice - November 2010.part8.rar']
2010-09-21 11:04:10,167::DEBUG::[newsunpack:1118] build_filelists(): ts: []
2010-09-21 11:04:10,167::INFO::[postproc:317] unpack_magic finished on Retro Choice Magazine - 2010-11
2010-09-21 11:04:10,168::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part1.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part1.rar unique?:False
2010-09-21 11:04:10,170::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part2.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part2.rar unique?:False
2010-09-21 11:04:10,174::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part3.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part3.rar unique?:False
2010-09-21 11:04:10,174::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part4.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part4.rar unique?:False
2010-09-21 11:04:10,174::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part5.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part5.rar unique?:False
2010-09-21 11:04:10,176::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part6.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part6.rar unique?:False
2010-09-21 11:04:10,177::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part7.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part7.rar unique?:False
2010-09-21 11:04:10,177::DEBUG::[misc:837] Moving. Old path:D:\Downloads\Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part8.rar new path:D:\Downloads\Books\_UNPACK_Retro Choice Magazine - 2010-11\Retro Choice - November 2010.part8.rar unique?:False
2010-09-21 11:04:10,183::DEBUG::[emailer:57] Connecting to server smtp.gmail.com:465
2010-09-21 11:04:10,819::DEBUG::[bpsmeter:60] bps: 591410.729219
2010-09-21 11:04:11,617::DEBUG::[emailer:63] Connected to server smtp.gmail.com:465
2010-09-21 11:04:14,009::INFO::[emailer:114] Notification e-mail succesfully sent
2010-09-21 11:04:14,049::INFO::[postproc:466] Cleaning up Retro Choice Magazine - 2010-11
2010-09-21 11:04:14,051::INFO::[__init__:702] D:\SABnzbd\cache\SABnzbd_article_ewvtbf removed
2010-09-21 11:04:14,052::INFO::[__init__:702] D:\SABnzbd\cache\SABnzbd_article_1jo8j2 removed
2010-09-21 11:04:14,052::INFO::[postproc:134] Saving postproc queue
2010-09-21 11:04:14,052::DEBUG::[__init__:649] Saving data for postproc1.sab in D:\SABnzbd\cache\postproc1.sab
2010-09-21 11:04:14,177::INFO::[downloader:357] Post-processing finished, resuming download

[shypike]

Bad luck. SABnzbd can log like there's no tomorrow but in this case
it doesn't log the one part that I need
I had expected to see the actual invocation of unrar, but alas.

Can you email your sabnzbd.ini file (please remove passwords first)
to bugs at sabnzbd.org?
Please add this NZB too (although I doubt whether that makes any difference).

[Stu1983]

files sent

Stu

[shypike]

Nothing revealing found, alas.
The only other option is that I prepare a custom version for you,
with some additional logging added.
Let me know if you want to test that.

[Stu1983]

yeah no problem I can test it for you

Stu

[shypike]

OK, it may take while, I'm extremely busy this week.