Unable to activate SSL. (Port already in use error)

aName · November 2, 2017, 10:01am

Sonarr version (exact version): 2.0.0.4949
OS: Windows 7 x64
Description of issue:
Hello,

I am unable to activate SSL in sonarr.
I followed this page https://github.com/Sonarr/Sonarr/wiki/SSL to do so, but I still can’t start the service after making the changes, so I have to rollback my config file manually every time.
I have set the http port to 8989 and the https port to 8988, but I have an error in Sonarr console telling me that port 8989 is already in use, but I checked and only Sonarr is using this port. When I deactivate SSL the service starts normally.
Did any of you had this error before?

Thanks in advance for your help!

markus101 · November 2, 2017, 1:43pm

Please post the relevant ((trace log)) file (enable trace logging, setup SSL and restart).

aName · November 3, 2017, 8:51am

Thank you for your answer, here is my log file :

17-11-2 22:21:10.4|Debug|ProcessProvider|Found 1 processes with the name: NzbDrone.Console
17-11-2 22:21:10.5|Debug|ProcessProvider| - [6472] NzbDrone.Console
17-11-2 22:21:10.5|Debug|ProcessProvider|Found 0 processes with the name: NzbDrone
17-11-2
 22:21:11.0|Info|MigrationLogger|*** Migrating data 
source=C:\ProgramData\NzbDrone\nzbdrone.db;cache 
size=-10485760;datetimekind=Utc;journal mode=Wal;pooling=True;version=3 
***
17-11-2 22:21:12.0|Debug|MigrationLogger|Took: 00:00:00.9606545
17-11-2
 22:21:12.0|Info|MigrationLogger|*** Migrating data 
source=C:\ProgramData\NzbDrone\logs.db;cache 
size=-10485760;datetimekind=Utc;journal mode=Wal;pooling=True;version=3 
***
17-11-2 22:21:12.1|Debug|MigrationLogger|Took: 00:00:00.0509544
17-11-2 22:21:12.2|Debug|netsh.exe|Starting netsh.exe http show urlacl
17-11-2 22:21:14.1|Debug|netsh.exe|URL Reservations:
17-11-2 22:21:14.1|Debug|netsh.exe|-----------------
17-11-2 22:21:14.2|Debug|netsh.exe|    Reserved URL            : http://*:2869/
17-11-2 22:21:14.2|Debug|netsh.exe|        User: NT AUTHORITY\LOCAL SERVICE
17-11-2 22:21:14.2|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.2|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.2|Debug|netsh.exe|            SDDL: D:(A;;GX;;;LS)
17-11-2 22:21:14.2|Debug|netsh.exe|    Reserved URL            : http://+:80/Temporary_Listen_Addresses/
17-11-2 22:21:14.2|Debug|netsh.exe|        User: \Everyone
17-11-2 22:21:14.3|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.3|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.3|Debug|netsh.exe|            SDDL: D:(A;;GX;;;WD)
17-11-2 22:21:14.3|Debug|netsh.exe|    Reserved URL            : http://+:80/116B50EB-ECE2-41ac-8429-9F9E963361B7/
17-11-2 22:21:14.3|Debug|netsh.exe|        User: NT AUTHORITY\NETWORK SERVICE
17-11-2 22:21:14.3|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.3|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.4|Debug|netsh.exe|            SDDL: D:(A;;GX;;;NS)
17-11-2 22:21:14.4|Debug|netsh.exe|    Reserved URL            : https://+:443/C574AC30-5794-4AEE-B1BB-6651C5315029/
17-11-2 22:21:14.4|Debug|netsh.exe|        User: NT AUTHORITY\NETWORK SERVICE
17-11-2 22:21:14.4|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.4|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.4|Debug|netsh.exe|            SDDL: D:(A;;GX;;;NS)
17-11-2 22:21:14.4|Debug|netsh.exe|    Reserved URL            : http://*:5357/
17-11-2 22:21:14.5|Debug|netsh.exe|        User: BUILTIN\Users
17-11-2 22:21:14.5|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.5|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.5|Debug|netsh.exe|        User: NT AUTHORITY\LOCAL SERVICE
17-11-2 22:21:14.5|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.5|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.5|Debug|netsh.exe|            SDDL: D:(A;;GX;;;BU)(A;;GX;;;LS)
17-11-2 22:21:14.6|Debug|netsh.exe|    Reserved URL            : https://*:5358/
17-11-2 22:21:14.6|Debug|netsh.exe|        User: BUILTIN\Users
17-11-2 22:21:14.6|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.6|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.7|Debug|netsh.exe|        User: NT AUTHORITY\LOCAL SERVICE
17-11-2 22:21:14.7|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.7|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.7|Debug|netsh.exe|            SDDL: D:(A;;GX;;;BU)(A;;GX;;;LS)
17-11-2 22:21:14.7|Debug|netsh.exe|    Reserved URL            : https://+:443/sra_{BA195980-CD49-458b-9E23-C84EE0ADCD75}/
17-11-2 22:21:14.7|Debug|netsh.exe|        User: NT SERVICE\SstpSvc
17-11-2 22:21:14.7|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.8|Debug|netsh.exe|            Delegate: Yes
17-11-2 22:21:14.8|Debug|netsh.exe|        User: BUILTIN\Administrators
17-11-2 22:21:14.8|Debug|netsh.exe|            Listen: No
17-11-2 22:21:14.8|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.8|Debug|netsh.exe|        User: NT AUTHORITY\SYSTEM
17-11-2 22:21:14.8|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.9|Debug|netsh.exe|            Delegate: Yes
17-11-2
 22:21:14.9|Debug|netsh.exe|            SDDL: 
