SABnzbd Forums


http://45.79.196.47/

Failed to initialize connection to IPv6 server

http://45.79.196.47/viewtopic.php?t=18469

Page 1 of 1

Failed to initialize connection to IPv6 server

Posted: December 21st, 2014, 11:28 am
by sander
SABnzbd says "Failed to initialize" to IPv6-only newsservers:

Code: Select all

sander@flappie:~$ cat ~/.sabnzbd/logs/sabnzbd.log | grep newszilla6 | tail -5
2014-12-21 16:55:12,893::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2014-12-21 16:55:12,893::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2014-12-21 16:55:12,893::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2014-12-21 16:55:12,893::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119
2014-12-21 16:55:12,894::INFO::[downloader:664] Thread 4@newszilla6.xs4all.nl:119: failed to initialize
sander@flappie:~$
... while IPv6 is working:

Code: Select all

sander@flappie:~$ 
sander@flappie:~$ telnet newszilla6.xs4all.nl 119
Trying 2001:888:0:18::119...
Connected to newszilla.ipv6.xs4all.nl.
Escape character is '^]'.
201 dreader35.news.xs4all.nl NNRP Service Ready - newsmaster@xs4all.nl (no posting).
quit
205 Transferred 86 bytes in 0 articles, 0 groups.  Disconnecting.
Connection closed by foreign host.
sander@flappie:~$
This seems to happen after my computer has reconnected to the network (with IPv6), and/or has connected to a new network (with IPv6).

A restart of SABnzbd 'solves' the problem.

So: does SABnzbd save the (old?) state of the connections to newsservers ("not working") instead of setting up a fresh connection?

Re: Failed to initialize connection to IPv6 server

Posted: December 22nd, 2014, 2:48 am
by shypike
sander wrote: So: does SABnzbd save the (old?) state of the connections to newsservers ("not working") instead of setting up a fresh connection?
IPv4 and IPv6 are treated exactly the same, unless the Python libraries do otherwise.
Does traffic resume after about 10 minutes?
(This is the lock-down period for unwilling servers.)

Re: Failed to initialize connection to IPv6 server

Posted: December 22nd, 2014, 2:59 am
by sander
shypike wrote: Does traffic resume after about 10 minutes?
(This is the lock-down period for unwilling servers.)
I don't think so, but I'll try.

Thanks.

Re: Failed to initialize connection to IPv6 server

Posted: December 26th, 2014, 10:14 am
by sander
I can't reproduce it; so far SABnzbd behaves well.

See logging. First: network with no IPv6, then network with IPv6, and SAB nicely picks. And "sudo netstat -apon | grep 119 | grep tcp6" shows IPv6 connections.

So ... false alarm from my side ...

Code: Select all

2014-12-26 16:07:05,209::INFO::[newswrapper:233] Failed to connect: (110, '[Errno 101] Network is unreachable') 1@newszilla6.xs4all.nl:119
2014-12-26 16:07:05,209::INFO::[newswrapper:233] Failed to connect: (110, '[Errno 101] Network is unreachable') 2@newszilla6.xs4all.nl:119
2014-12-26 16:08:36,373::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:08:36,374::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:08:36,375::INFO::[newswrapper:233] Failed to connect: (110, '[Errno 101] Network is unreachable') 4@newszilla6.xs4all.nl:119
2014-12-26 16:08:36,376::INFO::[newswrapper:233] Failed to connect: (110, '[Errno 101] Network is unreachable') 3@newszilla6.xs4all.nl:119
2014-12-26 16:09:13,865::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:09:13,866::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:09:13,879::INFO::[newswrapper:233] Failed to connect: (110, '[Errno 101] Network is unreachable') 2@newszilla6.xs4all.nl:119
2014-12-26 16:09:13,885::INFO::[newswrapper:233] Failed to connect: (110, '[Errno 101] Network is unreachable') 1@newszilla6.xs4all.nl:119
2014-12-26 16:10:45,096::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:10:45,097::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:11:05,068::INFO::[downloader:577] Connecting 4@newszilla6.xs4all.nl:119 finished
2014-12-26 16:11:08,029::INFO::[downloader:577] Connecting 3@newszilla6.xs4all.nl:119 finished
2014-12-26 16:11:23,897::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:11:23,897::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2014-12-26 16:11:36,397::INFO::[downloader:577] Connecting 1@newszilla6.xs4all.nl:119 finished
2014-12-26 16:11:36,398::INFO::[downloader:577] Connecting 2@newszilla6.xs4all.nl:119 finished

