Page 1 of 2

1.2.0: Unpacking failed, an expected file was not unpacked

Posted: January 16th, 2017, 2:44 am
by duhcati
Hi,

I have been on the 1.2.0 beta releases, release candidates and now on 1.2.0 stable. First of all, sorry for not reporting this earlier as this would have probably been better to submit while 1.2.0 was still in Beta, but I keep seeing "Unpacking failed, an expected file was not unpacked" which results in invalid extractions (with folder names like: "_UNPACK_Some.Downloaded.Usenet.Package"). The error message says there is a file missing with the same name as the package itself ("Unpacking failed, these file(s) are missing: Some.Downloaded.Usenet.Package").

When I search the forums I notice this particular issue popped up a lot in 2012 and has since been solved.

It has started happening since the 1.2.0 betas and is still happening in the stable release. I have been using for sabnzbd for quite a long time, so perhaps it is caused by some old settings during package upgrade? Any idea what is going on?

Thanks!

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 16th, 2017, 2:47 am
by safihre
Check your settings, do you have Post process only verified jobs turned off?
If it's turned on, can you send me one of those NZB's that throw this error at [email protected]?

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 16th, 2017, 2:53 am
by duhcati
Post process only verified jobs is on... I have just sent you an email with four samples of nzb files that are triggering this error to be thrown.

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 25th, 2017, 6:21 pm
by xmicks
I am on latest freenas and experiencing the same since I updated to 1.2.0 yesterday. I downloaded the same download that went wrong on sab on windows and it completed correctly. I also have the setting "Post-Process Only Verified Jobs" tuned on. It comes with the error message and the end of extracting. I can also play the downloaded movie just fine.

Here the logs: Cut off the long extract commands.

Code: Select all

