search

feelfreelinux / cspot

A Spotify Connect player targeting, but not limited to embedded devices (ESP32).
Other
460 stars 43 forks source link

TrackPlayer EOF #162

Open axbusch opened 8 months ago

axbusch commented 8 months ago

i build the last version and i'm testing on linux mint

i see the programm in spotify and can cast to the program It starts an then immediately stops playing. I see some EOF log and then when i try to start to play again the same thing happens

`/cspotcli Start stop [2023-10-26 21:19:13.465] I BellHTTPServer.cpp:191: Server listening on port 7864

[2023-10-26 21:19:13.471] I MDNSService.cpp:121: using avahi for CSpot player Waiting for spotify app to connect... [2023-10-26 21:19:26.424] I main.cpp:88: Received zeroauth POST data [2023-10-26 21:19:26.425] I main.cpp:195: Creating player [2023-10-26 21:19:26.559] D Session.cpp:67: Connecting with AP [2023-10-26 21:19:26.591] D PlainConnection.cpp:101: Connected to spotify server [2023-10-26 21:19:26.617] I Session.cpp:43: Received APHello response [2023-10-26 21:19:26.618] D Session.cpp:48: Received shannon keys [2023-10-26 21:19:26.687] D Session.cpp:87: Authorization successful [2023-10-26 21:19:26.687] I MercurySession.cpp:42: Received packet, command: 4 [2023-10-26 21:19:26.688] D TimeProvider.cpp:15: Time synced with spotify servers [2023-10-26 21:19:26.688] I MercurySession.cpp:42: Received packet, command: 2 [2023-10-26 21:19:26.688] I MercurySession.cpp:42: Received packet, command: 118 [2023-10-26 21:19:26.688] I MercurySession.cpp:42: Received packet, command: 27 [2023-10-26 21:19:26.688] I MercurySession.cpp:42: Received packet, command: 80 [2023-10-26 21:19:26.688] I MercurySession.cpp:42: Received packet, command: 31 [2023-10-26 21:19:26.688] I MercurySession.cpp:42: Received packet, command: 105 [2023-10-26 21:19:26.706] I MercurySession.cpp:42: Received packet, command: 181 [2023-10-26 21:19:26.769] I MercurySession.cpp:42: Received packet, command: 74 [2023-10-26 21:19:26.788] I AccessKeyFetcher.cpp:99: Access token expired, fetching new one... 265 [2023-10-26 21:19:26.940] I AccessKeyFetcher.cpp:114: Access token sucessfully fetched [2023-10-26 21:19:27.762] D MercurySession.cpp:251: Executing Mercury Request, type SUB [2023-10-26 21:19:27.763] D MercurySession.cpp:153: Received country code DE [2023-10-26 21:19:27.784] I MercurySession.cpp:42: Received packet, command: 179 [2023-10-26 21:19:27.784] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:27.784] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:27.785] D SpircHandler.cpp:61: Sent kMessageTypeHello! [2023-10-26 21:19:27.834] I MercurySession.cpp:42: Received packet, command: 181 [2023-10-26 21:19:27.835] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:27.835] D SpircHandler.cpp:69: Received subscription response [2023-10-26 21:19:27.835] D SpircHandler.cpp:132: Notify frame [2023-10-26 21:19:27.835] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:28.434] I MercurySession.cpp:42: Received packet, command: 181 [2023-10-26 21:19:28.434] D SpircHandler.cpp:69: Received subscription response [2023-10-26 21:19:28.434] D SpircHandler.cpp:179: Load frame 11! [2023-10-26 21:19:28.434] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:28.435] I TrackPlayer.cpp:98: Resetting state [2023-10-26 21:19:28.488] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:28.489] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:28.517] D MercurySession.cpp:251: Executing Mercury Request, type GET [2023-10-26 21:19:28.549] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:28.549] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:28.549] I TrackQueue.cpp:158: Track name: Show vor großem Publikum - Teil 10 [2023-10-26 21:19:28.549] I TrackQueue.cpp:159: Track duration: 86173 [2023-10-26 21:19:28.549] D TrackQueue.cpp:161: trackInfo.restriction.size() = 1 [2023-10-26 21:19:28.549] D TrackQueue.cpp:212: File format: 2 [2023-10-26 21:19:28.549] D TrackQueue.cpp:212: File format: 1 [2023-10-26 21:19:28.591] I MercurySession.cpp:42: Received packet, command: 13 [2023-10-26 21:19:28.591] I TrackQueue.cpp:252: Got audio key [2023-10-26 21:19:28.591] I TrackQueue.cpp:275: Received access key, fetching CDN URL... [2023-10-26 21:19:28.719] I TrackQueue.cpp:301: Received CDN URL, https://audio-ak-spotify-com.akamaized.net/audio/cd0499bebde81616a1ae147e1ad0171bea158f63?__token__=exp=1698441568~hmac=c2e1fc35ee7961156d2c6a19afb5d64098b1675b410dcc41cac3e8de826dd82d [2023-10-26 21:19:28.719] I TrackPlayer.cpp:171: Got track ID=cd0499bebde81616a1ae147e1ad0171bea158f63 [2023-10-26 21:19:28.719] I CDNAudioFile.cpp:43: Opening HTTP stream to https://audio-ak-spotify-com.akamaized.net/audio/cd0499bebde81616a1ae147e1ad0171bea158f63?__token__=exp=1698441568~hmac=c2e1fc35ee7961156d2c6a19afb5d64098b1675b410dcc41cac3e8de826dd82d [2023-10-26 21:19:28.897] I CDNAudioFile.cpp:70: Header and footer bytes received [2023-10-26 21:19:28.897] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:28.920] I TrackPlayer.cpp:205: Playing Last hash 0 new hash 5649293368421495089 [2023-10-26 21:19:28.937] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:28.980] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:28.981] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:29.012] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:29.012] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:30.315] I TrackPlayer.cpp:223: EOF [2023-10-26 21:19:30.315] I TrackPlayer.cpp:254: Playing done [2023-10-26 21:19:30.326] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:30.327] I TrackPlayer.cpp:98: Resetting state [2023-10-26 21:19:30.377] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:30.378] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:30.673] I TrackPlayer.cpp:171: Got track ID=cd0499bebde81616a1ae147e1ad0171bea158f63 [2023-10-26 21:19:30.673] I CDNAudioFile.cpp:43: Opening HTTP stream to https://audio-ak-spotify-com.akamaized.net/audio/cd0499bebde81616a1ae147e1ad0171bea158f63?__token__=exp=1698441568~hmac=c2e1fc35ee7961156d2c6a19afb5d64098b1675b410dcc41cac3e8de826dd82d [2023-10-26 21:19:30.786] I CDNAudioFile.cpp:70: Header and footer bytes received [2023-10-26 21:19:30.786] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:30.786] I TrackPlayer.cpp:205: Playing [2023-10-26 21:19:30.840] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:30.844] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:32.866] I TrackPlayer.cpp:223: EOF [2023-10-26 21:19:32.866] I TrackPlayer.cpp:254: Playing done [2023-10-26 21:19:33.321] I MercurySession.cpp:42: Received packet, command: 181 [2023-10-26 21:19:33.323] D SpircHandler.cpp:69: Received subscription response [2023-10-26 21:19:33.327] D SpircHandler.cpp:281: External play command [2023-10-26 21:19:33.327] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:33.374] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:33.377] I TrackPlayer.cpp:98: Resetting state [2023-10-26 21:19:33.400] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:33.409] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:33.461] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:33.461] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:33.661] I TrackPlayer.cpp:171: Got track ID=cd0499bebde81616a1ae147e1ad0171bea158f63 [2023-10-26 21:19:33.661] I CDNAudioFile.cpp:43: Opening HTTP stream to https://audio-ak-spotify-com.akamaized.net/audio/cd0499bebde81616a1ae147e1ad0171bea158f63?__token__=exp=1698441568~hmac=c2e1fc35ee7961156d2c6a19afb5d64098b1675b410dcc41cac3e8de826dd82d [2023-10-26 21:19:33.786] I CDNAudioFile.cpp:70: Header and footer bytes received [2023-10-26 21:19:33.786] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:33.786] I TrackPlayer.cpp:205: Playing [2023-10-26 21:19:33.835] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:33.835] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:35.878] I TrackPlayer.cpp:223: EOF [2023-10-26 21:19:35.878] I TrackPlayer.cpp:254: Playing done [2023-10-26 21:19:41.233] I MercurySession.cpp:42: Received packet, command: 181 [2023-10-26 21:19:41.233] D SpircHandler.cpp:69: Received subscription response [2023-10-26 21:19:41.233] D SpircHandler.cpp:281: External play command [2023-10-26 21:19:41.233] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:41.294] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:41.295] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:41.316] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:41.316] I TrackPlayer.cpp:98: Resetting state [2023-10-26 21:19:41.362] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:41.363] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:41.658] I TrackPlayer.cpp:171: Got track ID=cd0499bebde81616a1ae147e1ad0171bea158f63 [2023-10-26 21:19:41.658] I CDNAudioFile.cpp:43: Opening HTTP stream to https://audio-ak-spotify-com.akamaized.net/audio/cd0499bebde81616a1ae147e1ad0171bea158f63?__token__=exp=1698441568~hmac=c2e1fc35ee7961156d2c6a19afb5d64098b1675b410dcc41cac3e8de826dd82d [2023-10-26 21:19:41.783] I CDNAudioFile.cpp:70: Header and footer bytes received [2023-10-26 21:19:41.783] D MercurySession.cpp:251: Executing Mercury Request, type SEND [2023-10-26 21:19:41.784] I TrackPlayer.cpp:205: Playing [2023-10-26 21:19:41.879] I MercurySession.cpp:42: Received packet, command: 178 [2023-10-26 21:19:41.879] D MercurySession.cpp:174: Received mercury packet [2023-10-26 21:19:43.897] I TrackPlayer.cpp:223: EOF [2023-10-26 21:19:43.897] I TrackPlayer.cpp:254: Playing done `

Regards

philippe44 commented 8 months ago

What sink have you selected? Seems that you have the NamedPipe one, hence all track just play at download speed and you exhaust your playlist. You should chose a real backend.