SABnzbd Forums

hi. I installed one of the release candidates and ran into a problem. I downgraded to 4.9.x and it went away.  Now I installed the final version and the problem returns.  When I start up SABNZBd on my mac, it freezes.  A popup growl notification appears that says "Shutting Down", but it never becomes responsive, nor shuts down. Activity monitor shows cpu usage of 30-70%. Any thoughts? Is there a way in one of the config files to stop it from trying to shutdown on startup?


Version: 0.5.0 Final
OS: OSX Snow Leopard
Install-type: OSx .app
Skin (if applicable): Default
Firewall Software: none
Are you using IPV6? no
Is the issue reproducible? yes

Log file output:
2010-02-25 20:22:47,568::INFO::[SABnzbd:938] Console logging for OSX App disabled
2010-02-25 20:22:47,572::INFO::[SABnzbd:945] --------------------------------
2010-02-25 20:22:47,573::INFO::[SABnzbd:946] SABnzbd.py-0.5.0 (rev=3321)
2010-02-25 20:22:47,573::INFO::[SABnzbd:956] Platform = posix
2010-02-25 20:22:47,573::INFO::[SABnzbd:957] Python-version = 2.6.3 (r263:75183, Oct  5 2009, 14:29:08)
[GCC 4.0.1 (Apple Computer, Inc. build 5250)]
2010-02-25 20:22:47,574::INFO::[SABnzbd:961] [osx] IO priority setting
2010-02-25 20:22:47,580::INFO::[SABnzbd:966] [osx] IO priority set to throttle for process scope
2010-02-25 20:22:47,637::INFO::[__init__:664] Loading data for bookmarks.sab from /Users/yargok/Library/Application Support/SABnzbd/cache/bookmarks.sab
2010-02-25 20:22:47,638::INFO::[__init__:695] /Users/yargok/Library/Application Support/SABnzbd/cache/bookmarks.sab removed
2010-02-25 20:22:47,639::INFO::[__init__:664] Loading data for rss_data.sab from /Users/yargok/Library/Application Support/SABnzbd/cache/rss_data.sab
2010-02-25 20:22:47,640::INFO::[__init__:664] Loading data for bytes9.sab from /Users/yargok/Library/Application Support/SABnzbd/cache/bytes9.sab
2010-02-25 20:22:47,641::INFO::[__init__:664] Loading data for queue9.sab from /Users/yargok/Library/Application Support/SABnzbd/cache/queue9.sab
2010-02-25 20:22:47,642::INFO::[postproc:138] Loading postproc queue
2010-02-25 20:22:47,642::INFO::[__init__:664] Loading data for postproc1.sab from /Users/yargok/Library/Application Support/SABnzbd/cache/postproc1.sab
2010-02-25 20:22:47,643::INFO::[__init__:695] /Users/yargok/Library/Application Support/SABnzbd/cache/postproc1.sab removed
2010-02-25 20:22:47,645::INFO::[__init__:664] Loading data for watched_data.sab from /Users/yargok/Library/Application Support/SABnzbd/cache/watched_data.sab
2010-02-25 20:22:47,646::INFO::[downloader:327] Resuming
2010-02-25 20:22:47,669::INFO::[__init__:248] All processes started
2010-02-25 20:22:47,670::INFO::[SABnzbd:265] Web dir is /Applications/SABnzbd.app/Contents/Resources/interfaces/Classic
2010-02-25 20:22:47,687::INFO::[SABnzbd:1010] Starting SABnzbd.py-0.5.0
2010-02-25 20:22:47,711::INFO::[nzbqueue:92] Saving queue
2010-02-25 20:22:47,712::INFO::[__init__:643] Saving data for queue9.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/queue9.sab
2010-02-25 20:22:47,713::INFO::[__init__:643] Saving data for bytes9.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/bytes9.sab
2010-02-25 20:22:47,714::INFO::[__init__:643] Saving data for rss_data.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/rss_data.sab
2010-02-25 20:22:47,721::INFO::[__init__:643] Saving data for bookmarks.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/bookmarks.sab
2010-02-25 20:22:47,722::INFO::[__init__:643] Saving data for watched_data.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/watched_data.sab
2010-02-25 20:22:47,723::INFO::[postproc:133] Saving postproc queue
2010-02-25 20:22:47,725::INFO::[__init__:643] Saving data for postproc1.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/postproc1.sab
2010-02-25 20:22:47,740::INFO::[dirscanner:367] Dirscanner starting up
2010-02-25 20:22:47,741::INFO::[urlgrabber:103] URLGrabber starting up
2010-02-25 20:22:47,741::INFO::[SABnzbd:382] _yenc module... found!
2010-02-25 20:22:47,742::INFO::[SABnzbd:390] par2 binary... found (/Applications/SABnzbd.app/Contents/Resources/osx/par2/par2-sl)
2010-02-25 20:22:47,742::INFO::[SABnzbd:398] unrar binary... found (/Applications/SABnzbd.app/Contents/Resources/osx/unrar/unrar)
2010-02-25 20:22:47,743::INFO::[SABnzbd:403] unzip binary... found (/usr/bin/unzip)
2010-02-25 20:22:47,743::INFO::[SABnzbd:409] nice binary... found (/usr/bin/nice)
2010-02-25 20:22:47,744::INFO::[SABnzbd:415] ionice binary... NOT found!
2010-02-25 20:22:47,744::INFO::[SABnzbd:418] pyOpenSSL... found (True)
2010-02-25 20:22:47,747::INFO::[SABnzbd:1108] Starting web-interface on 0.0.0.0:192
2010-02-25 20:22:47,752::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus STARTING
2010-02-25 20:22:47,757::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Started monitor thread '_TimeoutMonitor'.
2010-02-25 20:22:47,768::ERROR::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Error in HTTP server: shutting down
Traceback (most recent call last):
  File "cherrypy/process/servers.pyc", line 75, in _start_http_thread
  File "cherrypy/wsgiserver/__init__.pyc", line 1629, in start