2017-01-24 14:43:40,864::INFO::[postproc:694] No par2 sets for Term Life 2016 1080p BluRay DTS
2017-01-24 14:43:40,887::DEBUG::[newsunpack:1688] build_filelists(): joinables: []
2017-01-24 14:43:40,888::DEBUG::[newsunpack:1689] build_filelists(): zips: []
2017-01-24 14:43:40,888::DEBUG::[newsunpack:1690] build_filelists(): rars: [u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part001.rar', u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part006.rar', u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part074.rar', u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part008.rar', u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part073.rar',.............
2017-01-24 14:43:40,888::DEBUG::[newsunpack:1691] build_filelists(): 7zips: []
2017-01-24 14:43:40,888::DEBUG::[newsunpack:1692] build_filelists(): ts: []
...
2017-01-24 14:44:47,338::INFO::[postproc:782] RAR files verified successfully
2017-01-24 14:44:47,338::DEBUG::[__init__:897] Saving data for __verified__ in /mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/__ADMIN__
2017-01-24 14:44:47,338::INFO::[postproc:712] Verification and repair finished for Term Life 2016 1080p BluRay DTS
2017-01-24 14:44:47,342::DEBUG::[tvsort:527] Found Movie (Term Life 2016 1080p BluRay DTS)
2017-01-24 14:44:47,379::INFO::[misc:833] Creating directories: /mnt/Media/Complete/Movies/Term Life (2016)/Term Life 2016 1080p BluRay DTS.1
2017-01-24 14:44:47,379::DEBUG::[misc:1282] Renaming "/mnt/Media/Complete/Movies/Term Life (2016)/Term Life 2016 1080p BluRay DTS.1" to "/mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1"
2017-01-24 14:44:47,379::INFO::[postproc:376] Running unpack_magic on Term Life 2016 1080p BluRay DTS
...
2017-01-24 14:44:49,229::DEBUG::[newsunpack:1688] build_filelists(): joinables: []
2017-01-24 14:44:49,229::DEBUG::[newsunpack:1689] build_filelists(): zips: []
2017-01-24 14:44:49,229::DEBUG::[newsunpack:1690] build_filelists(): rars: [u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part001.rar', u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYv.................
2017-01-24 14:44:49,229::DEBUG::[newsunpack:1691] build_filelists(): 7zips: []
2017-01-24 14:44:49,229::DEBUG::[newsunpack:1692] build_filelists(): ts: []
2017-01-24 14:44:49,230::INFO::[newsunpack:230] Unrar starting on /mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS
2017-01-24 14:44:49,230::DEBUG::[newsunpack:437] Rar_sets: {u'8LUUYvG5d0DqGSqRvm': [u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part001.rar', u'/mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part00............
2017-01-24 14:44:49,231::INFO::[newsunpack:452] Extracting rarfile /mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS/8LUUYvG5d0DqGSqRvm.part001.rar (belonging to 8LUUYvG5d0DqGSqRvm) to /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1
2017-01-24 14:44:49,231::DEBUG::[newsunpack:533] rar_extract(): Extractionpath: /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1
...
2017-01-24 14:47:29,771::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Als eerste op Place2Home.net NZB's (Klik Hier).url
2017-01-24 14:47:29,771::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Als eerste op Place2Home.org Torrents (Klik Hier).url
2017-01-24 14:47:29,771::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Flyer Place2Home.net.jpg
2017-01-24 14:47:29,772::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Place2Home.wmv
2017-01-24 14:47:29,772::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Term.Life.2016.1080p.BluRay.DTS.x264-CyTSuNee.mkv
2017-01-24 14:47:29,772::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Term.Life.2016.1080p.BluRay.DTS.x264-CyTSuNee.nfo
2017-01-24 14:47:29,772::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Voor de beste usenet accounts_ Newsconnection (Klik Hier).url
2017-01-24 14:47:29,772::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/Term Life 2016 1080p BluRay DTS x264-CyTSuNee
2017-01-24 14:47:29,772::INFO::[newsunpack:752] Missing expected file: Term Life 2016 1080p BluRay DTS x264-CyTSuNee => unrar error?
2017-01-24 14:47:29,772::DEBUG::[newsunpack:745] Checking existence of /mnt/Media/Complete/Movies/Term Life (2016)/_UNPACK_Term Life 2016 1080p BluRay DTS.1/8LUUYvG5d0DqGSqRvm
2017-01-24 14:47:29,772::INFO::[newsunpack:752] Missing expected file: 8LUUYvG5d0DqGSqRvm => unrar error?
2017-01-24 14:47:29,772::DEBUG::[newsunpack:756] Expecting files: [u"8LUUYvG5d0DqGSqRvm/Als eerste op Place2Home.net NZB's (Klik Hier).url", u'8LUUYvG5d0DqGSqRvm/Als eerste op Place2Home.org Torrents (Klik Hier).url', u'8LUUYvG5d0DqGSqRvm/Flyer Place2Home.net.jpg', u'8LUUYvG5d0DqGSqRvm/Place2Home.wmv', u'8LUUYvG5d0DqGSqRvm/Term Life 2016 1080p BluRay DTS x264-CyTSuNee/Term.Life.2016.1080p.BluRay.DTS.x264-CyTSuNee.mkv', u'8LUUYvG5d0DqGSqRvm/Term Life 2016 1080p BluRay DTS x264-CyTSuNee/Term.Life.2016.1080p.BluRay.DTS.x264-CyTSuNee.nfo', u'8LUUYvG5d0DqGSqRvm/Voor de beste usenet accounts_ Newsconnection (Klik Hier).url', u'8LUUYvG5d0DqGSqRvm/Term Life 2016 1080p BluRay DTS x264-CyTSuNee', u'8LUUYvG5d0DqGSqRvm']
2017-01-24 14:47:29,773::INFO::[newsunpack:234] Unrar finished on /mnt/Media/Sabnzbd/Inc/Term Life 2016 1080p BluRay DTS
2017-01-24 14:47:29,773::INFO::[postproc:381] unpack_magic finished on Term Life 2016 1080p BluRay DTS

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 26th, 2017, 1:56 am
by safihre
It's a Windows specific bug that will be fixed in 1.2.1. For now you can fix it by unchecking Verify results of unpack (Config Switches).

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 26th, 2017, 6:21 am
by xmicks
Im having issues of freenas(FreeBSD), on windows it downloads and processes correctly. If I uncheck that checkbox, wil my download be repaired and unrared correctly?

I saw an old post that it could be caused by the indexers naming the files. I downloaded same download from an other indexer and still problem persists.

Also I tried unraring the download from freenas on my windows laptop and it said that there were damaged rar archieves. Maybe repair is not good? But other downloads that dont require repair result too in bad unrar.

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 26th, 2017, 6:43 am
by safihre
Oops yes I mixed Windows/FreeBSD things up.

What I am missing from the log is the actual unrar output.
There should be a line 'Running unrar' followed by the command that was executed and the output of unrar.
Is that even there?

EDIT: You can also email me the whole log at [email protected], it will be faster for me to inspect :)

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 26th, 2017, 2:44 pm
by xmicks
mail sent!

But fix for freebsd is in 1.2.1?

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 26th, 2017, 3:11 pm
by safihre
The fix is that the check is removed.
But your problem seems different, I will read your logs as soon as possible! :)

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 28th, 2017, 11:08 am
by josh4trunks
@safihre
The FreeNAS plugin has unrar v5.10 packaged. Is there a minimum required version for sabnzbd v1.2.0?
I see FreeBSD has the latest version (v5.40) available so I can update the plugin to use that.

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 28th, 2017, 12:06 pm
by safihre
It should be fine with any 5.x version I suppose.
This is a bit odd problem and hard to diagnose because Sab doesn't log the console output of unrar when it's not successful. However, it also doesn't report that it was *not* successful, which is really strange. It should report a failure and stop, but it just continues.
You can also reproduce xmicks problem?

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 28th, 2017, 12:52 pm
by josh4trunks
I should have some time this Sunday night to try and reproduce this.

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 28th, 2017, 6:17 pm
by xmicks
I just did unrar from commandline on a download that failed and it ended with "ALL OK!". So does that mean that everything is extracted okay, or is there a some kind of verification that is done by sab?

@Josh4trunks Do you need anything from me to reproduce the situation?

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 29th, 2017, 11:24 am
by safihre
@xmicks I just read your latest log with the successful unrar and there it's an RAR3 job, so maybe indeed a RAR5 problem.

But why did it fail? Did you disable 'Verify results of unpack'? This way it shouldn't fail.

Re: 1.2.0: Unpacking failed, an expected file was not unpack

Posted: January 29th, 2017, 4:31 pm
by xmicks
Checked again, and it was enabled... I'm pretty sure it wasn't before though, but I had been enable en disabling those switches to see if that helped the problem go over. Feel kind of stupid though. Still weird that it wouldn't log the extraction when it is enabled and that the setting only goes wrong on some downloads.

I clicked "Retry" in the history section and it would unpack the download fine. In the logs it was logging the extraction like it should, achive after archive like I seen yesterday when I did it manually. It still said RAR3 though.

Minor thing offtopic is that it wouldn't show the size of the download in the history section after it completed (when I was "Retry"ing) also forgets the password. I'll send you a pic of the history and my logs. Big thanks, also to Josh4Trunks for the help!