Code: Select all
2012-09-19 23:07:30,407::INFO::[_cplogging:55] [19/Sep/2012:23:07:30] ENGINE Bus STARTING
2012-09-19 23:07:30,410::INFO::[_cplogging:55] [19/Sep/2012:23:07:30] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-19 23:07:30,611::INFO::[_cplogging:55] [19/Sep/2012:23:07:30] ENGINE Serving on 192.168.1.150:8086
2012-09-19 23:07:30,611::INFO::[_cplogging:55] [19/Sep/2012:23:07:30] ENGINE Bus STARTED
2012-09-19 23:08:06,170::WARNING::[nzbstuff:684] Invalid NZB file The Green Hornet 2011 BluRay 1080p DTS HDMA AVC REMUX FraMeSToR.nzb, skipping (reason=junk after document element, line=62413)
2012-09-19 23:29:06,153::INFO::[_cplogging:55] [19/Sep/2012:23:29:06] ENGINE Bus STARTING
2012-09-19 23:29:06,154::INFO::[_cplogging:55] [19/Sep/2012:23:29:06] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-19 23:29:06,456::INFO::[_cplogging:55] [19/Sep/2012:23:29:06] ENGINE Serving on 192.168.1.150:8086
2012-09-19 23:29:06,457::INFO::[_cplogging:55] [19/Sep/2012:23:29:06] ENGINE Bus STARTED
2012-09-19 23:29:30,479::WARNING::[nzbstuff:684] Invalid NZB file The Green Hornet 2011 BluRay 1080p DTS HDMA AVC REMUX FraMeSToR.nzb, skipping (reason=junk after document element, line=62413)
2012-09-20 11:40:54,530::INFO::[_cplogging:55] [20/Sep/2012:11:40:54] ENGINE Bus STARTING
2012-09-20 11:40:54,628::INFO::[_cplogging:55] [20/Sep/2012:11:40:54] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-20 11:40:54,927::INFO::[_cplogging:55] [20/Sep/2012:11:40:54] ENGINE Serving on 192.168.1.150:8086
2012-09-20 11:40:54,928::INFO::[_cplogging:55] [20/Sep/2012:11:40:54] ENGINE Bus STARTED
2012-09-20 11:42:00,194::WARNING::[nzbstuff:684] Invalid NZB file The Green Hornet 2011 BluRay 1080p DTS HDMA AVC REMUX FraMeSToR.nzb, skipping (reason=junk after document element, line=62413)
2012-09-22 10:42:21,670::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus STARTING
2012-09-22 10:42:21,676::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-22 10:42:21,776::ERROR::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Error in HTTP server: shutting down
Traceback (most recent call last):
File "cherrypy\process\servers.pyo", line 75, in _start_http_thread
File "cherrypy\wsgiserver\__init__.pyo", line 1644, in start
error: (10049, "Can't assign requested address")
2012-09-22 10:42:21,786::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus STOPPING
2012-09-22 10:42:21,786::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('192.168.1.150', 8086)) already shut down
2012-09-22 10:42:21,789::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Stopped thread '_TimeoutMonitor'.
2012-09-22 10:42:21,789::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus STOPPED
2012-09-22 10:42:21,789::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus EXITING
2012-09-22 10:42:21,789::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus EXITED
2012-09-22 10:42:21,875::ERROR::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Error in 'start' listener <bound method Server.start of <cherrypy._cpserver.Server object at 0x0290BB50>>
Traceback (most recent call last):
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:42:21,875::ERROR::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Shutting down due to error in start listener:
Traceback (most recent call last):
File "cherrypy\process\wspbus.pyo", line 184, in start
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:42:21,875::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus STOPPING
2012-09-22 10:42:21,875::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('192.168.1.150', 8086)) already shut down
2012-09-22 10:42:21,875::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE No thread running for _TimeoutMonitor.
2012-09-22 10:42:21,875::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus STOPPED
2012-09-22 10:42:21,875::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus EXITING
2012-09-22 10:42:21,875::INFO::[_cplogging:55] [22/Sep/2012:10:42:21] ENGINE Bus EXITED
2012-09-22 10:42:21,877::ERROR::[sabnzbd:1486] Failed to start web-interface:
Traceback (most recent call last):
File "SABnzbd.py", line 1475, in main
File "cherrypy\process\wspbus.pyo", line 184, in start
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:42:21,877::ERROR::[sabnzbd:302] Failed to start web-interface :
2012-09-22 10:45:29,987::INFO::[_cplogging:55] [22/Sep/2012:10:45:29] ENGINE Bus STARTING
2012-09-22 10:45:29,990::INFO::[_cplogging:55] [22/Sep/2012:10:45:29] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-22 10:45:30,091::ERROR::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Error in HTTP server: shutting down
Traceback (most recent call last):
File "cherrypy\process\servers.pyo", line 75, in _start_http_thread
File "cherrypy\wsgiserver\__init__.pyo", line 1644, in start
error: (10049, "Can't assign requested address")
2012-09-22 10:45:30,092::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus STOPPING
2012-09-22 10:45:30,092::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('192.168.1.150', 8086)) already shut down
2012-09-22 10:45:30,102::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Stopped thread '_TimeoutMonitor'.
2012-09-22 10:45:30,102::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus STOPPED
2012-09-22 10:45:30,102::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus EXITING
2012-09-22 10:45:30,102::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus EXITED
2012-09-22 10:45:30,190::ERROR::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Error in 'start' listener <bound method Server.start of <cherrypy._cpserver.Server object at 0x029DBB50>>
Traceback (most recent call last):
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:45:30,190::ERROR::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Shutting down due to error in start listener:
Traceback (most recent call last):
File "cherrypy\process\wspbus.pyo", line 184, in start
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:45:30,190::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus STOPPING
2012-09-22 10:45:30,190::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('192.168.1.150', 8086)) already shut down
2012-09-22 10:45:30,190::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE No thread running for _TimeoutMonitor.
2012-09-22 10:45:30,190::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus STOPPED
2012-09-22 10:45:30,190::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus EXITING
2012-09-22 10:45:30,191::INFO::[_cplogging:55] [22/Sep/2012:10:45:30] ENGINE Bus EXITED
2012-09-22 10:45:30,191::ERROR::[sabnzbd:1486] Failed to start web-interface:
Traceback (most recent call last):
File "SABnzbd.py", line 1475, in main
File "cherrypy\process\wspbus.pyo", line 184, in start
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:45:30,191::ERROR::[sabnzbd:302] Failed to start web-interface :
2012-09-22 10:47:31,043::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus STARTING
2012-09-22 10:47:31,046::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-22 10:47:31,148::ERROR::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Error in HTTP server: shutting down
Traceback (most recent call last):
File "cherrypy\process\servers.pyo", line 75, in _start_http_thread
File "cherrypy\wsgiserver\__init__.pyo", line 1644, in start
error: (10049, "Can't assign requested address")
2012-09-22 10:47:31,148::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus STOPPING
2012-09-22 10:47:31,148::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('192.168.1.150', 8086)) already shut down
2012-09-22 10:47:31,158::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Stopped thread '_TimeoutMonitor'.
2012-09-22 10:47:31,158::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus STOPPED
2012-09-22 10:47:31,158::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus EXITING
2012-09-22 10:47:31,158::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus EXITED
2012-09-22 10:47:31,246::ERROR::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Error in 'start' listener <bound method Server.start of <cherrypy._cpserver.Server object at 0x028DDB30>>
Traceback (most recent call last):
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:47:31,246::ERROR::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Shutting down due to error in start listener:
Traceback (most recent call last):
File "cherrypy\process\wspbus.pyo", line 184, in start
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:47:31,246::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus STOPPING
2012-09-22 10:47:31,246::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('192.168.1.150', 8086)) already shut down
2012-09-22 10:47:31,246::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE No thread running for _TimeoutMonitor.
2012-09-22 10:47:31,246::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus STOPPED
2012-09-22 10:47:31,247::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus EXITING
2012-09-22 10:47:31,247::INFO::[_cplogging:55] [22/Sep/2012:10:47:31] ENGINE Bus EXITED
2012-09-22 10:47:31,247::ERROR::[sabnzbd:1486] Failed to start web-interface:
Traceback (most recent call last):
File "SABnzbd.py", line 1475, in main
File "cherrypy\process\wspbus.pyo", line 184, in start
File "cherrypy\process\wspbus.pyo", line 147, in publish
File "cherrypy\_cpserver.pyo", line 90, in start
File "cherrypy\process\servers.pyo", line 62, in start
File "cherrypy\process\servers.pyo", line 97, in wait
error: (10049, "Can't assign requested address")
2012-09-22 10:47:31,247::ERROR::[sabnzbd:302] Failed to start web-interface :
2012-09-22 10:54:48,525::INFO::[_cplogging:55] [22/Sep/2012:10:54:48] ENGINE Bus STARTING
2012-09-22 10:54:48,526::INFO::[_cplogging:55] [22/Sep/2012:10:54:48] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-22 10:54:48,727::INFO::[_cplogging:55] [22/Sep/2012:10:54:48] ENGINE Serving on 192.168.1.150:8086
2012-09-22 10:54:48,729::INFO::[_cplogging:55] [22/Sep/2012:10:54:48] ENGINE Bus STARTED
2012-09-22 10:58:42,446::INFO::[_cplogging:55] [22/Sep/2012:10:58:42] ENGINE Bus STARTING
2012-09-22 10:58:42,447::INFO::[_cplogging:55] [22/Sep/2012:10:58:42] ENGINE Started monitor thread '_TimeoutMonitor'.
2012-09-22 10:58:42,648::INFO::[_cplogging:55] [22/Sep/2012:10:58:42] ENGINE Serving on 192.168.1.150:8086
2012-09-22 10:58:42,650::INFO::[_cplogging:55] [22/Sep/2012:10:58:42] ENGINE Bus STARTED
2012-09-22 11:08:14,388::DEBUG::[bpsmeter:250] bps: 45326.7011818
2012-09-22 11:08:14,443::DEBUG::[decoder:97] Decoding <Article: article=1339721217.33653.22@eu.news.astraweb.com, bytes=793024, partnum=22, art_id=None>
2012-09-22 11:08:16,305::INFO::[downloader:566] Connecting 50@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:16,529::INFO::[downloader:566] Connecting 27@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:17,661::INFO::[downloader:566] Connecting 16@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:17,671::INFO::[downloader:566] Connecting 17@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:19,536::DEBUG::[bpsmeter:250] bps: 28252.4298946
2012-09-22 11:08:22,056::INFO::[downloader:566] Connecting 47@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:22,066::INFO::[downloader:566] Connecting 4@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:23,871::INFO::[downloader:566] Connecting 31@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:23,956::INFO::[downloader:566] Connecting 10@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:24,299::INFO::[downloader:566] Connecting 41@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:24,989::DEBUG::[bpsmeter:250] bps: 14335.9298306
2012-09-22 11:08:24,989::INFO::[downloader:566] Connecting 36@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:26,594::INFO::[downloader:640] Thread 23@us-secure.newsdemon.com:563: timed out
2012-09-22 11:08:28,299::INFO::[downloader:566] Connecting 29@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:29,845::INFO::[downloader:566] Connecting 30@us-secure.newsdemon.com:563 finished
2012-09-22 11:08:29,996::DEBUG::[bpsmeter:250] bps: 41303.3067169
2012-09-22 11:08:30,927::INFO::[downloader:640] Thread 11@us-secure.newsdemon.com:563: timed out
2012-09-22 11:08:31,542::DEBUG::[decoder:97] Decoding <Article: article=1339721217.25687.18@eu.news.astraweb.com, bytes=792960, partnum=18, art_id=None>
2012-09-22 11:08:35,907::DEBUG::[bpsmeter:250] bps: 20713.1716617
2012-09-22 11:08:41,072::DEBUG::[bpsmeter:250] bps: 8447.6332239
2012-09-22 11:08:46,296::DEBUG::[bpsmeter:250] bps: 11128.5553237
2012-09-22 11:08:51,726::DEBUG::[bpsmeter:250] bps: 9389.5497143
2012-09-22 11:08:56,608::INFO::[downloader:640] Thread 25@us-secure.newsdemon.com:563: timed out
2012-09-22 11:08:56,608::INFO::[downloader:640] Thread 35@us-secure.newsdemon.com:563: timed out
2012-09-22 11:08:57,223::DEBUG::[bpsmeter:250] bps: 14970.9111156
2012-09-22 11:08:58,174::INFO::[downloader:640] Thread 21@us-secure.newsdemon.com:563: timed out
2012-09-22 11:08:59,865::INFO::[downloader:640] Thread 5@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:02,615::DEBUG::[bpsmeter:250] bps: 9401.97055639
2012-09-22 11:09:02,779::INFO::[downloader:566] Connecting 14@us-secure.newsdemon.com:563 finished
2012-09-22 11:09:08,040::DEBUG::[bpsmeter:250] bps: 11635.6115193
2012-09-22 11:09:11,515::INFO::[downloader:640] Thread 26@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:13,844::DEBUG::[bpsmeter:250] bps: 8534.91427831
2012-09-22 11:09:16,648::INFO::[downloader:640] Thread 44@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:16,648::INFO::[downloader:640] Thread 45@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:19,239::DEBUG::[bpsmeter:250] bps: 11214.9353464
2012-09-22 11:09:20,667::INFO::[downloader:640] Thread 49@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:23,280::INFO::[downloader:640] Thread 3@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:24,384::DEBUG::[bpsmeter:250] bps: 12534.3788867
2012-09-22 11:09:30,000::DEBUG::[bpsmeter:250] bps: 26399.6134364
2012-09-22 11:09:35,198::DEBUG::[bpsmeter:250] bps: 14854.2072923
2012-09-22 11:09:36,157::INFO::[downloader:640] Thread 32@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:40,213::DEBUG::[bpsmeter:250] bps: 19160.7097315
2012-09-22 11:09:40,717::INFO::[downloader:640] Thread 18@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:43,996::INFO::[downloader:640] Thread 39@us-secure.newsdemon.com:563: timed out
2012-09-22 11:09:45,920::DEBUG::[bpsmeter:250] bps: 13999.0400542
2012-09-22 11:09:51,030::DEBUG::[bpsmeter:250] bps: 6041.57490664
2012-09-22 11:09:56,240::DEBUG::[bpsmeter:250] bps: 6008.78856927
2012-09-22 11:10:01,447::DEBUG::[bpsmeter:250] bps: 4981.95155818
2012-09-22 11:10:01,973::INFO::[downloader:640] Thread 28@us-secure.newsdemon.com:563: timed out
2012-09-22 11:10:01,973::INFO::[newswrapper:223] Failed to connect: (10038, 'Socket operation on non-socket') 28@us-secure.newsdemon.com:563
2012-09-22 11:10:02,973::INFO::[downloader:640] Thread 43@us-secure.newsdemon.com:563: timed out
2012-09-22 11:10:06,974::DEBUG::[bpsmeter:250] bps: 3001.98196233
2012-09-22 11:10:12,032::DEBUG::[bpsmeter:250] bps: 1874.31841099
2012-09-22 11:10:12,244::INFO::[downloader:640] Thread 22@us-secure.newsdemon.com:563: timed out
2012-09-22 11:10:12,246::INFO::[newswrapper:223] Failed to connect: (10038, 'Socket operation on non-socket') 22@us-secure.newsdemon.com:563
2012-09-22 11:10:14,742::DEBUG::[decoder:97] Decoding <Article: article=1339720989.43782.123@eu.news.astraweb.com, bytes=792960, partnum=123, art_id=None>
2012-09-22 11:10:14,743::INFO::[downloader:643] Thread 40@us-secure.newsdemon.com:563: server closed connection
2012-09-22 11:10:16,743::INFO::[downloader:640] Thread 38@us-secure.newsdemon.com:563: timed out
2012-09-22 11:10:17,743::DEBUG::[bpsmeter:250] bps: 2284.13726016
2012-09-22 11:10:20,730::INFO::[downloader:375] 40@us-secure.newsdemon.com:563: Initiating connection
2012-09-22 11:10:22,915::DEBUG::[bpsmeter:250] bps: 4841.8598261
2012-09-22 11:10:26,917::INFO::[downloader:375] 23@us-secure.newsdemon.com:563: Initiating connection
2012-09-22 11:10:27,364::INFO::[downloader:566] Connecting 40@us-secure.newsdemon.com:563 finished
2012-09-22 11:10:27,930::DEBUG::[bpsmeter:250] bps: 1932.13375985
I looked for API calls and didnt seem to find anything that looked like one. This is my first time looking at this LOG so I may be missing something but seeing all those time outs doesnt seem right although you would know better than I. I hope this can shed more light.