D:(A;;GA;;;S-1-5-80-3435701886-799518250-3791383489-3228296122-2938884314)(A;;GR;;;BA)(A;;GA;;;SY)
17-11-2 22:21:14.9|Debug|netsh.exe|    Reserved URL            : https://+:4094/v1/
17-11-2 22:21:14.9|Debug|netsh.exe|        User: \Everyone
17-11-2 22:21:14.9|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:14.9|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:14.9|Debug|netsh.exe|            SDDL: D:(A;;GX;;;WD)
17-11-2 22:21:15.0|Debug|netsh.exe|    Reserved URL            : http://*:7878/
17-11-2 22:21:15.0|Debug|netsh.exe|        User: \Everyone
17-11-2 22:21:15.0|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.0|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:15.0|Debug|netsh.exe|            SDDL: D:(A;;GX;;;WD)
17-11-2 22:21:15.0|Debug|netsh.exe|    Reserved URL            : http://*:9117/
17-11-2 22:21:15.0|Debug|netsh.exe|        User: \Everyone
17-11-2 22:21:15.1|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.1|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:15.1|Debug|netsh.exe|            SDDL: D:(A;;GX;;;WD)
17-11-2 22:21:15.1|Debug|netsh.exe|    Reserved URL            : http://*:8988/
17-11-2 22:21:15.1|Debug|netsh.exe|        User: \Everyone
17-11-2 22:21:15.1|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.2|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:15.2|Debug|netsh.exe|            SDDL: D:(A;;GX;;;WD)
17-11-2 22:21:15.2|Debug|netsh.exe|    Reserved URL            : http://*:8989/
17-11-2 22:21:15.2|Debug|netsh.exe|        User: \Everyone
17-11-2 22:21:15.2|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.2|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:15.2|Debug|netsh.exe|            SDDL: D:(A;;GX;;;WD)
17-11-2 22:21:15.3|Debug|netsh.exe|    Reserved URL            : http://+:47001/wsman/
17-11-2 22:21:15.3|Debug|netsh.exe|        User: NT SERVICE\WinRM
17-11-2 22:21:15.3|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.3|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:15.3|Debug|netsh.exe|        User: NT SERVICE\Wecsvc
17-11-2 22:21:15.3|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.4|Debug|netsh.exe|            Delegate: No
17-11-2
 22:21:15.4|Debug|netsh.exe|            SDDL: 
D:(A;;GX;;;S-1-5-80-569256582-2953403351-2909559716-1301513147-412116970)(A;;GX;;;S-1-5-80-4059739203-877974739-1245631912-527174227-2996563517)
17-11-2 22:21:15.4|Debug|netsh.exe|    Reserved URL            : http://+:5985/wsman/
17-11-2 22:21:15.4|Debug|netsh.exe|        User: NT SERVICE\WinRM
17-11-2 22:21:15.4|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.4|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:15.5|Debug|netsh.exe|        User: NT SERVICE\Wecsvc
17-11-2 22:21:15.5|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.5|Debug|netsh.exe|            Delegate: No
17-11-2
 22:21:15.5|Debug|netsh.exe|            SDDL: 
D:(A;;GX;;;S-1-5-80-569256582-2953403351-2909559716-1301513147-412116970)(A;;GX;;;S-1-5-80-4059739203-877974739-1245631912-527174227-2996563517)
17-11-2 22:21:15.5|Debug|netsh.exe|    Reserved URL            : https://+:5986/wsman/
17-11-2 22:21:15.5|Debug|netsh.exe|        User: NT SERVICE\WinRM
17-11-2 22:21:15.6|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.6|Debug|netsh.exe|            Delegate: No
17-11-2 22:21:15.6|Debug|netsh.exe|        User: NT SERVICE\Wecsvc
17-11-2 22:21:15.6|Debug|netsh.exe|            Listen: Yes
17-11-2 22:21:15.6|Debug|netsh.exe|            Delegate: No
17-11-2
 22:21:15.6|Debug|netsh.exe|            SDDL: 
