search

fullphat / snarl

When { stuff_happens(); tell_me() }
http://snarl.fullphat.net
57 stars 2 forks source link

5.0.0 Can't Connect to Settings Through Tray #63

Open LeeThompson opened 5 years ago

LeeThompson commented 5 years ago

New installation of 5.0.0 on a Windows 10 Enterprise machine (tried running it as administrator) it tries to connect to http://localhost:9989/ but nothing is listening on that interface. I have to do http://netbiosname:9989 or full dns name http://host.domain:9989.

LeeThompson commented 5 years ago

If Snarl is not running as administrator the netbiosname/dns name doesn't work and instead I get:

Bad Request - Invalid Hostname HTTP Error 400. The request hostname is invalid.

fullphat commented 5 years ago

Can you get to the console ok if you go to http://127.0.0.1:9989?

LeeThompson commented 5 years ago

No, localhost doesn't work at all (by name or number).

fullphat commented 5 years ago

Ok, leave it with me, I'll do some further testing on a non-admin account. The console relies on what is effectively IIS under the covers and Windows can be a pain. Out of interest, could you change the console port to be 50000 and see if that fixes it?

LeeThompson commented 5 years ago

No change at 50000

LeeThompson commented 5 years ago

One note, I'm not sure if this has any effect on it but more information about my environment:

Windows Server 2008 R2 domain (yeah at home, I'm a dev that uses these technologies so it helps me) My windows user account is a Domain Administrator. (I still need to start snarl with the 'run as admin' option)

The Snarl machine is running Windows 10 Enterprise edition (domain member). Windows firewall is disabled on the LAN (per domain policy). UAC is disabled on the machine (because it annoys me).

(Edited for clarity)

fullphat commented 5 years ago

Which machine is Snarl running on? It shouldn't need to be run as admin, but I have seen issues with it not being able to listen on certain port ranges if it's not running as admin.

LeeThompson commented 5 years ago

It's running on the Windows 10 box (it's my workstation/coding box).

If I don't have 'run as administrator' under compatibility I can't connect to it at all.

fullphat commented 5 years ago

