Service not starting [Windows]

[htou]

Running ver 0.7.11 (win install) as a service on local system.
Win 7 Pro 64bit

Up until today sab has been running flawlessly as a service. Now i cant get the service to start. I've tried starting the service via command line which completes successfully however when i go over to the local services via task manager it says its stopped. When i try to start it from here it says "the operation cannnot be completed, access denied". When i navigate over to Component Services and try to start it from there it tries to start but then fails.

I tried to run the console which loads with the command prompt screen but then quickly disappears. SABnzbd-helper is running as a service also but im not sure what this actually does.

How do i get the sab service running again?

[shypike]

For testing you should use SABnzbd-console.exe and run it from a command prompt.

[htou]

So got the console to run via command prompt which enabled me to log into sab's UI. Is there something i need to switch on in the interface to allow the service to run?

[shypike]

Judging by the error message you got, it looks like there's some access rights problem.
Under which account does the SABnzbd service run?
The SABHelper is needed to restart SABnzbd and it also functions as a watchdog.
SABHelper needs to run under the local system account.

[htou]

I'm going to remove and reinstall the service again and see how that goes.

My first thought was access permissions but I have not altered any settings. Everything has been running fine until today. The sab and helper service runs on the local system.

[shypike]

The sab and helper service runs on the local system.

That does mean that you have no access to external drives,
but I don't suppose you were using those.

[htou]

No external drives.

So I try to do fresh install , deleting everything from Program Files and the user\local\appdata folder. When I install and run sabnzbd I get an error msg saying “error occurred – see the logfile C:Program Files (x86)\SANnzbd\SABnzbd.exe.log" for details. Im sure i have deleted everything, even by running the uninstall.

I can’t find this log file anywhere. My original issue has mutated into something worse. Anyone got ideas. PS. I removed sab and helper as a service prior to uninstalling.

[shypike]

