Page 1 of 1

[nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 3:32 am
by glutaman
Hi lads, I'm getting this in the logs and the jobs never even start. They're stuck at 0% and the error is flooding the logs ever 30 seconds or so.

Tried restarting the container, rebuilding it, rebooting my Synology altogether, but the error persists. Any ideas?

As a new user I can't seem to be able to post code blocks or URLs so please add a dot before the com pastebin com/3q18CLfx

Edit: I can post code now so I'll put it here too:

Code: Select all

today at 09:18:27Container started
today at 09:08:26[s6-finish] sending all processes the KILL signal and exiting.
today at 09:18:27[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
today at 09:18:27[s6-init] ensuring user provided files have correct perms...exited 0.
today at 09:18:28[fix-attrs.d] applying fixed ownership & permissions...
today at 09:18:28[fix-attrs.d] done.
today at 09:18:28[cont-init.d] executing container initialization scripts...
today at 09:18:28[cont-init.d] 01-envfile: executing...
today at 09:18:28[cont-init.d] 01-envfile: exited 0.
today at 09:18:28[cont-init.d] 01-migrations: executing...
today at 09:18:28[migrations] started
today at 09:18:28[migrations] no migrations found
today at 09:18:28[cont-init.d] 01-migrations: exited 0.
today at 09:18:28[cont-init.d] 02-tamper-check: executing...
today at 09:18:28[cont-init.d] 02-tamper-check: exited 0.
today at 09:18:28[cont-init.d] 10-adduser: executing...
today at 09:18:28usermod: no changes
today at 09:18:28
today at 09:18:28         | | / __| | | / \
today at 09:18:28         | | \__ \ | | | () |
today at 09:18:28         |_| |___/ |_| \__/
today at 09:18:28
today at 09:18:28
today at 09:18:28SABnzbd: https://sabnzbd.org/donate
today at 09:18:28
today at 09:18:28To support LSIO projects visit:
today at 09:18:28https://www.linuxserver.io/donate/
today at 09:18:28-------------------------------------
today at 09:18:28GID/UID
today at 09:18:28-------------------------------------
today at 09:18:28
today at 09:18:28User uid: 1029
today at 09:18:28[cont-init.d] 10-adduser: exited 0.
today at 09:18:28[cont-init.d] 20-config: executing...
today at 09:18:28[cont-init.d] 20-config: exited 0.
today at 09:18:28[cont-init.d] 90-custom-folders: executing...
today at 09:18:28[cont-init.d] 90-custom-folders: exited 0.
today at 09:18:28[cont-init.d] 99-custom-files: executing...
today at 09:18:28[custom-init] no custom files found exiting...
today at 09:18:28[cont-init.d] 99-custom-files: exited 0.
today at 09:18:28[cont-init.d] done.
today at 09:18:28[services.d] starting services
today at 09:18:28[services.d] done.
today at 09:18:412022-04-17 09:18:41,847::INFO::[SABnzbd:1166] ------------------------------ --
today at 09:18:412022-04-17 09:18:41,889::INFO::[SABnzbd:1167] SABnzbd.py-3.5.3
today at 09:18:412022-04-17 09:18:41,902::INFO::[SABnzbd:1186] Platform=posix - Linux-4.4.180+-x86_64-with
today at 09:18:412022-04-17 09:18:41,904::INFO::[SABnzbd:1192] Preferred encoding = UTF-8
today at 09:18:412022-04-17 09:18:41,906::INFO::[SABnzbd:1211] SSL version=OpenSSL 1.1.1n 15 Mar 2022
today at 09:18:412022-04-17 09:18:41,946::INFO::[SABnzbd:1220] Certified version=2020.12.05
today at 09:18:412022-04-17 09:18:41,947::INFO::[SABnzbd:1221] Loaded additional certificates from /etc/ssl/certs/ca-certificates.crt
today at 09:18:412022-04-17 09:18:41,988::INFO::[postproc:133] Loading postproc queue
today at 09:18:412022-04-17 09:18:41,991::INFO::[scheduler:179] Scheduling speedlimit(['0']) on days [1, 2, 3, 4, 5] at 17:00
today at 09:18:422022-04-17 09:18:42,096::INFO::[downloader:439] Speed โ€‹โ€‹limit set to 0.0 B/s
today at 09:18:422022-04-17 09:18:42,097::INFO::[__init__:321] All processes started
today at 09:18:422022-04-17 09:18:42,123::INFO::[SABnzbd:336] Template location for Glitter is /app/sabnzbd/interfaces/Glitter
today at 09:18:422022-04-17 09:18:42,125::INFO::[SABnzbd:336] Template location for Config is /app/sabnzbd/interfaces/Config
today at 09:18:422022-04-17 09:18:42,168::INFO::[misc:1161] [N/A] Running external command: ['/usr/local/bin/unrar']
today at 09:18:422022-04-17 09:18:42,293::INFO::[misc:1161] [N/A] Running external command: ['/usr/bin/7za']
today at 09:18:422022-04-17 09:18:42,344::INFO::[misc:1161] [N/A] Running external command: ['/usr/bin/par2', '-h']
today at 09:18:422022-04-17 09:18:42,482::INFO::[SABnzbd:423] SABYenc module (v4.0.2)... found!
today at 09:18:422022-04-17 09:18:42,483::INFO::[SABnzbd:442] Cryptography module (v36.0.1)... found!
today at 09:18:422022-04-17 09:18:42,483::INFO::[SABnzbd:447] par2 binary... found (/usr/bin/par2)
today at 09:18:422022-04-17 09:18:42,483::INFO::[SABnzbd:454] UNRAR binary... found (/usr/local/bin/unrar)
today at 09:18:422022-04-17 09:18:42,483::INFO::[SABnzbd:462] UNRAR binary version 6.10
today at 09:18:422022-04-17 09:18:42,484::INFO::[SABnzbd:470] 7za binary... found (/usr/bin/7za)
today at 09:18:422022-04-17 09:18:42,484::INFO::[SABnzbd:472] 7za binary version 16.02
today at 09:18:422022-04-17 09:18:42,484::INFO::[SABnzbd:483] nice binary... found (/bin/nice)
today at 09:18:422022-04-17 09:18:42,485::INFO::[SABnzbd:487] ionice binary... found (/bin/ionice)
today at 09:18:422022-04-17 09:18:42,489::INFO::[SABnzbd:1430] Starting web-interface on :::8090
today at 09:18:422022-04-17 09:18:42,491::INFO::[_cplogging:213] [17/Apr/2022:09:18:42] ENGINE Bus STARTING
today at 09:18:47/usr/lib/python3.9/site-packages/cherrypy/process/servers.py:416: UserWarning: Unable to verify that the server is bound on 8090
today at 09:18:47  warnings.warn(msg)
today at 09:18:472022-04-17 09:18:47,683::INFO::[_cplogging:213] [17/Apr/2022:09:18:47] ENGINE Serving on http://:::8090
today at 09:18:472022-04-17 09:18:47,683::INFO::[_cplogging:213] [17/Apr/2022:09:18:47] ENGINE Bus STARTED
today at 09:18:472022-04-17 09:18:47,693::INFO::[dirscanner:117] Dirscanner starting up
today at 09:18:472022-04-17 09:18:47,695::INFO::[notifier:123] Sending notification: SABnzbd - SABnzbd 3.5.3 started (type=startup, job_cat=None)
today at 09:18:472022-04-17 09:18:47,698::INFO::[zconfig:61] No bonjour/zeroconf support installed
today at 09:18:472022-04-17 09:18:47,700::INFO::[ssdp:108] Serving SSDP on 172.17.0.12 as SABnzbd
today at 09:19:172022-04-17 09:19:17,702::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part001.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,703::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part002.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,703::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part671.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,703::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part003.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,703::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part004.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,703::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part005.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,704::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part006.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,705::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part013.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,705::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part014.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,705::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part015.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,706::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part016.rar in job //redacted//
today at 09:19:172022-04-17 09:19:17,706::INFO::[nzbqueue:879] Resetting bad trylist for file df0cfb0a91c74aefbe6a5804d5563faf.part017.rar in job //redacted//

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 4:44 am
by sander
What if you do a reference download? So: In SABnzbd's upper right corner, click on the wrench symbol ("Status and interface options"), then click on first tab Status, and there click on the 1GB download?

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 5:06 am
by glutaman
Thanks for the quick reply. Same error for the 1GB reference download:

Code: Select all

today at 11:04:452022-04-17 11:04:45,410::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol000+001.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,411::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol001+002.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,411::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol003+004.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,411::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol007+008.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,412::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol015+016.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,412::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol031+032.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,412::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol063+064.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,413::INFO::[nzbqueue:879] Resetting bad trylist for file sometestfile-1000MB.vol127+073.par2 in job test_download_1000MB
today at 11:04:452022-04-17 11:04:45,413::INFO::[nzbqueue:883] Resetting bad trylist for job test_download_1000MB

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 5:35 am
by sander
Hmmm. That's bad.

FWIW: Message is from https://github.com/sabnzbd/sabnzbd/blob ... #L877-L885

I'm not good at this, but my first try would be: do your newsservers work? So: Config -> Servers -> Shows Details (per server), and click on Test Server. And that for every Enabled server. What is the result.

And Check #2: are your folders OK and writable? Check via: In SABnzbd's upper right corner, click on the wrench symbol ("Status and interface options"), then click on first tab Status, and there click on the Refresh Arrow. Post the values of the lower part here.

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 5:43 am
by sander
Ah, yes, I can reproduce when I have not one server Enabled, and also with a newsserver Enabled but no working credentials. In other words: I can reproduce with no working newsserver.

So check your newsservers like I described above.

Code: Select all

2022-04-17 12:42:21,822::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol000+02.par2 in job test_download_100MB
2022-04-17 12:42:21,822::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part1.rar in job test_download_100MB
2022-04-17 12:42:21,822::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part2.rar in job test_download_100MB
2022-04-17 12:42:21,822::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part3.rar in job test_download_100MB
2022-04-17 12:42:21,822::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part4.rar in job test_download_100MB
2022-04-17 12:42:21,822::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part5.rar in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part6.rar in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part7.rar in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol002+04.par2 in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol006+08.par2 in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol014+16.par2 in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol030+32.par2 in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol062+64.par2 in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol126+74.par2 in job test_download_100MB
2022-04-17 12:42:21,823::INFO::[nzbqueue:888] Resetting bad trylist for job test_download_100MB


2022-04-17 12:42:51,826::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol000+02.par2 in job test_download_100MB
2022-04-17 12:42:51,827::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part1.rar in job test_download_100MB
2022-04-17 12:42:51,827::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part2.rar in job test_download_100MB
2022-04-17 12:42:51,828::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part3.rar in job test_download_100MB
2022-04-17 12:42:51,828::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part4.rar in job test_download_100MB
2022-04-17 12:42:51,829::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part5.rar in job test_download_100MB
2022-04-17 12:42:51,830::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part6.rar in job test_download_100MB
2022-04-17 12:42:51,830::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.part7.rar in job test_download_100MB
2022-04-17 12:42:51,831::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol002+04.par2 in job test_download_100MB
2022-04-17 12:42:51,831::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol006+08.par2 in job test_download_100MB
2022-04-17 12:42:51,832::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol014+16.par2 in job test_download_100MB
2022-04-17 12:42:51,832::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol030+32.par2 in job test_download_100MB
2022-04-17 12:42:51,832::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol062+64.par2 in job test_download_100MB
2022-04-17 12:42:51,833::INFO::[nzbqueue:884] Resetting bad trylist for file sometestfile-100MB.vol126+74.par2 in job test_download_100MB
2022-04-17 12:42:51,834::INFO::[nzbqueue:888] Resetting bad trylist for job test_download_100MB

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 5:55 am
by glutaman
Holy crap that was it. The newsserver was unticked and I'm certain I didn't change that. Thanks for helping with the troubleshooting!

This isn't the only setting that changed without my input in the last few days actually. It was also asking me for user/pass the other day and had to edit the .ini file back to blanks.

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 6:52 am
by sander
Good it works now. I think SAB should warn when no newsserver is usable.

About your config: caused by docker thing, or (if your SAB is reachable from Internet) someone playing with your settings?

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 17th, 2022, 2:50 pm
by OneCD
sander wrote: โ†‘April 17th, 2022, 6:52 am Good it works now. I think SAB should warn when no newsserver is usable.
+1

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 18th, 2022, 10:20 am
by safihre
Or, if could be your browser or a password extension auto filling stuff in your configuration.

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 19th, 2022, 2:04 am
by safihre
I have added a warning if there are no servers that could be used for downloading!
If there are no servers at all, you will be redirected to the wizard anyway.

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 19th, 2022, 2:23 am
by OneCD
Thanks @safihre. ๐Ÿ‘

Re: [nzbqueue:879] Resetting bad trylist

Posted: April 19th, 2022, 2:56 am
by glutaman
Good stuff lads!!