Can you try R5.1 Beta 1 (see #65 for info) and let me know if this is still a problem? I have a Windows 10 Pro machine set up now but I can't replicate the issue...

LeeThompson commented 5 years ago

Tried Snarl 5.1-beta1-en_gb-x64, still busted, have to use

http://machinename:50000
http://machinename.domain:50000

http://localhost:50000 fails (http://127.0.0.1:50000 fails as well)

(Also "help" in Snarl Console is an invalid command)

fullphat commented 5 years ago

Still can't replicate the issue! Just created a brand new non-admin account on my Windows 10 laptop, and installed Snarl fresh.

Selecting "Settings..." from the tray menu opens up Edge with the management console displayed. Url is http://localhost:9989

Do you have some unusual configuration? Is your machine part of a domain?

LeeThompson commented 5 years ago

It is part of a Windows 2008 R2 domain.

fullphat commented 5 years ago

Any GPOs in place that might limit network connectivity?

Oddly, if I try http://machinename:9989, it works fine, but if I then change the management console port to something that hasn't been set to listen on all addresses (e.g. port 40000), then http://machinename:40000 fails with Bad Request: Invalid Hostname.

Is it just Snarl you have this problem with? Are you running any other local web servers that you can try the same tests on?

LeeThompson commented 5 years ago

Not having this issue with anything else, including forwarding and sending events to Snarl.

On the machine I can do telnet localhost 23053 in a non-elevated cmd.exe and get a connection.

The problem seems to be that Snarl's admin is binding to the specific IP address.

netstat result (adjusted slightly for readability):

TCP 0.0.0.0:9731        [Snarl.exe] LISTENING
TCP 0.0.0.0:9887        [Snarl.exe] LISTENING
TCP 0.0.0.0:23053       [Snarl.exe] LISTENING
TCP     192.168.0.22:50000      Access Denied   LISTENING
fullphat commented 5 years ago

By comparison, my Windows 10 laptop shows:

TCP 0.0.0.0:40000 cs20:0 LISTENING

So there is something very different between our setups. Can you send me the debug log? Run snarl.exe --log and send me the .debug file(s) it creates in its directory.

LeeThompson commented 5 years ago

Here's the debug log, please note since this is a public site, I've redacted my exact user profile directory (it is correct in the original log, I've replaced it with %APPDATA% which refers to the same location) and my external IP address.

[2019-05-16 09:54:09.122] -=-=- Snarl logging started -=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-
[2019-05-16 09:54:09.126] bootstrap: Thu, 16 May 2019 16:54:09 GMT
[2019-05-16 09:54:09.126] bootstrap: o/s info follows...
[2019-05-16 09:54:09.126]   platform: Win32NT
[2019-05-16 09:54:09.126]   version: Microsoft Windows NT 6.2.9200.0
[2019-05-16 09:54:09.126]   service pack: 
[2019-05-16 09:54:09.127] ServerInfo set as:
[2019-05-16 09:54:09.127]   Snarl
[2019-05-16 09:54:09.127]   5.1.0.9001
[2019-05-16 09:54:09.127]   48.9
[2019-05-16 09:54:09.127]   Beta 1
[2019-05-16 09:54:09.127] .........................................................
[2019-05-16 09:54:09.127] ::                     server_info                     ::
[2019-05-16 09:54:09.127] `````````````````````````````````````````````````````````
[2019-05-16 09:54:09.128]   release: 5.1.0 Beta 1
[2019-05-16 09:54:09.128]   api:     48
[2019-05-16 09:54:09.128]   sys:     48.9
[2019-05-16 09:54:09.128]   build:   5.1.0 (id=9001)
[2019-05-16 09:54:09.165] bootstrap: initialising settings...
[2019-05-16 09:54:09.166] SysAdminHelper(): no redirect.rc
[2019-05-16 09:54:09.166] SysAdminHelper(): trying from D:\Applications\Snarl\sysadmin.json...
[2019-05-16 09:54:09.169] SysAdminHelper.getSettingsFromPathOrUrl(): "D:\Applications\Snarl\sysadmin.json" assumed to be a path...
Files.ReadTextFromPath(): failed to read from "D:\Applications\Snarl\sysadmin.json": Could not find file 'D:\Applications\Snarl\sysadmin.json'.
[2019-05-16 09:54:09.170] SysAdminHelper.getSettingsFromPathOrUrl(): failed: missing or empty file
[2019-05-16 09:54:09.170] SysAdminHelper(): failed
[2019-05-16 09:54:09.170] SysAdminHelper(): no custom settings found; using defaults...
[2019-05-16 09:54:09.170] EnvironmentManager.loadSettingsFromSysAdmin(): ConfigurationFileUrl:  ""
[2019-05-16 09:54:09.170] EnvironmentManager.loadSettingsFromSysAdmin(): ConfigurationFilePath: ""
[2019-05-16 09:54:09.170] EnvironmentManager.loadSettingsFromSysAdmin(): not loaded
[2019-05-16 09:54:09.170] EnvironmentManager.Start(): using local settings...
[2019-05-16 09:54:09.171] EnvironmentManager.Start(): createLocalSettingsFolderStructure=True
[2019-05-16 09:54:09.171] EnvironmentManager.Start(): _localSettingsFile=%APPDATA%\full phat\snarl 5.0\etc\settings.json
[2019-05-16 09:54:09.294] EnvironmentManager.applySettings(): successfully applied settings
[2019-05-16 09:54:09.294] EnvironmentManager.Start(): loaded ok
[2019-05-16 09:54:09.294] EnvironmentManager.Start(): config file version: 48
[2019-05-16 09:54:09.294] .........................................................
[2019-05-16 09:54:09.294] ::                     environment                     ::
[2019-05-16 09:54:09.294] `````````````````````````````````````````````````````````
[2019-05-16 09:54:09.294]   Upgrading:             False
[2019-05-16 09:54:09.295]   SettingsAreReadOnly:   False
[2019-05-16 09:54:09.295]   PreviousConfigVersion: 0
[2019-05-16 09:54:09.295]   UsingFreshConfig:      False
[2019-05-16 09:54:09.295]   LocalSettingsFile:     %APPDATA%\full phat\snarl 5.0\etc\settings.json
[2019-05-16 09:54:09.295] bootstrap: starting UI...
[2019-05-16 09:54:09.311] bootstrap: starting management server on '*:50000'...
[2019-05-16 09:54:09.311] ManagementConsoleServer.StartManagementServer(): using http for management server...
[2019-05-16 09:54:09.318] bootstrap: management server started!
[2019-05-16 09:54:09.318] bootstrap: starting SnarlOSD...
[2019-05-16 09:54:09.357] bootstrap: starting notification roster...
NotificationRoster.Start(): %appdata% is %APPDATA%\full phat\snarl 5.0\etc\
NotificationRoster.Start(): loading osd.rc...
NotificationRoster.Start(): checking osd presets folder...
NotificationRoster.getOsdPresets(): loading osd presets...
[2019-05-16 09:54:09.455] bootstrap: starting application roster...
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\ExternalIPChecker\icon.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\HourlyChime\icon.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\KeyWatcher\icon.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\PeopleInSpace\icon.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\simpleextension\icon.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\etc\icons\snarl.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\StarWarsWeather\icon.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\etc\icons\subsmgr.png
[2019-05-16 09:54:09.456] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\SysInfo\icon.png
[2019-05-16 09:54:09.457] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\VolumeOMatic\icon.png
[2019-05-16 09:54:09.457] Registrar.Start(): Registering Snarl as an app...
[2019-05-16 09:54:09.467] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\etc\icons\snarl.png" url=""
[2019-05-16 09:54:09.467] Registrar.Register(): updating...
[2019-05-16 09:54:09.470] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\etc\icons\snarl.png
[2019-05-16 09:54:09.509] Registrar.Register(): setting message...
[2019-05-16 09:54:09.510] Registrar.Register(): setting response...
[2019-05-16 09:54:09.510] Registrar.Start(): registered Snarl ok
[2019-05-16 09:54:09.510] Registrar.Start(): Registering subscriptions manager...
[2019-05-16 09:54:09.510] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\etc\icons\subsmgr.png" url=""
[2019-05-16 09:54:09.510] Registrar.Register(): updating...
[2019-05-16 09:54:09.511] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\etc\icons\subsmgr.png
[2019-05-16 09:54:09.517] Registrar.Register(): setting message...
[2019-05-16 09:54:09.517] Registrar.Register(): setting response...
[2019-05-16 09:54:09.517] Registrar.Start(): registered subscription manager ok
[2019-05-16 09:54:09.517] bootstrap: starting extension roster...
[2019-05-16 09:54:09.518] PluginService.getSnarlApps(): loading extensions...
[2019-05-16 09:54:09.522] SnarlAppHelper(): ExternalIPChecker->Initialise(): Success
[2019-05-16 09:54:09.522] readSetting:True
[2019-05-16 09:54:09.522] readSetting:True
[2019-05-16 09:54:09.522] readSetting:""
[2019-05-16 09:54:09.522] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\ExternalIPChecker\icon.png" url=""
[2019-05-16 09:54:09.522] Registrar.Register(): updating...
[2019-05-16 09:54:09.523] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\ExternalIPChecker\icon.png
[2019-05-16 09:54:09.529] Registrar.Register(): setting message...
[2019-05-16 09:54:09.529] Registrar.Register(): setting response...
[2019-05-16 09:54:09.529] SnarlAppHelper: Updated: Application "local.snarl.extension.ExternalIPChecker" updated successfully register: 
[2019-05-16 09:54:09.530] SnarlAppHelper(): HourlyChime->Initialise(): Success
[2019-05-16 09:54:09.530] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\HourlyChime\icon.png" url=""
[2019-05-16 09:54:09.530] Registrar.Register(): updating...
[2019-05-16 09:54:09.531] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\HourlyChime\icon.png
[2019-05-16 09:54:09.537] Registrar.Register(): setting message...
[2019-05-16 09:54:09.537] Registrar.Register(): setting response...
[2019-05-16 09:54:09.537] SnarlAppHelper: Updated: Application "local.snarl.extension.HourlyChime" updated successfully register: 
[2019-05-16 09:54:09.538] SnarlAppHelper(): KeyWatcher->Initialise(): Success
[2019-05-16 09:54:09.538] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\KeyWatcher\icon.png" url=""
[2019-05-16 09:54:09.538] Registrar.Register(): updating...
[2019-05-16 09:54:09.539] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\KeyWatcher\icon.png
[2019-05-16 09:54:09.545] Registrar.Register(): setting message...
[2019-05-16 09:54:09.545] Registrar.Register(): setting response...
[2019-05-16 09:54:09.545] SnarlAppHelper: Updated: Application "local.snarl.extension.KeyWatcher" updated successfully register: 
[2019-05-16 09:54:09.546] SnarlAppHelper(): PeopleInSpace->Initialise(): Success
[2019-05-16 09:54:09.547] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\PeopleInSpace\icon.png" url=""
[2019-05-16 09:54:09.547] Registrar.Register(): updating...
[2019-05-16 09:54:09.547] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\PeopleInSpace\icon.png
[2019-05-16 09:54:09.553] Registrar.Register(): setting message...
[2019-05-16 09:54:09.553] Registrar.Register(): setting response...
[2019-05-16 09:54:09.553] SnarlAppHelper: Updated: Application "local.snarl.extension.PeopleInSpace" updated successfully register: 
[2019-05-16 09:54:09.555] SnarlAppHelper(): simpleextension->Initialise(): AuthenticationFailure: The moonlight filtered incorrectly across the still lake
[2019-05-16 09:54:09.555] readSetting:True
[2019-05-16 09:54:09.555] readSetting:True
[2019-05-16 09:54:09.555] readSetting:"Some information here"
[2019-05-16 09:54:09.555] readSetting:True
[2019-05-16 09:54:09.555] readSetting:True
[2019-05-16 09:54:09.555] readSetting:"Foo"
[2019-05-16 09:54:09.555] [simple extension] 'who' is now "Foo"
[2019-05-16 09:54:09.555] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\simpleextension\icon.png" url=""
[2019-05-16 09:54:09.555] Registrar.Register(): updating...
[2019-05-16 09:54:09.556] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\simpleextension\icon.png
[2019-05-16 09:54:09.561] Registrar.Register(): setting message...
[2019-05-16 09:54:09.561] Registrar.Register(): setting response...
[2019-05-16 09:54:09.561] SnarlAppHelper: Updated: Application "local.snarl.extension.simpleextension" updated successfully register: 
[2019-05-16 09:54:09.564] SnarlAppHelper(): StarWarsWeather->Initialise(): Success
[2019-05-16 09:54:09.564] readSetting:True
[2019-05-16 09:54:09.564] readSetting:True
[2019-05-16 09:54:09.564] readSetting:"> Welcome to Star Wars Weather!  A just-for-fun SnarlApp..."
[2019-05-16 09:54:09.564] readSetting:True
[2019-05-16 09:54:09.564] readSetting:True
[2019-05-16 09:54:09.564] readSetting:""
[2019-05-16 09:54:09.564] time now: 5/16/2019 9:54:09 AM
[2019-05-16 09:54:09.564] time at place: 5/16/2019 3:54:09 AM
[2019-05-16 09:54:09.564] is daytime: False
[2019-05-16 09:54:09.564] temp: -44
[2019-05-16 09:54:09.565] currently: 15 - Blowing snow
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): access token:      
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): what:              Notify (2)
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): host:              
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): timestamp:         5/16/2019 9:54:09 AM
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): headers...
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 09:54:09.567] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 09:54:09.567] MasterMessageHandler.doNotify(): creating notification...
[2019-05-16 09:54:09.568] MasterMessageHandler.doNotify(): processing...
[2019-05-16 09:54:09.569] Notification.Process(): data...
[2019-05-16 09:54:09.570] Notification.Process(): looking for registration "local.snarl.extension.StarWarsWeather"...
[2019-05-16 09:54:09.570] Registrar.Find(): looking for AppId local.snarl.extension.StarWarsWeather...
[2019-05-16 09:54:09.570] Registrar.Find(): found
[2019-05-16 09:54:09.573] Registrar.Find(): failed password check
[2019-05-16 09:54:09.573] MasterMessageHandler.doNotify(): NotRegistered: Application not registered
[2019-05-16 09:54:09.573] SnarlAppHost.ShowNotification(): NotRegistered: Application not registered
[2019-05-16 09:54:09.573] time now: 5/16/2019 9:54:09 AM
[2019-05-16 09:54:09.573] time at place: 5/16/2019 2:54:09 PM
[2019-05-16 09:54:09.573] is daytime: True
[2019-05-16 09:54:09.573] temp: 43
[2019-05-16 09:54:09.573] currently: 20 - Foggy
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): access token:      
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): what:              Notify (2)
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): host:              
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): timestamp:         5/16/2019 9:54:09 AM
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): headers...
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 09:54:09.573] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 09:54:09.573] MasterMessageHandler.doNotify(): creating notification...
[2019-05-16 09:54:09.573] MasterMessageHandler.doNotify(): processing...
[2019-05-16 09:54:09.573] Notification.Process(): data...
[2019-05-16 09:54:09.573] Notification.Process(): looking for registration "local.snarl.extension.StarWarsWeather"...
[2019-05-16 09:54:09.573] Registrar.Find(): looking for AppId local.snarl.extension.StarWarsWeather...
[2019-05-16 09:54:09.573] Registrar.Find(): found
[2019-05-16 09:54:09.573] Registrar.Find(): failed password check
[2019-05-16 09:54:09.573] MasterMessageHandler.doNotify(): NotRegistered: Application not registered
[2019-05-16 09:54:09.574] SnarlAppHost.ShowNotification(): NotRegistered: Application not registered
[2019-05-16 09:54:09.574] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\StarWarsWeather\icon.png" url=""
[2019-05-16 09:54:09.574] Registrar.Register(): updating...
[2019-05-16 09:54:09.574] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\StarWarsWeather\icon.png
[2019-05-16 09:54:09.580] Registrar.Register(): setting message...
[2019-05-16 09:54:09.580] Registrar.Register(): setting response...
[2019-05-16 09:54:09.580] SnarlAppHelper: Updated: Application "local.snarl.extension.StarWarsWeather" updated successfully register: 
[2019-05-16 09:54:09.586] SnarlAppHelper(): SysInfo->Initialise(): Success
[2019-05-16 09:54:09.586] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\SysInfo\icon.png" url=""
[2019-05-16 09:54:09.586] Registrar.Register(): updating...
[2019-05-16 09:54:09.586] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\SysInfo\icon.png
[2019-05-16 09:54:09.592] Registrar.Register(): setting message...
[2019-05-16 09:54:09.592] Registrar.Register(): setting response...
[2019-05-16 09:54:09.592] SnarlAppHelper: Updated: Application "local.snarl.extension.SysInfo" updated successfully register: 
[2019-05-16 09:54:09.592] PluginService.getSnarlApps: failed: The system cannot find the file specified. (Exception from HRESULT: 0x80070002)
[2019-05-16 09:54:09.602] SnarlAppHelper(): VolumeOMatic->Initialise(): Success
[2019-05-16 09:54:09.602] Registrar.Register(): icons: stock="" file icon="D:\Applications\Snarl\apps\VolumeOMatic\icon.png" url=""
[2019-05-16 09:54:09.602] Registrar.Register(): updating...
[2019-05-16 09:54:09.602] IconHelper.IconHelper(): using file icon D:\Applications\Snarl\apps\VolumeOMatic\icon.png
[2019-05-16 09:54:09.608] Registrar.Register(): setting message...
[2019-05-16 09:54:09.608] Registrar.Register(): setting response...
[2019-05-16 09:54:09.608] SnarlAppHelper: Updated: Application "local.snarl.extension.VolumeOMatic" updated successfully register: 
[2019-05-16 09:54:09.608] PluginService.getForwarders(): loading forwarders...
[2019-05-16 09:54:09.611] SnarlForwarderHelper(): Boxcar->Initialise(): Success
[2019-05-16 09:54:09.612] SnarlForwarderHelper(): GNTP->Initialise(): Success
[2019-05-16 09:54:09.613] SnarlForwarderHelper(): Mail->Initialise(): Success
[2019-05-16 09:54:09.614] SnarlForwarderHelper(): Prowl->Initialise(): Success
[2019-05-16 09:54:09.615] SnarlForwarderHelper(): PushBullet->Initialise(): Success
[2019-05-16 09:54:09.616] SnarlForwarderHelper(): Pushover->Initialise(): Success
[2019-05-16 09:54:09.617] SnarlForwarderHelper(): RunFile->Initialise(): Success
[2019-05-16 09:54:09.651] SnarlForwarderHelper(): Say->Initialise(): Success
[2019-05-16 09:54:09.652] SnarlForwarderHelper(): SNP->Initialise(): Success
[2019-05-16 09:54:09.654] SnarlForwarderHelper(): URL->Initialise(): Success
[2019-05-16 09:54:09.654] bootstrap: starting rules roster...
[2019-05-16 09:54:09.654] bootstrap: starting presence monitor...
[2019-05-16 09:54:09.656] bootstrap: starting OSD reflector...
[2019-05-16 09:54:09.657] CustomWindow.Create(): w>snarl_osd_reflector,,0x0527058E,0x00590344
[2019-05-16 09:54:09.657] bootstrap: enabling...
[2019-05-16 09:54:09.657] bootstrap: displaying welcome message...
[2019-05-16 09:54:09.658] Notification.Process(): data...
[2019-05-16 09:54:09.658] Notification.Process(): looking for registration "application/x-vnd.fullphat-snarl"...
[2019-05-16 09:54:09.658] Registrar.Find(): looking for AppId application/x-vnd.fullphat-snarl...
[2019-05-16 09:54:09.658] Registrar.Find(): found
[2019-05-16 09:54:09.659] Notification.Process(): looking for event "WelcomeMessage"...
[2019-05-16 09:54:09.661] NotificationRoster.Add(): uid= mode=Normal
[2019-05-16 09:54:09.661] NotificationRoster.Add(): replay=False forwarded=False
[2019-05-16 09:54:09.664] Notification.SendToOSD(): Sending "notify?transport=Snarl&api=5.1&flags=0&app-sig=application/x-vnd.fullphat-snarl&app-icon=D:\Applications\Snarl\etc\icons\snarl.png&app-name=Snarl&event-name=Welcome Message&guid=1472ae75-1c62-46cc-aea1-7019d61743bf&token=444&title=Welcome to Snarl!&text=Snarl 5.1.0 Beta 1 (5.1.0.9001)
Copyright © 2005-2019 full phat products
http://www.getsnarl.info&icon=D:\Applications\Snarl\etc\icons\snarl.png&priority=0&timeout=10"...
[2019-05-16 09:54:09.690] Notification.SendToOSD(): OSD replied with Success
[2019-05-16 09:54:09.690] NotificationRoster.Add(): created notification 1f5f0bcb-37b8-4a1a-a3cb-b67327e7a78e (444)
[2019-05-16 09:54:09.690] RulesRoster.Process(): added to roster ok, token=444
[2019-05-16 09:54:09.690] bootstrap: starting network roster...
[2019-05-16 09:54:09.691] network.service: starting transports...
net.fullphat.gntp: start
[2019-05-16 09:54:09.693] network.service: added net.fullphat.gntp
[2019-05-16 09:54:09.695] network.service: added net.fullphat.simple_udp
[2019-05-16 09:54:09.696] net.fullphat.snp: start
[2019-05-16 09:54:09.696] network.service: added net.fullphat.snp
[2019-05-16 09:54:09.697] net.fullphat.snphttp: start
[2019-05-16 09:54:09.697] network.service: added net.fullphat.snphttp
[2019-05-16 09:54:09.698] network.service: added net.fullphat.win32ipc
[2019-05-16 09:54:09.698] NetworkRoster.Start(): loading listeners...
[2019-05-16 09:54:09.699] Listener.Listener(): creating listener e92825a6-d020-4022-979f-d17805a0d1cb ("SNARL")...
[2019-05-16 09:54:09.699]     transportId: net.fullphat.gntp
[2019-05-16 09:54:09.699]      protocolId: gntp
[2019-05-16 09:54:09.699] success!  icon=
[2019-05-16 09:54:09.700] Listener.Listener(): AddListener: Success
[2019-05-16 09:54:09.701] Listener.Listener(): EnableListener: Success
[2019-05-16 09:54:09.701] Listener.Listener(): creating listener 92cab069-7a13-4429-ad71-efb9730e1fb1 ("SNP 3.1")...
[2019-05-16 09:54:09.701]     transportId: net.fullphat.snp
[2019-05-16 09:54:09.701]      protocolId: snp31
[2019-05-16 09:54:09.701] success!  icon=
[2019-05-16 09:54:09.702] Listener.Listener(): AddListener: Success
[2019-05-16 09:54:09.702] Listener.Listener(): EnableListener: Success
[2019-05-16 09:54:09.702] Listener.Listener(): creating listener fe4ce0e2-3035-460e-bd82-69383916a6d8 ("SNP v1")...
[2019-05-16 09:54:09.702]     transportId: net.fullphat.snp
[2019-05-16 09:54:09.702]      protocolId: snp1
[2019-05-16 09:54:09.702] success!  icon=
[2019-05-16 09:54:09.703] Listener.Listener(): AddListener: Success
[2019-05-16 09:54:09.703] Listener.Listener(): EnableListener: Success
[2019-05-16 09:54:09.703] Listener.Listener(): creating listener 41379f46-1be6-447d-bd70-c0175a0135c1 ("Win32 IPC")...
[2019-05-16 09:54:09.703]     transportId: net.fullphat.win32ipc
[2019-05-16 09:54:09.703]      protocolId: hydride
[2019-05-16 09:54:09.703] success!  icon=
[2019-05-16 09:54:09.703] [win32ipc] AddReceiver
[2019-05-16 09:54:09.704] Listener.Listener(): AddListener: Success
[2019-05-16 09:54:09.704] Listener.Listener(): EnableListener: Success
[2019-05-16 09:54:09.704] NetworkRoster.Start(): loading subscriptions...
[2019-05-16 09:54:09.704] bootstrap: waking extensions...
[2019-05-16 09:54:09.705] [win32ipc]: 0x0024
[2019-05-16 09:54:09.705] [win32ipc]: 0x0081
[2019-05-16 09:54:09.706] [win32ipc]: 0x0083
[2019-05-16 09:54:09.706] [win32ipc]: 0x0001
[2019-05-16 09:54:09.707] [win32ipc]: window is 0x00A90E62
[2019-05-16 09:54:09.707] CustomWindow.threadProc(): w>snarl,Snarl -> 0x00A90E62
[2019-05-16 09:54:09.707] CustomWindow.threadProc(): running...
[2019-05-16 09:54:09.708] [win32ipc]: 0x031F
[2019-05-16 09:54:09.752] <external_ip>: async request started
[2019-05-16 09:54:09.753] <people_in_space>: async request started
[2019-05-16 09:54:09.753] time now: 5/16/2019 9:54:09 AM
[2019-05-16 09:54:09.753] time at place: 5/16/2019 3:54:09 AM
[2019-05-16 09:54:09.753] is daytime: False
[2019-05-16 09:54:09.753] temp: -38
[2019-05-16 09:54:09.753] currently: 33 - Fair
[2019-05-16 09:54:09.753] time now: 5/16/2019 9:54:09 AM
[2019-05-16 09:54:09.754] time at place: 5/16/2019 2:54:09 PM
[2019-05-16 09:54:09.754] is daytime: True
[2019-05-16 09:54:09.754] temp: 48
[2019-05-16 09:54:09.754] currently: 36 - Hot
[2019-05-16 09:54:09.754] StarWarsWeather.Open(): using interval of 240 minute(s)
[2019-05-16 09:54:09.768] [sysinfo] power: Online battery: NoSystemBattery
[2019-05-16 09:54:09.769] bootstrap: main startup completed, other threads may still be initialising...
[2019-05-16 09:54:09.816] <people_in_space>: download completed
[2019-05-16 09:54:09.818] <people_in_space>: data: {"message": "success", "number": 6, "people": [{"craft": "ISS", "name": "Oleg Kononenko"}, {"craft": "ISS", "name": "David Saint-Jacques"}, {"craft": "ISS", "name": "Anne McClain"}, {"craft": "ISS", "name": "Alexey Ovchinin"}, {"craft": "ISS", "name": "Nick Hague"}, {"craft": "ISS", "name": "Christina Koch"}]}
[2019-05-16 09:54:09.885] <external_ip>: download completed
[2019-05-16 09:54:09.885] <external_ip>: address is now "[EXTERNAL IP - REDACTED]"; was ""
[2019-05-16 09:54:19.680] Notification.HandleCallback(): NotificationExpired
[2019-05-16 09:54:19.680] Notification.HandleCallback(): no specific callback provided
[2019-05-16 09:54:19.680] Notification.HandleCallback(): no reply port provided
[2019-05-16 09:56:43.960] Stopping presence monitor...
[2019-05-16 09:56:43.960] Removing tray icon...
[2019-05-16 09:56:43.973] Stopping network roster...
[2019-05-16 09:56:43.976] [win32ipc]: closing window...
[2019-05-16 09:56:43.977] CustomWindow.threadProc(): WM_QUIT: tidying up...
[2019-05-16 09:56:43.977] [win32ipc]: 0x0090
[2019-05-16 09:56:43.977] [win32ipc]: 0x0002
[2019-05-16 09:56:43.978] [win32ipc]: 0x0082
[2019-05-16 09:56:44.177] network.service: stopping transports...
net.fullphat.gntp: stop
[2019-05-16 09:56:44.177]     net.fullphat.gntp: NotInitialised
[2019-05-16 09:56:44.177]     net.fullphat.simple_udp: Success
[2019-05-16 09:56:44.177] net.fullphat.snp: stop
[2019-05-16 09:56:44.177]     net.fullphat.snp: NotInitialised
[2019-05-16 09:56:44.178] net.fullphat.snphttp: stop
[2019-05-16 09:56:44.178]     net.fullphat.snphttp: NotInitialised
[2019-05-16 09:56:44.178] [win32ipc]: stop
[2019-05-16 09:56:44.178]     net.fullphat.win32ipc: Success
[2019-05-16 09:56:44.178] Stopping extension roster...
[2019-05-16 09:56:44.380] Stopping application roster...
[2019-05-16 09:56:44.380] Telling SnarlOSD to quit...
[2019-05-16 09:56:44.380] CustomWindow.Dispose()
[2019-05-16 09:56:44.381] CustomWindow.Destroy(): DestroyWindow() returned: True
[2019-05-16 09:56:44.382] Stopping management server...
[2019-05-16 09:56:44.383] ===== END =====
LeeThompson commented 5 years ago