The log file should be where the -f parameter said it should be.
Maybe you should add -l2 to the service parameters.
(That's minus el two)
What are your current service parameters?

[htou]

Post reinstalling sab I didn't try to "install" the service.

I thought I would first test whether I could get to the UI as you would normally do and that's when I get the above error. I'll ignore the error and start the services and set the parameters as advised. Previously I had used the -f parameter for the service install.

I have a OS image from 2 weeks ago that i can load up if it gets too much.

[shypike]

The log file is your local profile. AppData\local\SABnzbd\logs
Alternatively you can start SABnzbd-console.exe instead from a command prompt.

[htou]

Reimaging didnt work

My log after running the console. I have a feeling i have screwed everything up beyond repair trying to troubleshoot my issue.

Code: Select all

C:\Program Files (x86)\SABnzbd>SABnzbd-service.exe -f -l2 F:\Sabnzbd\sabnzbd.ini
 --server myipaddress:8080 install

C:\Program Files (x86)\SABnzbd>SABnzbd-console.exe
2013-03-25 00:10:39,134::INFO::[sabnzbd:1257] --------------------------------
2013-03-25 00:10:39,135::INFO::[sabnzbd:1258] SABnzbd-console.exe-0.7.3 (rev=e24
aedc6acf1e477887a115b9a423838bdb19172)
2013-03-25 00:10:39,203::INFO::[sabnzbd:1266] Platform=Windows-Vista-6.1.7601-SP
1 (=Vista+ x64) Class=nt
2013-03-25 00:10:39,203::INFO::[sabnzbd:1271] Python-version = 2.5.5 (r255:77872
, Jan 31 2010, 15:49:35) [MSC v.1310 32 bit (Intel)]
2013-03-25 00:10:39,204::INFO::[sabnzbd:1272] Arguments = SABnzbd-console.exe
2013-03-25 00:10:39,204::INFO::[sabnzbd:1285] Read INI file C:\Program Files (x8
6)\SABnzbd\sabnzbd.ini
2013-03-25 00:10:39,207::INFO::[__init__:919] Loading data for bookmarks.sab fro
m C:\Program Files (x86)\SABnzbd\admin\bookmarks.sab
2013-03-25 00:10:39,207::INFO::[__init__:922] C:\Program Files (x86)\SABnzbd\adm
in\bookmarks.sab missing, trying old cache
2013-03-25 00:10:39,209::INFO::[__init__:925] C:\Program Files (x86)\SABnzbd\cac
he\bookmarks.sab missing
2013-03-25 00:10:39,210::INFO::[__init__:919] Loading data for rss_data.sab from
 C:\Program Files (x86)\SABnzbd\admin\rss_data.sab
2013-03-25 00:10:39,210::INFO::[__init__:922] C:\Program Files (x86)\SABnzbd\adm
in\rss_data.sab missing, trying old cache
2013-03-25 00:10:39,210::INFO::[__init__:925] C:\Program Files (x86)\SABnzbd\cac
he\rss_data.sab missing
2013-03-25 00:10:39,211::INFO::[__init__:919] Loading data for totals9.sab from
C:\Program Files (x86)\SABnzbd\admin\totals9.sab
2013-03-25 00:10:39,213::INFO::[__init__:922] C:\Program Files (x86)\SABnzbd\adm
in\totals9.sab missing, trying old cache
2013-03-25 00:10:39,213::INFO::[__init__:925] C:\Program Files (x86)\SABnzbd\cac
he\totals9.sab missing
2013-03-25 00:10:39,226::INFO::[postproc:90] Loading postproc queue
2013-03-25 00:10:39,227::INFO::[__init__:919] Loading data for postproc1.sab fro
m C:\Program Files (x86)\SABnzbd\admin\postproc1.sab
2013-03-25 00:10:39,229::INFO::[__init__:922] C:\Program Files (x86)\SABnzbd\adm
in\postproc1.sab missing, trying old cache
2013-03-25 00:10:39,229::INFO::[__init__:925] C:\Program Files (x86)\SABnzbd\cac
he\postproc1.sab missing
2013-03-25 00:10:39,230::INFO::[__init__:919] Loading data for queue9.sab from C
:\Program Files (x86)\SABnzbd\admin\queue9.sab
2013-03-25 00:10:39,230::INFO::[__init__:922] C:\Program Files (x86)\SABnzbd\adm
in\queue9.sab missing, trying old cache
2013-03-25 00:10:39,232::INFO::[__init__:925] C:\Program Files (x86)\SABnzbd\cac
he\queue9.sab missing
2013-03-25 00:10:39,233::INFO::[__init__:919] Loading data for watched_data.sab
from C:\Program Files (x86)\SABnzbd\admin\watched_data.sab
2013-03-25 00:10:39,233::INFO::[__init__:922] C:\Program Files (x86)\SABnzbd\adm
in\watched_data.sab missing, trying old cache
2013-03-25 00:10:39,234::INFO::[__init__:925] C:\Program Files (x86)\SABnzbd\cac
he\watched_data.sab missing
2013-03-25 00:10:39,236::INFO::[downloader:208] Resuming
2013-03-25 00:10:39,236::INFO::[__init__:318] All processes started
2013-03-25 00:10:39,237::INFO::[sabnzbd:333] Web dir is C:\Program Files (x86)\S
ABnzbd\interfaces\Plush
2013-03-25 00:10:39,240::INFO::[sabnzbd:333] Web dir is C:\Program Files (x86)\S
ABnzbd\interfaces\Config
2013-03-25 00:10:39,272::INFO::[sabnzbd:462] _yenc module... found!
2013-03-25 00:10:39,275::INFO::[sabnzbd:470] par2 binary... found (C:\Program Fi
les (x86)\SABnzbd\win\par2\x64\par2.exe)
2013-03-25 00:10:39,276::INFO::[sabnzbd:475] par2-classic binary... found (C:\Pr
ogram Files (x86)\SABnzbd\win\par2\par2-classic.exe)
2013-03-25 00:10:39,276::INFO::[sabnzbd:478] unrar binary... found (C:\Program F
iles (x86)\SABnzbd\win\unrar\x64\UnRAR.exe)
2013-03-25 00:10:39,276::INFO::[sabnzbd:483] unzip binary... found (C:\Program F
iles (x86)\SABnzbd\win\unzip\unzip.exe)
2013-03-25 00:10:39,296::INFO::[sabnzbd:498] pyOpenSSL... found (True)
2013-03-25 00:10:39,305::INFO::[sabnzbd:1468] Starting web-interface on myipaddress:8080
2013-03-25 00:10:40,308::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 STARTING
2013-03-25 00:10:40,316::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Sta
rted monitor thread '_TimeoutMonitor'.
2013-03-25 00:10:40,420::ERROR::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Er
ror 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")

2013-03-25 00:10:40,421::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 STOPPING
2013-03-25 00:10:40,423::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE HTT
P Server cherrypy._cpwsgi_server.CPWSGIServer(('myipaddress', 8080)) already s
hut down
2013-03-25 00:10:40,428::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Sto
pped thread '_TimeoutMonitor'.
2013-03-25 00:10:40,430::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 STOPPED
2013-03-25 00:10:40,430::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 EXITING
2013-03-25 00:10:40,431::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 EXITED
Exception in thread HTTPServer Thread-10:
Traceback (most recent call last):
  File "threading.pyo", line 488, in __bootstrap_inner
  File "threading.pyo", line 448, in run
  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")

2013-03-25 00:10:40,519::ERROR::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Er
ror in 'start' listener <bound method Server.start of <cherrypy._cpserver.Server
 object at 0x029A1A50>>
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")

2013-03-25 00:10:40,519::ERROR::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Sh
utting 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")

2013-03-25 00:10:40,522::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 STOPPING
2013-03-25 00:10:40,523::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE HTT
P Server cherrypy._cpwsgi_server.CPWSGIServer(('myipaddress', 8080)) already s
hut down
2013-03-25 00:10:40,525::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE No
thread running for _TimeoutMonitor.
2013-03-25 00:10:40,525::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 STOPPED
2013-03-25 00:10:40,526::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 EXITING
2013-03-25 00:10:40,526::INFO::[_cplogging:55] [25/Mar/2013:00:10:40] ENGINE Bus
 EXITED
2013-03-25 00:10:40,528::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")
2013-03-25 00:10:40,529::ERROR::[sabnzbd:302] Failed to start web-interface :
2013-03-25 00:10:40,530::INFO::[__init__:359] SABnzbd shutting down...
2013-03-25 00:10:40,532::INFO::[__init__:895] Saving data for bookmarks.sab in C
:\Program Files (x86)\SABnzbd\admin\bookmarks.sab
2013-03-25 00:10:40,535::INFO::[urlgrabber:72] URLGrabber shutting down
2013-03-25 00:10:40,536::INFO::[__init__:895] Saving data for watched_data.sab i
n C:\Program Files (x86)\SABnzbd\admin\watched_data.sab
2013-03-25 00:10:40,536::INFO::[dirscanner:256] Dirscanner shutting down
2013-03-25 00:10:40,540::INFO::[notifier:87] Sending registration to localhost:2
3053
2013-03-25 00:10:41,042::INFO::[postproc:84] Saving postproc queue
2013-03-25 00:10:41,042::INFO::[__init__:895] Saving data for postproc1.sab in C
:\Program Files (x86)\SABnzbd\admin\postproc1.sab
2013-03-25 00:10:41,046::INFO::[nzbqueue:176] Saving queue
2013-03-25 00:10:41,046::INFO::[__init__:895] Saving data for queue9.sab in C:\P
rogram Files (x86)\SABnzbd\admin\queue9.sab
2013-03-25 00:10:41,049::INFO::[__init__:895] Saving data for rss_data.sab in C:
\Program Files (x86)\SABnzbd\admin\rss_data.sab
2013-03-25 00:10:41,051::INFO::[__init__:895] Saving data for bookmarks.sab in C
:\Program Files (x86)\SABnzbd\admin\bookmarks.sab
2013-03-25 00:10:41,052::INFO::[__init__:895] Saving data for watched_data.sab i
n C:\Program Files (x86)\SABnzbd\admin\watched_data.sab
2013-03-25 00:10:41,055::INFO::[postproc:84] Saving postproc queue
2013-03-25 00:10:41,055::INFO::[__init__:895] Saving data for postproc1.sab in C
:\Program Files (x86)\SABnzbd\admin\postproc1.sab
2013-03-25 00:10:41,058::INFO::[__init__:422] All processes stopped

C:\Program Files (x86)\SABnzbd>

[sander]

"error: (10049, "Can't assign requested address")"?

Can you run

sabnzbd-console.exe -s 0.0.0.0:8080

EDIT:

... which is the same as:

sabnzbd-console.exe --server 0.0.0.0:8080

"myipaddress": I cannot think of a situation where filling out something else than 127.0.0.1 or 0.0.0.0 could be useful. Filling out something is 99.999% of the time cause of problems.
My guess is that you have filled out a public IP address, which is not your machine.

[htou]

i originally had sab pointing to a particualr ip address, not one of the defaults. Had issues with the modem yesterday which changed the original ip address sab was pointing too. tried the update and it was downhill from there.

Ive tried the suggested and can now access the UI, thank you sander. I still cannot run sab as a service though. Tried to start the service in safe mode and i get the msg Windows could not start the SABnzbd Binary Newsreader service on Local Computer. Error 1068: the Dependency service or group failed to start. Sab helper was running.

Event viewer -

Code: Select all

Log Name:      Application
Source:        SABnzbd
Date:          25/03/2013 1:54:30 AM
Event ID:      3
Task Category: None
Level:         Error
Keywords:      Classic
User:          N/A
Computer:      hellias-PC
Description:
The instance's SvcRun() method failed 
Traceback (most recent call last):
  File "win32serviceutil.pyo", line 806, in SvcRun
  File "SABnzbd.pyo", line 1684, in SvcDoRun
  File "SABnzbd.pyo", line 1487, in main
  File "SABnzbd.pyo", line 311, in Bail_Out
  File "sabnzbd\misc.pyo", line 692, in exit_sab
IOError: (9, 'Bad file descriptor') 
%2: %3
Event Xml:
<Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">
  <System>
    <Provider Name="SABnzbd" />
    <EventID Qualifiers="49152">3</EventID>
    <Level>2</Level>
    <Task>0</Task>
    <Keywords>0x80000000000000</Keywords>
    <TimeCreated SystemTime="2013-03-24T15:54:30.000000000Z" />
    <EventRecordID>13032</EventRecordID>
    <Channel>Application</Channel>
    <Computer>hellias-PC</Computer>
    <Security />
  </System>
  <EventData>
    <Data>Traceback (most recent call last):
  File "win32serviceutil.pyo", line 806, in SvcRun
  File "SABnzbd.pyo", line 1684, in SvcDoRun
  File "SABnzbd.pyo", line 1487, in main
  File "SABnzbd.pyo", line 311, in Bail_Out
  File "sabnzbd\misc.pyo", line 692, in exit_sab
IOError: (9, 'Bad file descriptor')</Data>
  </EventData>
</Event>

[shypike]

2013-03-25 00:10:39,135::INFO::[sabnzbd:1258] SABnzbd-console.exe-0.7.3 (rev=e24aedc6acf1e477887a115b9a423838bdb19172)

You're still on 0.7.3? We're at 0.7.11 now.

Regarding Sander's advice.
Which host address did you use to setup SABnzbd?
Normally you should be using 0.0.0.0
It is possible to use your local network IP (e.g. 192.168.1.4), but it should always be the same.

BTW: I don't think SABnzbd can work in safe mode.

[htou]

Well I don't know why that version is showing when I specifically downloaded and installed the latest yesterday. It don't know how I would even have access to that version.

I'm going to go fresh install again.

I did use a local ip so that I can acess sab on the WLAN. Is there any advice on running the service? Thanks for the heads up on safe mode, I was trying anything.