Page 1 of 1

SAB not launching after system update (OSX)

Posted: September 25th, 2014, 5:20 am
by krocko
I installed a couple system updates on my Mac yesterday (OSX 10.9.5 and Safari 7.1 - maybe also xcode 6.0.1, but this might also have been installed earlier), and after rebooting SABnzbd+ no longer works. The icon in the menu bar pops up for about a second, and then disappears without any error.

Error log:

Code: Select all

2014-09-25 12:16:16,746::INFO::[SABnzbd:1255] Console logging for OSX App disabled
2014-09-25 12:16:16,746::INFO::[SABnzbd:1262] --------------------------------
2014-09-25 12:16:16,746::INFO::[SABnzbd:1263] SABnzbd.py-0.7.18 (rev=2d10f879da8f5df418a2afe52923a63fb3bf23b9)
2014-09-25 12:16:16,747::INFO::[SABnzbd:1275] Platform = posix
2014-09-25 12:16:16,747::INFO::[SABnzbd:1276] Python-version = 2.7.2 (default, Oct 11 2012, 20:14:37) 
[GCC 4.2.1 Compatible Apple Clang 4.0 (tags/Apple/clang-418.0.60)]
2014-09-25 12:16:16,747::INFO::[SABnzbd:1277] Arguments = /Applications/SABnzbd.app/Contents/Resources/SABnzbd.py
2014-09-25 12:16:16,747::INFO::[SABnzbd:1300] [osx] IO priority setting
2014-09-25 12:16:16,750::INFO::[SABnzbd:1305] [osx] IO priority set to throttle for process scope
2014-09-25 12:16:16,751::INFO::[SABnzbd:1309] Read INI file /Users/krocko/Library/Application Support/SABnzbd/sabnzbd.ini
2014-09-25 12:16:16,751::INFO::[__init__:941] Loading data for bookmarks.sab from /Users/krocko/Library/Application Support/SABnzbd/admin/bookmarks.sab
2014-09-25 12:16:16,752::INFO::[__init__:941] Loading data for rss_data.sab from /Users/krocko/Library/Application Support/SABnzbd/admin/rss_data.sab
2014-09-25 12:16:16,752::INFO::[__init__:941] Loading data for totals9.sab from /Users/krocko/Library/Application Support/SABnzbd/admin/totals9.sab
2014-09-25 12:16:16,752::INFO::[postproc:91] Loading postproc queue
2014-09-25 12:16:16,752::INFO::[__init__:941] Loading data for postproc1.sab from /Users/krocko/Library/Application Support/SABnzbd/admin/postproc1.sab
2014-09-25 12:16:16,753::INFO::[__init__:941] Loading data for queue9.sab from /Users/krocko/Library/Application Support/SABnzbd/admin/queue9.sab
2014-09-25 12:16:16,753::INFO::[__init__:941] Loading data for watched_data.sab from /Users/krocko/Library/Application Support/SABnzbd/admin/watched_data.sab
2014-09-25 12:16:16,754::INFO::[__init__:941] Loading data for Rating.sab from /Users/krocko/Library/Application Support/SABnzbd/admin/Rating.sab
2014-09-25 12:16:16,754::INFO::[__init__:944] /Users/krocko/Library/Application Support/SABnzbd/admin/Rating.sab missing, trying old cache
2014-09-25 12:16:16,754::INFO::[__init__:947] /Users/krocko/Library/Application Support/SABnzbd/cache/Rating.sab missing
2014-09-25 12:16:16,754::INFO::[scheduler:172] Setting schedule for midnight BPS reset
2014-09-25 12:16:16,755::INFO::[downloader:211] Resuming
2014-09-25 12:16:16,755::INFO::[__init__:333] All processes started
2014-09-25 12:16:16,755::INFO::[SABnzbd:335] Web dir is /Applications/SABnzbd.app/Contents/Resources/interfaces/Plush
2014-09-25 12:16:16,755::INFO::[SABnzbd:335] Web dir is /Applications/SABnzbd.app/Contents/Resources/interfaces/Config
2014-09-25 12:16:16,760::INFO::[SABnzbd:464] _yenc module... found!
2014-09-25 12:16:16,760::INFO::[SABnzbd:472] par2 binary... found (/Applications/SABnzbd.app/Contents/Resources/osx/par2/par2-sl)
2014-09-25 12:16:16,760::INFO::[SABnzbd:480] unrar binary... found (/Applications/SABnzbd.app/Contents/Resources/osx/unrar/unrar)
2014-09-25 12:16:16,760::INFO::[SABnzbd:485] unzip binary... found (/usr/bin/unzip)
2014-09-25 12:16:16,761::INFO::[SABnzbd:491] nice binary... found (/usr/bin/nice)
2014-09-25 12:16:16,761::INFO::[SABnzbd:497] ionice binary... NOT found!
2014-09-25 12:16:16,761::INFO::[SABnzbd:500] pyOpenSSL... found (True)
2014-09-25 12:16:16,763::INFO::[SABnzbd:1510] Starting web-interface on 0.0.0.0:8080
2014-09-25 12:16:16,765::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus STARTING
2014-09-25 12:16:16,767::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Started monitor thread '_TimeoutMonitor'.
2014-09-25 12:16:16,768::ERROR::[_cplogging:55] [25/Sep/2014:12:16:16] 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 1644, in start
error: [Errno 49] Can't assign requested address

