-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Tue 2026-02-17 21:43:00 EST. -- Feb 17 21:42:00 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:00 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:00 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:00 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:00 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:00 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:01 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:01 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:01 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:01 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:01 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:01 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:02 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:03 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:03 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:03 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:03 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: new high-speed USB device number 5 using xhci_hcd Feb 17 21:42:03 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:03 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: New USB device found, idVendor=20b1, idProduct=3008, bcdDevice= 7.40 Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: Product: iFi (by AMR) HD USB Audio Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: Manufacturer: iFi (by AMR) Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: SerialNumber: 0004 Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: 1:4 : unsupported format bits 0x100000000 Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: Warning! Unlikely big volume range (=32512), cval->res is probably wrong. Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: [10] FU [iFi (by AMR) HD USB Audio Playback Volume] ch = 2, val = -32512/0/1 Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: Warning! Unlikely big volume range (=32512), cval->res is probably wrong. Feb 17 21:42:03 volumio77 kernel: usb 1-1.1: [10] FU [iFi (by AMR) HD USB Audio Playback Volume] ch = 1, val = -32512/0/1 Feb 17 21:42:03 volumio77 kernel: hid-generic 0003:20B1:3008.0002: hiddev96,hidraw0: USB HID v1.10 Device [iFi (by AMR) iFi (by AMR) HD USB Audio] on usb-0000:01:00.0-1.1/input3 Feb 17 21:42:04 volumio77 volumio[1058]: info: Feb 17 21:42:04 volumio77 volumio[1058]: ---------------------------- USB Audio Device Attached Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::Close All Modals sent Feb 17 21:42:04 volumio77 volumio[1058]: info: Preparing to save Alsa Options, stopping services first Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:04 volumio77 volumio[1058]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"iFi (by AMR) HD USB Audio","alsacard":"Audio"},"i2s":false} Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: Device 5 does not have any Mixer Control Available Feb 17 21:42:04 volumio77 volumio[1058]: info: QobuzConnect: setDeactiveState invoked Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:04 volumio77 vtcs[1619]: [2026-02-17 21:42:04.179] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 17 21:42:04 volumio77 vtcs[1619]: [2026-02-17 21:42:04.180] [tisoc] [error] [SpkconServer.cpp:383] recv error. client fd=8 errorno=104 error=Connection reset by peer Feb 17 21:42:04 volumio77 vtcs[1619]: [2026-02-17 21:42:04.180] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 17 21:42:04 volumio77 sudo[1824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 17 21:42:04 volumio77 sudo[1824]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 systemd[1]: Stopping Volumio Tidal Connect Service... Feb 17 21:42:04 volumio77 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 17 21:42:04 volumio77 systemd[1]: vtcs.service: Succeeded. Feb 17 21:42:04 volumio77 systemd[1]: Stopped Volumio Tidal Connect Service. Feb 17 21:42:04 volumio77 sudo[1824]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 17 21:42:04 volumio77 volumio[1058]: info: Updating Volume Controller Parameters: Device: 5 Name: iFi (by AMR) HD USB Audio Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 17 21:42:04 volumio77 volumio[1058]: info: Disabling external Volume Control Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:04 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:04 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:04 volumio77 volumio[1058]: info: Preparing to generate the ALSA configuration file Feb 17 21:42:04 volumio77 sudo[1830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 17 21:42:04 volumio77 sudo[1830]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 sudo[1830]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 volumio[1058]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 17 21:42:04 volumio77 volumio[1058]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Feb 17 21:42:04 volumio77 volumio[1058]: info: Reading ALSA contributions from plugins. Feb 17 21:42:04 volumio77 sudo[1837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 17 21:42:04 volumio77 sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 17 21:42:04 volumio77 sudo[1837]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:04 volumio77 sudo[1839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 17 21:42:04 volumio77 sudo[1839]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 qobuz-connect[1556]: 20260217 21:42:04.400 [1556.1556] INFO SampleApp: Stopping Local configuration server Feb 17 21:42:04 volumio77 systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 17 21:42:04 volumio77 qobuz-connect[1556]: 20260217 21:42:04.411 [1556.1556] INFO SampleApp: shat down connection on UNIX socket Feb 17 21:42:04 volumio77 systemd[1]: qobuz-connect.service: Succeeded. Feb 17 21:42:04 volumio77 systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 17 21:42:04 volumio77 systemd[1]: Started Volumio Qobuz Connect Service. Feb 17 21:42:04 volumio77 volumio[1058]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 17 21:42:04 volumio77 volumio[1058]: info: QobuzConnect: setDeactiveState invoked Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:04 volumio77 sudo[1839]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:04 volumio77 volumio[1058]: info: Asound.conf file unchanged, so no further update is needed Feb 17 21:42:04 volumio77 volumio[1058]: info: Output device has changed, restarting MPD Feb 17 21:42:04 volumio77 sudo[1848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 17 21:42:04 volumio77 sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 sudo[1848]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 volumio[1058]: info: Output device has changed, restarting Shairport Sync Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 21:42:04 volumio77 sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 17 21:42:04 volumio77 sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 systemd[1]: Stopping MPD OLED Plugin... Feb 17 21:42:04 volumio77 systemd[1]: mpd_oled_plugin.service: Main process exited, code=killed, status=15/TERM Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 17 21:42:04 volumio77 volumio[1058]: xcb_connection_has_error() returned true Feb 17 21:42:04 volumio77 volumio[1058]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: QobuzConnect: setDeactiveState invoked Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:04 volumio77 sudo[1859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 17 21:42:04 volumio77 sudo[1859]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 sudo[1862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 17 21:42:04 volumio77 sudo[1862]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 sudo[1859]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 sudo[1862]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 sudo[1870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 17 21:42:04 volumio77 sudo[1870]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 17 21:42:04 volumio77 volumio[1058]: info: MPD Permissions set Feb 17 21:42:04 volumio77 sudo[1870]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 volumio[1058]: info: Executing endpoint qc_getconfig Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 17 21:42:04 volumio77 sudo[1872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 17 21:42:04 volumio77 sudo[1872]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 systemd[1]: Stopping Volumio Qobuz Connect Service... Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Feb 17 21:42:04 volumio77 systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT Feb 17 21:42:04 volumio77 systemd[1]: qobuz-connect.service: Succeeded. Feb 17 21:42:04 volumio77 systemd[1]: Stopped Volumio Qobuz Connect Service. Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 17 21:42:04 volumio77 volumio[1058]: info: Starting Shairport Sync Feb 17 21:42:04 volumio77 systemd[1]: Started Volumio Qobuz Connect Service. Feb 17 21:42:04 volumio77 sudo[1872]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 sudo[1882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 17 21:42:04 volumio77 sudo[1882]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 17 21:42:04 volumio77 systemd[1]: shairport-sync.service: Succeeded. Feb 17 21:42:04 volumio77 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 17 21:42:04 volumio77 systemd[1]: mpd_oled_plugin.service: Succeeded. Feb 17 21:42:04 volumio77 systemd[1]: Stopped MPD OLED Plugin. Feb 17 21:42:04 volumio77 systemd[1]: Stopping Music Player Daemon... Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 17 21:42:04 volumio77 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 17 21:42:04 volumio77 volumio[1058]: info: Executing endpoint qc_getconfig Feb 17 21:42:04 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 17 21:42:04 volumio77 sudo[1882]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:04 volumio77 systemd[1]: mpd.service: Succeeded. Feb 17 21:42:04 volumio77 systemd[1]: Stopped Music Player Daemon. Feb 17 21:42:04 volumio77 systemd[1]: Starting Music Player Daemon... Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.901 [1876.1876] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.905 [1876.1876] INFO VolumeManager: [0xaf3c30]: Setting new playback volume: 75 Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.906 [1876.1876] INFO VolumeManager: [0xaf3c30]: Setting new mute state: 0 Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.906 [1876.1876] INFO QobuzConnect: [0xaf4600]: Client initialized! Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.906 [1876.1876] INFO SampleApp: Starting Avahi advertising, name: Volumio77, service name: _qobuz-connect._tcp Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 17 21:42:04 volumio77 volumio[1058]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 17 21:42:04 volumio77 volumio[1058]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 17 21:42:04 volumio77 volumio[1058]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 17 21:42:04 volumio77 volumio[1058]: info: Shairport-Sync Started Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.922 [1876.1876] INFO LocalConfigManager: [0xaf3510]: Starting Local Configuration server Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.922 [1876.1876] INFO SampleApp: Starting Local configuration server Feb 17 21:42:04 volumio77 qobuz-connect[1876]: 20260217 21:42:04.923 [1876.1876] INFO SampleApp: Connected to UNIX socket client 0xae8f60 Feb 17 21:42:04 volumio77 sudo[1888]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 17 21:42:04 volumio77 sudo[1888]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:04 volumio77 sudo[1888]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:05 volumio77 qobuz-connect[1876]: 20260217 21:42:05.051 [1876.1876] INFO SampleApp: Playback volume changed: 75 Feb 17 21:42:05 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:05 volumio77 mpd[1893]: Feb 17 21:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 17 21:42:05 volumio77 systemd[1]: Started Music Player Daemon. Feb 17 21:42:05 volumio77 sudo[1851]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:05 volumio77 volumio[1058]: error: updateQueue error: null Feb 17 21:42:05 volumio77 systemd[1]: Started MPD OLED Plugin. Feb 17 21:42:05 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:05 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:05 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:05 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:06 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:06 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:06 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:06 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:06 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:06 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: TidalConnect service stoped! Feb 17 21:42:07 volumio77 volumio[1058]: info: TidalConnect service stoped! Feb 17 21:42:07 volumio77 volumio[1058]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 17 21:42:07 volumio77 volumio[1058]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 17 21:42:07 volumio77 sudo[1960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 17 21:42:07 volumio77 sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:07 volumio77 systemd[1]: Started Volumio Tidal Connect Service. Feb 17 21:42:07 volumio77 sudo[1960]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: Executing endpoint tc_getconfig Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 17 21:42:07 volumio77 vtcs[1962]: STARTING TidalConnect services, version: 1.6.1 Feb 17 21:42:07 volumio77 vtcs[1962]: STARTED TidalConnect services. Feb 17 21:42:07 volumio77 volumio[1058]: info: Executing endpoint tc_connect Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 17 21:42:07 volumio77 volumio[1058]: info: Connecting to TidalConnect Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::servicePushState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:07 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:07 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:07 volumio77 volumio[1058]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::servicePushState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:07 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:07 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:07 volumio77 volumio[1058]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Feb 17 21:42:07 volumio77 volumio[1058]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.pdINq1tLVqfuUCLNPutZ39aT7Gy2.b3f4f5f6b0ac2b5e94f2a07d2f3dba02.state.status' Feb 17 21:42:07 volumio77 volumio[1058]: info: TidalConnect service stoped! Feb 17 21:42:07 volumio77 volumio[1058]: info: TidalConnect service stoped! Feb 17 21:42:07 volumio77 volumio[1058]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 17 21:42:07 volumio77 volumio[1058]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 17 21:42:07 volumio77 sudo[1990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 17 21:42:07 volumio77 sudo[1990]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 17 21:42:07 volumio77 sudo[1990]: pam_unix(sudo:session): session closed for user root Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:07 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreStateMachine::getcurrentVolume Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioRetrievevolume Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:08 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:08 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:08 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:09 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:10 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:10 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:10 volumio77 volumio[1058]: info: TidalConnect service started! Feb 17 21:42:10 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:10 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:10 volumio77 volumio[1058]: info: TidalConnect service started! Feb 17 21:42:10 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:10 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:11 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:11 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:11 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:11 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:11 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:11 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:12 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:12 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:12 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:12 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:12 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:12 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:13 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:14 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:14 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:14 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:14 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:14 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:14 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:15 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:15 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:15 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:15 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:15 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:15 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:16 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::ClearQueue Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::stop Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:16 volumio77 volumio[1058]: info: CorePlayQueue::clearPlayQueue Feb 17 21:42:16 volumio77 volumio[1058]: info: CorePlayQueue::saveQueue Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushQueue Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::addQueueItems Feb 17 21:42:16 volumio77 volumio[1058]: info: CorePlayQueue::addQueueItems Feb 17 21:42:16 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:16 volumio77 volumio[1058]: info: Adding Item to queue: qobuz://album/0001166106652 Feb 17 21:42:16 volumio77 volumio[1058]: info: Using cached record of: qobuz://album/0001166106652 Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushQueue Feb 17 21:42:16 volumio77 volumio[1058]: info: CorePlayQueue::saveQueue Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::updateTrackBlock Feb 17 21:42:16 volumio77 volumio[1058]: info: CorePlayQueue::getTrackBlock Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPlay Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::play index 0 Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::stop Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::play index undefined Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:16 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreStateMachine::startPlaybackTimer Feb 17 21:42:16 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:16 volumio77 volumio[1058]: info: [1771382536359] ControllerQobuz::clearAddPlayTrack Feb 17 21:42:16 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 21:42:16 volumio77 volumio[1058]: info: sendMpdCommand stop took 2 milliseconds Feb 17 21:42:16 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 21:42:16 volumio77 volumio[1058]: info: Feb 17 21:42:16 volumio77 volumio[1058]: ---------------------------- MPD announces system playlist update Feb 17 21:42:16 volumio77 volumio[1058]: info: Ignoring MPD Status Update Feb 17 21:42:16 volumio77 volumio[1058]: info: sendMpdCommand clear took 1 milliseconds Feb 17 21:42:16 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/3449613" Feb 17 21:42:16 volumio77 volumio[1058]: error: updateQueue error: null Feb 17 21:42:16 volumio77 volumio[1058]: info: ------------------------------ 3ms Feb 17 21:42:16 volumio77 volumio[1058]: STREAMING PROXY: Handling url /?data=qobuz://song/3449613 Feb 17 21:42:16 volumio77 volumio[1058]: info: Executing endpoint getStreamUrlqobuz Feb 17 21:42:16 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 17 21:42:16 volumio77 volumio[1058]: info: getStreamUrl took 542 milliseconds Feb 17 21:42:16 volumio77 volumio[1058]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2564213&eid=3449613&fmt=6&profile=raw&app_id=539451548&cid=2595455&etsp=1771386136&hmac=ftS7nA6Ip4mXCygdJRawZhq2qMo Feb 17 21:42:16 volumio77 volumio[1058]: STREAMING PROXY: Requesting upstream with range: none Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Upstream status code: 200 Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Client closed connection Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/3449613" Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Upstream closed. Received 15640 bytes Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Incomplete transfer. Expected 20892036, got 15640 Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Retrying with range: bytes=15640- (attempt 1) Feb 17 21:42:17 volumio77 volumio[1058]: info: Feb 17 21:42:17 volumio77 volumio[1058]: ---------------------------- MPD announces system playlist update Feb 17 21:42:17 volumio77 volumio[1058]: info: Ignoring MPD Status Update Feb 17 21:42:17 volumio77 volumio[1058]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/3449613" took 2 milliseconds Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand play Feb 17 21:42:17 volumio77 volumio[1058]: info: ------------------------------ 3ms Feb 17 21:42:17 volumio77 volumio[1058]: info: sendMpdCommand play took 2 milliseconds Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Handling url /?data=qobuz://song/3449613 Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:17 volumio77 volumio[1058]: info: Executing endpoint getStreamUrlqobuz Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:17 volumio77 volumio[1058]: info: getStreamUrl took 608 milliseconds Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2564213&eid=3449613&fmt=6&profile=raw&app_id=539451548&cid=2595455&etsp=1771386137&hmac=dNVAuWbfBIX-e71stj73xFz9FPA Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Requesting upstream with range: none Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:17 volumio77 volumio[1058]: STREAMING PROXY: Upstream status code: 200 Feb 17 21:42:17 volumio77 volumio[1058]: info: Feb 17 21:42:17 volumio77 volumio[1058]: ---------------------------- MPD announces state update: player Feb 17 21:42:17 volumio77 volumio[1058]: info: ControllerMpd::getState Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand status Feb 17 21:42:17 volumio77 volumio[1058]: info: Feb 17 21:42:17 volumio77 volumio[1058]: ---------------------------- MPD announces state update: player Feb 17 21:42:17 volumio77 volumio[1058]: info: sendMpdCommand status took 36 milliseconds Feb 17 21:42:17 volumio77 volumio[1058]: info: ControllerMpd::getState Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand status Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::parseState Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 21:42:17 volumio77 volumio[1058]: info: sendMpdCommand status took 2 milliseconds Feb 17 21:42:17 volumio77 volumio[1058]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::parseState Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::parseTrackInfo Feb 17 21:42:17 volumio77 volumio[1058]: info: ControllerMpd::pushState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::servicePushState Feb 17 21:42:17 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:17 volumio77 volumio[1058]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3449613","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/3449613","trackType":"qobuz"} Feb 17 21:42:17 volumio77 volumio[1058]: verbose: CURRENT POSITION 0 Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreStateMachine::syncState stateService play Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreStateMachine::syncState currentStatus stop Feb 17 21:42:17 volumio77 volumio[1058]: info: ------------------------------ 42ms Feb 17 21:42:17 volumio77 volumio[1058]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 17 21:42:17 volumio77 volumio[1058]: verbose: ControllerMpd::parseTrackInfo Feb 17 21:42:17 volumio77 volumio[1058]: info: ControllerMpd::pushState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::servicePushState Feb 17 21:42:17 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:17 volumio77 volumio[1058]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1006,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"796 Kbps","isStreaming":false,"title":"3449613","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/3449613","trackType":"qobuz"} Feb 17 21:42:17 volumio77 volumio[1058]: verbose: CURRENT POSITION 0 Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreStateMachine::syncState stateService play Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreStateMachine::syncState currentStatus play Feb 17 21:42:17 volumio77 volumio[1058]: info: Received an update from plugin. extracting info from payload Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:17 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:17 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:17 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:17 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:17 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: info: ------------------------------ 45ms Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: STREAMING PROXY: Resuming with range: bytes=15640- Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: STREAMING PROXY: Resume upstream status code: 206 Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:18 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:19 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:19 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:19 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:19 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:19 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:19 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:20 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:20 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:20 volumio77 volumio[1058]: STREAMING PROXY: Upstream closed. Received 20892036 bytes Feb 17 21:42:20 volumio77 volumio[1058]: STREAMING PROXY: Client closed connection Feb 17 21:42:20 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:20 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:20 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:20 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:21 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:21 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:21 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:21 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:21 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:21 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:22 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:22 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:22 volumio77 volumio[1058]: STREAMING PROXY: Resume ended. Received 20876396 bytes Feb 17 21:42:22 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:22 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:22 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:22 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:22 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:23 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:23 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:23 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:23 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:23 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:23 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:23 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:24 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:24 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:24 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:24 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:24 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:24 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:25 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:25 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:25 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:25 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:25 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:25 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:26 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:26 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:26 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:26 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:26 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:26 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:27 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:28 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:28 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:28 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:28 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:28 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:28 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:29 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:29 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:29 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:29 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:29 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:29 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:30 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:30 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:30 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:30 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:30 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:30 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:31 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:32 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:32 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:32 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:32 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:32 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:32 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:33 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:33 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:33 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:33 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:33 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:33 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:34 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:34 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:34 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:34 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:34 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:34 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:35 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:36 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:36 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:36 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:36 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:36 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:36 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:37 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:37 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:37 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:37 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:37 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:37 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPause Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::pause Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::stPlaybackTimer Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::servicePause Feb 17 21:42:38 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::servicePause Feb 17 21:42:38 volumio77 volumio[1058]: info: [1771382558787] ControllerQobuz::pause Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 21:42:38 volumio77 volumio[1058]: info: ControllerMpd::pause Feb 17 21:42:38 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand pause Feb 17 21:42:38 volumio77 volumio[1058]: info: Feb 17 21:42:38 volumio77 volumio[1058]: ---------------------------- MPD announces state update: player Feb 17 21:42:38 volumio77 volumio[1058]: info: sendMpdCommand pause took 1 milliseconds Feb 17 21:42:38 volumio77 volumio[1058]: info: ControllerMpd::getState Feb 17 21:42:38 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand status Feb 17 21:42:38 volumio77 volumio[1058]: info: sendMpdCommand status took 0 milliseconds Feb 17 21:42:38 volumio77 volumio[1058]: verbose: ControllerMpd::parseState Feb 17 21:42:38 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 21:42:38 volumio77 volumio[1058]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 17 21:42:38 volumio77 volumio[1058]: verbose: ControllerMpd::parseTrackInfo Feb 17 21:42:38 volumio77 volumio[1058]: info: ControllerMpd::pushState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::servicePushState Feb 17 21:42:38 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:38 volumio77 volumio[1058]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20843,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"850 Kbps","isStreaming":false,"title":"3449613","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/3449613","trackType":"qobuz"} Feb 17 21:42:38 volumio77 volumio[1058]: verbose: CURRENT POSITION 0 Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::syncState stateService pause Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::syncState currentStatus pause Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:38 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:38 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:38 volumio77 volumio[1058]: info: CoreStateMachine::stPlaybackTimer Feb 17 21:42:38 volumio77 volumio[1058]: info: ------------------------------ 18ms Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:39 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:40 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:40 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:40 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:40 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:40 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:40 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:41 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:41 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:41 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:41 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:41 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:41 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:42 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:42 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:42 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:42 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:42 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:42 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 21:42:43 volumio77 volumio[1058]: info: CURURI: music-library Feb 17 21:42:43 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:43 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:44 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:44 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:44 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:44 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:44 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:44 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:45 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:45 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:45 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:45 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:45 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 21:42:45 volumio77 volumio[1058]: info: CURURI: music-library/USB Feb 17 21:42:45 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:45 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:45 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:46 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:46 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:46 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:46 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:46 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:46 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:46 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 21:42:46 volumio77 volumio[1058]: info: CURURI: music-library/USB/T7 Feb 17 21:42:47 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:47 volumio77 volumio[1058]: info: Preloading song: music-library/USB/T7/1 - Final Monograph_patient cases Updates in HTN Mangement.mp3 Feb 17 21:42:47 volumio77 volumio[1058]: info: Preloading song: music-library/USB/T7/QuickTime movie.mov Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:47 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/1 - Final Monograph_patient cases Updates in HTN Mangement.mp3 in service mpd Feb 17 21:42:47 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=//extralarge&path=%2Fmnt%2FUSB%2FT7%2F1%20-%20Final%20Monograph_patient%20cases%20Updates%20in%20HTN%20Mangement.mp3&metadata=false Feb 17 21:42:47 volumio77 volumio[1058]: info: URI /mnt/USB/T7/1 - Final Monograph_patient cases Updates in HTN Mangement.mp3 Feb 17 21:42:47 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/QuickTime movie.mov in service mpd Feb 17 21:42:47 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=//extralarge&path=%2Fmnt%2FUSB%2FT7%2FQuickTime%20movie.mov&metadata=false Feb 17 21:42:47 volumio77 volumio[1058]: info: URI /mnt/USB/T7/QuickTime movie.mov Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:47 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:48 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:48 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:48 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:48 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:48 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:48 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:49 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:49 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:49 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:49 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:49 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:49 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:50 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:50 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:50 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:50 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:50 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:50 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:51 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:52 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:52 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:52 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:52 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:52 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:52 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:53 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:53 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:53 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:53 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:53 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:53 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:54 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:54 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:54 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:54 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:54 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:54 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:55 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:56 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:56 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:56 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 21:42:56 volumio77 volumio[1058]: info: CURURI: music-library/USB/T7/Music Feb 17 21:42:56 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:56 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:56 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:56 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:56 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:57 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:57 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:57 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:57 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:57 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:57 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 17 21:42:58 volumio77 volumio[1058]: info: CURURI: music-library/USB/T7/Music/DSD Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:58 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:58 volumio77 volumio[1058]: info: Preloading song: music-library/USB/T7/Music/DSD/04 - Ben Webster, Brian Torff, Bucky Pizzarelli, Robert Len, Jaco Pastorius, Frédéric Alarie, Various Artists - Soledad.dsf Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/04 - Ben Webster, Brian Torff, Bucky Pizzarelli, Robert Len, Jaco Pastorius, Frédéric Alarie, Various Artists - Soledad.dsf in service mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=//extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F04%20-%20Ben%20Webster%2C%20Brian%20Torff%2C%20Bucky%20Pizzarelli%2C%20Robert%20Len%2C%20Jaco%20Pastorius%2C%20Fr%C3%A9d%C3%A9ric%20Alarie%2C%20Various%20Artists%20-%20Soledad.dsf&metadata=false Feb 17 21:42:58 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/04 - Ben Webster, Brian Torff, Bucky Pizzarelli, Robert Len, Jaco Pastorius, Frédéric Alarie, Various Artists - Soledad.dsf Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:58 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::ClearQueue Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::stop Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::updateTrackBlock Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::getTrackBlock Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::stPlaybackTimer Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::pushState Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushState Feb 17 21:42:58 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output update for this device Feb 17 21:42:58 volumio77 volumio[1058]: info: MRS: Pushing multiroomSync output Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetState Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::serviceStop Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::serviceStop Feb 17 21:42:58 volumio77 volumio[1058]: info: [1771382578635] ControllerQobuz::stop Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: ControllerMpd::stop Feb 17 21:42:58 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::clearPlayQueue Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::saveQueue Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushQueue Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::addQueueItems Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::addQueueItems Feb 17 21:42:58 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/04 - Ben Webster, Brian Torff, Bucky Pizzarelli, Robert Len, Jaco Pastorius, Frédéric Alarie, Various Artists - Soledad.dsf Feb 17 21:42:58 volumio77 volumio[1058]: info: Using cached record of: music-library/USB/T7/Music/DSD/04 - Ben Webster, Brian Torff, Bucky Pizzarelli, Robert Len, Jaco Pastorius, Frédéric Alarie, Various Artists - Soledad.dsf Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPushQueue Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::saveQueue Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::updateTrackBlock Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::getTrackBlock Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreCommandRouter::volumioPlay Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::play index 0 Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:58 volumio77 volumio[1058]: info: CoreStateMachine::addQueueItems Feb 17 21:42:58 volumio77 volumio[1058]: info: CorePlayQueue::addQueueItems Feb 17 21:42:58 volumio77 volumio[1058]: info: Preload queue cleared Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch in service mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch in service mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1 Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1 in service mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/5 Tracks in DSD 512, Volume 2 - NDSD015 Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/5 Tracks in DSD 512, Volume 2 - NDSD015 in service mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Alchemyholic Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Alchemyholic in service mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/America Live Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/America Live in service mpd Feb 17 21:42:58 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Audiolab The DSD Sampler - NDSD004 Feb 17 21:42:58 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Audiolab The DSD Sampler - NDSD004 in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Audiophile Hi-Res System Test Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Audiophile Hi-Res System Test in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Barley Moon Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Barley Moon in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Ben Webster Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Ben Webster in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Blue Coast Collection Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Blue Coast Collection in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Cool Jazz [Pure DSD] - MRC2008 Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Cool Jazz [Pure DSD] - MRC2008 in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Derek-Jones_Julie_DSD-FLAC-WAV-MQA Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Derek-Jones_Julie_DSD-FLAC-WAV-MQA in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Derek-Jones_Julie_DSD-FLAC-WAV-MQA.zip Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Derek-Jones_Julie_DSD-FLAC-WAV-MQA.zip in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Empty Triangles (Exclusive NativeDSD Edition) - SGSEMPT1 Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Empty Triangles (Exclusive NativeDSD Edition) - SGSEMPT1 in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Fire and Rain Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Fire and Rain in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/iFi Stereo DSD 256 Sampler Album - NDSD002 Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/iFi Stereo DSD 256 Sampler Album - NDSD002 in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Nagoya Double-reed Ensemble Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Nagoya Double-reed Ensemble in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Nocturnal Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Nocturnal in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/ProStudioMasters Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/ProStudioMasters in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/Quad 80th Anniversary DSD Sampler - NDSD005 Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/Quad 80th Anniversary DSD Sampler - NDSD005 in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: Adding Item to queue: music-library/USB/T7/Music/DSD/The Cary Audio DSD Sampler - NDSD009 Feb 17 21:42:59 volumio77 volumio[1058]: info: Exploding uri music-library/USB/T7/Music/DSD/The Cary Audio DSD Sampler - NDSD009 in service mpd Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreStateMachine::stop Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreStateMachine::play index undefined Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 21:42:59 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreStateMachine::startPlaybackTimer Feb 17 21:42:59 volumio77 volumio[1058]: info: CorePlayQueue::getTrack 0 Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreCommandRouter::volumioGetVisibleSources Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 21:42:59 volumio77 volumio[1058]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 17 21:42:59 volumio77 volumio[1058]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio Feb 17 21:42:59 volumio77 volumio[1058]: verbose: ControllerMpd::clearAddPlayTracks USB/T7/Music/DSD/04 - Ben Webster, Brian Torff, Bucky Pizzarelli, Robert Len, Jaco Pastorius, Frédéric Alarie, Various Artists - Soledad.dsf Feb 17 21:42:59 volumio77 volumio[1058]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 21:42:59 volumio77 volumio[1058]: info: Feb 17 21:42:59 volumio77 volumio[1058]: ---------------------------- MPD announces state update: player Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various%20Artists/NativeDSD%20Music%20-%20Free%20Starter%20Pack/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch%2F01_Spoken-Introduction-NativeDSD-Co-Founder-Jonas-Sacks_256fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch/01_Spoken-Introduction-NativeDSD-Co-Founder-Jonas-Sacks_256fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various%20Artists/NativeDSD%20Music%20-%20Free%20Starter%20Pack/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch%2F02_Shostakovich_Symphony-no-5-in-D-minor-Allegretto-excerpt-from-FR724SACD_256fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch/02_Shostakovich_Symphony-no-5-in-D-minor-Allegretto-excerpt-from-FR724SACD_256fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various%20Artists/NativeDSD%20Music%20-%20Free%20Starter%20Pack/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch%2F03_Barrios_La-Catedral-Preludio-excerpt-from-EUDDR1801_256fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch/03_Barrios_La-Catedral-Preludio-excerpt-from-EUDDR1801_256fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various%20Artists/NativeDSD%20Music%20-%20Free%20Starter%20Pack/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch%2F04_Skidmore_The-Impossible-Sum-excerpt-from-TTK0015_256fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch/04_Skidmore_The-Impossible-Sum-excerpt-from-TTK0015_256fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various%20Artists/NativeDSD%20Music%20-%20Free%20Starter%20Pack/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch%2F05_Newman_Short-People-from-JL002_256fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch/05_Newman_Short-People-from-JL002_256fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various%20Artists/NativeDSD%20Music%20-%20Free%20Starter%20Pack/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch%2F06_Rodgers_The-Sweetest-Sounds-from-JL009_256fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch/06_Rodgers_The-Sweetest-Sounds-from-JL009_256fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various%20Artists/NativeDSD%20Music%20-%20Free%20Starter%20Pack/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch%2F07_Vivaldi_The-Four-Seasons-Winter-II-Largo-from-40318_256fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/2574-NDSD017-nativedsd-music-free-starter-pack-dsd256-2ch/07_Vivaldi_The-Four-Seasons-Winter-II-Largo-from-40318_256fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F01_Sliced-Bread-Megszegett-kenyer_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/01_Sliced-Bread-Megszegett-kenyer_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F02_The-Grief-of-The-Rooster-Kakas-sirato_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/02_The-Grief-of-The-Rooster-Kakas-sirato_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F03_Above-The-Fig-Fuge-folott_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/03_Above-The-Fig-Fuge-folott_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F04_On-Elliahs-Chariot-Illes-szekeren_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/04_On-Elliahs-Chariot-Illes-szekeren_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F05_The-Way-Az-ut_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/05_The-Way-Az-ut_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F06_Man-of-Words-Szavak-embere_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/06_Man-of-Words-Szavak-embere_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F07_My-Baby-Az-en-babam_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/07_My-Baby-Az-en-babam_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F08_Easy-Autumn-Wind-Konnyed-oszi-szel_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/08_Easy-Autumn-Wind-Konnyed-oszi-szel_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F09_If-It-Does-Ha-megis_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/09_If-It-Does-Ha-megis_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F10_The-Hunter-Whip-Vadaszi-ostor_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/10_The-Hunter-Whip-Vadaszi-ostor_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F11_Make-Music-Lobbantsd-zenere_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/11_Make-Music-Lobbantsd-zenere_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F12_Again-and-Again-Ujra-meg-ujra_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/12_Again-and-Again-Ujra-meg-ujra_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Veni/The%20Way/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F3378-hres2202-the-way-dsd128-2ch%2F13_Passengers-Utasok_128fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/3378-hres2202-the-way-dsd128-2ch/13_Passengers-Utasok_128fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Les%20Chats%20Noirs/Les%20Chats%20Noirs/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2F01.%20La%20Chanson%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/01. La Chanson DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Yuko%20Mabuchi%20(piano)%2C%20JJ%20Kirkpatrick%20(trumpet)%2C%20Del%20Atkins%20(bass)%2C%20Bobby%20Breton%20(drums)/Yuko%20Mabuchi%20plays%20Miles%20Davis/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2F02.%20Milestones%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/02. Milestones DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Rachel%20Podger%2C%20Brecon%20Baroque/Le%20Quattro%20Stagioni/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2F03.%20Le%20Quattro%20Stagioni%20-%20Concerto%20no.%204%20-%20Winter%20II.%20Largo%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/03. Le Quattro Stagioni - Concerto no. 4 - Winter II. Largo DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Ricardo%20Gall%C3%A9n/En%20Silencio/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2F04.%20La%20Catedral%20-%20III.%20Allegro%20solemne%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/04. La Catedral - III. Allegro solemne DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Feenbrothers/Play%20Dave%20Brubeck/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2F05.%20Take%20five%20Reprise%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/05. Take five Reprise DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Les%20Chats%20Noirs/Les%20Chats%20Noirs/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2FDSD%20512fs%20-%202ch%2F01.%20La%20Chanson%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/DSD 512fs - 2ch/01. La Chanson DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Yuko%20Mabuchi%20(piano)%2C%20JJ%20Kirkpatrick%20(trumpet)%2C%20Del%20Atkins%20(bass)%2C%20Bobby%20Breton%20(drums)/Yuko%20Mabuchi%20plays%20Miles%20Davis/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2FDSD%20512fs%20-%202ch%2F02.%20Milestones%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/DSD 512fs - 2ch/02. Milestones DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Rachel%20Podger%2C%20Brecon%20Baroque/Le%20Quattro%20Stagioni/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2FDSD%20512fs%20-%202ch%2F03.%20Le%20Quattro%20Stagioni%20-%20Concerto%20no.%204%20-%20Winter%20II.%20Largo%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/DSD 512fs - 2ch/03. Le Quattro Stagioni - Concerto no. 4 - Winter II. Largo DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Ricardo%20Gall%C3%A9n/En%20Silencio/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2FDSD%20512fs%20-%202ch%2F04.%20La%20Catedral%20-%20III.%20Allegro%20solemne%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/DSD 512fs - 2ch/04. La Catedral - III. Allegro solemne DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Feenbrothers/Play%20Dave%20Brubeck/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%20Volume%201%2FDSD%20512fs%20-%202ch%2F05.%20Take%20five%20Reprise%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512 Volume 1/DSD 512fs - 2ch/05. Take five Reprise DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various/5%20Tracks%20in%20DSD%20512%2C%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%2C%20Volume%202%20-%20NDSD015%2FDSD%20512fs%20-%202ch%2F01.%20Brazil%20-%20From%20'Waves%20-%20The%20Bossa%20Nova%20Session'%20GRV1012%20Groove%20Note%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512, Volume 2 - NDSD015/DSD 512fs - 2ch/01. Brazil - From 'Waves - The Bossa Nova Session' GRV1012 Groove Note DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various/5%20Tracks%20in%20DSD%20512%2C%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%2C%20Volume%202%20-%20NDSD015%2FDSD%20512fs%20-%202ch%2F02.%20Summer%20Wind%20-%20From%20'Acoustic%20Trio%20DSD%20Sessions'%20SSP110413D64%20Sketti%20Sandwich%20Productions%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512, Volume 2 - NDSD015/DSD 512fs - 2ch/02. Summer Wind - From 'Acoustic Trio DSD Sessions' SSP110413D64 Sketti Sandwich Productions DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various/5%20Tracks%20in%20DSD%20512%2C%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%2C%20Volume%202%20-%20NDSD015%2FDSD%20512fs%20-%202ch%2F03.%20Violin%20Sonata%20in%20G%20Major%2C%20Op.%201%20No.%208%20%20III.%20Gavotte%20-%20From%20'Silk%20Baroque'%20PTC5186800%20Pentatone%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512, Volume 2 - NDSD015/DSD 512fs - 2ch/03. Violin Sonata in G Major, Op. 1 No. 8 III. Gavotte - From 'Silk Baroque' PTC5186800 Pentatone DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various/5%20Tracks%20in%20DSD%20512%2C%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%2C%20Volume%202%20-%20NDSD015%2FDSD%20512fs%20-%202ch%2F04.%20Concerto%20in%20Fa%20%20Allegro%20agitato%20-%20From%20%20'Simply%20%20George'%20%20VDM03855042%20VDM%20Records%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512, Volume 2 - NDSD015/DSD 512fs - 2ch/04. Concerto in Fa Allegro agitato - From 'Simply George' VDM03855042 VDM Records DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Various/5%20Tracks%20in%20DSD%20512%2C%20Volume%202/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2F5%20Tracks%20in%20DSD%20512%2C%20Volume%202%20-%20NDSD015%2FDSD%20512fs%20-%202ch%2F05.%20Tears%20of%20Joy%20-%20From%20'Tears%20of%20Joy'%20VVDHR005%20VIVID%20Productions%20DSD%20512fs%20-%202ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/5 Tracks in DSD 512, Volume 2 - NDSD015/DSD 512fs - 2ch/05. Tears of Joy - From 'Tears of Joy' VVDHR005 VIVID Productions DSD 512fs - 2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Zoltan%20Lantos/Alchemyholic/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch%2F01_Deep-Rewind_64fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch/01_Deep-Rewind_64fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Zoltan%20Lantos/Alchemyholic/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch%2F02_Sonoma-Fuse_64fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch/02_Sonoma-Fuse_64fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Zoltan%20Lantos/Alchemyholic/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch%2F03_Shiyama_64fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch/03_Shiyama_64fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Zoltan%20Lantos/Alchemyholic/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch%2F04_Alchemyholic_64fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch/04_Alchemyholic_64fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Zoltan%20Lantos/Alchemyholic/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch%2F05_Poemology_64fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch/05_Poemology_64fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Zoltan%20Lantos/Alchemyholic/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch%2F06_Helium-Fish_64fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch/06_Helium-Fish_64fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=Zoltan%20Lantos/Alchemyholic/extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch%2F07_Theravada_64fs-2ch.dsf&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch/07_Theravada_64fs-2ch.dsf Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=//extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch.zip&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch.zip Feb 17 21:42:59 volumio77 volumio[1058]: info: ALBUMART /albumart?cacheid=419&web=//extralarge&path=%2Fmnt%2FUSB%2FT7%2FMusic%2FDSD%2FAlchemyholic%2F5401-hres2416-alchemyholic-dsd64-2ch.zip&metadata=false Feb 17 21:42:59 volumio77 volumio[1058]: info: URI /mnt/USB/T7/Music/DSD/Alchemyholic/5401-hres2416-alchemyholic-dsd64-2ch.zip Feb 17 21:42:59 volumio77 volumio[1058]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 21:42:59 volumio77 volumio[1058]: Error: Unable to resolve or reject the same promise twice Feb 17 21:42:59 volumio77 volumio[1058]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 17 21:42:59 volumio77 volumio[1058]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Feb 17 21:42:59 volumio77 volumio[1058]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Feb 17 21:42:59 volumio77 volumio[1058]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Feb 17 21:42:59 volumio77 volumio[1058]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Feb 17 21:42:59 volumio77 volumio[1058]: at Socket.emit (events.js:315:20) Feb 17 21:42:59 volumio77 volumio[1058]: at addChunk (internal/streams/readable.js:309:12) Feb 17 21:42:59 volumio77 volumio[1058]: at readableAddChunk (internal/streams/readable.js:280:11) Feb 17 21:42:59 volumio77 volumio[1058]: at Socket.Readable.push (internal/streams/readable.js:223:10) Feb 17 21:42:59 volumio77 volumio[1058]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Feb 17 21:42:59 volumio77 volumio[1058]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 21:43:00 volumio77 sudo[2083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-17 21:42 Feb 17 21:43:00 volumio77 sudo[2083]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"