-- Logs begin at Thu 2025-07-03 04:31:24 CDT, end at Thu 2025-07-03 13:22:39 CDT. -- Jul 03 13:21:16 volumio-ski-dock volumiologrotate[593]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jul 03 13:21:16 volumio-ski-dock volumiologrotate[593]: ls: cannot access 'SKI': No such file or directory Jul 03 13:21:16 volumio-ski-dock volumiologrotate[593]: ls: cannot access 'DOCK': No such file or directory Jul 03 13:21:26 volumio-ski-dock volumio[974]: info: CorePlayQueue::getQueue Jul 03 13:21:26 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 4 Jul 03 13:21:26 volumio-ski-dock volumio[974]: info: [1751566886114] ControllerPandora::ExpireOldTracks::reaper Jul 03 13:21:26 volumio-ski-dock volumio[974]: info: [1751566886114] [Pandora] ExpireOldTracks::reaper: No victims found: Expiring zero tracks. Don't worry -- Jason will return. Jul 03 13:22:17 volumio-ski-dock volumiologrotate[593]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jul 03 13:22:17 volumio-ski-dock volumiologrotate[593]: ls: cannot access 'SKI': No such file or directory Jul 03 13:22:17 volumio-ski-dock volumiologrotate[593]: ls: cannot access 'DOCK': No such file or directory Jul 03 13:22:32 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 4 Jul 03 13:22:32 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 11 Jul 03 13:22:32 volumio-ski-dock volumio[974]: info: Prefetching next song Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957400] ControllerPandora::pandoraListener Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ControllerMpd::getState Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: Jul 03 13:22:37 volumio-ski-dock volumio[974]: ---------------------------- MPD announces state update: player Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ControllerMpd::getState Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: sendMpdCommand status took 1 milliseconds Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: sendMpdCommand status took 1 milliseconds Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseState Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 4 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957403] ControllerPandora::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::servicePushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 4 Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"trackType":"mp3"} Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: CURRENT POSITION 4 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState stateService stop Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState currentStatus play Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::play index undefined Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 11 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ControllerMpd::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::servicePushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 11 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 11 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::startPlaybackTimer Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 11 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957424] ControllerPandora::clearAddPlayTrack Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ControllerMpd::clear Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand clear Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ------------------------------ 24ms Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: Jul 03 13:22:37 volumio-ski-dock volumio[974]: ---------------------------- MPD announces system playlist update Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: Ignoring MPD Status Update Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: sendMpdCommand clear took 8 milliseconds Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957434] ControllerPandora::checkForExpiredStations Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957434] [Pandora] checkForExpiredStations: Stations expired Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957434] ControllerPandora::PandoraHandler::fillStationData Jul 03 13:22:37 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:37 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:37 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:37 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:37 volumio-ski-dock volumio[974]: error: updateQueue error: null Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ------------------------------ 23ms Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getQueue Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957797] ControllerPandora::removeTrack Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::removeQueueItem Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::removeQueueItem 4 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::saveQueue Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushQueue Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957803] [Pandora] removeTrack: Removed track with uri: /pandora/stationToken=105742234413966655trackId=1796781934410945298 at queue index: 4 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ControllerMpd::getState Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957806] ControllerPandora::appendTracksToMpd Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957807] [Pandora] appendTracksToMpd: Added 1 track(s) to mpd Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand addid Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand play Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: Jul 03 13:22:37 volumio-ski-dock volumio[974]: ---------------------------- MPD announces system playlist update Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: Ignoring MPD Status Update Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: sendMpdCommand status took 10 milliseconds Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: sendMpdCommand addid took 6 milliseconds Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: sendMpdCommand play took 7 milliseconds Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957814] ControllerPandora::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::servicePushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 10 Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null,"trackType":"mp3"} Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: CURRENT POSITION 10 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState stateService stop Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState currentStatus stop Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: No code Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: MPD COMMAND [object Object] Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957827] ControllerPandora::pushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreCommandRouter::servicePushState Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 10 Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: STATE SERVICE {"service":"pandora","type":"song","trackType":"mp3","title":"That Lady (Pt. 1 & 2)","name":"That Lady (Pt. 1 & 2)","artist":"The Isley Brothers","album":"It's Your Thing: The Story Of The Isley Brothers","albumart":"http://cont-2.p-cdn.us/images/1e/67/a9/b6/c06c46c58df2bca692d26beb/1080W_1080H.jpg","realUri":"http://t1-3.p-cdn.us/access/2840608400473362179.mp3?version=5&lid=139994741&token=UVCCSkkm1XX54rblEenmP5V%2FesClw9TCHx8WeZBDfnV0rArLoJWDfjUUAQ0JGJusBuWe6CPXwL6emRSjvTBnhrS4L2Yh9AoGWQTD9Zo4fwGvGGJ8XA%2BTZkVTd7rf3gNucR5OazIsHSIIa0qCOEgb7Za0S8IaY2WwJtbpS%2BmwpouZhjMOY9xCPgkmb2F5pKk6yryNml1PSHEHAZGJbM33UXPtjsuFtVGFMCS3kQclB49g8KxhvIbqiX72VgORc3jvUh%2FE7x1XOYIOgOLtUEq5jcrx4QbXRuhW7d3Ihc0yIXnXwY7aOO%2FaHbJq80%2BFSwLmWq73uV3uzONsMkbY20d1ug%3D%3D","isStreaming":true,"duration":334,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"uri":"http://t1-3.p-cdn.us/access/2840608400473362179.mp3?version=5&lid=139994741&token=UVCCSkkm1XX54rblEenmP5V%2FesClw9TCHx8WeZBDfnV0rArLoJWDfjUUAQ0JGJusBuWe6CPXwL6emRSjvTBnhrS4L2Yh9AoGWQTD9Zo4fwGvGGJ8XA%2BTZkVTd7rf3gNucR5OazIsHSIIa0qCOEgb7Za0S8IaY2WwJtbpS%2BmwpouZhjMOY9xCPgkmb2F5pKk6yryNml1PSHEHAZGJbM33UXPtjsuFtVGFMCS3kQclB49g8KxhvIbqiX72VgORc3jvUh%2FE7x1XOYIOgOLtUEq5jcrx4QbXRuhW7d3Ihc0yIXnXwY7aOO%2FaHbJq80%2BFSwLmWq73uV3uzONsMkbY20d1ug%3D%3D","seek":0,"status":"play"} Jul 03 13:22:37 volumio-ski-dock volumio[974]: verbose: CURRENT POSITION 10 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState stateService play Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState currentStatus stop Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957833] ControllerPandora::fetchAndAddTracks Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957834] ControllerPandora::getStationTracks Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getQueue Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957834] [Pandora] PandoraHandler::getSongMaxDiff: -1 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957834] ControllerPandora::fetchAndAddTracks::getSqInfo Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957835] ControllerPandora::getStationTracks Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getQueue Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: CorePlayQueue::getQueue Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957835] [Pandora] fetchAndAddTracks: diff1: -1 sQPos1: 9 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957835] [Pandora] fetchAndAddTracks: Fetching tracks Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: [1751566957835] ControllerPandora::PandoraHandler::fillStationData Jul 03 13:22:37 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:37 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:37 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: Jul 03 13:22:37 volumio-ski-dock volumio[974]: ---------------------------- MPD announces system playlist update Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: Ignoring MPD Status Update Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ------------------------------ 38ms Jul 03 13:22:37 volumio-ski-dock volumio[974]: info: ------------------------------ 3ms Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: [1751566958193] ControllerPandora::PandoraHandler::fetchTracks::fetchStationPlaylist Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: [1751566958249] ControllerPandora::pandoraListener Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: ControllerMpd::getState Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: Jul 03 13:22:38 volumio-ski-dock volumio[974]: ---------------------------- MPD announces state update: player Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: ControllerMpd::getState Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jul 03 13:22:38 volumio-ski-dock kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: Jul 03 13:22:38 volumio-ski-dock volumio[974]: ---------------------------- MPD announces state update: player Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: sendMpdCommand status took 29 milliseconds Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: ControllerMpd::getState Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand status Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: sendMpdCommand status took 28 milliseconds Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseState Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseState Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: sendMpdCommand status took 2 milliseconds Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseState Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseTrackInfo Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseTrackInfo Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 10 Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: [1751566958284] ControllerPandora::pushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreCommandRouter::servicePushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 10 Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":334,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"That Lady (Pt. 1 & 2)","artist":"The Isley Brothers","album":"It's Your Thing: The Story Of The Isley Brothers","uri":"http://t1-3.p-cdn.us/access/2840608400473362179.mp3?version=5&lid=139994741&token=UVCCSkkm1XX54rblEenmP5V%2FesClw9TCHx8WeZBDfnV0rArLoJWDfjUUAQ0JGJusBuWe6CPXwL6emRSjvTBnhrS4L2Yh9AoGWQTD9Zo4fwGvGGJ8XA%2BTZkVTd7rf3gNucR5OazIsHSIIa0qCOEgb7Za0S8IaY2WwJtbpS%2BmwpouZhjMOY9xCPgkmb2F5pKk6yryNml1PSHEHAZGJbM33UXPtjsuFtVGFMCS3kQclB49g8KxhvIbqiX72VgORc3jvUh%2FE7x1XOYIOgOLtUEq5jcrx4QbXRuhW7d3Ihc0yIXnXwY7aOO%2FaHbJq80%2BFSwLmWq73uV3uzONsMkbY20d1ug%3D%3D","trackType":"mp3"} Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: CURRENT POSITION 10 Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState stateService play Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreStateMachine::syncState currentStatus play Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: Received an update from plugin. extracting info from payload Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreStateMachine::pushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioPushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: MRS: Pushing multiroomSync output Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreStateMachine::setConsumeUpdateService pandora Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: ControllerMpd::pushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreCommandRouter::servicePushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 10 Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: ------------------------------ 47ms Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 03 13:22:38 volumio-ski-dock volumio[974]: verbose: ControllerMpd::parseTrackInfo Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: ControllerMpd::pushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreCommandRouter::servicePushState Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CorePlayQueue::getTrack 10 Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current pandora Received mpd Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: ------------------------------ 21ms Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreCommandRouter::volumioGetQueue Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CoreStateMachine::getQueue Jul 03 13:22:38 volumio-ski-dock volumio[974]: info: CorePlayQueue::getQueue Jul 03 13:22:38 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:38 volumio-ski-dock volumio[974]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jul 03 13:22:38 volumio-ski-dock volumio[974]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 13:22:38 volumio-ski-dock volumio[974]: SyntaxError: Unexpected token u in JSON at position 0 Jul 03 13:22:38 volumio-ski-dock volumio[974]: at JSON.parse () Jul 03 13:22:38 volumio-ski-dock volumio[974]: at Request._callback (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:41:31) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at Request.self.callback (/data/plugins/music_service/pandora/node_modules/request/request.js:185:22) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at Request.emit (events.js:315:20) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at Request. (/data/plugins/music_service/pandora/node_modules/request/request.js:1154:10) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at Request.emit (events.js:315:20) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:1076:12) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at Object.onceWrapper (events.js:421:28) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at IncomingMessage.emit (events.js:327:22) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 03 13:22:38 volumio-ski-dock volumio[974]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 03 13:22:38 volumio-ski-dock volumio[974]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 13:22:39 volumio-ski-dock sudo[29115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-03 13:21 Jul 03 13:22:39 volumio-ski-dock sudo[29115]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"