D:(A;;GX;;;S-1-5-80-569256582-2953403351-2909559716-1301513147-412116970)(A;;GX;;;S-1-5-80-4059739203-877974739-1245631912-527174227-2996563517)
17-11-2 22:21:15.7|Info|Router|Application mode: Service
17-11-2 22:21:15.7|Debug|Router|Service selected
17-11-2 22:21:16.1|Debug|netsh.exe|Starting netsh.exe http show sslcert ipport=0.0.0.0:8988
17-11-2 22:21:16.6|Debug|netsh.exe|SSL Certificate bindings:
17-11-2 22:21:16.7|Debug|netsh.exe|-------------------------
17-11-2 22:21:16.7|Debug|netsh.exe|    IP:port                 : 0.0.0.0:8988
17-11-2 22:21:16.7|Debug|netsh.exe|    Certificate Hash        : 514308da2be8aab378c2642e85008da101f31acc
17-11-2 22:21:16.7|Debug|netsh.exe|    Application ID          : {c2172af4-f9a6-4d91-baee-c2e4ee680613}
17-11-2 22:21:16.7|Debug|netsh.exe|    Certificate Store Name  : (null)
17-11-2 22:21:16.7|Debug|netsh.exe|    Verify Client Certificate Revocation    : Enabled
17-11-2 22:21:16.8|Debug|netsh.exe|    Verify Revocation Using Cached Client Certificate Only    : Disabled
17-11-2 22:21:16.8|Debug|netsh.exe|    Usage Check    : Enabled
17-11-2 22:21:16.8|Debug|netsh.exe|    Revocation Freshness Time : 0
17-11-2 22:21:16.8|Debug|netsh.exe|    URL Retrieval Timeout   : 0
17-11-2 22:21:16.8|Debug|netsh.exe|    Ctl Identifier          : (null)
17-11-2 22:21:16.8|Debug|netsh.exe|    Ctl Store Name          : (null)
17-11-2 22:21:16.9|Debug|netsh.exe|    DS Mapper Usage    : Disabled
17-11-2 22:21:16.9|Debug|netsh.exe|    Negotiate Client Certificate    : Disabled
17-11-2 22:21:16.9|Debug|netsh.exe|Starting netsh.exe http add urlacl https://*:8988/ sddl=D:(A;;GX;;;S-1-1-0)
17-11-2 22:21:17.1|Debug|netsh.exe|Url reservation add failed, Error: 183
17-11-2 22:21:17.1|Debug|netsh.exe|Cannot create a file when that file already exists.
17-11-2 22:21:17.1|Info|OwinHostController|Listening on the following URLs:
17-11-2 22:21:17.1|Info|OwinHostController|  http://*:8989/
17-11-2 22:21:17.2|Info|OwinHostController|  https://*:8988/
17-11-2 22:21:17.7|Debug|OwinAppFactory|Attaching NzbDroneVersionMiddleWare to host
17-11-2 22:21:17.7|Debug|OwinAppFactory|Attaching SignalRMiddleWare to host
17-11-2 22:21:17.7|Debug|OwinAppFactory|Attaching NancyMiddleWare to host
17-11-2 22:21:17.9|Info|NancyBootstrapper|Starting Web Server
17-11-2 22:21:18.7|Trace|EventAggregator|Publishing ApplicationStartedEvent
17-11-2 22:21:19.1|Trace|EventAggregator|ApplicationStartedEvent -> QualityDefinitionService
17-11-2 22:21:19.1|Debug|QualityDefinitionService|Setting up default quality config
17-11-2 22:21:19.2|Trace|EventAggregator|ApplicationStartedEvent <- QualityDefinitionService
17-11-2 22:21:19.2|Trace|EventAggregator|ApplicationStartedEvent -> ProgressMessageTarget
17-11-2 22:21:19.3|Trace|EventAggregator|ApplicationStartedEvent <- ProgressMessageTarget
17-11-2 22:21:19.3|Trace|EventAggregator|ApplicationStartedEvent -> ProfileService
17-11-2 22:21:19.3|Trace|Owin|SQLite error (5): database is locked

