Retry fails, but re-add same nzb succeeds

Report & discuss bugs found in SABnzbd
Forum rules
Help us help you:
  • Are you using the latest stable version of SABnzbd? Downloads page.
  • Tell us what system you run SABnzbd on.
  • Adhere to the forum rules.
  • Do you experience problems during downloading?
    Check your connection in Status and Interface settings window.
    Use Test Server in Config > Servers.
    We will probably ask you to do a test using only basic settings.
  • Do you experience problems during repair or unpacking?
    Enable +Debug logging in the Status and Interface settings window and share the relevant parts of the log here using [ code ] sections.
Post Reply
zmcddna
Newbie
Newbie
Posts: 4
Joined: December 19th, 2012, 3:21 am

Retry fails, but re-add same nzb succeeds

Post by zmcddna »

(This is for the 0.7.16 binary distribution running on Windows 8.1.)

Sometimes when adding from an indexer, the files in the nzb aren't yet propagated to my news server and the download fails. No problem, I just wait a few hours and Retry.

However, often the Retry also fails, even after waiting several hours. It downloads a little bit more, as if it is obtaining some missing data, but then still fails at the end with not enough blocks.

Immediately after the failed retry, if I re-add the exact same nzb directly from the nzb backup folder, the full job downloads and completes successfully.

It seems unlikely that all the remaining files suddenly became available in the couple minutes between the retry and re-add, so I'm wondering if there could be something going on with the Retry feature?

Is there anything in the logs I should specifically look for, or different options to try?

For one recent example, some of the log output looks like the following.

The initial failed download:

Code: Select all

2014-03-05 00:58:34,901::INFO::[newsunpack:1052] Verified in 0 seconds, repair is required
2014-03-05 00:58:34,903::INFO::[newsunpack:1103] Need to fetch 589 more blocks, checking blocks
2014-03-05 00:58:34,903::INFO::[newsunpack:1125] 58 blocks available
2014-03-05 00:58:34,903::INFO::[newsunpack:1158] Added 58 blocks to NOT.THE.ORIGINAL.FILENAME
2014-03-05 00:58:34,903::DEBUG::[newsunpack:1271] PAR2 output was
...
Verifying source files:
Target: "NOT.THE.ORIGINAL.FILENAME.nfo" - found.
Target: "NOT.THE.ORIGINAL.FILENAME.r00" - missing.
Target: "NOT.THE.ORIGINAL.FILENAME.r01" - missing.
Scanning: "NOT.THE.ORIGINAL.FILENAME.r02": 0.1%
File: "NOT.THE.ORIGINAL.FILENAME.r02" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r03" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r04" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r05" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r06" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r07" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r08" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r09" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r10" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r11" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r12" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r13" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r14" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r15" - no data found.
Target: "NOT.THE.ORIGINAL.FILENAME.r16" - missing.
Target: "NOT.THE.ORIGINAL.FILENAME.rar" - missing.
Target: "NOT.THE.ORIGINAL.FILENAME.sfv" - found.
Scanning extra files:
Scanning: "NOT.THE.ORIGINAL.FILENAME.srr": 0.1%
File: "NOT.THE.ORIGINAL.FILENAME.srr" - no data found.
Repair is required.
4 file(s) are missing.
14 file(s) exist but are damaged.
2 file(s) are ok.
You have 2 out of 591 data blocks available.
Repair is not possible.
You need 589 more recovery blocks to be able to repair.
Retry approx 17 hours later, failed:

Code: Select all