Re: Failed to initialize connection to IPv6 server

Posted: March 8th, 2015, 4:35 am
by sander
Still the same problem: IPv6 is working system wide, but SABnzbd thinks it's not. I think this happens after the network interface has been down or after some IPv4-only was there for some time.
Pausing SABnzbd does not solve it.
Restarting SABnzbd does 'solve' it, so to me it feels some state (of non-working IPv6) is saved by SABnzbd or python

I think I'll put my own connect-to-ipv6-code into downloader.py to verify and show IPv6 is working

Code: Select all

                        try:
                            logging.info("%s@%s: Initiating connection",
                                              nw.thrdnum, server.id)
                            nw.init_connect(self.write_fds)
                        except:
                            logging.error(T('Failed to initialize %s@%s'), nw.thrdnum, server.id)
                            logging.info("Traceback: ", exc_info = True)
                            self.__reset_nw(nw, "failed to initialize")

Code: Select all

2015-03-08 10:07:19,907::INFO::[downloader:381] 1@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:07:19,907::ERROR::[downloader:386] Failed to initialize 1@weathergirl-ipv6.tele2.net:119
2015-03-08 10:07:19,908::INFO::[downloader:664] Thread 1@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:07:19,908::INFO::[downloader:381] 2@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:07:19,908::ERROR::[downloader:386] Failed to initialize 2@weathergirl-ipv6.tele2.net:119
2015-03-08 10:07:19,908::INFO::[downloader:664] Thread 2@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:07:19,909::INFO::[downloader:381] 3@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:07:19,909::ERROR::[downloader:386] Failed to initialize 3@weathergirl-ipv6.tele2.net:119
2015-03-08 10:07:19,909::INFO::[downloader:664] Thread 3@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:07:19,910::INFO::[downloader:381] 4@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:07:19,912::INFO::[downloader:381] 1@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:07:19,914::INFO::[downloader:381] 3@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:07:19,917::INFO::[downloader:381] 2@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:07:19,920::INFO::[downloader:381] 2@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:07:19,925::INFO::[downloader:381] 4@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:07:19,930::INFO::[downloader:381] 5@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:07:20,397::INFO::[downloader:381] 3@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:07:20,398::INFO::[downloader:381] 1@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:07:20,398::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:07:20,399::ERROR::[downloader:386] Failed to initialize 1@newszilla6.xs4all.nl:119
2015-03-08 10:07:20,399::INFO::[downloader:664] Thread 1@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:07:20,399::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:07:20,399::ERROR::[downloader:386] Failed to initialize 2@newszilla6.xs4all.nl:119
2015-03-08 10:07:20,400::INFO::[downloader:664] Thread 2@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:07:20,400::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:07:20,400::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2015-03-08 10:07:20,401::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:07:20,401::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:07:20,401::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119
2015-03-08 10:07:20,402::INFO::[downloader:664] Thread 4@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:14:36,233::INFO::[downloader:381] 1@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:14:36,234::ERROR::[downloader:386] Failed to initialize 1@weathergirl-ipv6.tele2.net:119
2015-03-08 10:14:36,234::INFO::[downloader:664] Thread 1@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:14:36,235::INFO::[downloader:381] 2@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:14:36,235::ERROR::[downloader:386] Failed to initialize 2@weathergirl-ipv6.tele2.net:119
2015-03-08 10:14:36,236::INFO::[downloader:664] Thread 2@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:14:36,236::INFO::[downloader:381] 3@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:14:36,236::ERROR::[downloader:386] Failed to initialize 3@weathergirl-ipv6.tele2.net:119
2015-03-08 10:14:36,237::INFO::[downloader:664] Thread 3@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:14:36,237::INFO::[downloader:381] 4@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:14:36,240::INFO::[downloader:381] 1@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:14:36,243::INFO::[downloader:381] 3@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:14:36,245::INFO::[downloader:381] 2@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:14:36,248::INFO::[downloader:381] 1@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:14:36,249::INFO::[downloader:381] 3@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:14:36,251::INFO::[downloader:381] 4@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:14:36,253::INFO::[downloader:381] 5@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:14:36,255::INFO::[downloader:381] 2@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:14:36,257::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:14:36,257::ERROR::[downloader:386] Failed to initialize 1@newszilla6.xs4all.nl:119
2015-03-08 10:14:36,258::INFO::[downloader:664] Thread 1@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:14:36,258::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:14:36,258::ERROR::[downloader:386] Failed to initialize 2@newszilla6.xs4all.nl:119
2015-03-08 10:14:36,259::INFO::[downloader:664] Thread 2@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:14:36,259::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:14:36,259::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2015-03-08 10:14:36,259::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:14:36,260::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:14:36,260::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119
2015-03-08 10:14:36,260::INFO::[downloader:664] Thread 4@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:16:36,538::INFO::[downloader:381] 1@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:16:36,539::ERROR::[downloader:386] Failed to initialize 1@weathergirl-ipv6.tele2.net:119
2015-03-08 10:16:36,542::INFO::[downloader:664] Thread 1@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:16:36,542::INFO::[downloader:381] 2@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:16:36,542::ERROR::[downloader:386] Failed to initialize 2@weathergirl-ipv6.tele2.net:119
2015-03-08 10:16:36,543::INFO::[downloader:664] Thread 2@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:16:36,543::INFO::[downloader:381] 3@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:16:36,544::ERROR::[downloader:386] Failed to initialize 3@weathergirl-ipv6.tele2.net:119
2015-03-08 10:16:36,544::INFO::[downloader:664] Thread 3@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:16:36,545::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:16:36,545::ERROR::[downloader:386] Failed to initialize 1@newszilla6.xs4all.nl:119
2015-03-08 10:16:36,546::INFO::[downloader:664] Thread 1@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:16:36,547::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:16:36,547::ERROR::[downloader:386] Failed to initialize 2@newszilla6.xs4all.nl:119
2015-03-08 10:16:36,548::INFO::[downloader:664] Thread 2@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:16:36,549::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:16:36,549::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2015-03-08 10:16:36,550::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:16:36,551::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:16:36,551::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119
2015-03-08 10:16:36,552::INFO::[downloader:664] Thread 4@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:18:36,767::INFO::[downloader:381] 1@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:18:36,767::ERROR::[downloader:386] Failed to initialize 1@weathergirl-ipv6.tele2.net:119
2015-03-08 10:18:36,768::INFO::[downloader:664] Thread 1@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:18:36,768::INFO::[downloader:381] 2@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:18:36,769::ERROR::[downloader:386] Failed to initialize 2@weathergirl-ipv6.tele2.net:119
2015-03-08 10:18:36,769::INFO::[downloader:664] Thread 2@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:18:36,770::INFO::[downloader:381] 3@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:18:36,770::ERROR::[downloader:386] Failed to initialize 3@weathergirl-ipv6.tele2.net:119
2015-03-08 10:18:36,770::INFO::[downloader:664] Thread 3@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:18:36,771::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:18:36,772::ERROR::[downloader:386] Failed to initialize 1@newszilla6.xs4all.nl:119
2015-03-08 10:18:36,772::INFO::[downloader:664] Thread 1@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:18:36,773::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:18:36,773::ERROR::[downloader:386] Failed to initialize 2@newszilla6.xs4all.nl:119
2015-03-08 10:18:36,774::INFO::[downloader:664] Thread 2@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:18:36,775::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:18:36,775::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2015-03-08 10:18:36,776::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:18:36,776::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:18:36,776::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119
2015-03-08 10:18:36,777::INFO::[downloader:664] Thread 4@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:20:36,928::INFO::[downloader:381] 1@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:20:36,928::ERROR::[downloader:386] Failed to initialize 1@weathergirl-ipv6.tele2.net:119
2015-03-08 10:20:36,931::INFO::[downloader:664] Thread 1@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:20:36,931::INFO::[downloader:381] 2@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:20:36,932::ERROR::[downloader:386] Failed to initialize 2@weathergirl-ipv6.tele2.net:119
2015-03-08 10:20:36,938::INFO::[downloader:664] Thread 2@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:20:37,018::INFO::[downloader:381] 3@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:20:37,018::ERROR::[downloader:386] Failed to initialize 3@weathergirl-ipv6.tele2.net:119
2015-03-08 10:20:37,019::INFO::[downloader:664] Thread 3@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:20:37,019::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:20:37,020::ERROR::[downloader:386] Failed to initialize 1@newszilla6.xs4all.nl:119
2015-03-08 10:20:37,020::INFO::[downloader:664] Thread 1@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:20:37,021::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:20:37,021::ERROR::[downloader:386] Failed to initialize 2@newszilla6.xs4all.nl:119
2015-03-08 10:20:37,022::INFO::[downloader:664] Thread 2@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:20:37,022::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:20:37,022::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2015-03-08 10:20:37,023::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:20:37,023::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:20:37,024::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119
2015-03-08 10:20:37,024::INFO::[downloader:664] Thread 4@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:22:37,178::INFO::[downloader:381] 1@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:22:37,178::ERROR::[downloader:386] Failed to initialize 1@weathergirl-ipv6.tele2.net:119
2015-03-08 10:22:37,179::INFO::[downloader:664] Thread 1@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:22:37,179::INFO::[downloader:381] 2@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:22:37,179::ERROR::[downloader:386] Failed to initialize 2@weathergirl-ipv6.tele2.net:119
2015-03-08 10:22:37,180::INFO::[downloader:664] Thread 2@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:22:37,181::INFO::[downloader:381] 3@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:22:37,181::ERROR::[downloader:386] Failed to initialize 3@weathergirl-ipv6.tele2.net:119
2015-03-08 10:22:37,181::INFO::[downloader:664] Thread 3@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:22:37,182::INFO::[downloader:381] 4@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:22:37,183::INFO::[downloader:381] 3@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:22:37,184::INFO::[downloader:381] 1@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:22:37,185::INFO::[downloader:381] 2@reader.i-telligent.com:119: Initiating connection
2015-03-08 10:22:37,186::INFO::[downloader:381] 3@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:22:37,187::INFO::[downloader:381] 4@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:22:37,188::INFO::[downloader:381] 5@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:22:37,188::INFO::[downloader:381] 1@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:22:37,189::INFO::[downloader:381] 2@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:22:37,190::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:22:37,190::ERROR::[downloader:386] Failed to initialize 1@newszilla6.xs4all.nl:119
2015-03-08 10:22:37,190::INFO::[downloader:664] Thread 1@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:22:37,191::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:22:37,191::ERROR::[downloader:386] Failed to initialize 2@newszilla6.xs4all.nl:119
2015-03-08 10:22:37,191::INFO::[downloader:664] Thread 2@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:22:37,191::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:22:37,191::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2015-03-08 10:22:37,192::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:22:37,192::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:22:37,192::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119
2015-03-08 10:22:37,192::INFO::[downloader:664] Thread 4@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:25:15,156::INFO::[downloader:381] 1@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:25:15,157::ERROR::[downloader:386] Failed to initialize 1@weathergirl-ipv6.tele2.net:119
2015-03-08 10:25:15,158::INFO::[downloader:664] Thread 1@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:25:15,158::INFO::[downloader:381] 2@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:25:15,158::ERROR::[downloader:386] Failed to initialize 2@weathergirl-ipv6.tele2.net:119
2015-03-08 10:25:15,159::INFO::[downloader:664] Thread 2@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:25:15,159::INFO::[downloader:381] 3@weathergirl-ipv6.tele2.net:119: Initiating connection
2015-03-08 10:25:15,160::ERROR::[downloader:386] Failed to initialize 3@weathergirl-ipv6.tele2.net:119
2015-03-08 10:25:15,160::INFO::[downloader:664] Thread 3@weathergirl-ipv6.tele2.net:119: failed to initialize
2015-03-08 10:25:15,162::INFO::[downloader:381] 2@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:25:15,163::INFO::[downloader:381] 4@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:25:15,164::INFO::[downloader:381] 1@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:25:15,164::INFO::[downloader:381] 3@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:25:15,165::INFO::[downloader:381] 5@newsreader3.eweka.nl:119: Initiating connection
2015-03-08 10:25:15,167::INFO::[downloader:381] 1@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:25:15,167::ERROR::[downloader:386] Failed to initialize 1@newszilla6.xs4all.nl:119
2015-03-08 10:25:15,168::INFO::[downloader:664] Thread 1@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:25:15,169::INFO::[downloader:381] 2@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:25:15,169::ERROR::[downloader:386] Failed to initialize 2@newszilla6.xs4all.nl:119
2015-03-08 10:25:15,169::INFO::[downloader:664] Thread 2@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:25:15,170::INFO::[downloader:381] 3@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:25:15,170::ERROR::[downloader:386] Failed to initialize 3@newszilla6.xs4all.nl:119
2015-03-08 10:25:15,170::INFO::[downloader:664] Thread 3@newszilla6.xs4all.nl:119: failed to initialize
2015-03-08 10:25:15,170::INFO::[downloader:381] 4@newszilla6.xs4all.nl:119: Initiating connection
2015-03-08 10:25:15,170::ERROR::[downloader:386] Failed to initialize 4@newszilla6.xs4all.nl:119