This is really weird, I copied Snarl to my gaming machine (also a domain member, the only difference is it's on Windows 10 Professional instead of Enterprise) and ran SnarlOSD-setup. It didn't have the same snarl config (default port) but the http://localhost:9989 works on it.

And netstat shows: TCP 0.0.0.0:9989 LISTENING

Gaming box Log:

[2019-05-16 10:10:22.715] -=-=- Snarl logging started -=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-
[2019-05-16 10:10:22.892] bootstrap: Thu, 16 May 2019 17:10:22 GMT
[2019-05-16 10:10:22.892] bootstrap: o/s info follows...
[2019-05-16 10:10:22.892]   platform: Win32NT
[2019-05-16 10:10:22.892]   version: Microsoft Windows NT 6.2.9200.0
[2019-05-16 10:10:22.892]   service pack: 
[2019-05-16 10:10:22.893] ServerInfo set as:
[2019-05-16 10:10:22.893]   Snarl
[2019-05-16 10:10:22.893]   5.1.0.9001
[2019-05-16 10:10:22.893]   48.9
[2019-05-16 10:10:22.893]   Beta 1
[2019-05-16 10:10:22.893] .........................................................
[2019-05-16 10:10:22.893] ::                     server_info                     ::
[2019-05-16 10:10:22.906] `````````````````````````````````````````````````````````
[2019-05-16 10:10:22.906]   release: 5.1.0 Beta 1
[2019-05-16 10:10:22.906]   api:     48
[2019-05-16 10:10:22.906]   sys:     48.9
[2019-05-16 10:10:22.906]   build:   5.1.0 (id=9001)
[2019-05-16 10:10:22.934] bootstrap: initialising settings...
[2019-05-16 10:10:22.936] SysAdminHelper(): no redirect.rc
[2019-05-16 10:10:22.936] SysAdminHelper(): trying from E:\Temp\Snarl\sysadmin.json...
[2019-05-16 10:10:22.939] SysAdminHelper.getSettingsFromPathOrUrl(): "E:\Temp\Snarl\sysadmin.json" assumed to be a path...
Files.ReadTextFromPath(): failed to read from "E:\Temp\Snarl\sysadmin.json": Could not find file 'E:\Temp\Snarl\sysadmin.json'.
[2019-05-16 10:10:22.939] SysAdminHelper.getSettingsFromPathOrUrl(): failed: missing or empty file
[2019-05-16 10:10:22.939] SysAdminHelper(): failed
[2019-05-16 10:10:22.939] SysAdminHelper(): no custom settings found; using defaults...
[2019-05-16 10:10:22.940] EnvironmentManager.loadSettingsFromSysAdmin(): ConfigurationFileUrl:  ""
[2019-05-16 10:10:22.940] EnvironmentManager.loadSettingsFromSysAdmin(): ConfigurationFilePath: ""
[2019-05-16 10:10:22.940] EnvironmentManager.loadSettingsFromSysAdmin(): not loaded
[2019-05-16 10:10:22.940] EnvironmentManager.Start(): using local settings...
[2019-05-16 10:10:22.940] EnvironmentManager.Start(): createLocalSettingsFolderStructure=True
[2019-05-16 10:10:22.940] EnvironmentManager.Start(): _localSettingsFile=%APPDATA%\full phat\snarl 5.0\etc\settings.json
[2019-05-16 10:10:23.081] EnvironmentManager.applySettings(): successfully applied settings
[2019-05-16 10:10:23.081] EnvironmentManager.Start(): loaded ok
[2019-05-16 10:10:23.081] EnvironmentManager.Start(): config file version: 48
[2019-05-16 10:10:23.081] .........................................................
[2019-05-16 10:10:23.081] ::                     environment                     ::
[2019-05-16 10:10:23.081] `````````````````````````````````````````````````````````
[2019-05-16 10:10:23.081]   Upgrading:             False
[2019-05-16 10:10:23.081]   SettingsAreReadOnly:   False
[2019-05-16 10:10:23.081]   PreviousConfigVersion: 0
[2019-05-16 10:10:23.081]   UsingFreshConfig:      False
[2019-05-16 10:10:23.081]   LocalSettingsFile:     %APPDATA%\full phat\snarl 5.0\etc\settings.json
[2019-05-16 10:10:23.081] bootstrap: starting UI...
[2019-05-16 10:10:23.097] bootstrap: starting management server on '*:9989'...
[2019-05-16 10:10:23.098] ManagementConsoleServer.StartManagementServer(): using http for management server...
[2019-05-16 10:10:23.103] bootstrap: management server started!
[2019-05-16 10:10:23.104] bootstrap: starting SnarlOSD...
[2019-05-16 10:10:23.134] bootstrap: starting notification roster...
NotificationRoster.Start(): %appdata% is %APPDATA%\full phat\snarl 5.0\etc\
NotificationRoster.Start(): loading osd.rc...
NotificationRoster.Start(): checking osd presets folder...
NotificationRoster.getOsdPresets(): loading osd presets...
[2019-05-16 10:10:23.142] bootstrap: starting application roster...
[2019-05-16 10:10:23.143] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\ExternalIPChecker\icon.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\HourlyChime\icon.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\KeyWatcher\icon.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\PeopleInSpace\icon.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\simpleextension\icon.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\etc\icons\snarl.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\StarWarsWeather\icon.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\etc\icons\subsmgr.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\SysInfo\icon.png
[2019-05-16 10:10:23.144] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\VolumeOMatic\icon.png
[2019-05-16 10:10:23.145] Registrar.Start(): Registering Snarl as an app...
[2019-05-16 10:10:23.152] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\etc\icons\snarl.png" url=""
[2019-05-16 10:10:23.152] Registrar.Register(): updating...
[2019-05-16 10:10:23.156] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\etc\icons\snarl.png
[2019-05-16 10:10:23.193] Registrar.Register(): setting message...
[2019-05-16 10:10:23.193] Registrar.Register(): setting response...
[2019-05-16 10:10:23.193] Registrar.Start(): registered Snarl ok
[2019-05-16 10:10:23.194] Registrar.Start(): Registering subscriptions manager...
[2019-05-16 10:10:23.194] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\etc\icons\subsmgr.png" url=""
[2019-05-16 10:10:23.194] Registrar.Register(): updating...
[2019-05-16 10:10:23.194] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\etc\icons\subsmgr.png
[2019-05-16 10:10:23.195] Registrar.Register(): setting message...
[2019-05-16 10:10:23.195] Registrar.Register(): setting response...
[2019-05-16 10:10:23.195] Registrar.Start(): registered subscription manager ok
[2019-05-16 10:10:23.195] bootstrap: starting extension roster...
[2019-05-16 10:10:23.195] PluginService.getSnarlApps(): loading extensions...
[2019-05-16 10:10:23.199] SnarlAppHelper(): ExternalIPChecker->Initialise(): Success
[2019-05-16 10:10:23.199] readSetting:True
[2019-05-16 10:10:23.199] readSetting:True
[2019-05-16 10:10:23.199] readSetting:""
[2019-05-16 10:10:23.200] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\ExternalIPChecker\icon.png" url=""
[2019-05-16 10:10:23.200] Registrar.Register(): updating...
[2019-05-16 10:10:23.200] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\ExternalIPChecker\icon.png
[2019-05-16 10:10:23.200] Registrar.Register(): setting message...
[2019-05-16 10:10:23.200] Registrar.Register(): setting response...
[2019-05-16 10:10:23.200] SnarlAppHelper: Updated: Application "local.snarl.extension.ExternalIPChecker" updated successfully register: 
[2019-05-16 10:10:23.202] SnarlAppHelper(): HourlyChime->Initialise(): Success
[2019-05-16 10:10:23.202] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\HourlyChime\icon.png" url=""
[2019-05-16 10:10:23.202] Registrar.Register(): updating...
[2019-05-16 10:10:23.202] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\HourlyChime\icon.png
[2019-05-16 10:10:23.202] Registrar.Register(): setting message...
[2019-05-16 10:10:23.202] Registrar.Register(): setting response...
[2019-05-16 10:10:23.202] SnarlAppHelper: Updated: Application "local.snarl.extension.HourlyChime" updated successfully register: 
[2019-05-16 10:10:23.203] SnarlAppHelper(): KeyWatcher->Initialise(): Success
[2019-05-16 10:10:23.204] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\KeyWatcher\icon.png" url=""
[2019-05-16 10:10:23.204] Registrar.Register(): updating...
[2019-05-16 10:10:23.204] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\KeyWatcher\icon.png
[2019-05-16 10:10:23.204] Registrar.Register(): setting message...
[2019-05-16 10:10:23.204] Registrar.Register(): setting response...
[2019-05-16 10:10:23.205] SnarlAppHelper: Updated: Application "local.snarl.extension.KeyWatcher" updated successfully register: 
[2019-05-16 10:10:23.206] SnarlAppHelper(): PeopleInSpace->Initialise(): Success
[2019-05-16 10:10:23.206] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\PeopleInSpace\icon.png" url=""
[2019-05-16 10:10:23.206] Registrar.Register(): updating...
[2019-05-16 10:10:23.206] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\PeopleInSpace\icon.png
[2019-05-16 10:10:23.207] Registrar.Register(): setting message...
[2019-05-16 10:10:23.207] Registrar.Register(): setting response...
[2019-05-16 10:10:23.207] SnarlAppHelper: Updated: Application "local.snarl.extension.PeopleInSpace" updated successfully register: 
[2019-05-16 10:10:23.208] SnarlAppHelper(): simpleextension->Initialise(): AuthenticationFailure: The moonlight filtered incorrectly across the still lake
[2019-05-16 10:10:23.208] readSetting:True
[2019-05-16 10:10:23.208] readSetting:True
[2019-05-16 10:10:23.208] readSetting:"Some information here"
[2019-05-16 10:10:23.208] readSetting:True
[2019-05-16 10:10:23.208] readSetting:True
[2019-05-16 10:10:23.208] readSetting:"Foo"
[2019-05-16 10:10:23.208] [simple extension] 'who' is now "Foo"
[2019-05-16 10:10:23.208] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\simpleextension\icon.png" url=""
[2019-05-16 10:10:23.208] Registrar.Register(): updating...
[2019-05-16 10:10:23.208] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\simpleextension\icon.png
[2019-05-16 10:10:23.209] Registrar.Register(): setting message...
[2019-05-16 10:10:23.209] Registrar.Register(): setting response...
[2019-05-16 10:10:23.209] SnarlAppHelper: Updated: Application "local.snarl.extension.simpleextension" updated successfully register: 
[2019-05-16 10:10:23.211] SnarlAppHelper(): StarWarsWeather->Initialise(): Success
[2019-05-16 10:10:23.211] readSetting:True
[2019-05-16 10:10:23.211] readSetting:True
[2019-05-16 10:10:23.211] readSetting:"> Welcome to Star Wars Weather!  A just-for-fun SnarlApp..."
[2019-05-16 10:10:23.211] readSetting:True
[2019-05-16 10:10:23.211] readSetting:True
[2019-05-16 10:10:23.211] readSetting:""
[2019-05-16 10:10:23.212] time now: 5/16/2019 10:10:23 AM
[2019-05-16 10:10:23.212] time at place: 5/16/2019 4:10:23 AM
[2019-05-16 10:10:23.212] is daytime: False
[2019-05-16 10:10:23.212] temp: -61
[2019-05-16 10:10:23.212] currently: 41 - Heavy snow
[2019-05-16 10:10:23.214] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 10:10:23.214] MasterRequestHandler.Handle(): access token:      
[2019-05-16 10:10:23.214] MasterRequestHandler.Handle(): what:              Notify (2)
[2019-05-16 10:10:23.215] MasterRequestHandler.Handle(): host:              
[2019-05-16 10:10:23.215] MasterRequestHandler.Handle(): timestamp:         5/16/2019 10:10:23 AM
[2019-05-16 10:10:23.215] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 10:10:23.215] MasterRequestHandler.Handle(): headers...
[2019-05-16 10:10:23.215] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:23.215] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 10:10:23.215] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:23.215] MasterMessageHandler.doNotify(): creating notification...
[2019-05-16 10:10:23.215] MasterMessageHandler.doNotify(): processing...
[2019-05-16 10:10:23.217] Notification.Process(): data...
[2019-05-16 10:10:23.217] Notification.Process(): looking for registration "local.snarl.extension.StarWarsWeather"...
[2019-05-16 10:10:23.218] Registrar.Find(): looking for AppId local.snarl.extension.StarWarsWeather...
[2019-05-16 10:10:23.218] Registrar.Find(): found
[2019-05-16 10:10:23.222] Registrar.Find(): failed password check
[2019-05-16 10:10:23.222] MasterMessageHandler.doNotify(): NotRegistered: Application not registered
[2019-05-16 10:10:23.222] SnarlAppHost.ShowNotification(): NotRegistered: Application not registered
[2019-05-16 10:10:23.222] time now: 5/16/2019 10:10:23 AM
[2019-05-16 10:10:23.222] time at place: 5/16/2019 3:10:23 PM
[2019-05-16 10:10:23.222] is daytime: True
[2019-05-16 10:10:23.222] temp: 29
[2019-05-16 10:10:23.222] currently: 23 - Blustery
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): access token:      
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): what:              Notify (2)
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): host:              
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): timestamp:         5/16/2019 10:10:23 AM
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): headers...
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 10:10:23.222] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:23.222] MasterMessageHandler.doNotify(): creating notification...
[2019-05-16 10:10:23.222] MasterMessageHandler.doNotify(): processing...
[2019-05-16 10:10:23.222] Notification.Process(): data...
[2019-05-16 10:10:23.222] Notification.Process(): looking for registration "local.snarl.extension.StarWarsWeather"...
[2019-05-16 10:10:23.222] Registrar.Find(): looking for AppId local.snarl.extension.StarWarsWeather...
[2019-05-16 10:10:23.222] Registrar.Find(): found
[2019-05-16 10:10:23.223] Registrar.Find(): failed password check
[2019-05-16 10:10:23.223] MasterMessageHandler.doNotify(): NotRegistered: Application not registered
[2019-05-16 10:10:23.223] SnarlAppHost.ShowNotification(): NotRegistered: Application not registered
[2019-05-16 10:10:23.223] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\StarWarsWeather\icon.png" url=""
[2019-05-16 10:10:23.223] Registrar.Register(): updating...
[2019-05-16 10:10:23.223] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\StarWarsWeather\icon.png
[2019-05-16 10:10:23.223] Registrar.Register(): setting message...
[2019-05-16 10:10:23.223] Registrar.Register(): setting response...
[2019-05-16 10:10:23.224] SnarlAppHelper: Updated: Application "local.snarl.extension.StarWarsWeather" updated successfully register: 
[2019-05-16 10:10:23.228] SnarlAppHelper(): SysInfo->Initialise(): Success
[2019-05-16 10:10:23.229] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\SysInfo\icon.png" url=""
[2019-05-16 10:10:23.229] Registrar.Register(): updating...
[2019-05-16 10:10:23.229] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\SysInfo\icon.png
[2019-05-16 10:10:23.229] Registrar.Register(): setting message...
[2019-05-16 10:10:23.229] Registrar.Register(): setting response...
[2019-05-16 10:10:23.229] SnarlAppHelper: Updated: Application "local.snarl.extension.SysInfo" updated successfully register: 
[2019-05-16 10:10:23.230] PluginService.getSnarlApps: failed: The system cannot find the file specified. (Exception from HRESULT: 0x80070002)
[2019-05-16 10:10:23.237] SnarlAppHelper(): VolumeOMatic->Initialise(): Success
[2019-05-16 10:10:23.237] Registrar.Register(): icons: stock="" file icon="E:\Temp\Snarl\apps\VolumeOMatic\icon.png" url=""
[2019-05-16 10:10:23.238] Registrar.Register(): updating...
[2019-05-16 10:10:23.238] IconHelper.IconHelper(): using file icon E:\Temp\Snarl\apps\VolumeOMatic\icon.png
[2019-05-16 10:10:23.238] Registrar.Register(): setting message...
[2019-05-16 10:10:23.238] Registrar.Register(): setting response...
[2019-05-16 10:10:23.238] SnarlAppHelper: Updated: Application "local.snarl.extension.VolumeOMatic" updated successfully register: 
[2019-05-16 10:10:23.239] PluginService.getForwarders(): loading forwarders...
[2019-05-16 10:10:23.241] SnarlForwarderHelper(): Boxcar->Initialise(): Success
[2019-05-16 10:10:23.242] SnarlForwarderHelper(): GNTP->Initialise(): Success
[2019-05-16 10:10:23.244] SnarlForwarderHelper(): Mail->Initialise(): Success
[2019-05-16 10:10:23.245] SnarlForwarderHelper(): Prowl->Initialise(): Success
[2019-05-16 10:10:23.246] SnarlForwarderHelper(): PushBullet->Initialise(): Success
[2019-05-16 10:10:23.246] SnarlForwarderHelper(): Pushover->Initialise(): Success
[2019-05-16 10:10:23.248] SnarlForwarderHelper(): RunFile->Initialise(): Success
[2019-05-16 10:10:23.288] SnarlForwarderHelper(): Say->Initialise(): Success
[2019-05-16 10:10:23.290] SnarlForwarderHelper(): SNP->Initialise(): Success
[2019-05-16 10:10:23.291] SnarlForwarderHelper(): URL->Initialise(): Success
[2019-05-16 10:10:23.291] bootstrap: starting rules roster...
[2019-05-16 10:10:23.291] bootstrap: starting presence monitor...
[2019-05-16 10:10:23.292] bootstrap: starting OSD reflector...
[2019-05-16 10:10:23.294] CustomWindow.Create(): w>snarl_osd_reflector,,0x05ED058E,0x002F0A04
[2019-05-16 10:10:23.294] bootstrap: enabling...
[2019-05-16 10:10:23.294] bootstrap: displaying welcome message...
[2019-05-16 10:10:23.295] Notification.Process(): data...
[2019-05-16 10:10:23.295] Notification.Process(): looking for registration "application/x-vnd.fullphat-snarl"...
[2019-05-16 10:10:23.295] Registrar.Find(): looking for AppId application/x-vnd.fullphat-snarl...
[2019-05-16 10:10:23.295] Registrar.Find(): found
[2019-05-16 10:10:23.295] Notification.Process(): looking for event "WelcomeMessage"...
[2019-05-16 10:10:23.297] NotificationRoster.Add(): uid= mode=Normal
[2019-05-16 10:10:23.297] NotificationRoster.Add(): replay=False forwarded=False
[2019-05-16 10:10:23.301] Notification.SendToOSD(): Sending "notify?transport=Snarl&api=5.1&flags=0&app-sig=application/x-vnd.fullphat-snarl&app-icon=E:\Temp\Snarl\etc\icons\snarl.png&app-name=Snarl&event-name=Welcome Message&guid=fdd5e64f-faf2-4857-8090-ea2a49fe0bc7&token=444&title=Welcome to Snarl!&text=Snarl 5.1.0 Beta 1 (5.1.0.9001)
Copyright © 2005-2019 full phat products
http://www.getsnarl.info&icon=E:\Temp\Snarl\etc\icons\snarl.png&priority=0&timeout=10"...
[2019-05-16 10:10:23.317] Notification.SendToOSD(): OSD replied with Success
[2019-05-16 10:10:23.317] NotificationRoster.Add(): created notification 2799614d-94f3-4292-bd3e-b7c6b6fa1f27 (444)
[2019-05-16 10:10:23.317] RulesRoster.Process(): added to roster ok, token=444
[2019-05-16 10:10:23.317] bootstrap: starting network roster...
[2019-05-16 10:10:23.318] network.service: starting transports...
net.fullphat.gntp: start
[2019-05-16 10:10:23.320] network.service: added net.fullphat.gntp
[2019-05-16 10:10:23.321] network.service: added net.fullphat.simple_udp
[2019-05-16 10:10:23.322] net.fullphat.snp: start
[2019-05-16 10:10:23.322] network.service: added net.fullphat.snp
[2019-05-16 10:10:23.323] net.fullphat.snphttp: start
[2019-05-16 10:10:23.323] network.service: added net.fullphat.snphttp
[2019-05-16 10:10:23.324] network.service: added net.fullphat.win32ipc
[2019-05-16 10:10:23.324] NetworkRoster.Start(): loading listeners...
[2019-05-16 10:10:23.325] Listener.Listener(): creating listener 56f836a4-3e2d-4d41-aa97-0001ead13f8a ("Win32 IPC")...
[2019-05-16 10:10:23.325]     transportId: net.fullphat.win32ipc
[2019-05-16 10:10:23.325]      protocolId: hydride
[2019-05-16 10:10:23.326] success!  icon=
[2019-05-16 10:10:23.326] [win32ipc] AddReceiver
[2019-05-16 10:10:23.328] Listener.Listener(): AddListener: Success
[2019-05-16 10:10:23.328] Listener.Listener(): EnableListener: Success
[2019-05-16 10:10:23.328] NetworkRoster.Start(): loading subscriptions...
[2019-05-16 10:10:23.328] bootstrap: waking extensions...
[2019-05-16 10:10:23.329] [win32ipc]: 0x0024
[2019-05-16 10:10:23.329] [win32ipc]: 0x0081
[2019-05-16 10:10:23.330] [win32ipc]: 0x0083
[2019-05-16 10:10:23.330] [win32ipc]: 0x0001
[2019-05-16 10:10:23.330] [win32ipc]: window is 0x000E0482
[2019-05-16 10:10:23.330] CustomWindow.threadProc(): w>snarl,Snarl -> 0x000E0482
[2019-05-16 10:10:23.330] CustomWindow.threadProc(): running...
[2019-05-16 10:10:23.331] [win32ipc]: 0x031F
[2019-05-16 10:10:23.348] <external_ip>: async request started
[2019-05-16 10:10:23.349] <people_in_space>: async request started
[2019-05-16 10:10:23.350] time now: 5/16/2019 10:10:23 AM
[2019-05-16 10:10:23.350] time at place: 5/16/2019 4:10:23 AM
[2019-05-16 10:10:23.350] is daytime: False
[2019-05-16 10:10:23.350] temp: -47
[2019-05-16 10:10:23.350] currently: 16 - Snow
[2019-05-16 10:10:23.350] time now: 5/16/2019 10:10:23 AM
[2019-05-16 10:10:23.350] time at place: 5/16/2019 3:10:23 PM
[2019-05-16 10:10:23.350] is daytime: True
[2019-05-16 10:10:23.350] temp: 40
[2019-05-16 10:10:23.350] currently: 21 - Haze
[2019-05-16 10:10:23.350] StarWarsWeather.Open(): using interval of 240 minute(s)
[2019-05-16 10:10:23.358] [sysinfo] power: Online battery: NoSystemBattery
[2019-05-16 10:10:23.359] bootstrap: main startup completed, other threads may still be initialising...
[2019-05-16 10:10:23.411] <people_in_space>: download completed
[2019-05-16 10:10:23.414] <people_in_space>: data: {"message": "success", "number": 6, "people": [{"craft": "ISS", "name": "Oleg Kononenko"}, {"craft": "ISS", "name": "David Saint-Jacques"}, {"craft": "ISS", "name": "Anne McClain"}, {"craft": "ISS", "name": "Alexey Ovchinin"}, {"craft": "ISS", "name": "Nick Hague"}, {"craft": "ISS", "name": "Christina Koch"}]}
[2019-05-16 10:10:23.489] <external_ip>: download completed
[2019-05-16 10:10:23.489] <external_ip>: address is now "[EXTERNAL IP - REDACTED]"; was ""
[2019-05-16 10:10:33.312] Notification.HandleCallback(): NotificationExpired
[2019-05-16 10:10:33.312] Notification.HandleCallback(): no specific callback provided
[2019-05-16 10:10:33.312] Notification.HandleCallback(): no reply port provided
[2019-05-16 10:10:55.176] <KeyWatcher> state of scroll changed to False
[2019-05-16 10:10:55.176] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 10:10:55.176] MasterRequestHandler.Handle(): access token:      
[2019-05-16 10:10:55.176] MasterRequestHandler.Handle(): what:              DeleteNotification (9)
[2019-05-16 10:10:55.176] MasterRequestHandler.Handle(): host:              
[2019-05-16 10:10:55.176] MasterRequestHandler.Handle(): timestamp:         5/16/2019 10:10:55 AM
[2019-05-16 10:10:55.176] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 10:10:55.177] MasterRequestHandler.Handle(): headers...
[2019-05-16 10:10:55.177] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:55.177] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 10:10:55.177] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:55.177] SnarlAppHost.HideNotification(): NotificationNotFound: Notification not found
[2019-05-16 10:10:55.285] <KeyWatcher> state of scroll changed to True
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): access token:      
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): what:              Notify (2)
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): host:              
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): timestamp:         5/16/2019 10:10:55 AM
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): headers...
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 10:10:55.285] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:10:55.285] MasterMessageHandler.doNotify(): creating notification...
[2019-05-16 10:10:55.285] MasterMessageHandler.doNotify(): processing...
[2019-05-16 10:10:55.285] Notification.Process(): data...
[2019-05-16 10:10:55.285] Notification.Process(): looking for registration "local.snarl.extension.KeyWatcher"...
[2019-05-16 10:10:55.285] Registrar.Find(): looking for AppId local.snarl.extension.KeyWatcher...
[2019-05-16 10:10:55.285] Registrar.Find(): found
[2019-05-16 10:10:55.285] Notification.Process(): using default event...
[2019-05-16 10:10:55.285] IconHelper.IconHelper(): using stock icon "E:\Temp\Snarl\etc\icons\stock\system-warning.png"
[2019-05-16 10:10:55.285] NotificationRoster.Add(): uid=scroll-lock-on mode=Normal
[2019-05-16 10:10:55.285] NotificationRoster.Add(): replay=False forwarded=False
[2019-05-16 10:10:55.286] Notification.SendToOSD(): Sending "notify?transport=Snarl&api=5.1&flags=0&app-sig=local.snarl.extension.KeyWatcher&app-icon=E:\Temp\Snarl\apps\KeyWatcher\icon.png&app-name=KeyWatcher&event-name=(Default)&guid=56fca6af-afac-491e-8b4f-28cd53da5088&token=448&title=Scroll Lock on&icon=E:\Temp\Snarl\etc\icons\stock\system-warning.png&priority=0&timeout=10"...
[2019-05-16 10:10:55.351] Notification.SendToOSD(): OSD replied with Success
[2019-05-16 10:10:55.351] NotificationRoster.Add(): created notification 10076e49-ac2e-4803-bae3-95c5bed5f6e1 (448)
[2019-05-16 10:10:55.351] RulesRoster.Process(): added to roster ok, token=448
[2019-05-16 10:10:55.352] MasterMessageHandler.doNotify(): Created
[2019-05-16 10:10:55.352] SnarlAppHost.ShowNotification(): Created
[2019-05-16 10:11:00.638] <KeyWatcher> state of scroll changed to False
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): access token:      
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): what:              DeleteNotification (9)
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): host:              
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): timestamp:         5/16/2019 10:11:00 AM
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): headers...
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 10:11:00.638] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:11:00.638] Going to hide 10076e49-ac2e-4803-bae3-95c5bed5f6e1
[2019-05-16 10:11:00.639] Notification.HandleCallback(): NotificationDismissed
[2019-05-16 10:11:00.639] Notification.HandleCallback(): no specific callback provided
[2019-05-16 10:11:00.639] Notification.HandleCallback(): asking reply port to handle signal...
[2019-05-16 10:11:00.639] SnarlAppHost.HideNotification(): Success
[2019-05-16 10:11:00.640] ExtensionReplyPort.MessageReceived(): NotificationDismissed
[2019-05-16 10:11:00.640] #### DISMISSED ####
[2019-05-16 10:11:00.640] Notification.HandleCallback(): result was Success
[2019-05-16 10:11:00.751] <KeyWatcher> state of scroll changed to True
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): sending subsystem: SnarlApp
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): access token:      
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): what:              Notify (2)
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): host:              
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): timestamp:         5/16/2019 10:11:00 AM
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): has content?       True
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): headers...
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): |** not authorised **|
[2019-05-16 10:11:00.751] MasterRequestHandler.Handle(): ----------------------
[2019-05-16 10:11:00.751] MasterMessageHandler.doNotify(): creating notification...
[2019-05-16 10:11:00.751] MasterMessageHandler.doNotify(): processing...
[2019-05-16 10:11:00.751] Notification.Process(): data...
[2019-05-16 10:11:00.751] Notification.Process(): looking for registration "local.snarl.extension.KeyWatcher"...
[2019-05-16 10:11:00.751] Registrar.Find(): looking for AppId local.snarl.extension.KeyWatcher...
[2019-05-16 10:11:00.751] Registrar.Find(): found
[2019-05-16 10:11:00.751] Notification.Process(): using default event...
[2019-05-16 10:11:00.751] IconHelper.IconHelper(): using stock icon "E:\Temp\Snarl\etc\icons\stock\system-warning.png"
[2019-05-16 10:11:00.751] NotificationRoster.Add(): uid=scroll-lock-on mode=Normal
[2019-05-16 10:11:00.751] NotificationRoster.Add(): replay=False forwarded=False
[2019-05-16 10:11:00.752] Notification.SendToOSD(): Sending "notify?transport=Snarl&api=5.1&flags=0&app-sig=local.snarl.extension.KeyWatcher&app-icon=E:\Temp\Snarl\apps\KeyWatcher\icon.png&app-name=KeyWatcher&event-name=(Default)&guid=f5bcea1c-216f-4484-af38-11385de498cf&token=452&title=Scroll Lock on&icon=E:\Temp\Snarl\etc\icons\stock\system-warning.png&priority=0&timeout=10"...
[2019-05-16 10:11:00.767] Notification.SendToOSD(): OSD replied with Success
[2019-05-16 10:11:00.767] NotificationRoster.Add(): created notification 847cd664-684c-4164-bff6-e268696e5b13 (452)
[2019-05-16 10:11:00.767] RulesRoster.Process(): added to roster ok, token=452
[2019-05-16 10:11:00.767] MasterMessageHandler.doNotify(): Created
[2019-05-16 10:11:00.767] SnarlAppHost.ShowNotification(): Created
[2019-05-16 10:11:10.764] Notification.HandleCallback(): NotificationExpired
[2019-05-16 10:11:10.764] Notification.HandleCallback(): no specific callback provided
[2019-05-16 10:11:10.764] Notification.HandleCallback(): asking reply port to handle signal...
[2019-05-16 10:11:10.764] ExtensionReplyPort.MessageReceived(): NotificationExpired
[2019-05-16 10:11:10.764] Notification.HandleCallback(): result was Success
[2019-05-16 10:11:56.313] Stopping presence monitor...
[2019-05-16 10:11:56.313] Removing tray icon...
[2019-05-16 10:11:56.325] Stopping network roster...
[2019-05-16 10:11:56.327] [win32ipc]: closing window...
[2019-05-16 10:11:56.327] CustomWindow.threadProc(): WM_QUIT: tidying up...
[2019-05-16 10:11:56.327] [win32ipc]: 0x0090
[2019-05-16 10:11:56.328] [win32ipc]: 0x0002
[2019-05-16 10:11:56.328] [win32ipc]: 0x0082
[2019-05-16 10:11:56.529] network.service: stopping transports...
net.fullphat.gntp: stop
[2019-05-16 10:11:56.529]     net.fullphat.gntp: NotInitialised
[2019-05-16 10:11:56.529]     net.fullphat.simple_udp: Success
[2019-05-16 10:11:56.530] net.fullphat.snp: stop
[2019-05-16 10:11:56.530]     net.fullphat.snp: NotInitialised
[2019-05-16 10:11:56.530] net.fullphat.snphttp: stop
[2019-05-16 10:11:56.530]     net.fullphat.snphttp: NotInitialised
[2019-05-16 10:11:56.530] [win32ipc]: stop
[2019-05-16 10:11:56.530]     net.fullphat.win32ipc: Success
[2019-05-16 10:11:56.530] Stopping extension roster...
[2019-05-16 10:11:56.731] Stopping application roster...
[2019-05-16 10:11:56.731] Telling SnarlOSD to quit...
[2019-05-16 10:11:56.731] CustomWindow.Dispose()
[2019-05-16 10:11:56.733] CustomWindow.Destroy(): DestroyWindow() returned: True
[2019-05-16 10:11:56.734] Stopping management server...
[2019-05-16 10:11:56.735] ===== END =====
LeeThompson commented 5 years ago

Since this seems to be ... weird - maybe a better workaround could be a config setting to set the url when 'settings' is selected in the tray?

fullphat commented 5 years ago

Thanks for the logs - they show that everything's working correctly so far as Snarl's concerned. My test laptop is Windows 10 Pro as well so I wonder if there's something strange going on with Enterprise Edition?

I could add a custom string in the settings field, but you wouldn't be able to get to the settings (except manually) to change it!

LeeThompson commented 5 years ago

I could add a custom string in the settings field, but you wouldn't be able to get to the settings (except manually) to change it!

That might be ok if this is a rare weirdness :)

fullphat commented 5 years ago

Fair enough! New option added in Beta2

LeeThompson commented 5 years ago

Fair enough! New option added in Beta2

Thanks! If it turns out to be a more widespread issue I'd be happy to help track it down since obviously I have a machine doing it but if it's just that one easier just to set a config option lol (So if you want you can consider it closed for now).

LeeThompson commented 5 years ago

Saw the new setting in Beta 4. Works fine! Thanks!