mherger wrote: 
> If you enabled debug logging for plugin.spotty you'd see what exact 
> parameters it was using to run those auth calls etc. Please do so and 
> see where you'd get that Mercury error. Then we can try to run that 
> command from the command line. 

Hello again... Below, I'm copying the resulting server log after I
enabled debug logging for Spotty. I updated to the latest 7.9.2 build,
cleared the log, rebooted the server and clicked on the "Playlist" and
"Transfer Playback" links on the Spotty page. Let me know if you find
anything that I can change/try later. I have to head out to work and
couldn't see anything that I could act upon. I added XX to the last
three octets of the Mac address as  I believe this is also used as the
S/N for Squeezeboxes

[18-04-26 11:57:35.7699] main::init (387) Starting Logitech Media Server
(v7.9.2, 1524593278, Wed Apr 25 07:38:10 WEDT 2018) perl 5.014001 -
MSWin32-x86-multi-thread
[18-04-26 11:57:43.0465] Plugins::CustomScan::Scanner::executeSQLFile
(522) Couldn't open:
C:\ProgramData\Squeezebox\Cache\InstalledPlugins\Plugins\CustomScan\SQL\SQLite\dbupgrade_valuesort.sql
: No such file or directory
[18-04-26 11:57:43.0476] Plugins::CustomScan::Scanner::executeSQLFile
(522) Couldn't open:
C:\ProgramData\Squeezebox\Cache\InstalledPlugins\Plugins\CustomScan\SQL\SQLite\dbupgrade_extravalue.sql
: No such file or directory
[18-04-26 11:57:43.0490] Plugins::CustomScan::Scanner::executeSQLFile
(522) Couldn't open:
C:\ProgramData\Squeezebox\Cache\InstalledPlugins\Plugins\CustomScan\SQL\SQLite\dbupgrade_valuetype.sql
: No such file or directory
[18-04-26 11:57:43.2927] Plugins::NPRRadio::Metadata::init (21) Register
NPR meta provider, default icon= 
[18-04-26 11:57:43.3636] Plugins::Spotty::Plugin::purgeAudioCache (464)
Starting audio cache cleanup...
[18-04-26 11:57:43.3666] Plugins::Spotty::Plugin::purgeAudioCache (487)
Max. cache size is: 0MB, current cache size is 0MB
[18-04-26 11:57:43.3677] Plugins::Spotty::Plugin::purgeAudioCache (518)
Starting temporary file cleanup... (C:\Users\Luis\AppData\Local\Temp)
[18-04-26 11:57:43.3728] Plugins::Spotty::Plugin::purgeAudioCache (538)
Audio cache cleanup done!
[18-04-26 11:57:48.6384] Plugins::Spotty::Plugin::findBin (775) Trying
helper applicaton:
C:\PROGRA~3\SQUEEZ~1\Cache\INSTAL~1\Plugins\Spotty\Bin\MSWIN3~1\spotty.exe
[18-04-26 11:57:48.7341] Plugins::Spotty::Plugin::helperCheck (701)
Found helper capabilities table: do {
my $a = {
debug => bless(do{\(my $o = 0)}, "JSON::XS::Boolean"),
"lms-auth" => bless(do{\(my $o = 1)}, "JSON::XS::Boolean"),
version => "0.11.0",
"volume-normalisation" => 'fix',
};
$a->{"volume-normalisation"} = \${$a->{"lms-auth"}};
$a;
}
[18-04-26 11:57:48.7345] Plugins::Spotty::Plugin::findBin (778) Found
helper applicaton:
C:\PROGRA~3\SQUEEZ~1\Cache\INSTAL~1\Plugins\Spotty\Bin\MSWIN3~1\spotty.exe
[18-04-26 11:57:50.2980] Slim::Plugin::MusicMagic::Common::__ANON__ (85)
Failed fetching filters from MusicIP
[18-04-26 11:57:52.4007]
Plugins::Spotty::Connect::DaemonManager::initHelpers (70) Initializing
Spotty Connect helper daemons...
[18-04-26 11:57:52.4012]
Plugins::Spotty::Connect::DaemonManager::startHelper (96) Need to create
Connect daemon for 00:04:20:XX:XX:XX
[18-04-26 11:57:52.4079] Plugins::Spotty::Connect::Daemon::start (66)
Starting Spotty Connect daemon: 
C:\PROGRA~3\SQUEEZ~1\Cache\INSTAL~1\Plugins\Spotty\Bin\MSWIN3~1\spotty.exe
-c C:\ProgramData\Squeezebox\Cache\spotty\000420XXXXXX -n Transporter
--disable-audio-cache --bitrate 96 --player-mac 00:04:20:XX:XX:XX --lms
192.168.1.100:9000
[18-04-26 11:58:52.0036]
Plugins::Spotty::Connect::DaemonManager::initHelpers (70) Initializing
Spotty Connect helper daemons...
[18-04-26 11:59:52.0019]
Plugins::Spotty::Connect::DaemonManager::initHelpers (70) Initializing
Spotty Connect helper daemons...
[18-04-26 12:00:51.9540] Plugins::Spotty::API::getToken (101) Didn't
find cached token. Need to refresh.
[18-04-26 12:00:51.9553] Plugins::Spotty::API::getToken (121) Trying to
get access token:
C:\PROGRA~3\SQUEEZ~1\Cache\INSTAL~1\Plugins\Spotty\Bin\MSWIN3~1\spotty.exe
-n Squeezebox -c "C:\ProgramData\Squeezebox\Cache\spotty\cd148266" -i
Transporter --get-token --scope
"user-read-private,user-follow-modify,user-follow-read,user-library-read,user-library-modify,user-top-read,user-read-recently-played,user-read-playback-state,user-modify-playback-state,playlist-read-private,playlist-read-collaborative,playlist-modify-public,playlist-modify-private"
[18-04-26 12:00:52.6891] Plugins::Spotty::API::getToken (124) Got
response: error getting token MercuryError
[18-04-26 12:00:52.6895] Plugins::Spotty::API::getToken (128) Failed to
get Spotify access token: malformed JSON string, neither array, object,
number, string or atom, at character offset 0 (before "error getting
token ...") at
C:\ProgramData\Squeezebox\Cache\InstalledPlugins/Plugins/Spotty/API.pm
line 125.

error getting token MercuryError
[18-04-26 12:00:52.6900] Plugins::Spotty::API::getToken (145) Failed to
get Spotify access token
[18-04-26 12:00:52.6916] Plugins::Spotty::API::getToken (96) Found
cached token: -1
[18-04-26 12:00:52.7439]
Plugins::Spotty::Connect::DaemonManager::initHelpers (70) Initializing
Spotty Connect helper daemons...
[18-04-26 12:00:56.4027] Plugins::Spotty::API::getToken (96) Found
cached token: -1
[18-04-26 12:00:56.4047] Plugins::Spotty::API::getToken (96) Found
cached token: -1
[18-04-26 12:01:02.8171] Plugins::Spotty::API::getToken (96) Found
cached token: -1
[18-04-26 12:01:02.8183] Plugins::Spotty::API::getToken (96) Found
cached token: -1


------------------------------------------------------------------------
tamanaco's Profile: http://forums.slimdevices.com/member.php?userid=4620
View this thread: http://forums.slimdevices.com/showthread.php?t=108898

_______________________________________________
plugins mailing list
plugins@lists.slimdevices.com
http://lists.slimdevices.com/mailman/listinfo/plugins

Reply via email to