Code: Select all

sander@flappie:~/.sabnzbd/logs$ date
zo mrt  8 10:21:30 CET 2015

Code: Select all

sander@flappie:~/.sabnzbd/logs$ telnet newszilla6.xs4all.nl 119
Trying 2001:888:0:18::119...
Connected to newszilla.ipv6.xs4all.nl.
Escape character is '^]'.
201 dreader37.news.xs4all.nl NNRP Service Ready - newsmaster@xs4all.nl (no posting).
quit
205 Transferred 86 bytes in 0 articles, 0 groups.  Disconnecting.
Connection closed by foreign host.
sander@flappie:~/.sabnzbd/logs$

Re: Failed to initialize connection to IPv6 server

Posted: March 8th, 2015, 5:36 am
by sander
I searched for "Set planned server resume" in my sabnzbd.log's, and this is the result:
in SAB 0.7, "Set planned server resume" does appear for eweka (ipv4), but not for newszilla6 (ipv6)
in SAB 0.8, "Set planned server resume" does occur for both eweka and newszilla6

Is there a difference between 0.7 and 0.8 regarding the detection of failing servers and server resuming?

Code: Select all

$ cat ~/.sabnzbd/logs/sabnzbd.log* | grep  -e resume -e "rev=" | sort

2015-02-13 20:01:19,309::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-14 01:27:51,275::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-14 10:18:58,041::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-15 21:34:35,018::DEBUG::[downloader:734] Set planned server resume newsreader3.eweka.nl in 10 mins
2015-02-15 21:44:35,020::DEBUG::[downloader:745] Trigger planned server resume newsreader3.eweka.nl
2015-02-18 21:25:40,530::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-21 13:03:05,325::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-21 13:13:20,966::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-21 13:14:14,492::DEBUG::[downloader:734] Set planned server resume newsreader3.eweka.nl in 10 mins
2015-02-21 13:24:14,501::DEBUG::[downloader:745] Trigger planned server resume newsreader3.eweka.nl
2015-02-22 18:07:06,972::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-22 18:14:49,327::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-22 20:05:59,932::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-22 23:03:12,291::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-02-23 07:01:15,952::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-03-07 09:42:18,529::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-03-08 10:28:32,396::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-03-08 10:28:34,482::DEBUG::[downloader:734] Set planned server resume newsreader3.eweka.nl in 10 mins
2015-03-08 10:29:23,941::INFO::[sabnzbdplus:1251] sabnzbdplus-0.7.20 (rev=1df2943d05d64915a166e2c97e1eef86f72e3ff3)
2015-03-08 10:54:53,232::INFO::[SABnzbd:1277] SABnzbd.py-0.8.x (rev=unknown)
2015-03-08 10:55:33,169::DEBUG::[downloader:759] Set planned server resume newszilla6.xs4all.nl in 10 mins
2015-03-08 10:56:37,804::INFO::[SABnzbd:1277] SABnzbd.py-0.8.x (rev=unknown)
2015-03-08 10:59:59,129::DEBUG::[downloader:759] Set planned server resume newszilla6.xs4all.nl in 10 mins
2015-03-08 11:02:29,796::DEBUG::[downloader:759] Set planned server resume newsreader3.eweka.nl in 10 mins
2015-03-08 11:02:30,351::DEBUG::[downloader:759] Set planned server resume newsreader3.eweka.nl in 10 mins
2015-03-08 11:09:59,135::DEBUG::[downloader:770] Trigger planned server resume newszilla6.xs4all.nl
2015-03-08 11:12:29,803::DEBUG::[downloader:770] Trigger planned server resume newsreader3.eweka.nl
2015-03-08 11:12:30,352::DEBUG::[downloader:770] Trigger planned server resume newsreader3.eweka.nl
2015-03-08 11:23:39,904::INFO::[SABnzbd:1277] SABnzbd.py-0.8.x (rev=unknown)
2015-03-08 11:23:42,498::DEBUG::[downloader:759] Set planned server resume newsreader3.eweka.nl in 10 mins
2015-03-08 11:24:01,543::INFO::[SABnzbd:1277] SABnzbd.py-0.8.x (rev=unknown)