2014-09-25 12:16:16,768::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus STOPPING
2014-09-25 12:16:16,769::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE HTTP Server None already shut down
2014-09-25 12:16:16,769::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('fe80::1%lo0', 8080)) already shut down
2014-09-25 12:16:16,771::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Stopped thread '_TimeoutMonitor'.
2014-09-25 12:16:16,771::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus STOPPED
2014-09-25 12:16:16,771::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus EXITING
2014-09-25 12:16:16,771::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus EXITED
2014-09-25 12:16:16,869::ERROR::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Error in 'start' listener <bound method ServerAdapter.start of <cherrypy.process.servers.ServerAdapter object at 0x29351f0>>
Traceback (most recent call last):
  File "cherrypy/process/wspbus.pyc", line 147, in publish
  File "cherrypy/process/servers.pyc", line 62, in start
  File "cherrypy/process/servers.pyc", line 97, in wait
error: [Errno 49] Can't assign requested address

2014-09-25 12:16:16,972::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Serving on 0.0.0.0:8080
2014-09-25 12:16:16,972::ERROR::[_cplogging:55] [25/Sep/2014:12:16:16] 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/process/servers.pyc", line 62, in start
  File "cherrypy/process/servers.pyc", line 97, in wait
error: [Errno 49] Can't assign requested address

2014-09-25 12:16:16,973::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus STOPPING
2014-09-25 12:16:16,975::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('0.0.0.0', 8080)) shut down
2014-09-25 12:16:16,975::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('fe80::1%lo0', 8080)) already shut down
2014-09-25 12:16:16,976::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE No thread running for _TimeoutMonitor.
2014-09-25 12:16:16,976::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus STOPPED
2014-09-25 12:16:16,976::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus EXITING
2014-09-25 12:16:16,976::INFO::[_cplogging:55] [25/Sep/2014:12:16:16] ENGINE Bus EXITED
2014-09-25 12:16:16,976::ERROR::[SABnzbd:1525] Failed to start web-interface: 
Traceback (most recent call last):
  File "/Applications/SABnzbd.app/Contents/Resources/SABnzbd.py", line 1517, in main
  File "cherrypy/process/wspbus.pyc", line 184, in start
  File "cherrypy/process/wspbus.pyc", line 147, in publish
  File "cherrypy/process/servers.pyc", line 62, in start
  File "cherrypy/process/servers.pyc", line 97, in wait
