Jan 10 10:02:04 yechezkel volumio[1367]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vittorio%20Negri/5267bc0b-abf6-4e6b-8ee7-44b72e893e7d.jpg' Jan 10 10:02:14 yechezkel go-librespot[1860]: time="2026-01-10T10:02:14+02:00" level=trace msg="sent dealer ping" Jan 10 10:02:16 yechezkel go-librespot[1860]: time="2026-01-10T10:02:16+02:00" level=trace msg="received dealer pong" Jan 10 10:02:20 yechezkel go-librespot[1860]: time="2026-01-10T10:02:20+02:00" level=trace msg="received accesspoint ping" Jan 10 10:02:21 yechezkel go-librespot[1860]: time="2026-01-10T10:02:21+02:00" level=trace msg="received accesspoint pong ack" Jan 10 10:02:23 yechezkel volumio[1367]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%D0%A7%D0%B0%D0%B9%D0%BA%D0%BE%D0%B2%D1%81%D0%BA%D0%B8%D0%B9%2C%20%D0%9F%D1%91%D1%82%D1%80%20%D0%98%D0%BB%D1%8C%D0%B8%D1%87/50da91c9-e62f-4f5c-99f1-66190180efb0.jpg' Jan 10 10:02:24 yechezkel volumio[1367]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 10 10:02:24 yechezkel volumio[1367]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Jan 10 10:02:24 yechezkel volumio[1367]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 10 10:02:24 yechezkel volumio[1367]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Jan 10 10:02:24 yechezkel volumio[1367]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Jan 10 10:02:24 yechezkel volumio[1367]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Jan 10 10:02:24 yechezkel volumio[1367]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Jan 10 10:02:24 yechezkel volumio[1367]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 10 10:02:24 yechezkel volumio[1367]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 10 10:02:24 yechezkel volumio[1367]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 10 10:02:24 yechezkel volumio[1367]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Jan 10 10:02:24 yechezkel volumio[1367]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 10 10:02:24 yechezkel volumio[1367]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Jan 10 10:02:24 yechezkel volumio[1367]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Jan 10 10:02:24 yechezkel volumio[1367]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Jan 10 10:02:24 yechezkel volumio[1367]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Jan 10 10:02:24 yechezkel volumio[1367]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 10 10:02:24 yechezkel volumio[1367]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:42 yechezkel volumio[1367]: info: Retrieving Cloud Streaming UI Jan 10 10:02:42 yechezkel volumio[1367]: info: Getting Tidal Cloud Configuration Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:42 yechezkel volumio[1367]: info: Getting Qobuz Cloud Configuration Jan 10 10:02:42 yechezkel volumio[1367]: info: Asking plugin for UI Config Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:42 yechezkel volumio[1367]: info: Getting Spotify Cloud Configuration Jan 10 10:02:42 yechezkel volumio[1367]: info: Asking plugin for UI Config Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:42 yechezkel volumio[1367]: info: Saving Spotify Acccount Jan 10 10:02:42 yechezkel volumio[1367]: info: Got it Jan 10 10:02:42 yechezkel volumio[1367]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 10 10:02:42 yechezkel volumio[1367]: info: Got Tidal Cloud Configuration Jan 10 10:02:42 yechezkel volumio[1367]: info: Got it Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 10 10:02:42 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 10 10:02:44 yechezkel go-librespot[1860]: time="2026-01-10T10:02:44+02:00" level=trace msg="sent dealer ping" Jan 10 10:02:44 yechezkel go-librespot[1860]: time="2026-01-10T10:02:44+02:00" level=trace msg="received dealer pong" Jan 10 10:02:46 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 10 10:02:49 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jan 10 10:02:49 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand update Jan 10 10:02:50 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 10 10:02:54 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 10 10:02:58 yechezkel volumio[1367]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 10 10:02:58 yechezkel volumio[1367]: info: Preparing to save Alsa Options, stopping services first Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPause Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreStateMachine::pause Jan 10 10:02:58 yechezkel volumio[1367]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"HDMI 1 Out"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 10:02:58 yechezkel volumio[1367]: info: Found match in Cards Database: setting mixer for card HDMI 1 Out Jan 10 10:02:58 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel vtcs[14104]: [2026-01-10 10:02:58.369] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 10 10:02:58 yechezkel vtcs[14104]: [2026-01-10 10:02:58.369] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 10 10:02:58 yechezkel sudo[21837]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: Device 1 does not have any Mixer Control Available Jan 10 10:02:58 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 10 10:02:58 yechezkel systemd[1]: vtcs.service: Killing process 14109 (vtcs) with signal SIGKILL. Jan 10 10:02:58 yechezkel sudo[21842]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel systemd[1]: vtcs.service: Deactivated successfully. Jan 10 10:02:58 yechezkel systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 10 10:02:58 yechezkel volumio[1367]: info: Updating Volume Controller Parameters: Device: 1 Name: HDMI 1 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 10 10:02:58 yechezkel sudo[21837]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 10 10:02:58 yechezkel volumio[1367]: info: Disabling external Volume Control Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:02:58 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:02:58 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel sudo[21842]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: Preparing to generate the ALSA configuration file Jan 10 10:02:58 yechezkel sudo[21851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21853]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21851]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel sudo[21862]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21853]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 10 10:02:58 yechezkel sudo[21862]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: Reading ALSA contributions from plugins. Jan 10 10:02:58 yechezkel volumio[1367]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Jan 10 10:02:58 yechezkel sudo[21870]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21871]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21870]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 10:02:58 yechezkel sudo[21877]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 10 10:02:58 yechezkel qobuz-connect[14068]: 20260110 10:02:58.556 [14068.14068] INFO SampleApp: Stopping Local configuration server Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 10 10:02:58 yechezkel volumio[1367]: info: Asound.conf file written Jan 10 10:02:58 yechezkel sudo[21885]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 10 10:02:58 yechezkel sudo[21885]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21885]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 10 10:02:58 yechezkel volumio[1367]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 10 10:02:58 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:02:58 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel sudo[21893]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:02:58 yechezkel sudo[21893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:58 yechezkel sudo[21893]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel sudo[21897]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:02:58 yechezkel sudo[21897]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:02:58 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:02:58 yechezkel systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:02:58 yechezkel sudo[21905]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21905]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:58 yechezkel sudo[21907]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:02:58 yechezkel sudo[21907]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21912]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:02:58 yechezkel sudo[21912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21907]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:02:58 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:02:58 yechezkel sudo[21905]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel sudo[21921]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21921]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21927]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21927]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21921]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel sudo[21927]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 10 10:02:58 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:02:58 yechezkel volumio[1367]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 10 10:02:58 yechezkel sudo[21923]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel sudo[21935]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel sudo[21943]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel sudo[21952]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21952]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel sudo[21943]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:02:58 yechezkel sudo[21960]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:02:58 yechezkel sudo[21960]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:02:58 yechezkel volumio[1367]: info: Preparing to generate the ALSA configuration file Jan 10 10:02:58 yechezkel sudo[21962]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:02:58 yechezkel sudo[21962]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:02:58 yechezkel sudo[21965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 10 10:02:58 yechezkel volumio[1367]: info: Reading ALSA contributions from plugins. Jan 10 10:02:58 yechezkel volumio[1367]: info: Asound.conf file unchanged, so no further update is needed Jan 10 10:02:58 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:02:58 yechezkel sudo[21969]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:02:58 yechezkel sudo[21969]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:58 yechezkel sudo[21969]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 10:02:58 yechezkel systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 10:02:58 yechezkel systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:02:58 yechezkel systemd[1]: shairport-sync.service: Consumed 6.001s CPU time. Jan 10 10:02:58 yechezkel sudo[21972]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:02:58 yechezkel sudo[21972]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:02:58 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:58 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:02:58 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:58 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:58 yechezkel volumio[1367]: info: Preparing to generate the ALSA configuration file Jan 10 10:02:58 yechezkel systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:02:58 yechezkel sudo[21982]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:58 yechezkel sudo[21982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:58 yechezkel sudo[21965]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:58 yechezkel sudo[21962]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel sudo[21982]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel sudo[22001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:59 yechezkel sudo[22001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel volumio[1367]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 10 10:02:59 yechezkel volumio[1367]: info: Reading ALSA contributions from plugins. Jan 10 10:02:59 yechezkel volumio[1367]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 10 10:02:59 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:02:59 yechezkel sudo[22001]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:02:59 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel sudo[22010]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:02:59 yechezkel sudo[22010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:02:59 yechezkel sudo[22010]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel volumio[1367]: info: Asound.conf file unchanged, so no further update is needed Jan 10 10:02:59 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:02:59 yechezkel sudo[22018]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:02:59 yechezkel sudo[22018]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel sudo[22020]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:02:59 yechezkel sudo[22020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:59 yechezkel sudo[22025]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:02:59 yechezkel sudo[22025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel sudo[22023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:02:59 yechezkel sudo[22023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel sudo[22023]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:02:59 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:02:59 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:02:59 yechezkel systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 10:02:59 yechezkel systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 10:02:59 yechezkel systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:02:59 yechezkel sudo[22037]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:59 yechezkel sudo[22037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:02:59 yechezkel sudo[22042]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:02:59 yechezkel sudo[22042]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel sudo[22020]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel volumio[1367]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Jan 10 10:02:59 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:02:59 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel sudo[22047]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:02:59 yechezkel sudo[22047]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:02:59 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:02:59 yechezkel sudo[22037]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel sudo[22047]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel sudo[22042]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel sudo[22070]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:02:59 yechezkel sudo[22070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel sudo[22071]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:02:59 yechezkel sudo[22071]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:02:59 yechezkel systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 10:02:59 yechezkel systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 10:02:59 yechezkel systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:02:59 yechezkel systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:02:59 yechezkel sudo[22071]: pam_unix(sudo:session): session closed for user root Jan 10 10:02:59 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:03:00 yechezkel qobuz-connect[14068]: 20260110 10:03:00.505 [14068.14068] INFO SampleApp: shat down connection on UNIX socket Jan 10 10:03:00 yechezkel volumio[1367]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 10 10:03:00 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:03:00 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:00 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:00 yechezkel systemd[1]: qobuz-connect.service: Deactivated successfully. Jan 10 10:03:00 yechezkel systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 10 10:03:00 yechezkel systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 10 10:03:00 yechezkel sudo[21960]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:00 yechezkel sudo[21871]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:00 yechezkel sudo[21877]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:00 yechezkel sudo[21952]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:00 yechezkel sudo[22070]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:00 yechezkel sudo[22018]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:00 yechezkel volumio[1367]: info: Executing endpoint qc_getconfig Jan 10 10:03:00 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.571 [22092.22092] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.573 [22092.22092] INFO VolumeManager: [0x47e298]: Setting new playback volume: 75 Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.573 [22092.22092] INFO VolumeManager: [0x47e298]: Setting new mute state: 0 Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.573 [22092.22092] INFO QobuzConnect: [0x47ec68]: Client initialized! Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.573 [22092.22092] INFO SampleApp: Starting Avahi advertising, name: yechezkel, service name: _qobuz-connect._tcp Jan 10 10:03:00 yechezkel volumio[1367]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 10 10:03:00 yechezkel volumio[1367]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.580 [22092.22092] INFO LocalConfigManager: [0x47db78]: Starting Local Configuration server Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.580 [22092.22092] INFO SampleApp: Starting Local configuration server Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.581 [22092.22092] INFO SampleApp: Connected to UNIX socket client 0x468818 Jan 10 10:03:00 yechezkel qobuz-connect[22092]: 20260110 10:03:00.721 [22092.22092] INFO SampleApp: Playback volume changed: 75 Jan 10 10:03:00 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:00 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:01 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel systemd[1]: mpd.service: Deactivated successfully. Jan 10 10:03:01 yechezkel systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 10:03:01 yechezkel systemd[1]: mpd.service: Consumed 1min 38.932s CPU time. Jan 10 10:03:01 yechezkel systemd[1]: mpd.socket: Deactivated successfully. Jan 10 10:03:01 yechezkel mpd_monitor.sh[22091]: MPD error: Connection reset by peer Jan 10 10:03:01 yechezkel systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 10:03:01 yechezkel systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 10:03:01 yechezkel volumio[1367]: error: [ytcr] Error connecting MPD: Jan 10 10:03:01 yechezkel volumio[1367]: (Error) read ECONNRESET Jan 10 10:03:01 yechezkel volumio[1367]: Error: read ECONNRESET Jan 10 10:03:01 yechezkel volumio[1367]: at Pipe.onStreamRead (node:internal/stream_base_commons:217:20) Jan 10 10:03:01 yechezkel volumio[1367]: Retrying in 5 seconds... Jan 10 10:03:01 yechezkel mpd_monitor.sh[14139]: MPD Monitor Service: MPD Appears to be inactive, restarting Jan 10 10:03:01 yechezkel mpd_monitor.sh[22099]: mpd: no process found Jan 10 10:03:01 yechezkel systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 10:03:01 yechezkel systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 10:03:01 yechezkel systemd[1]: mpd.service: Deactivated successfully. Jan 10 10:03:01 yechezkel systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 10:03:01 yechezkel systemd[1]: mpd.socket: Deactivated successfully. Jan 10 10:03:01 yechezkel systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 10:03:01 yechezkel systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 10:03:01 yechezkel systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 10:03:01 yechezkel systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel sudo[22103]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 10 10:03:01 yechezkel sudo[22103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 10 10:03:01 yechezkel sudo[22103]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel sudo[22115]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:01 yechezkel sudo[22115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel sudo[22127]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:01 yechezkel sudo[22127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:01 yechezkel systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 10 10:03:01 yechezkel sudo[22115]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:01 yechezkel sudo[22127]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:01 yechezkel volumio[1367]: info: Executing endpoint tc_getconfig Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 10 10:03:01 yechezkel vtcs[22129]: STARTING TidalConnect services, version: 1.5.2.56 Jan 10 10:03:01 yechezkel vtcs[22129]: STARTED TidalConnect services. Jan 10 10:03:01 yechezkel volumio[1367]: info: Executing endpoint tc_connect Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 10 10:03:01 yechezkel volumio[1367]: info: Connecting to TidalConnect Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:01 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:01 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:01 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:01 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:01 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:01 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:01 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:01 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:01 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:01 yechezkel volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:01 yechezkel sudo[22163]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:01 yechezkel sudo[22163]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:01 yechezkel sudo[22165]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:01 yechezkel sudo[22165]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:01 yechezkel sudo[22163]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:01 yechezkel sudo[22165]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:02 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:02 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:02 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:02 yechezkel sudo[22179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:02 yechezkel mpd[22105]: 2026-01-10T10:03:02 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 10 10:03:02 yechezkel sudo[22179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22179]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:02 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:02 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:02 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:02 yechezkel sudo[22191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:02 yechezkel sudo[22191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22191]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreStateMachine::getcurrentVolume Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioRetrievevolume Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:02 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:02 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 10 10:03:02 yechezkel volumio[1367]: info: Preparing to save Alsa Options, stopping services first Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPause Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreStateMachine::pause Jan 10 10:03:02 yechezkel volumio[1367]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"ADI-2 DAC (52061225)"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 10:03:02 yechezkel volumio[1367]: info: Setting mixer AES Rate for card ADI-2 DAC (52061225) Jan 10 10:03:02 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel vtcs[22129]: [2026-01-10 10:03:02.542] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 10 10:03:02 yechezkel vtcs[22129]: [2026-01-10 10:03:02.542] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 10 10:03:02 yechezkel sudo[22204]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:02 yechezkel sudo[22204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 10 10:03:02 yechezkel volumio[1367]: info: Updating Volume Controller Parameters: Device: 5 Name: ADI-2 DAC (52061225) Mixer: AES Rate Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 10 10:03:02 yechezkel volumio[1367]: info: Disabling external Volume Control Jan 10 10:03:02 yechezkel systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 10 10:03:02 yechezkel systemd[1]: vtcs.service: Killing process 22136 (vtcs) with signal SIGKILL. Jan 10 10:03:02 yechezkel systemd[1]: vtcs.service: Deactivated successfully. Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 10:03:02 yechezkel systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 10 10:03:02 yechezkel volumio[1367]: info: Preparing to generate the ALSA configuration file Jan 10 10:03:02 yechezkel sudo[22204]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel sudo[22212]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:02 yechezkel sudo[22212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel volumio[1367]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 10 10:03:02 yechezkel volumio[1367]: info: Reading ALSA contributions from plugins. Jan 10 10:03:02 yechezkel volumio[1367]: Unable to parse: Jan 10 10:03:02 yechezkel volumio[1367]: Simple mixer control 'AES Rate',0 Jan 10 10:03:02 yechezkel volumio[1367]: Capabilities: volume volume-joined Jan 10 10:03:02 yechezkel volumio[1367]: Playback channels: Mono Jan 10 10:03:02 yechezkel volumio[1367]: Capture channels: Mono Jan 10 10:03:02 yechezkel volumio[1367]: Limits: 0 - 200000 Jan 10 10:03:02 yechezkel volumio[1367]: Mono: 0 [0%] Jan 10 10:03:02 yechezkel volumio[1367]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Jan 10 10:03:02 yechezkel sudo[22219]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:03:02 yechezkel sudo[22219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22212]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel sudo[22219]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 10:03:02 yechezkel sudo[22225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:03:02 yechezkel sudo[22225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel qobuz-connect[22092]: 20260110 10:03:02.691 [22092.22092] INFO SampleApp: Stopping Local configuration server Jan 10 10:03:02 yechezkel systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 10 10:03:02 yechezkel volumio[1367]: Unable to parse: Jan 10 10:03:02 yechezkel volumio[1367]: Simple mixer control 'AES Rate',0 Jan 10 10:03:02 yechezkel volumio[1367]: Capabilities: volume volume-joined Jan 10 10:03:02 yechezkel volumio[1367]: Playback channels: Mono Jan 10 10:03:02 yechezkel volumio[1367]: Capture channels: Mono Jan 10 10:03:02 yechezkel volumio[1367]: Limits: 0 - 200000 Jan 10 10:03:02 yechezkel volumio[1367]: Mono: 0 [0%] Jan 10 10:03:02 yechezkel volumio[1367]: info: VolumeController:: Volume=undefined Mute =false Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:02 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:02 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: Asound.conf file written Jan 10 10:03:02 yechezkel sudo[22233]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 10 10:03:02 yechezkel sudo[22233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22233]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 10 10:03:02 yechezkel volumio[1367]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 10 10:03:02 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:03:02 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:02 yechezkel sudo[22240]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:03:02 yechezkel sudo[22240]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22240]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:03:02 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel sudo[22245]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:03:02 yechezkel sudo[22245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:03:02 yechezkel sudo[22252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:02 yechezkel sudo[22252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22255]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:03:02 yechezkel sudo[22255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:02 yechezkel sudo[22258]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:03:02 yechezkel sudo[22258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel systemd[1]: mpd.service: Deactivated successfully. Jan 10 10:03:02 yechezkel systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 10:03:02 yechezkel systemd[1]: mpd.service: Consumed 1.408s CPU time. Jan 10 10:03:02 yechezkel sudo[22255]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:03:02 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel systemd[1]: mpd.socket: Deactivated successfully. Jan 10 10:03:02 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:02 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:02 yechezkel systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 10:03:02 yechezkel systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 10:03:02 yechezkel sudo[22268]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:02 yechezkel sudo[22268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22271]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:02 yechezkel sudo[22271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22274]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:02 yechezkel sudo[22274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 10:03:02 yechezkel systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 10:03:02 yechezkel sudo[22252]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel sudo[22285]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:03:02 yechezkel sudo[22285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:03:02 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel sudo[22293]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:03:02 yechezkel sudo[22293]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel systemd[1]: mpd.service: Deactivated successfully. Jan 10 10:03:02 yechezkel systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 10:03:02 yechezkel sudo[22285]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel sudo[22268]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel sudo[22300]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:03:02 yechezkel sudo[22300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:02 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:03:02 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:03:02 yechezkel sudo[22309]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:03:02 yechezkel sudo[22309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel volumio[1367]: info: Preparing to generate the ALSA configuration file Jan 10 10:03:02 yechezkel sudo[22312]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:03:02 yechezkel sudo[22312]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:02 yechezkel sudo[22271]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:02 yechezkel volumio[1367]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 10 10:03:02 yechezkel volumio[1367]: info: Reading ALSA contributions from plugins. Jan 10 10:03:03 yechezkel volumio[1367]: info: Asound.conf file unchanged, so no further update is needed Jan 10 10:03:03 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:03:03 yechezkel sudo[22274]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22293]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22317]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:03:03 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:03 yechezkel sudo[22317]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel sudo[22318]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:03:03 yechezkel sudo[22318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel sudo[22318]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22320]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:03:03 yechezkel sudo[22320]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:03:03 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:03 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:03 yechezkel systemd[1]: mpd.socket: Deactivated successfully. Jan 10 10:03:03 yechezkel systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 10:03:03 yechezkel systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 10:03:03 yechezkel sudo[22332]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:03 yechezkel sudo[22332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel sudo[22334]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:03 yechezkel sudo[22334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 10:03:03 yechezkel systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 10:03:03 yechezkel systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 10:03:03 yechezkel systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 10:03:03 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:03:03 yechezkel sudo[22343]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:03:03 yechezkel sudo[22343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:03:03 yechezkel systemd[1]: shairport-sync.service: Consumed 1.521s CPU time. Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: Preparing to generate the ALSA configuration file Jan 10 10:03:03 yechezkel volumio[1367]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 10 10:03:03 yechezkel volumio[1367]: info: Reading ALSA contributions from plugins. Jan 10 10:03:03 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:03:03 yechezkel sudo[22343]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22351]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:03:03 yechezkel sudo[22351]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel volumio[1367]: info: Asound.conf file unchanged, so no further update is needed Jan 10 10:03:03 yechezkel volumio[1367]: info: Output device has changed, restarting MPD Jan 10 10:03:03 yechezkel sudo[22341]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 10 10:03:03 yechezkel sudo[22341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 10 10:03:03 yechezkel sudo[22341]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22354]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:03:03 yechezkel sudo[22354]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:03:03 yechezkel sudo[22312]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel volumio[1367]: info: Output device has changed, restarting Shairport Sync Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:03 yechezkel sudo[22309]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22358]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 10:03:03 yechezkel sudo[22358]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel sudo[22358]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel volumio[1367]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 10:03:03 yechezkel sudo[22362]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 10:03:03 yechezkel sudo[22362]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel volumio[1367]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:03 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:03 yechezkel sudo[22332]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22389]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:03 yechezkel sudo[22389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel sudo[22386]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 10 10:03:03 yechezkel sudo[22386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel sudo[22334]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel volumio[1367]: info: MPD Permissions set Jan 10 10:03:03 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:03:03 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:03:03 yechezkel volumio[1367]: (node:1367) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 10 10:03:03 yechezkel volumio[1367]: (Use `node --trace-warnings ...` to show where the warning was created) Jan 10 10:03:03 yechezkel volumio[1367]: (node:1367) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 10 10:03:03 yechezkel volumio[1367]: (node:1367) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 10 10:03:03 yechezkel volumio[1367]: (node:1367) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 10 10:03:03 yechezkel volumio[1367]: (node:1367) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Jan 10 10:03:03 yechezkel sudo[22398]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 10 10:03:03 yechezkel sudo[22398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:03 yechezkel volumio[1367]: info: Starting Shairport Sync Jan 10 10:03:03 yechezkel systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 10:03:03 yechezkel systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:03:03 yechezkel systemd[1]: mpd.service: Deactivated successfully. Jan 10 10:03:03 yechezkel systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 10:03:03 yechezkel sudo[22406]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 10:03:03 yechezkel sudo[22406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel sudo[22386]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22398]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel systemd[1]: mpd.socket: Deactivated successfully. Jan 10 10:03:03 yechezkel sudo[22408]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 10 10:03:03 yechezkel systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 10:03:03 yechezkel sudo[22408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:03 yechezkel systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 10:03:03 yechezkel systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 10:03:03 yechezkel systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 10:03:03 yechezkel systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 10:03:03 yechezkel sudo[22406]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22354]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:03:03 yechezkel volumio[1367]: info: Shairport-Sync Started Jan 10 10:03:03 yechezkel sudo[22389]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:03 yechezkel sudo[22412]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 10 10:03:03 yechezkel sudo[22412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 10 10:03:03 yechezkel sudo[22412]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:04 yechezkel mpd[22430]: 2026-01-10T10:03:04 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 10 10:03:04 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:04 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:04 yechezkel qobuz-connect[22092]: 20260110 10:03:04.591 [22092.22092] INFO SampleApp: shat down connection on UNIX socket Jan 10 10:03:04 yechezkel volumio[1367]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 10 10:03:04 yechezkel volumio[1367]: info: QobuzConnect: setDeactiveState invoked Jan 10 10:03:04 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:04 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:04 yechezkel systemd[1]: qobuz-connect.service: Deactivated successfully. Jan 10 10:03:04 yechezkel systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 10 10:03:04 yechezkel systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 10 10:03:04 yechezkel sudo[22225]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:04 yechezkel sudo[22351]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:04 yechezkel sudo[22300]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:04 yechezkel sudo[22408]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:04 yechezkel sudo[22317]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:04 yechezkel volumio[1367]: info: Executing endpoint qc_getconfig Jan 10 10:03:04 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.658 [22431.22431] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.660 [22431.22431] INFO VolumeManager: [0x1065298]: Setting new playback volume: 75 Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.660 [22431.22431] INFO VolumeManager: [0x1065298]: Setting new mute state: 0 Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.660 [22431.22431] INFO QobuzConnect: [0x1065c68]: Client initialized! Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.660 [22431.22431] INFO SampleApp: Starting Avahi advertising, name: yechezkel, service name: _qobuz-connect._tcp Jan 10 10:03:04 yechezkel volumio[1367]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 10 10:03:04 yechezkel volumio[1367]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.667 [22431.22431] INFO LocalConfigManager: [0x1064b78]: Starting Local Configuration server Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.667 [22431.22431] INFO SampleApp: Starting Local configuration server Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.668 [22431.22431] INFO SampleApp: Connected to UNIX socket client 0x104f818 Jan 10 10:03:04 yechezkel qobuz-connect[22431]: 20260110 10:03:04.808 [22431.22431] INFO SampleApp: Playback volume changed: 75 Jan 10 10:03:04 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:04 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:04 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:04 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:05 yechezkel systemd[1]: Started mpd.service - Music Player Daemon. Jan 10 10:03:05 yechezkel mpd_monitor.sh[14139]: MPD Monitor Service: MPD restarted due to no mpc output. Jan 10 10:03:05 yechezkel sudo[22025]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel sudo[21972]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel sudo[22362]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel sudo[21912]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel sudo[22258]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel sudo[22320]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel sudo[22245]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel sudo[21897]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel volumio[1367]: error: MPD error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: MPD error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: MPD error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: MPD error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: MPD error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: MPD error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: MPD error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: The expression evaluated to a falsy value: Jan 10 10:03:05 yechezkel volumio[1367]: assert.ok(self.idling) Jan 10 10:03:05 yechezkel volumio[1367]: error: updateQueue error: null Jan 10 10:03:05 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:05 yechezkel volumio[1367]: info: CURURI: music-library Jan 10 10:03:05 yechezkel volumio[1367]: info: Executing endpoint metavolumio Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 10 10:03:05 yechezkel volumio[1367]: info: Executing endpoint metavolumio Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 10 10:03:05 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:05 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:05 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:05 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:05 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:05 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:05 yechezkel sudo[22464]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:05 yechezkel sudo[22464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:05 yechezkel systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 10 10:03:05 yechezkel sudo[22464]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:05 yechezkel volumio[1367]: info: Executing endpoint tc_getconfig Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 10 10:03:05 yechezkel vtcs[22467]: STARTING TidalConnect services, version: 1.5.2.56 Jan 10 10:03:05 yechezkel vtcs[22467]: STARTED TidalConnect services. Jan 10 10:03:05 yechezkel volumio[1367]: info: Executing endpoint tc_connect Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 10 10:03:05 yechezkel volumio[1367]: info: Connecting to TidalConnect Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:05 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:05 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:05 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:05 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:05 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:05 yechezkel volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:05 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:05 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:05 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:05 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:05 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:05 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:05 yechezkel volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jan 10 10:03:05 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:05 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:06 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:06 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel sudo[22500]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:06 yechezkel sudo[22500]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:06 yechezkel sudo[22503]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:06 yechezkel sudo[22503]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:06 yechezkel sudo[22500]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:06 yechezkel sudo[22503]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:06 yechezkel volumio[1367]: info: CURURI: music-library/USB Jan 10 10:03:06 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:06 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:06 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel sudo[22516]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:06 yechezkel sudo[22516]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:06 yechezkel sudo[22516]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:06 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:06 yechezkel volumio[1367]: info: TidalConnect service stoped! Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel volumio[1367]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 10 10:03:06 yechezkel sudo[22528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 10 10:03:06 yechezkel sudo[22528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:06 yechezkel sudo[22528]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreStateMachine::getcurrentVolume Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioRetrievevolume Jan 10 10:03:06 yechezkel volumio[1367]: Unable to parse: Jan 10 10:03:06 yechezkel volumio[1367]: Simple mixer control 'AES Rate',0 Jan 10 10:03:06 yechezkel volumio[1367]: Capabilities: volume volume-joined Jan 10 10:03:06 yechezkel volumio[1367]: Playback channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Capture channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Limits: 0 - 200000 Jan 10 10:03:06 yechezkel volumio[1367]: Mono: 0 [0%] Jan 10 10:03:06 yechezkel volumio[1367]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Jan 10 10:03:06 yechezkel volumio[1367]: Unable to parse: Jan 10 10:03:06 yechezkel volumio[1367]: Simple mixer control 'AES Rate',0 Jan 10 10:03:06 yechezkel volumio[1367]: Capabilities: volume volume-joined Jan 10 10:03:06 yechezkel volumio[1367]: Playback channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Capture channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Limits: 0 - 200000 Jan 10 10:03:06 yechezkel volumio[1367]: Mono: 0 [0%] Jan 10 10:03:06 yechezkel volumio[1367]: info: VolumeController:: Volume=undefined Mute =false Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:06 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:06 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:06 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:06 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:06 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreStateMachine::updateTrackBlock Jan 10 10:03:06 yechezkel volumio[1367]: info: CorePlayQueue::getTrackBlock Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioRetrievevolume Jan 10 10:03:06 yechezkel volumio[1367]: Unable to parse: Jan 10 10:03:06 yechezkel volumio[1367]: Simple mixer control 'AES Rate',0 Jan 10 10:03:06 yechezkel volumio[1367]: Capabilities: volume volume-joined Jan 10 10:03:06 yechezkel volumio[1367]: Playback channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Capture channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Limits: 0 - 200000 Jan 10 10:03:06 yechezkel volumio[1367]: Mono: 0 [0%] Jan 10 10:03:06 yechezkel volumio[1367]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Jan 10 10:03:06 yechezkel volumio[1367]: Unable to parse: Jan 10 10:03:06 yechezkel volumio[1367]: Simple mixer control 'AES Rate',0 Jan 10 10:03:06 yechezkel volumio[1367]: Capabilities: volume volume-joined Jan 10 10:03:06 yechezkel volumio[1367]: Playback channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Capture channels: Mono Jan 10 10:03:06 yechezkel volumio[1367]: Limits: 0 - 200000 Jan 10 10:03:06 yechezkel volumio[1367]: Mono: 0 [0%] Jan 10 10:03:06 yechezkel volumio[1367]: info: VolumeController:: Volume=undefined Mute =false Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:06 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:06 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:06 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:06 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:06 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:06 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:07 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:07 yechezkel volumio[1367]: info: CURURI: music-library/USB/18music Jan 10 10:03:07 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:07 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 10:03:08 yechezkel sudo[22536]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel sudo[22538]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel sudo[22541]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel sudo[22546]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel sudo[22547]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22547]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel sudo[22551]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel sudo[22553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel sudo[22556]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 10:03:08 yechezkel sudo[22556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 10:03:08 yechezkel systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Jan 10 10:03:08 yechezkel systemd[1]: mpd_monitor.service: Deactivated successfully. Jan 10 10:03:08 yechezkel systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Jan 10 10:03:08 yechezkel systemd[1]: mpd_monitor.service: Consumed 1.013s CPU time. Jan 10 10:03:08 yechezkel systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 10 10:03:08 yechezkel mpd_monitor.sh[22559]: MPD Monitor Service: Starting MPD Monitor Service Jan 10 10:03:08 yechezkel sudo[22556]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel sudo[22551]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel sudo[22538]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel sudo[22546]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel sudo[22547]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel sudo[22536]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel sudo[22541]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel sudo[22553]: pam_unix(sudo:session): session closed for user root Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel volumio[1367]: info: Successfully started MPD Monitor Jan 10 10:03:08 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:08 yechezkel volumio[1367]: info: CURURI: music-library/USB/18music/NativeDSD Jan 10 10:03:08 yechezkel volumio[1367]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Jan 10 10:03:08 yechezkel volumio[1367]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Jan 10 10:03:08 yechezkel volumio[1367]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Jan 10 10:03:08 yechezkel volumio[1367]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Jan 10 10:03:08 yechezkel volumio[1367]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Jan 10 10:03:08 yechezkel volumio[1367]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Jan 10 10:03:08 yechezkel volumio[1367]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Jan 10 10:03:08 yechezkel volumio[1367]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 10 10:03:08 yechezkel volumio[1367]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 10 10:03:08 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:08 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:09 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:09 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:09 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:09 yechezkel volumio[1367]: info: TidalConnect service started! Jan 10 10:03:13 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:13 yechezkel volumio[1367]: info: CURURI: music-library/USB/‏‏אמצעי_אחס Jan 10 10:03:13 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:14 yechezkel go-librespot[1860]: time="2026-01-10T10:03:14+02:00" level=trace msg="sent dealer ping" Jan 10 10:03:14 yechezkel go-librespot[1860]: time="2026-01-10T10:03:14+02:00" level=trace msg="received dealer pong" Jan 10 10:03:17 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:17 yechezkel volumio[1367]: info: CURURI: music-library/USB/MUSIC_FOR_V Jan 10 10:03:18 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:21 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:21 yechezkel volumio[1367]: info: CURURI: music-library/USB/MUSIC_FOR_V/strumenti Jan 10 10:03:21 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:25 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:25 yechezkel volumio[1367]: info: CURURI: music-library/USB/MUSIC_FOR_V/strumenti/piano Jan 10 10:03:25 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:27 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:27 yechezkel volumio[1367]: info: CURURI: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC] Jan 10 10:03:27 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:27 yechezkel volumio[1367]: info: Preloading song: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Preloading song: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/02 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' I. Largo - Allegro.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Preloading song: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/03 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' II. Adagio.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Preloading song: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/04 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' III. Allegretto.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Preloading song: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/05 - Beethoven - Choral Famtasy in C minor, Op. 80, I. Adagio.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Preloading song: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/06 - Beethoven - Choral Famtasy in C minor, Op. 80, II. Finale. Allegro - etc..flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Preloading song: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/07 - Part - Credo for piano, mixed choir and orchestra.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac in service mpd Jan 10 10:03:27 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Helene%20Grimaud/Credo/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FHelene%20Grimaud%20-%20Credo%20%5BFLAC%5D%2F01%20-%20Corigliano%20-%20Fantasia%20on%20an%20Ostinato%20for%20solo%20piano.flac&metadata=false Jan 10 10:03:27 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/02 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' I. Largo - Allegro.flac in service mpd Jan 10 10:03:27 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Helene%20Grimaud/Credo/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FHelene%20Grimaud%20-%20Credo%20%5BFLAC%5D%2F02%20-%20Beethoven%20-%20Piano%20Sonata%20No.%2017%20in%20D%20minor%2C%20Op.%2031%20No.%202%20'The%20Tempest%2C'%20I.%20Largo%20-%20Allegro.flac&metadata=false Jan 10 10:03:27 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/02 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' I. Largo - Allegro.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/03 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' II. Adagio.flac in service mpd Jan 10 10:03:27 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Helene%20Grimaud/Credo/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FHelene%20Grimaud%20-%20Credo%20%5BFLAC%5D%2F03%20-%20Beethoven%20-%20Piano%20Sonata%20No.%2017%20in%20D%20minor%2C%20Op.%2031%20No.%202%20'The%20Tempest%2C'%20II.%20Adagio.flac&metadata=false Jan 10 10:03:27 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/03 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' II. Adagio.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/04 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' III. Allegretto.flac in service mpd Jan 10 10:03:27 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Helene%20Grimaud/Credo/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FHelene%20Grimaud%20-%20Credo%20%5BFLAC%5D%2F04%20-%20Beethoven%20-%20Piano%20Sonata%20No.%2017%20in%20D%20minor%2C%20Op.%2031%20No.%202%20'The%20Tempest%2C'%20III.%20Allegretto.flac&metadata=false Jan 10 10:03:27 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/04 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' III. Allegretto.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/05 - Beethoven - Choral Famtasy in C minor, Op. 80, I. Adagio.flac in service mpd Jan 10 10:03:27 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Helene%20Grimaud/Credo/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FHelene%20Grimaud%20-%20Credo%20%5BFLAC%5D%2F05%20-%20Beethoven%20-%20Choral%20Famtasy%20in%20C%20minor%2C%20Op.%2080%2C%20I.%20Adagio.flac&metadata=false Jan 10 10:03:27 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/05 - Beethoven - Choral Famtasy in C minor, Op. 80, I. Adagio.flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/06 - Beethoven - Choral Famtasy in C minor, Op. 80, II. Finale. Allegro - etc..flac in service mpd Jan 10 10:03:27 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Helene%20Grimaud/Credo/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FHelene%20Grimaud%20-%20Credo%20%5BFLAC%5D%2F06%20-%20Beethoven%20-%20Choral%20Famtasy%20in%20C%20minor%2C%20Op.%2080%2C%20II.%20Finale.%20Allegro%20-%20etc..flac&metadata=false Jan 10 10:03:27 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/06 - Beethoven - Choral Famtasy in C minor, Op. 80, II. Finale. Allegro - etc..flac Jan 10 10:03:27 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/07 - Part - Credo for piano, mixed choir and orchestra.flac in service mpd Jan 10 10:03:27 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Helene%20Grimaud/Credo/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FHelene%20Grimaud%20-%20Credo%20%5BFLAC%5D%2F07%20-%20Part%20-%20Credo%20for%20piano%2C%20mixed%20choir%20and%20orchestra.flac&metadata=false Jan 10 10:03:27 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/07 - Part - Credo for piano, mixed choir and orchestra.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::ClearQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::stop Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::clearPlayQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::saveQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::addQueueItems Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::addQueueItems Jan 10 10:03:29 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:29 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Using cached record of: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::saveQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::updateTrackBlock Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrackBlock Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 18 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPlay Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::play index 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::addQueueItems Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::addQueueItems Jan 10 10:03:29 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:29 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/02 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' I. Largo - Allegro.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Using cached record of: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/02 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' I. Largo - Allegro.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/03 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' II. Adagio.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Using cached record of: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/03 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' II. Adagio.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/04 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' III. Allegretto.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Using cached record of: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/04 - Beethoven - Piano Sonata No. 17 in D minor, Op. 31 No. 2 'The Tempest,' III. Allegretto.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/05 - Beethoven - Choral Famtasy in C minor, Op. 80, I. Adagio.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Using cached record of: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/05 - Beethoven - Choral Famtasy in C minor, Op. 80, I. Adagio.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/06 - Beethoven - Choral Famtasy in C minor, Op. 80, II. Finale. Allegro - etc..flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Using cached record of: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/06 - Beethoven - Choral Famtasy in C minor, Op. 80, II. Finale. Allegro - etc..flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/07 - Part - Credo for piano, mixed choir and orchestra.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: Using cached record of: music-library/USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/07 - Part - Credo for piano, mixed choir and orchestra.flac Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::stop Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::saveQueue Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::play index undefined Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::updateTrackBlock Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrackBlock Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::startPlaybackTimer Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand stop took 1 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand clear Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand clear took 1 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac" Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand add "USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac" took 6 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 6ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 6ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 6ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 5ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 2ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 2ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 1ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 1ms Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand play Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces system playlist update Jan 10 10:03:29 yechezkel volumio[1367]: info: Ignoring MPD Status Update Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 4ms Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand play took 4 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 3ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 3ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 3ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 3ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 2ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 2ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 2ms Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 2 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 1 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 1 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 1 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: Jan 10 10:03:29 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::getState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 5 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 4 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 4 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 2 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 2 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 2 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 2 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 2 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"264 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus stop Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"252 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"688 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 40ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 49ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 48ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 47ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 47ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 48ms Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 45 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand status took 45 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 44 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 43 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseState Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"539 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"539 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"539 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"539 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 79ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 78ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 79ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 77ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 77ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 77ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 76ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 77ms Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 77 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: info: sendMpdCommand playlistinfo took 77 milliseconds Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"539 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ControllerMpd::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::servicePushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":726,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"539 Kbps","isStreaming":false,"title":"Track01","artist":"Helene Grimaud","album":"Credo","uri":"USB/MUSIC_FOR_V/strumenti/piano/Helene Grimaud - Credo [FLAC]/01 - Corigliano - Fantasia on an Ostinato for solo piano.flac","trackType":"flac"} Jan 10 10:03:29 yechezkel volumio[1367]: verbose: CURRENT POSITION 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState stateService play Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::syncState currentStatus play Jan 10 10:03:29 yechezkel volumio[1367]: info: Received an update from plugin. extracting info from payload Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:29 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:29 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:29 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 131ms Jan 10 10:03:29 yechezkel volumio[1367]: info: ------------------------------ 131ms Jan 10 10:03:36 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 10:03:36 yechezkel volumio[1367]: info: CURURI: music-library/USB/MUSIC_FOR_V/strumenti/piano/Glenn Gould Jan 10 10:03:36 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:38 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::ClearQueue Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::stop Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::stPlaybackTimer Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::updateTrackBlock Jan 10 10:03:38 yechezkel volumio[1367]: info: CorePlayQueue::getTrackBlock Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::pushState Jan 10 10:03:38 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushState Jan 10 10:03:38 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output update for this device Jan 10 10:03:38 yechezkel volumio[1367]: info: MRS: Pushing multiroomSync output Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreCommandRouter::volumioGetState Jan 10 10:03:38 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::serviceStop Jan 10 10:03:38 yechezkel volumio[1367]: info: CorePlayQueue::getTrack 0 Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreCommandRouter::serviceStop Jan 10 10:03:38 yechezkel volumio[1367]: info: ControllerMpd::stop Jan 10 10:03:38 yechezkel volumio[1367]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 10:03:38 yechezkel volumio[1367]: info: CorePlayQueue::clearPlayQueue Jan 10 10:03:38 yechezkel volumio[1367]: info: CorePlayQueue::saveQueue Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreCommandRouter::volumioPushQueue Jan 10 10:03:38 yechezkel volumio[1367]: info: CoreStateMachine::addQueueItems Jan 10 10:03:38 yechezkel volumio[1367]: info: CorePlayQueue::addQueueItems Jan 10 10:03:38 yechezkel volumio[1367]: info: Preload queue cleared Jan 10 10:03:38 yechezkel volumio[1367]: info: Adding Item to queue: music-library/USB/MUSIC_FOR_V/strumenti/piano/Glenn Gould/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album Jan 10 10:03:38 yechezkel volumio[1367]: info: Exploding uri music-library/USB/MUSIC_FOR_V/strumenti/piano/Glenn Gould/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album in service mpd Jan 10 10:03:38 yechezkel volumio[1367]: info: Jan 10 10:03:38 yechezkel volumio[1367]: ---------------------------- MPD announces state update: player Jan 10 10:03:38 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=1%20Glenn%20Gould//extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FGlenn%20Gould%2F63-1%20Glenn%20Gould%20-%20The%20Glenn%20Gould%20Silver%20Jubilee%20Album%2F63-1%20Glenn%20Gould%20-%20The%20Glenn%20Gould%20Silver%20Jubilee%20Album.ape&metadata=false Jan 10 10:03:38 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Glenn Gould/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album.ape Jan 10 10:03:38 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Glenn%20Gould/The%20Glenn%20Gould%20Silver%20Jubilee%20Album/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FGlenn%20Gould%2F63-1%20Glenn%20Gould%20-%20The%20Glenn%20Gould%20Silver%20Jubilee%20Album%2F63-1%20Glenn%20Gould%20-%20The%20Glenn%20Gould%20Silver%20Jubilee%20Album.cue&metadata=false Jan 10 10:03:38 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Glenn Gould/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album.cue Jan 10 10:03:38 yechezkel volumio[1367]: info: ALBUMART /albumart?cacheid=751&web=Glenn%20Gould/The%20Glenn%20Gould%20Silver%20Jubilee%20Album/extralarge&path=%2Fmnt%2FUSB%2FMUSIC_FOR_V%2Fstrumenti%2Fpiano%2FGlenn%20Gould%2F63-1%20Glenn%20Gould%20-%20The%20Glenn%20Gould%20Silver%20Jubilee%20Album%2F63-1%20Glenn%20Gould%20-%20The%20Glenn%20Gould%20Silver%20Jubilee%20Album.cue&metadata=false Jan 10 10:03:38 yechezkel volumio[1367]: info: URI /mnt/USB/MUSIC_FOR_V/strumenti/piano/Glenn Gould/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album/63-1 Glenn Gould - The Glenn Gould Silver Jubilee Album.cue Jan 10 10:03:38 yechezkel volumio[1367]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 10:03:38 yechezkel volumio[1367]: Error: Unable to resolve or reject the same promise twice Jan 10 10:03:38 yechezkel volumio[1367]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 10 10:03:38 yechezkel volumio[1367]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Jan 10 10:03:38 yechezkel volumio[1367]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jan 10 10:03:38 yechezkel volumio[1367]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jan 10 10:03:38 yechezkel volumio[1367]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jan 10 10:03:38 yechezkel volumio[1367]: at Socket.emit (node:events:514:28) Jan 10 10:03:38 yechezkel volumio[1367]: at addChunk (node:internal/streams/readable:343:12) Jan 10 10:03:38 yechezkel volumio[1367]: at readableAddChunk (node:internal/streams/readable:312:11) Jan 10 10:03:38 yechezkel volumio[1367]: at Readable.push (node:internal/streams/readable:253:10) Jan 10 10:03:38 yechezkel volumio[1367]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jan 10 10:03:38 yechezkel volumio[1367]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 10:03:38 yechezkel sudo[22634]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-10 10:02' Jan 10 10:03:38 yechezkel sudo[22634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"