Triode wrote: > If you can still browse into spotify menus to the level which causes > spotifyd to be called then it has started up ok? Can you confirm - does > search work for instance at this point? > > You can set debug options on the server logging page and specify that > they are persistent so they stay applied when it restarts.
Thanks, I can search - but not play, this is what the log has with debug logging added: [22:09:01.606824] main:586 req: status.json res: (null) par: (null) prot: HTTP/1.0 auth: (null) [22:09:01.606931] process_status:1204 process status [22:09:16.026436] logged_out:60 logged out [22:09:16.042524] main:416 /var/lib/squeezeboxserver/cache/InstalledPlugins/Plugins/Spotify/Bin/i386-linux/spotifyd 2.2.9 started [22:09:16.042837] main:445 Config: username: USER cachedir: /var/lib/squeezeboxserver/cache/spotifycache bitrate: 320 volnorm: 1 httpport: 9005 cliport: 9090 [22:09:16.344454] main:534 new connection [22:09:16.345280] main:586 req: status.json res: (null) par: login prot: HTTP/1.0 auth: (null) [22:09:16.346427] main:665 relogging in as user: USER [22:09:16.349789] log_message:80 log: 22:09:16.349 I [ap:1766] Connecting to AP ap.spotify.com:4070 [22:09:16.353106] logged_in:53 logged in [22:09:16.377709] log_message:80 log: 22:09:16.377 I [ap:1224] Connected to AP: 78.31.8.82:4070 [22:09:17.353264] process_status:1204 process status [22:09:24.959780] logged_out:60 logged out [22:09:50.075940] main:416 /var/lib/squeezeboxserver/cache/InstalledPlugins/Plugins/Spotify/Bin/i386-linux/spotifyd 2.2.9 started [22:09:50.076825] main:445 Config: username: USER cachedir: /var/lib/squeezeboxserver/cache/spotifycache bitrate: 320 volnorm: 1 httpport: 9005 cliport: 9090 [22:09:55.195921] main:534 new connection [22:09:55.237690] main:586 req: browse.json res: spotify:track:4HZWSOWXgfRmvSN6A0Hndo par: (null) prot: HTTP/1.0 auth: (null) [22:09:55.238417] main:665 relogging in as user: USER [22:09:55.240916] log_message:80 log: 22:09:55.240 I [ap:1766] Connecting to AP ap.spotify.com:4070 [22:09:55.244478] logged_in:53 logged in [22:09:55.253500] log_message:80 log: 22:09:55.253 I [ap:1224] Connected to AP: 78.31.9.67:4070 [22:09:56.244719] main:1045 queuing track browse [22:09:56.309851] metadata_updated:85 new meta [22:09:56.309926] process_track:1154 process track [22:09:56.310027] process_track:1178 browse track: ok [22:12:49.546599] main:534 new connection [22:12:49.547185] main:586 req: status.json res: (null) par: (null) prot: HTTP/1.0 auth: (null) [22:12:49.547247] process_status:1204 process status [22:13:35.582354] main:534 new connection [22:13:35.583674] main:586 req: search.json res: (null) par: o=0&arq=10&alq=10&trq=10&q=H prot: HTTP/1.0 auth: (null) [22:13:35.583759] main:1112 search: H offset: 0 artist count: 10 album count: 10 track count: 10 [22:13:35.627875] search_callback:575 search: ok [22:13:35.634732] metadata_updated:85 new meta [22:13:37.142460] main:534 new connection [22:13:37.143388] main:586 req: search.json res: (null) par: o=0&arq=500&q=H prot: HTTP/1.0 auth: (null) [22:13:37.143449] main:1112 search: H offset: 0 artist count: 200 album count: 0 track count: 0 [22:13:37.273617] search_callback:575 search: ok [22:13:43.679097] main:534 new connection [22:13:43.680036] main:586 req: browse.json res: spotify:artist:1CG5RDRCUAce5jNYBzCv5n par: (null) prot: HTTP/1.0 auth: (null) [22:13:43.680193] main:993 created artist browse [22:13:43.702159] browse_artist_callback:147 browse artist: ok And then a service restart has the following in the log: [22:15:11.212218] logged_out:60 logged out [22:15:12.738693] main:416 /var/lib/squeezeboxserver/cache/InstalledPlugins/Plugins/Spotify/Bin/i386-linux/spotifyd 2.2.9 started [22:15:12.738901] main:445 Config: username: USER cachedir: /var/lib/squeezeboxserver/cache/spotifycache bitrate: 320 volnorm: 1 httpport: 9005 cliport: 9090 [22:15:17.368087] main:534 new connection [22:15:17.370087] main:586 req: browse.json res: spotify:track:4HZWSOWXgfRmvSN6A0Hndo par: (null) prot: HTTP/1.0 auth: (null) [22:15:17.370794] main:665 relogging in as user: mattbowne [22:15:17.372689] log_message:80 log: 22:15:17.372 I [ap:1766] Connecting to AP ap.spotify.com:4070 [22:15:17.374102] logged_in:53 logged in [22:15:17.395468] log_message:80 log: 22:15:17.395 I [ap:1224] Connected to AP: 78.31.9.67:4070 [22:15:18.374314] main:1045 queuing track browse [22:15:18.456534] metadata_updated:85 new meta [22:15:18.456617] process_track:1154 process track [22:15:18.456734] process_track:1178 browse track: ok [22:15:24.705929] main:534 new connection [22:15:24.706678] main:586 req: stream.pcm res: spotify:track:4HZWSOWXgfRmvSN6A0Hndo par: player=00%3A04%3A20%3A12%3A67%3Acf&start=0&sync=1&id=1 prot: SPOTSTREAM/1.0 auth: (null) [22:15:24.706773] main:776 newstream connection from 192.168.1.72 [22:15:24.706800] main:812 streamid: 0 newid: 1 type: PCM [22:15:24.708264] check_player:242 1: 706c61796572206973706c617965722030302533413034253341323025334131322533413637253341636620310a00fbbfff0f00000180adfb277f1100a0180708040000008c [22:15:24.709010] check_player:279 2: 706c6179657220697020303025334130342533413230253341313225334136372533416366203139322e3136382e312e373225334135373331340a0000a0180708040000008c [22:15:24.709100] main:849 streambuf_newstream [22:15:24.709147] main:1661 new stream pending state: Resource not loaded yet [22:15:24.709202] main:1661 new stream pending state: Resource not loaded yet [22:15:24.776460] main:1661 new stream pending state: Resource not loaded yet [22:15:24.776611] metadata_updated:85 new meta [22:15:24.776648] main:1625 Now playing: No Worries [22:15:24.831353] music_delivery:485 channels: 2 sample rate: 44100 streaming as: PCM [22:15:30.752749] main:534 new connection [22:15:30.753495] main:586 req: stream.pcm res: spotify:track:4HZWSOWXgfRmvSN6A0Hndo par: player=00%3A04%3A20%3A12%3A67%3Acf&start=0&sync=1&id=2 prot: SPOTSTREAM/1.0 auth: (null) [22:15:30.753610] main:776 newstream connection from 192.168.1.72 [22:15:30.753638] main:812 streamid: 1 newid: 2 type: PCM [22:15:30.753658] main:816 existing streaming connection exists - killing [22:15:30.753711] main:849 streambuf_newstream [22:15:30.753748] main:1625 Now playing: No Worries [22:15:30.801687] music_delivery:485 channels: 2 sample rate: 44100 streaming as: PCM ------------------------------------------------------------------------ mattbrowne's Profile: http://forums.slimdevices.com/member.php?userid=33884 View this thread: http://forums.slimdevices.com/showthread.php?t=79706 _______________________________________________ plugins mailing list [email protected] http://lists.slimdevices.com/mailman/listinfo/plugins