error: [Errno 49] Can't assign requested address
2014-09-25 12:16:16,976::ERROR::[SABnzbd:304] Failed to start web-interface : [Errno 49] Can't assign requested address
2014-09-25 12:16:16,977::INFO::[__init__:371] SABnzbd shutting down...
2014-09-25 12:16:16,977::INFO::[__init__:917] Saving data for bookmarks.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/bookmarks.sab
2014-09-25 12:16:17,177::INFO::[urlgrabber:72] URLGrabber shutting down
2014-09-25 12:16:17,178::INFO::[__init__:917] Saving data for watched_data.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/watched_data.sab
2014-09-25 12:16:17,379::INFO::[dirscanner:270] Dirscanner shutting down
2014-09-25 12:16:17,379::INFO::[postproc:85] Saving postproc queue
2014-09-25 12:16:17,380::INFO::[__init__:917] Saving data for postproc1.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/postproc1.sab
2014-09-25 12:16:17,580::INFO::[nzbqueue:214] Saving queue
2014-09-25 12:16:17,581::INFO::[__init__:917] Saving data for queue9.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/queue9.sab
2014-09-25 12:16:17,582::INFO::[__init__:917] Saving data for totals9.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/totals9.sab
2014-09-25 12:16:17,582::INFO::[__init__:917] Saving data for rss_data.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/rss_data.sab
2014-09-25 12:16:17,583::INFO::[__init__:917] Saving data for bookmarks.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/bookmarks.sab
2014-09-25 12:16:17,583::INFO::[__init__:917] Saving data for watched_data.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/watched_data.sab
2014-09-25 12:16:17,583::INFO::[postproc:85] Saving postproc queue
2014-09-25 12:16:17,583::INFO::[__init__:917] Saving data for postproc1.sab in /Users/krocko/Library/Application Support/SABnzbd/admin/postproc1.sab
2014-09-25 12:16:17,584::INFO::[__init__:438] All processes stopped
2014-09-25 12:16:17,587::INFO::[osxmenu:762] [osx] application terminating
2014-09-25 12:16:17,594::INFO::[osxmenu:766] [osx] application stopping daemon
2014-09-25 12:16:17,594::INFO::[_cplogging:55] [25/Sep/2014:12:16:17] ENGINE Bus STOPPING
2014-09-25 12:16:17,594::INFO::[_cplogging:55] [25/Sep/2014:12:16:17] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('0.0.0.0', 8080)) already shut down
2014-09-25 12:16:17,595::INFO::[_cplogging:55] [25/Sep/2014:12:16:17] ENGINE HTTP Server cherrypy._cpwsgi_server.CPWSGIServer(('fe80::1%lo0', 8080)) already shut down
2014-09-25 12:16:17,595::INFO::[_cplogging:55] [25/Sep/2014:12:16:17] ENGINE No thread running for _TimeoutMonitor.
2014-09-25 12:16:17,595::INFO::[_cplogging:55] [25/Sep/2014:12:16:17] ENGINE Bus STOPPED
2014-09-25 12:16:17,595::INFO::[_cplogging:55] [25/Sep/2014:12:16:17] ENGINE Bus EXITING
2014-09-25 12:16:17,595::INFO::[_cplogging:55] [25/Sep/2014:12:16:17] ENGINE Bus EXITED
2014-09-25 12:16:17,595::INFO::[osxmenu:775] Leaving SABnzbd
Can anyone make sense of the error log? Any help is greatly appreciated :)

Re: SAB not launching after system update (OSX)

Posted: September 25th, 2014, 5:25 am
by shypike
Yeah, OSX is so great for compatibility, not.
I'll look into the matter.

Re: SAB not launching after system update (OSX)

Posted: September 25th, 2014, 5:41 am
by krocko
shypike wrote:Yeah, OSX is so great for compatibility, not.
I'll look into the matter.
Thanks a lot and sorry for the trouble :)

Re: SAB not launching after system update (OSX)

Posted: September 26th, 2014, 1:50 am
by shypike
krocko wrote: Thanks a lot and sorry for the trouble :)
No problem. The real problem is with Apple and they way they support Python.
We end up with a separate build for each major OSX release.
You currently run a Mountain Lion build on Mavericks, which wasn't a problem before.

Re: SAB not launching after system update (OSX)

Posted: September 26th, 2014, 11:55 am
by shypike
I tested again on both my OSX systems, patched to the latest levels.
All works fine.
There's something wrong with the host address you are using.
Try this from a Utilities->Terminal window:
/Applications/SABnzbd.app/Contents/MacOS/SABnzbd -s 127.0.0.1:8080

Re: SAB not launching after system update (OSX)

Posted: September 27th, 2014, 2:02 am
by krocko
Well that's odd, your fix works great. Even when I change the IP in the line to what I was using previously. Which makes me wonder why it isn't working the normal way. Now I have to leave the terminal open, which is no biggie, but still. But thank you so much for getting me back online in no time :) This I can live with!

Re: SAB not launching after system update (OSX)

Posted: September 27th, 2014, 3:39 am
by shypike
The Terminal trick is only needed once.
After that, the new server setting is kept in the sabnzbd.ini file.
You should be able to use the normal way of starting again.

Re: SAB not launching after system update (OSX)

Posted: September 28th, 2014, 5:33 am
by krocko
Well what do you know, everything is super dandy again :) Thanks again so so much! And sorry for the troubles.