17-11-2 22:21:19.6|Trace|EventAggregator|ApplicationStartedEvent <- ProfileService
17-11-2 22:21:19.6|Trace|EventAggregator|ApplicationStartedEvent -> NotificationFactory
17-11-2 22:21:19.6|Debug|NotificationFactory|Initializing Providers. Count 20
17-11-2 22:21:19.6|Trace|EventAggregator|ApplicationStartedEvent <- NotificationFactory
17-11-2 22:21:19.7|Trace|EventAggregator|ApplicationStartedEvent -> CommandExecutor
17-11-2 22:21:19.7|Trace|EventAggregator|ApplicationStartedEvent <- CommandExecutor
17-11-2 22:21:19.7|Trace|EventAggregator|ApplicationStartedEvent -> CommandQueueManager
17-11-2 22:21:19.7|Trace|CommandQueueManager|Orphaning incomplete commands
17-11-2 22:21:19.7|Trace|EventAggregator|ApplicationStartedEvent <- CommandQueueManager
17-11-2 22:21:19.7|Trace|EventAggregator|ApplicationStartedEvent -> Scheduler
17-11-2 22:21:19.8|Trace|EventAggregator|ApplicationStartedEvent <- Scheduler
17-11-2 22:21:19.8|Trace|EventAggregator|ApplicationStartedEvent -> TaskManager
17-11-2 22:21:19.8|Trace|ConfigService|Using default config value for 'rsssyncinterval' defaultValue:'15'
17-11-2 22:21:19.8|Trace|ConfigService|Using default config value for 'downloadedepisodesscaninterval' defaultValue:'1'
17-11-2 22:21:19.8|Trace|TaskManager|Initializing jobs. Available: 10 Existing: 10
17-11-2 22:21:20.0|Trace|EventAggregator|ApplicationStartedEvent <- TaskManager
17-11-2 22:21:20.0|Trace|EventAggregator|ApplicationStartedEvent -> IndexerFactory
17-11-2 22:21:20.0|Debug|IndexerFactory|Initializing Providers. Count 12
17-11-2 22:21:20.0|Trace|EventAggregator|ApplicationStartedEvent <- IndexerFactory
17-11-2 22:21:20.0|Trace|EventAggregator|ApplicationStartedEvent -> MetadataFactory
17-11-2 22:21:20.0|Debug|MetadataFactory|Initializing Providers. Count 4
17-11-2 22:21:20.1|Trace|EventAggregator|ApplicationStartedEvent <- MetadataFactory
17-11-2 22:21:20.1|Trace|EventAggregator|ApplicationStartedEvent -> DownloadClientFactory
17-11-2 22:21:20.1|Debug|DownloadClientFactory|Initializing Providers. Count 15
17-11-2 22:21:20.1|Trace|EventAggregator|ApplicationStartedEvent <- DownloadClientFactory
17-11-2 22:21:20.1|Trace|EventAggregator|ApplicationStartedEvent -> UserService
17-11-2 22:21:20.2|Trace|EventAggregator|ApplicationStartedEvent <- UserService
17-11-2 22:21:20.2|Trace|EventAggregator|ApplicationStartedEvent ~> HealthCheckService
17-11-2 22:21:20.2|Trace|EventAggregator|ApplicationStartedEvent ~> ConfigFileProvider
17-11-2 22:21:20.3|Trace|EventAggregator|ApplicationStartedEvent <~ ConfigFileProvider
17-11-2 22:21:20.3|Trace|HttpClient|Req: [GET] http://localhost:8080/gui/token.html
17-11-2 22:21:20.4|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
17-11-2 22:21:20.4|Trace|HttpClient|Res: [GET] http://localhost:8080/gui/token.html: 200.OK (76 ms)
17-11-2
 22:21:20.4|Trace|HttpClient|Response content (121 bytes): 
<html><div id='token' 
style='display:none;'>Fdq0y4KoQ6AuxQOJYeyJ5P4EFPhQNmnzVrWZ5ny_-dwAxH4FJtW9UU-M-1kAAAAA</div></html>
17-11-2 22:21:20.5|Debug|UTorrentProxy|uTorrent authentication succeeded.
17-11-2 22:21:20.5|Trace|HttpClient|Req: [GET] http://localhost:8080/gui/?token=(removed)&list=1
17-11-2 22:21:20.5|Trace|ConfigService|Using default config value for 'proxyenabled' defaultValue:'False'
17-11-2 22:21:20.5|Trace|HttpClient|Res: [GET] http://localhost:8080/gui/?token=(removed)&list=1: 200.OK (15 ms)
17-11-2 22:21:20.5|Trace|HttpClient|Response content (1853 bytes): {"build":41866,"torrents": [

aName · November 6, 2017, 9:15am

Hi,
I finally got SSL to work on port 8990.
For some reason port 8988 was system reserved, causing the error Url reservation add failed, Error: 183.
So if some of you encounter the same issue, just change the SSL port and it should do just fine!

system · January 5, 2018, 9:15am

This topic was automatically closed 60 days after the last reply. New replies are no longer allowed.