mattbrowne wrote: > 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
So looks to me that the helper app is running but it does not receive requests from players until you restart LMS. This sounds like a startup problem related to a firewall or something like that - you could also try changing the helper app port to see if something else is conflicting, but if its running ok and you can get search results then this side of things is working, its the fact that players don't manage to connect to it which is the problem. ------------------------------------------------------------------------ Triode's Profile: http://forums.slimdevices.com/member.php?userid=17 View this thread: http://forums.slimdevices.com/showthread.php?t=79706 _______________________________________________ plugins mailing list [email protected] http://lists.slimdevices.com/mailman/listinfo/plugins