error: [Errno 13] Permission denied

2010-02-25 20:22:47,769::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus STOPPING
2010-02-25 20:22:47,770::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('0.0.0.0', 192)) already shut down
2010-02-25 20:22:47,771::ERROR::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Error in 'start' listener >
Traceback (most recent call last):
  File "cherrypy/process/wspbus.pyc", line 147, in publish
  File "cherrypy/_cpserver.pyc", line 90, in start
  File "cherrypy/process/servers.pyc", line 62, in start
  File "cherrypy/process/servers.pyc", line 97, in wait
error: [Errno 13] Permission denied

2010-02-25 20:22:47,771::ERROR::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Shutting down due to error in start listener:
Traceback (most recent call last):
  File "cherrypy/process/wspbus.pyc", line 184, in start
  File "cherrypy/process/wspbus.pyc", line 147, in publish
  File "cherrypy/_cpserver.pyc", line 90, in start
  File "cherrypy/process/servers.pyc", line 62, in start
  File "cherrypy/process/servers.pyc", line 97, in wait
error: [Errno 13] Permission denied

2010-02-25 20:22:47,772::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus STOPPING
2010-02-25 20:22:47,772::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('0.0.0.0', 192)) already shut down
2010-02-25 20:22:47,778::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Stopped thread '_TimeoutMonitor'.
2010-02-25 20:22:47,779::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus STOPPED
2010-02-25 20:22:47,779::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus EXITING
2010-02-25 20:22:47,780::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus EXITED
2010-02-25 20:22:47,781::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Stopped thread '_TimeoutMonitor'.
2010-02-25 20:22:47,781::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus STOPPED
2010-02-25 20:22:47,782::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus EXITING
2010-02-25 20:22:47,782::INFO::[_cplogging:55] [25/Feb/2010:20:22:47] ENGINE Bus EXITED
2010-02-25 20:22:47,783::ERROR::[SABnzbd:238] Failed to start web-interface
2010-02-25 20:22:47,783::INFO::[__init__:284] SABnzbd shutting down...
2010-02-25 20:22:47,783::INFO::[__init__:643] Saving data for bookmarks.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/bookmarks.sab
2010-02-25 20:22:47,784::INFO::[urlgrabber:98] URLGrabber shutting down
2010-02-25 20:22:47,786::INFO::[__init__:643] Saving data for watched_data.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/watched_data.sab
2010-02-25 20:22:47,787::INFO::[dirscanner:281] Dirscanner shutting down
2010-02-25 20:22:48,884::INFO::[downloader:483] Shutting down
2010-02-25 20:22:48,885::INFO::[assembler:102] Shutting down
2010-02-25 20:22:48,887::INFO::[postproc:133] Saving postproc queue
2010-02-25 20:22:48,887::INFO::[__init__:643] Saving data for postproc1.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/postproc1.sab
2010-02-25 20:22:48,897::INFO::[nzbqueue:92] Saving queue
2010-02-25 20:22:48,897::INFO::[__init__:643] Saving data for queue9.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/queue9.sab
2010-02-25 20:22:48,898::INFO::[__init__:643] Saving data for bytes9.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/bytes9.sab
2010-02-25 20:22:48,900::INFO::[__init__:643] Saving data for rss_data.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/rss_data.sab
2010-02-25 20:22:48,901::INFO::[__init__:643] Saving data for bookmarks.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/bookmarks.sab
2010-02-25 20:22:48,902::INFO::[__init__:643] Saving data for watched_data.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/watched_data.sab
2010-02-25 20:22:48,903::INFO::[postproc:133] Saving postproc queue
2010-02-25 20:22:48,903::INFO::[__init__:643] Saving data for postproc1.sab in /Users/yargok/Library/Application Support/SABnzbd/cache/postproc1.sab
2010-02-25 20:22:48,904::INFO::[__init__:319] All processes stopped

It looks like the port for the web-ui is not available.
Which one are you using?
Is any other program running and using that port?

Be aware that low port numbers (I think below 8000) are not available for "normal" users.

shypike wrote: It looks like the port for the web-ui is not available.
Which one are you using?
Is any other program running and using that port?

Be aware that low port numbers (I think below 8000) are not available for "normal" users.

I just tried a higher port (default 8080) and that fixed it.  I used port 192 successfully with version 4.9.x.  Weird.  Thanks for the help.

Wow this gets even weirder.  So i changed the port to 8080 in the file located in /Users/yargok/Library/Application Support/SABnzbd and sabnzbd now starts up no problem. BUT it starts up and uses port 192 which is where I had it set in that file previously.  I have another sabnzbd.ini file in /Users/yargok/.sabnzbd which is (i think) what was used with version 4.9.x.  In that file the port number is still 192. 

Before I had this problem, when I first installed the RC, I was accessing sabnzbd on port 192, like i always had.  Then I went through the configuration to make sure all of it was right and noticed (I now remember) that the web interface settings space had said 8080 as the port even though I was connecting to 192.  I clicked reboot after changing the port to 192 and I ran into the crashing problem.

So this might be a bug - it is reading the port from both files? The web interface edits the port in the ini file in the first location, but the port currently in use is in the second.