2014-03-05 17:54:03,331::INFO::[newsunpack:1052] Verified in 2 seconds, repair is required
2014-03-05 17:54:03,331::INFO::[newsunpack:1103] Need to fetch 462 more blocks, checking blocks
2014-03-05 17:54:03,331::INFO::[newsunpack:1125] 0 blocks available
2014-03-05 17:54:03,332::DEBUG::[newsunpack:1271] PAR2 output was
...
Verifying source files:
Target: "NOT.THE.ORIGINAL.FILENAME.nfo" - found.
Scanning: "NOT.THE.ORIGINAL.FILENAME.r00": 3.0%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r00": 27.6%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r00": 52.2%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r00": 76.8%
Target: "NOT.THE.ORIGINAL.FILENAME.r00" - found.
Scanning: "NOT.THE.ORIGINAL.FILENAME.r01": 3.0%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r01": 27.6%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r01": 52.2%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r01": 76.8%
Target: "NOT.THE.ORIGINAL.FILENAME.r01" - found.
Scanning: "NOT.THE.ORIGINAL.FILENAME.r02": 90.8%
File: "NOT.THE.ORIGINAL.FILENAME.r02" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r03" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r04" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r05" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r06" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r07" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r08" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r09" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r10" - no data found.
Scanning: "NOT.THE.ORIGINAL.FILENAME.r11": 0.1%
File: "NOT.THE.ORIGINAL.FILENAME.r11" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r12" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r13" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r14" - no data found.
File: "NOT.THE.ORIGINAL.FILENAME.r15" - no data found.
Scanning: "NOT.THE.ORIGINAL.FILENAME.r16": 14.3%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r16": 43.0%
Scanning: "NOT.THE.ORIGINAL.FILENAME.r16": 71.7%
Target: "NOT.THE.ORIGINAL.FILENAME.r16" - found.
Scanning: "NOT.THE.ORIGINAL.FILENAME.rar": 3.0%
Scanning: "NOT.THE.ORIGINAL.FILENAME.rar": 27.6%
Scanning: "NOT.THE.ORIGINAL.FILENAME.rar": 52.2%
Scanning: "NOT.THE.ORIGINAL.FILENAME.rar": 76.8%
Target: "NOT.THE.ORIGINAL.FILENAME.rar" - found.
Target: "NOT.THE.ORIGINAL.FILENAME.sfv" - found.
Scanning extra files:
Scanning: "NOT.THE.ORIGINAL.FILENAME.srr": 0.1%
File: "NOT.THE.ORIGINAL.FILENAME.srr" - no data found.
Repair is required.
14 file(s) exist but are damaged.
6 file(s) are ok.
You have 129 out of 591 data blocks available.
Repair is not possible.
You need 462 more recovery blocks to be able to repair.
All those "no data found" files do appear at the beginning of the retry log as "added to queue", but then it didn't appear to download any additional data for most of them. Only .rar, .r01, .r02, and .r16 showed in the log as "Decoding", and those appear above as "found" instead of "no data found".

In addition, in the initial failure log, there are tons of "missing from all servers" errors, but in the retry log, there are none. It's as if the files were simply skipped, not even attempted.

Immediate re-add a few minutes after the retry, and everything downloads successfully:

Code: Select all

2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.rar OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r14 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r08 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r09 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.nfo OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r04 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r05 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r06 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r07 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r00 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r01 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r02 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r03 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r11 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r16 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r12 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r13 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r10 OK
2014-03-05 18:02:29,746::DEBUG::[newsunpack:1424] Quick-check of file NOT.THE.ORIGINAL.FILENAME.r15 OK
2014-03-05 18:02:29,746::INFO::[newsunpack:826] Quick-check for NOT.THE.ORIGINAL.FILENAME is OK, skipping repair
Ideas?
Top
User avatar
shypike
Administrator
Administrator
Posts: 19773
Joined: January 18th, 2008, 12:49 pm

Re: Retry fails, but re-add same nzb succeeds

Post by shypike »

Retry will not "fill in the blanks", some shortcomings in the NZB format cause that.
That's why a new full download will work.
Alternatively you can remove partial files and retry from History.
Top
zmcddna
Newbie
Newbie
Posts: 4
Joined: December 19th, 2012, 3:21 am

Re: Retry fails, but re-add same nzb succeeds

Post by zmcddna »

Ok, makes sense.

I wonder if it might be a useful option to add to the Retry dialog, like a "Force Full Redownload" button, to save a bit of manual cleanup...
Top
Post Reply

Return to “Bug Reports”