Re: Failed to initialize connection to IPv6 server

Posted: March 8th, 2015, 3:52 pm
by shypike
sander wrote:
Is there a difference between 0.7 and 0.8 regarding the detection of failing servers and server resuming?
There should not be, but 7 and 8 have been in parallel for too long.
I'll have a look at it.

Re: Failed to initialize connection to IPv6 server

Posted: March 8th, 2015, 4:16 pm
by sander
Does init_connect() set up a real new connection, or does it re-use an existing connection? If it re-uses, it could the connection is already gone 'below its feet'?

Code: Select all

    def init_connect(self, write_fds):
        self.nntp = NNTP(self.server.hostip, self.server.port, self.server.info, self.server.ssl,
                         self.server.ssl_type, self.server.send_group, self,
                         self.server.username, self.server.password, self.blocking, write_fds)
        self.recv = self.nntp.sock.recv

        self.timeout = time.time() + self.server.timeout

Re: Failed to initialize connection to IPv6 server

Posted: March 9th, 2015, 3:07 am
by sander
Another possibility I'll investigate (long shot): I have IPv6 privacy extensions on, resulting in more than 1 IPv6 address. Maybe Python/SAB gets confused by that? Maybe an open connection on one IPv6 session, and trying a session on the another IPv6 address?

I'll turn off privacy extentsions and see what happens.

EDIT:

turned them off in /etc/sysctl.d/10-ipv6-privacy.conf, and now just one IPv6 address on WLAN0. I'll report back if that changes anything
All times are UTC-05:00
Page 1 of 1

Powered by phpBB® Forum Software © phpBB Limited