-- Logs begin at Tue 2024-04-30 01:08:52 CEST, end at Tue 2024-04-30 01:14:43 CEST. -- Apr 30 01:13:03 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 01:13:03 volumio-salon volumio[738]: info: CURURI: music-library/NAS/MP3/CD Rip Apr 30 01:13:03 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:13:03 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:03 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:03 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:03 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:03 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:03 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:03 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:03 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:04 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:04 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:04 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:04 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:04 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:04 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:04 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:04 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:05 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:05 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:05 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:05 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:05 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:05 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:05 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:05 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:05 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:05 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:05 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:05 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:05 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:05 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:05 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:05 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:05 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:05 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:05 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:05 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:05 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:05 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:05 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:05 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:05 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:05 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:05 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:05 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:05 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:05 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:05 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:06 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:06 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:06 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:06 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:06 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:06 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:06 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:06 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:06 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:06 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:06 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:06 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:06 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:06 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:06 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:06 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:06 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:06 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:06 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:06 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:06 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:06 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:06 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:06 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:07 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:07 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:07 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:07 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:07 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:07 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:07 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:07 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:07 volumio-salon volumio[738]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Apr 30 01:13:07 volumio-salon volumio[738]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Apr 30 01:13:07 volumio-salon volumio[738]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) Apr 30 01:13:07 volumio-salon volumio[738]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) Apr 30 01:13:07 volumio-salon volumio[738]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) Apr 30 01:13:07 volumio-salon volumio[738]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:440:9) Apr 30 01:13:07 volumio-salon volumio[738]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 01:13:07 volumio-salon volumio[738]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 30 01:13:08 volumio-salon kernel: CIFS: __readahead_batch() returned 382/1024 Apr 30 01:13:08 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::ClearQueue Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::stop Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::clearPlayQueue Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::saveQueue Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushQueue Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::addQueueItems Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::addQueueItems Apr 30 01:13:08 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:13:08 volumio-salon volumio[738]: info: Adding Item to queue: music-library/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1 Apr 30 01:13:08 volumio-salon volumio[738]: info: Exploding uri music-library/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1 in service mpd Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F01%20Jarle%20Benhoft%20%26%20The%20Kringkastringsorkester%20-%20The%20One.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F02%20Jojo%20Effect%20feat%20Iain%20Mackenzie%20-%20Mambo%20Tonight.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/02 Jojo Effect feat Iain Mackenzie - Mambo Tonight.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F03%20Augusta%20-%20L'Importante%20e%20Finire%20(suonho%20Falled%20In%20dub).flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/03 Augusta - L'Importante e Finire (suonho Falled In dub).flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F04%20Betina%20Bager%20%26%20Brian%20O%20-%20Singing%20in%20the%20rain%20(version%20original).flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/04 Betina Bager & Brian O - Singing in the rain (version original).flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F05%20Hindi%20Zahra%20-%20Beutiful%20Tango.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/05 Hindi Zahra - Beutiful Tango.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F06%20Jaqee%20-%20Take%20it%20or%20leave%20it.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/06 Jaqee - Take it or leave it.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F07%20Les%20Baxter%20-%20Jungle%20Flower%20(Club%20des%20Belugas%20remix).flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/07 Les Baxter - Jungle Flower (Club des Belugas remix).flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F08%20Jose%20James%20-%20Promise%20In%20Love.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/08 Jose James - Promise In Love.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F09%20Bird%20-%20Some%20Boys.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/09 Bird - Some Boys.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F10%20NxGrandjean%20-%20Heroes%20And%20Saints.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/10 NxGrandjean - Heroes And Saints.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F11%20Quadron%20-%20Day.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/11 Quadron - Day.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F12%20Julien%20Dyne%20-%20Falling%20Down%20feat%20Parks%20(DJ%20Mitsu%20The%20Beats%20remix).flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/12 Julien Dyne - Falling Down feat Parks (DJ Mitsu The Beats remix).flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F13%20Keramick%20%26%20Lobo%20-%20Gone.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/13 Keramick & Lobo - Gone.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Various/Ram%20Cafe%205%20(CD2)/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FCD%20Rip%2FVarious%20%20Ram%20Cafe%205%20(CD2)%20(2010)%20-%20cd1%2F14%20Onerica%20-%20Paradise.flac&metadata=false Apr 30 01:13:08 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/14 Onerica - Paradise.flac Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushQueue Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::saveQueue Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::updateTrackBlock Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrackBlock Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPlay Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::play index 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::stop Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::play index undefined Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::startPlaybackTimer Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::clearAddPlayTracks NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand stop Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand stop took 1 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand clear Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces system playlist update Apr 30 01:13:08 volumio-salon volumio[738]: info: Ignoring MPD Status Update Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand clear took 2 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand add "NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac" Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces system playlist update Apr 30 01:13:08 volumio-salon volumio[738]: info: Ignoring MPD Status Update Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces system playlist update Apr 30 01:13:08 volumio-salon volumio[738]: info: Ignoring MPD Status Update Apr 30 01:13:08 volumio-salon volumio[738]: error: updateQueue error: null Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces system playlist update Apr 30 01:13:08 volumio-salon volumio[738]: info: Ignoring MPD Status Update Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 11ms Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand add "NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac" took 9 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 7ms Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 6ms Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand play Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces system playlist update Apr 30 01:13:08 volumio-salon volumio[738]: info: Ignoring MPD Status Update Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces system playlist update Apr 30 01:13:08 volumio-salon volumio[738]: info: Ignoring MPD Status Update Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces state update: player Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 9ms Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand play took 7 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 7ms Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 6ms Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces state update: player Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces state update: player Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand status took 19 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces state update: player Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand status took 22 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand status took 20 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:08 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus stop Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 29ms Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces state update: player Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:08 volumio-salon volumio[738]: info: Apr 30 01:13:08 volumio-salon volumio[738]: ---------------------------- MPD announces state update: player Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand status took 9 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand status took 5 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand status took 3 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:08 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:08 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"327 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:08 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:08 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 79ms Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 79ms Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 58 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 57 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 56 milliseconds Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:08 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"707 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:08 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:08 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"707 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:08 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:08 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"707 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:08 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:08 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:08 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:08 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 118ms Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 112ms Apr 30 01:13:08 volumio-salon volumio[738]: info: ------------------------------ 112ms Apr 30 01:13:16 volumio-salon volumio[738]: info: MPD Database updated - AlbumList cache refreshed Apr 30 01:13:16 volumio-salon volumio[738]: info: Apr 30 01:13:16 volumio-salon volumio[738]: ---------------------------- MPD announces state update: database Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: Apr 30 01:13:16 volumio-salon volumio[738]: ---------------------------- MPD announces state update: update Apr 30 01:13:16 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: MPD Database updated - AlbumList cache refreshed Apr 30 01:13:16 volumio-salon volumio[738]: info: Apr 30 01:13:16 volumio-salon volumio[738]: ---------------------------- MPD announces state update: database Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: Apr 30 01:13:16 volumio-salon volumio[738]: ---------------------------- MPD announces state update: update Apr 30 01:13:16 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: MPD Database updated - AlbumList cache refreshed Apr 30 01:13:16 volumio-salon volumio[738]: info: Apr 30 01:13:16 volumio-salon volumio[738]: ---------------------------- MPD announces state update: database Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: Apr 30 01:13:16 volumio-salon volumio[738]: ---------------------------- MPD announces state update: update Apr 30 01:13:16 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:16 volumio-salon volumio[738]: info: ControllerMpd::getState Apr 30 01:13:16 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand status Apr 30 01:13:18 volumio-salon volumio[738]: info: sendMpdCommand status took 2038 milliseconds Apr 30 01:13:18 volumio-salon volumio[738]: info: sendMpdCommand status took 2043 milliseconds Apr 30 01:13:18 volumio-salon volumio[738]: info: sendMpdCommand status took 2044 milliseconds Apr 30 01:13:18 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:18 volumio-salon volumio[738]: info: Command Router : Notfying DB Updatefalse Apr 30 01:13:18 volumio-salon volumio[738]: info: CoreCommandRouter::Close All Modals sent Apr 30 01:13:18 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:18 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:18 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:18 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:20 volumio-salon volumio[738]: info: sendMpdCommand status took 3516 milliseconds Apr 30 01:13:20 volumio-salon volumio[738]: info: sendMpdCommand status took 3516 milliseconds Apr 30 01:13:20 volumio-salon volumio[738]: info: sendMpdCommand status took 3517 milliseconds Apr 30 01:13:20 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:20 volumio-salon volumio[738]: info: Command Router : Notfying DB Updatefalse Apr 30 01:13:20 volumio-salon volumio[738]: info: CoreCommandRouter::Close All Modals sent Apr 30 01:13:20 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:20 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:20 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:20 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand status took 4997 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand status took 4996 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand status took 4997 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:21 volumio-salon volumio[738]: info: Command Router : Notfying DB Updatefalse Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::Close All Modals sent Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseState Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 2881 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 2880 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:21 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8831,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"703 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:21 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:21 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8831,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"703 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:21 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:21 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: ------------------------------ 5097ms Apr 30 01:13:21 volumio-salon volumio[738]: info: ------------------------------ 5097ms Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 1472 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 1472 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:21 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8968,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"674 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:21 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:21 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8968,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"674 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:21 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:21 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: ------------------------------ 5135ms Apr 30 01:13:21 volumio-salon volumio[738]: info: ------------------------------ 5136ms Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 116 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: info: sendMpdCommand playlistinfo took 116 milliseconds Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:21 volumio-salon volumio[738]: verbose: ControllerMpd::parseTrackInfo Apr 30 01:13:21 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9220,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"870 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:21 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:21 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: ControllerMpd::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::servicePushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9220,"duration":406,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"870 Kbps","isStreaming":false,"title":"Jarle Benhoft & The Kringkastringsorkester - The One","artist":"Various","album":"Ram Cafe 5 (CD2)","uri":"NAS/MP3/CD Rip/Various Ram Cafe 5 (CD2) (2010) - cd1/01 Jarle Benhoft & The Kringkastringsorkester - The One.flac","trackType":"flac"} Apr 30 01:13:21 volumio-salon volumio[738]: verbose: CURRENT POSITION 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState stateService play Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::syncState currentStatus play Apr 30 01:13:21 volumio-salon volumio[738]: info: Received an update from plugin. extracting info from payload Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:13:21 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:13:21 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:13:21 volumio-salon volumio[738]: info: ------------------------------ 5172ms Apr 30 01:13:21 volumio-salon volumio[738]: info: ------------------------------ 5172ms Apr 30 01:13:24 volumio-salon volumiologrotate[477]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Apr 30 01:13:24 volumio-salon volumiologrotate[477]: ls: cannot access 'SALON': No such file or directory Apr 30 01:13:30 volumio-salon volumio[738]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 01:13:35 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 30 01:13:35 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 30 01:13:46 volumio-salon volumio[738]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Apr 30 01:13:48 volumio-salon volumio[738]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Apr 30 01:13:48 volumio-salon volumio[738]: info: Folder /tmp/plugins removed Apr 30 01:13:49 volumio-salon volumio[738]: info: Check plugin dependencies Apr 30 01:13:49 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 30 01:13:49 volumio-salon volumio[738]: info: Checking if plugin already exists Apr 30 01:13:49 volumio-salon volumio[738]: info: Rename folder Apr 30 01:13:49 volumio-salon volumio[738]: info: Folder /tmp/downloaded_plugin.zip removed Apr 30 01:13:49 volumio-salon volumio[738]: info: Move to category Apr 30 01:13:50 volumio-salon volumio[738]: info: Checking if install.sh is present Apr 30 01:13:50 volumio-salon volumio[738]: info: Executing install.sh Apr 30 01:13:50 volumio-salon sudo[1532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Apr 30 01:13:50 volumio-salon sudo[1532]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 01:13:50 volumio-salon volumio[738]: info: Installing Go-librespot Apr 30 01:13:51 volumio-salon volumio[738]: info: Checking old vollibrespot installs Apr 30 01:13:51 volumio-salon systemd[1]: Reloading. Apr 30 01:13:51 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 30 01:13:51 volumio-salon systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 30 01:13:51 volumio-salon volumio[738]: info: Dowloading daemon Apr 30 01:13:53 volumio-salon volumio[738]: info: Creating Start Script Apr 30 01:13:53 volumio-salon systemd[1]: Reloading. Apr 30 01:13:53 volumio-salon systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 30 01:13:53 volumio-salon sudo[1532]: pam_unix(sudo:session): session closed for user root Apr 30 01:13:53 volumio-salon volumio[738]: Plugin install end detected on script Apr 30 01:13:53 volumio-salon volumio[738]: info: Install script completed Apr 30 01:13:53 volumio-salon volumio[738]: info: Adding reference to registry Apr 30 01:13:53 volumio-salon volumio[738]: info: Done installing plugin. Apr 30 01:13:53 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 30 01:13:53 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 30 01:13:53 volumio-salon volumio[738]: info: Folder /tmp/plugins removed Apr 30 01:13:53 volumio-salon volumio[738]: info: Folder /tmp/downloaded_plugin.zip removed Apr 30 01:13:53 volumio-salon volumio[738]: info: Folder /data/temp removed Apr 30 01:14:17 volumio-salon volumio[738]: info: Enabling plugin spop Apr 30 01:14:17 volumio-salon volumio[738]: info: Loading plugin "spop"... Apr 30 01:14:18 volumio-salon volumio[738]: info: PLUGIN START: spop Apr 30 01:14:18 volumio-salon volumio[738]: info: Creating Spotify config file Apr 30 01:14:18 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 30 01:14:18 volumio-salon volumio[738]: info: Done. Apr 30 01:14:18 volumio-salon volumio[738]: info: Spotify config file written Apr 30 01:14:18 volumio-salon sudo[1578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 30 01:14:18 volumio-salon sudo[1578]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 01:14:18 volumio-salon systemd[1]: Started go-librespot Daemon. Apr 30 01:14:18 volumio-salon go-librespot[1580]: Librespot-go daemon starting... Apr 30 01:14:18 volumio-salon sudo[1578]: pam_unix(sudo:session): session closed for user root Apr 30 01:14:18 volumio-salon go-librespot[1580]: time="2024-04-30T01:14:18+02:00" level=info msg="generated new device id: d0f202308c7c2b96947c7b5c174c3bf05aaac1df" Apr 30 01:14:18 volumio-salon go-librespot[1580]: time="2024-04-30T01:14:18+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 30 01:14:18 volumio-salon go-librespot[1580]: time="2024-04-30T01:14:18+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 30 01:14:18 volumio-salon go-librespot[1580]: time="2024-04-30T01:14:18+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 30 01:14:18 volumio-salon go-librespot[1580]: time="2024-04-30T01:14:18+02:00" level=debug msg="zeroconf server listening on port 35447" Apr 30 01:14:19 volumio-salon nmbd[604]: [2024/04/30 01:14:19.152211, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 30 01:14:19 volumio-salon nmbd[604]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.10.147 for name WORKGROUP<1d>. Apr 30 01:14:19 volumio-salon nmbd[604]: This response was from IP 192.168.10.4, reporting an IP address of 192.168.10.4. Apr 30 01:14:19 volumio-salon nmbd[604]: [2024/04/30 01:14:19.152696, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 30 01:14:19 volumio-salon nmbd[604]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.10.147 for name WORKGROUP<1d>. Apr 30 01:14:19 volumio-salon nmbd[604]: This response was from IP 192.168.10.4, reporting an IP address of 192.168.10.4. Apr 30 01:14:19 volumio-salon nmbd[604]: [2024/04/30 01:14:19.152899, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 30 01:14:19 volumio-salon nmbd[604]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.10.147 for name WORKGROUP<1d>. Apr 30 01:14:19 volumio-salon nmbd[604]: This response was from IP 192.168.10.4, reporting an IP address of 192.168.10.4. Apr 30 01:14:19 volumio-salon volumio[738]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 01:14:21 volumio-salon volumio[738]: info: go-librespot daemon successfully initialized Apr 30 01:14:24 volumio-salon volumiologrotate[477]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Apr 30 01:14:24 volumio-salon volumiologrotate[477]: ls: cannot access 'SALON': No such file or directory Apr 30 01:14:24 volumio-salon volumio[738]: info: Initializing connection to go-librespot Websocket Apr 30 01:14:24 volumio-salon go-librespot[1580]: time="2024-04-30T01:14:24+02:00" level=debug msg="new websocket client" Apr 30 01:14:24 volumio-salon volumio[738]: info: Connection to go-librespot Websocket established Apr 30 01:14:26 volumio-salon volumio[738]: info: Received OAUTH Data Apr 30 01:14:26 volumio-salon volumio[738]: info: Executing Spotify Oauth Login Apr 30 01:14:26 volumio-salon volumio[738]: info: Saving Spotify Refresh Token Apr 30 01:14:27 volumio-salon sudo[1633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 30 01:14:27 volumio-salon sudo[1633]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 01:14:27 volumio-salon sudo[1633]: pam_unix(sudo:session): session closed for user root Apr 30 01:14:27 volumio-salon sudo[1636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 01:14:27 volumio-salon sudo[1636]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 01:14:27 volumio-salon sudo[1636]: pam_unix(sudo:session): session closed for user root Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: BQBB4JDA7duV55ZgcAk1M8NFCzVp8mOE2BsxEM5OamfZD0Hbt0dSMgOEaqk6Qjrh2rYy6FlAwLYupukI7UlfdbLyDBfGIDgXwYtSWmmEQY82MTijcZSuxaJtDuAE1EmlgrG2xbKoPAkJ83PRV_majd4eupC5AsjXqr7wlNHykJICTwMcUZ3vrpUSdZtiU0fj_kyXD2m9sJLkbMRob_mhGhncN3FuF3Lon8xkypYWed_tpdIg6pa6jWE_BUixAb2SOLk9Ibb-EsA Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 30 01:14:27 volumio-salon volumio[738]: info: New Spotify access token = BQBB4JDA7duV55ZgcAk1M8NFCzVp8mOE2BsxEM5OamfZD0Hbt0dSMgOEaqk6Qjrh2rYy6FlAwLYupukI7UlfdbLyDBfGIDgXwYtSWmmEQY82MTijcZSuxaJtDuAE1EmlgrG2xbKoPAkJ83PRV_majd4eupC5AsjXqr7wlNHykJICTwMcUZ3vrpUSdZtiU0fj_kyXD2m9sJLkbMRob_mhGhncN3FuF3Lon8xkypYWed_tpdIg6pa6jWE_BUixAb2SOLk9Ibb-EsA Apr 30 01:14:27 volumio-salon volumio[738]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 30 01:14:27 volumio-salon volumio[738]: verbose: New Socket.io Connection to 192.168.10.147 from 192.168.10.11 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 7 Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::volumioGetState Apr 30 01:14:27 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: User informations: {"display_name":"Kodi","external_urls":{"spotify":"https://open.spotify.com/user/31on4nvrquweh3ms5li3qcojjndi"},"href":"https://api.spotify.com/v1/users/31on4nvrquweh3ms5li3qcojjndi","id":"31on4nvrquweh3ms5li3qcojjndi","images":[],"type":"user","uri":"spotify:user:31on4nvrquweh3ms5li3qcojjndi","followers":{"href":null,"total":0},"country":"PL","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"a.d@a2r.pl"} Apr 30 01:14:27 volumio-salon volumio[738]: info: Creating Spotify config file Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 30 01:14:27 volumio-salon volumio[738]: info: Spotify config file written Apr 30 01:14:27 volumio-salon sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 30 01:14:27 volumio-salon sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 01:14:27 volumio-salon systemd[1]: Stopping go-librespot Daemon... Apr 30 01:14:27 volumio-salon systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Apr 30 01:14:27 volumio-salon systemd[1]: go-librespot-daemon.service: Succeeded. Apr 30 01:14:27 volumio-salon systemd[1]: Stopped go-librespot Daemon. Apr 30 01:14:27 volumio-salon volumio[738]: info: Connection to go-librespot Websocket closed Apr 30 01:14:27 volumio-salon systemd[1]: Started go-librespot Daemon. Apr 30 01:14:27 volumio-salon go-librespot[1641]: Librespot-go daemon starting... Apr 30 01:14:27 volumio-salon sudo[1639]: pam_unix(sudo:session): session closed for user root Apr 30 01:14:27 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:27+02:00" level=info msg="generated new device id: a6cfb5e8d005764bfae486f589b9f4511dca0092" Apr 30 01:14:27 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:27+02:00" level=debug msg="stored credentials not found" Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: BQBCI5G1KvNPQf5BX-n2cO7BzLOHW3HxiPeGXMUpQ9-dNP6S3ktlSvcvJCaGyD5j8DasK27yVqGkpcxTYV9euT3ESEtaLTEV5NGa0jIm9RU-FlFMhJrvmWj8AelIVVWKiBWkakcgiX27np5mie87CDa6-h-mxtex75BKlzP0D3MynS55STzLqQiNJpDK2b7jVAsOHbDFiDvGPHkW639j_zRYjXwWoIptByGWiJcQ01w4SovWJD0CZQQ4_pzAiP-1W2E1fEAQCK8 Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 30 01:14:27 volumio-salon volumio[738]: info: New Spotify access token = BQBCI5G1KvNPQf5BX-n2cO7BzLOHW3HxiPeGXMUpQ9-dNP6S3ktlSvcvJCaGyD5j8DasK27yVqGkpcxTYV9euT3ESEtaLTEV5NGa0jIm9RU-FlFMhJrvmWj8AelIVVWKiBWkakcgiX27np5mie87CDa6-h-mxtex75BKlzP0D3MynS55STzLqQiNJpDK2b7jVAsOHbDFiDvGPHkW639j_zRYjXwWoIptByGWiJcQ01w4SovWJD0CZQQ4_pzAiP-1W2E1fEAQCK8 Apr 30 01:14:27 volumio-salon volumio[738]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 30 01:14:27 volumio-salon volumio[738]: SPOTIFY: User informations: {"display_name":"Kodi","external_urls":{"spotify":"https://open.spotify.com/user/31on4nvrquweh3ms5li3qcojjndi"},"href":"https://api.spotify.com/v1/users/31on4nvrquweh3ms5li3qcojjndi","id":"31on4nvrquweh3ms5li3qcojjndi","images":[],"type":"user","uri":"spotify:user:31on4nvrquweh3ms5li3qcojjndi","followers":{"href":null,"total":0},"country":"PL","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"a.d@a2r.pl"} Apr 30 01:14:27 volumio-salon volumio[738]: info: Spotify Successfully logged in Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 30 01:14:27 volumio-salon volumio[738]: info: [1714432467430] CoreMusicLibrary::Adding element Spotify Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 30 01:14:27 volumio-salon volumio[738]: Cannot find translation for source Spotify Apr 30 01:14:27 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:27+02:00" level=debug msg="obtained new client token: AADV4OZokFUbMmn9iFHQykEcjIeindbiFV41P58gyX+QA7T+KfYC89a64LbP969ND1KRKZVC/HsiJ4l9qwPt26s1zuTDro5fnCS5YqVaHAwXALsOI1fDXglCDOMwnVrmE/XeWr5aQPZskD2O9oJ2aAVdi8SSAsRDj62MWODqPXTRTnXjfcXYuStIirBMsC2c+buQkSpoooY86iMvdVUkdqy9c7i/qLXVlRtxPkDvq9XzKhiArbPnSy5bH7FzUw==" Apr 30 01:14:27 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:27+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 30 01:14:27 volumio-salon volumio[738]: info: Getting Spotify volume Apr 30 01:14:27 volumio-salon volumio[738]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 30 01:14:27 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:27+02:00" level=debug msg="completed keyexchange" Apr 30 01:14:27 volumio-salon volumio[738]: info: CoreCommandRouter::volumioGetState Apr 30 01:14:27 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="completed challenge" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="authenticated as 31on4nvrquweh3ms5li3qcojjndi" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="authenticated as 31on4nvrquweh3ms5li3qcojjndi" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="dealer connection opened" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="stored credentials for 31on4nvrquweh3ms5li3qcojjndi" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 30 01:14:28 volumio-salon volumio[738]: info: Spotify volume: 100 Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="received connection id: MzA5M2IyZjMtOTQ0Mi00YmUzLTllMWEtYzQ2ZDAyOTVhZjczK2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLXprZ3QuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwKzRGQzkxRjdFMUM3N0M4QjYzMEJFMDRFRTZBOTQ4MkY3ODBDQzUwQjlDNDY4RDA4MkVGNTVCNEUwMDVCMTJDQkI=" Apr 30 01:14:28 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:28+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 30 01:14:29 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 30 01:14:29 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 30 01:14:30 volumio-salon volumio[738]: info: Initializing connection to go-librespot Websocket Apr 30 01:14:30 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:30+02:00" level=debug msg="new websocket client" Apr 30 01:14:30 volumio-salon volumio[738]: info: Connection to go-librespot Websocket established Apr 30 01:14:30 volumio-salon volumio[738]: info: go-librespot daemon successfully initialized Apr 30 01:14:30 volumio-salon volumio[738]: info: CoreCommandRouter::volumioGetVisibleSources Apr 30 01:14:30 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 30 01:14:30 volumio-salon volumio[738]: info: CoreCommandRouter::volumioGetQueue Apr 30 01:14:30 volumio-salon volumio[738]: info: CoreStateMachine::getQueue Apr 30 01:14:30 volumio-salon volumio[738]: info: CorePlayQueue::getQueue Apr 30 01:14:30 volumio-salon volumio[738]: info: Listing playlists Apr 30 01:14:32 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 01:14:32 volumio-salon volumio[738]: info: CURURI: music-library Apr 30 01:14:32 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:14:33 volumio-salon volumio[738]: info: Getting Spotify volume Apr 30 01:14:33 volumio-salon volumio[738]: info: Spotify volume: 100 Apr 30 01:14:33 volumio-salon volumio[738]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Apr 30 01:14:33 volumio-salon volumio[738]: info: CoreCommandRouter::volumioGetState Apr 30 01:14:33 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:14:33 volumio-salon volumio[738]: info: Initializing connection to go-librespot Websocket Apr 30 01:14:33 volumio-salon go-librespot[1641]: time="2024-04-30T01:14:33+02:00" level=debug msg="new websocket client" Apr 30 01:14:33 volumio-salon volumio[738]: info: Connection to go-librespot Websocket established Apr 30 01:14:33 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 01:14:33 volumio-salon volumio[738]: info: CURURI: music-library/NAS Apr 30 01:14:33 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:14:34 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 01:14:34 volumio-salon volumio[738]: info: CURURI: music-library/NAS/MP3 Apr 30 01:14:34 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:14:36 volumio-salon volumio[738]: info: Getting Spotify volume Apr 30 01:14:36 volumio-salon volumio[738]: info: Spotify volume: 100 Apr 30 01:14:36 volumio-salon volumio[738]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Apr 30 01:14:36 volumio-salon volumio[738]: info: CoreCommandRouter::volumioGetState Apr 30 01:14:36 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:14:43 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::ClearQueue Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::stop Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::stPlaybackTimer Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::updateTrackBlock Apr 30 01:14:43 volumio-salon volumio[738]: info: CorePlayQueue::getTrackBlock Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::pushState Apr 30 01:14:43 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushState Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::serviceStop Apr 30 01:14:43 volumio-salon volumio[738]: info: CorePlayQueue::getTrack 0 Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreCommandRouter::serviceStop Apr 30 01:14:43 volumio-salon volumio[738]: info: ControllerMpd::stop Apr 30 01:14:43 volumio-salon volumio[738]: verbose: ControllerMpd::sendMpdCommand stop Apr 30 01:14:43 volumio-salon volumio[738]: info: CorePlayQueue::clearPlayQueue Apr 30 01:14:43 volumio-salon volumio[738]: info: CorePlayQueue::saveQueue Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreCommandRouter::volumioPushQueue Apr 30 01:14:43 volumio-salon volumio[738]: info: CoreStateMachine::addQueueItems Apr 30 01:14:43 volumio-salon volumio[738]: info: CorePlayQueue::addQueueItems Apr 30 01:14:43 volumio-salon volumio[738]: info: Preload queue cleared Apr 30 01:14:43 volumio-salon volumio[738]: info: Adding Item to queue: music-library/NAS/MP3/Fahrenheit_Project_Part_Four_2003_EAC-FLAC Apr 30 01:14:43 volumio-salon volumio[738]: info: Exploding uri music-library/NAS/MP3/Fahrenheit_Project_Part_Four_2003_EAC-FLAC in service mpd Apr 30 01:14:43 volumio-salon volumio[738]: info: Apr 30 01:14:43 volumio-salon volumio[738]: ---------------------------- MPD announces state update: player Apr 30 01:14:43 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Solar%20Fields/Fahrenheit%20Project%20Part%20Four/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FFahrenheit_Project_Part_Four_2003_EAC-FLAC%2FCDImage.cue&metadata=false Apr 30 01:14:43 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/Fahrenheit_Project_Part_Four_2003_EAC-FLAC/CDImage.cue Apr 30 01:14:43 volumio-salon volumio[738]: info: ALBUMART /albumart?cacheid=834&web=Puff%20Dragon/Fahrenheit%20Project%20Part%20Four/extralarge&path=%2Fmnt%2FNAS%2FMP3%2FFahrenheit_Project_Part_Four_2003_EAC-FLAC%2FCDImage.cue&metadata=false Apr 30 01:14:43 volumio-salon volumio[738]: info: URI /mnt/NAS/MP3/Fahrenheit_Project_Part_Four_2003_EAC-FLAC/CDImage.cue Apr 30 01:14:43 volumio-salon volumio[738]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 01:14:43 volumio-salon volumio[738]: Error: Unable to resolve or reject the same promise twice Apr 30 01:14:43 volumio-salon volumio[738]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 30 01:14:43 volumio-salon volumio[738]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 30 01:14:43 volumio-salon volumio[738]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 30 01:14:43 volumio-salon volumio[738]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 30 01:14:43 volumio-salon volumio[738]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 30 01:14:43 volumio-salon volumio[738]: at Socket.emit (events.js:315:20) Apr 30 01:14:43 volumio-salon volumio[738]: at addChunk (internal/streams/readable.js:309:12) Apr 30 01:14:43 volumio-salon volumio[738]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 30 01:14:43 volumio-salon volumio[738]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 30 01:14:43 volumio-salon volumio[738]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 30 01:14:43 volumio-salon volumio[738]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 01:14:43 volumio-salon sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-30 01:13 Apr 30 01:14:43 volumio-salon sudo[1659]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"