-- Logs begin at Wed 2024-07-17 08:27:46 CEST, end at Wed 2024-07-17 14:39:41 CEST. -- Jul 17 14:38:00 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 14:38:13 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 14:38:13 minidsp-shd volumio[711]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 17 14:38:13 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 17 14:38:13 minidsp-shd volumio[711]: info: Received Get System Version Jul 17 14:38:13 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 14:38:13 minidsp-shd volumio[711]: info: Received Get System Info Jul 17 14:38:13 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 14:38:13 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 14:38:13 minidsp-shd volumio[711]: info: Discovery: Getting this device information Jul 17 14:38:13 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetState Jul 17 14:38:13 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 14:38:15 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 14:38:27 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:27 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 14:38:27 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 14:38:27 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 14:38:27 minidsp-shd volumio[711]: info: Received Get System Version Jul 17 14:38:27 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 14:38:27 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:38 minidsp-shd volumio[711]: info: Retrieving Cloud Streaming UI Jul 17 14:38:38 minidsp-shd volumio[711]: info: Getting Tidal Cloud Configuration Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:38 minidsp-shd volumio[711]: info: Getting Qobuz Cloud Configuration Jul 17 14:38:38 minidsp-shd volumio[711]: info: Asking plugin for UI Config Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:38 minidsp-shd volumio[711]: info: Getting Spotify Cloud Configuration Jul 17 14:38:38 minidsp-shd volumio[711]: info: Asking plugin for UI Config Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:38 minidsp-shd volumio[711]: info: Saving Spotify Acccount Jul 17 14:38:38 minidsp-shd volumio[711]: info: Got it Jul 17 14:38:38 minidsp-shd volumio[711]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 17 14:38:38 minidsp-shd volumio[711]: info: Got Tidal Cloud Configuration Jul 17 14:38:38 minidsp-shd volumio[711]: info: Got it Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetBrowseSources Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetBrowseSources Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetBrowseSources Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:38:38 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 17 14:38:42 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:38:46 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:38:50 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:38:54 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:38:58 minidsp-shd volumio[711]: info: Jul 17 14:38:58 minidsp-shd volumio[711]: ---------------------------- MPD announces system playlist update Jul 17 14:38:58 minidsp-shd volumio[711]: info: Ignoring MPD Status Update Jul 17 14:38:58 minidsp-shd volumio[711]: info: Jul 17 14:38:58 minidsp-shd volumio[711]: ---------------------------- MPD announces state update: player Jul 17 14:38:58 minidsp-shd volumio[711]: info: ControllerMpd::getState Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand status Jul 17 14:38:58 minidsp-shd volumio[711]: info: Jul 17 14:38:58 minidsp-shd volumio[711]: ---------------------------- MPD announces system playlist update Jul 17 14:38:58 minidsp-shd volumio[711]: info: Ignoring MPD Status Update Jul 17 14:38:58 minidsp-shd volumio[711]: info: Jul 17 14:38:58 minidsp-shd volumio[711]: ---------------------------- MPD announces state update: player Jul 17 14:38:58 minidsp-shd volumio[711]: info: ControllerMpd::getState Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand status Jul 17 14:38:58 minidsp-shd volumio[711]: info: Jul 17 14:38:58 minidsp-shd volumio[711]: ---------------------------- MPD announces system playlist update Jul 17 14:38:58 minidsp-shd volumio[711]: info: Ignoring MPD Status Update Jul 17 14:38:58 minidsp-shd volumio[711]: info: Jul 17 14:38:58 minidsp-shd volumio[711]: ---------------------------- MPD announces state update: player Jul 17 14:38:58 minidsp-shd volumio[711]: info: ControllerMpd::getState Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand status Jul 17 14:38:58 minidsp-shd volumio[711]: info: ------------------------------ 10ms Jul 17 14:38:58 minidsp-shd volumio[711]: info: sendMpdCommand status took 9 milliseconds Jul 17 14:38:58 minidsp-shd volumio[711]: info: ------------------------------ 8ms Jul 17 14:38:58 minidsp-shd volumio[711]: info: sendMpdCommand status took 7 milliseconds Jul 17 14:38:58 minidsp-shd volumio[711]: info: ------------------------------ 6ms Jul 17 14:38:58 minidsp-shd volumio[711]: info: sendMpdCommand status took 5 milliseconds Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::parseState Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::parseState Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::parseState Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 14:38:58 minidsp-shd volumio[711]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 14:38:58 minidsp-shd volumio[711]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 14:38:58 minidsp-shd volumio[711]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::parseTrackInfo Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::parseTrackInfo Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: ControllerMpd::parseTrackInfo Jul 17 14:38:58 minidsp-shd volumio[711]: info: ControllerMpd::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1157604,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rea Garvey - Let's Be Lovers Tonight","artist":"WDR 2 Rhein und Ruhr aktuell, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-wdr2-rheinruhr.icecastssl.wdr.de/wdr/wdr2/rheinruhr/mp3/128/stream.mp3?aggregator=tunein","trackType":""} Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: CURRENT POSITION 69 Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::syncState stateService play Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::syncState currentStatus play Jul 17 14:38:58 minidsp-shd volumio[711]: info: Received an update from plugin. extracting info from payload Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: ControllerMpd::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1157604,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rea Garvey - Let's Be Lovers Tonight","artist":"WDR 2 Rhein und Ruhr aktuell, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-wdr2-rheinruhr.icecastssl.wdr.de/wdr/wdr2/rheinruhr/mp3/128/stream.mp3?aggregator=tunein","trackType":""} Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: CURRENT POSITION 69 Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::syncState stateService play Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::syncState currentStatus play Jul 17 14:38:58 minidsp-shd volumio[711]: info: Received an update from plugin. extracting info from payload Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: ControllerMpd::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1157604,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Rea Garvey - Let's Be Lovers Tonight","artist":"WDR 2 Rhein und Ruhr aktuell, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://wdr-wdr2-rheinruhr.icecastssl.wdr.de/wdr/wdr2/rheinruhr/mp3/128/stream.mp3?aggregator=tunein","trackType":""} Jul 17 14:38:58 minidsp-shd volumio[711]: verbose: CURRENT POSITION 69 Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::syncState stateService play Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::syncState currentStatus play Jul 17 14:38:58 minidsp-shd volumio[711]: info: Received an update from plugin. extracting info from payload Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:38:58 minidsp-shd volumio[711]: info: ------------------------------ 52ms Jul 17 14:38:58 minidsp-shd volumio[711]: info: ------------------------------ 50ms Jul 17 14:38:58 minidsp-shd volumio[711]: info: ------------------------------ 49ms Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:38:58 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:38:58 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:02 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:04 minidsp-shd volumio[711]: info: Enabling MyMusic plugin ms_surface_dial Jul 17 14:39:04 minidsp-shd volumio[711]: info: Enabling plugin ms_surface_dial Jul 17 14:39:04 minidsp-shd volumio[711]: info: Loading plugin "ms_surface_dial"... Jul 17 14:39:05 minidsp-shd volumio[711]: info: Applying required configuration parameters for plugin ms_surface_dial Jul 17 14:39:05 minidsp-shd volumio[711]: info: PLUGIN START: ms_surface_dial Jul 17 14:39:05 minidsp-shd volumio[711]: info: Done. Jul 17 14:39:05 minidsp-shd dbus-daemon[431]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.15' (uid=1000 pid=711 comm="/usr/bin/node /volumio/index.js ") Jul 17 14:39:05 minidsp-shd systemd[1]: Starting Bluetooth service... Jul 17 14:39:05 minidsp-shd bluetoothd[12541]: Bluetooth daemon 5.23 Jul 17 14:39:05 minidsp-shd dbus-daemon[431]: [system] Successfully activated service 'org.bluez' Jul 17 14:39:05 minidsp-shd systemd[1]: Started Bluetooth service. Jul 17 14:39:05 minidsp-shd bluetoothd[12541]: Starting SDP server Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: Core ver 2.22 Jul 17 14:39:05 minidsp-shd kernel: NET: Registered protocol family 31 Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: HCI device and connection manager initialized Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: HCI socket layer initialized Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: L2CAP socket layer initialized Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: SCO socket layer initialized Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: BNEP filters: protocol multicast Jul 17 14:39:05 minidsp-shd kernel: Bluetooth: BNEP socket layer initialized Jul 17 14:39:05 minidsp-shd bluetoothd[12541]: Bluetooth management interface 1.14 initialized Jul 17 14:39:05 minidsp-shd dbus-daemon[431]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.16' (uid=0 pid=12541 comm="/usr/local/libexec/bluetooth/bluetoothd ") Jul 17 14:39:05 minidsp-shd systemd[1]: Starting Hostname Service... Jul 17 14:39:05 minidsp-shd volumio[711]: info: msSurfaceDial Managed Objs {"/org/bluez":{"org.freedesktop.DBus.Introspectable":{},"org.bluez.AgentManager1":{},"org.bluez.ProfileManager1":{}}} Jul 17 14:39:05 minidsp-shd volumio[711]: info: [msSurfaceDial init()] check /org/bluez Jul 17 14:39:05 minidsp-shd volumio[711]: info: [msSurfaceDial init()] Adapter: null; SurfaceDial: null Jul 17 14:39:05 minidsp-shd volumio[711]: info: msSurfaceDial BluetoothSurfaceDial init() - ready! Jul 17 14:39:05 minidsp-shd volumio[711]: info: CoreCommandRouter::Reload Ui Jul 17 14:39:06 minidsp-shd dbus-daemon[431]: [system] Successfully activated service 'org.freedesktop.hostname1' Jul 17 14:39:06 minidsp-shd systemd[1]: Started Hostname Service. Jul 17 14:39:06 minidsp-shd sudo[12549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 17 14:39:06 minidsp-shd sudo[12549]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 14:39:06 minidsp-shd sudo[12549]: pam_unix(sudo:session): session closed for user root Jul 17 14:39:06 minidsp-shd sudo[12552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 17 14:39:06 minidsp-shd sudo[12552]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 14:39:06 minidsp-shd sudo[12552]: pam_unix(sudo:session): session closed for user root Jul 17 14:39:06 minidsp-shd volumio[711]: verbose: New Socket.io Connection to 192.168.1.229 from 192.168.1.223 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.5 Safari/605.1.15 Total Clients: 6 Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:39:06 minidsp-shd volumio[711]: info: Retrieving Cloud Streaming UI Jul 17 14:39:06 minidsp-shd volumio[711]: info: Getting Tidal Cloud Configuration Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:39:06 minidsp-shd volumio[711]: info: Getting Qobuz Cloud Configuration Jul 17 14:39:06 minidsp-shd volumio[711]: info: Asking plugin for UI Config Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:39:06 minidsp-shd volumio[711]: info: Getting Spotify Cloud Configuration Jul 17 14:39:06 minidsp-shd volumio[711]: info: Asking plugin for UI Config Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:39:06 minidsp-shd volumio[711]: info: Saving Spotify Acccount Jul 17 14:39:06 minidsp-shd volumio[711]: info: Got it Jul 17 14:39:06 minidsp-shd volumio[711]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetState Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 14:39:06 minidsp-shd volumio[711]: info: Got Tidal Cloud Configuration Jul 17 14:39:06 minidsp-shd volumio[711]: info: Got it Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetBrowseSources Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetBrowseSources Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetBrowseSources Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:06 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 17 14:39:08 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 14:39:08 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 14:39:10 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:10 minidsp-shd volumio[711]: info: Enabling MyMusic plugin airplay_emulation Jul 17 14:39:10 minidsp-shd volumio[711]: info: Enabling plugin airplay_emulation Jul 17 14:39:10 minidsp-shd volumio[711]: info: Loading plugin "airplay_emulation"... Jul 17 14:39:11 minidsp-shd volumio[711]: info: Starting Shairport Sync Jul 17 14:39:11 minidsp-shd volumio[711]: info: PLUGIN START: airplay_emulation Jul 17 14:39:11 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 14:39:11 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 14:39:11 minidsp-shd volumio[711]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 14:39:11 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 14:39:11 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 14:39:11 minidsp-shd volumio[711]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 14:39:11 minidsp-shd volumio[711]: info: Done. Jul 17 14:39:11 minidsp-shd volumio[711]: info: Starting Shairport Sync Jul 17 14:39:11 minidsp-shd volumio[711]: info: Starting Shairport Sync Jul 17 14:39:11 minidsp-shd sudo[12574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 14:39:11 minidsp-shd sudo[12574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 14:39:11 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 14:39:11 minidsp-shd sudo[12577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 14:39:11 minidsp-shd sudo[12577]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 14:39:11 minidsp-shd systemd[1]: shairport-sync.service: Succeeded. Jul 17 14:39:11 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 14:39:11 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 14:39:11 minidsp-shd sudo[12574]: pam_unix(sudo:session): session closed for user root Jul 17 14:39:11 minidsp-shd volumio[711]: info: Shairport-Sync Started Jul 17 14:39:11 minidsp-shd volumio[711]: Error adding Membership: Error: addMembership EINVAL Jul 17 14:39:11 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 14:39:11 minidsp-shd systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 17 14:39:11 minidsp-shd systemd[1]: shairport-sync.service: Succeeded. Jul 17 14:39:11 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 14:39:11 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 14:39:11 minidsp-shd sudo[12577]: pam_unix(sudo:session): session closed for user root Jul 17 14:39:11 minidsp-shd volumio[711]: info: Shairport-Sync Started Jul 17 14:39:13 minidsp-shd volumio[711]: info: Enabling MyMusic plugin cd_controller Jul 17 14:39:13 minidsp-shd volumio[711]: info: Enabling plugin cd_controller Jul 17 14:39:13 minidsp-shd volumio[711]: info: Loading plugin "cd_controller"... Jul 17 14:39:13 minidsp-shd volumio[711]: info: PLUGIN START: cd_controller Jul 17 14:39:13 minidsp-shd volumio[711]: info: Preparing CD Folders Jul 17 14:39:13 minidsp-shd volumio[711]: info: Adding CD REST API Endpoints Jul 17 14:39:13 minidsp-shd volumio[711]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jul 17 14:39:13 minidsp-shd volumio[711]: info: Starting UDEV Watcher for CD Jul 17 14:39:13 minidsp-shd volumio[711]: info: Detecting CD presence with UDEV Jul 17 14:39:13 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jul 17 14:39:13 minidsp-shd volumio[711]: info: Done. Jul 17 14:39:14 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:16 minidsp-shd volumio[711]: info: Disabling MyMusic plugin cd_controller Jul 17 14:39:16 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Jul 17 14:39:16 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 14:39:16 minidsp-shd volumio[711]: Cannot find translation for source Presets Jul 17 14:39:16 minidsp-shd volumio[711]: Cannot find translation for source Spotify Jul 17 14:39:16 minidsp-shd volumio[711]: Cannot find translation for source 80s80s Radio Jul 17 14:39:16 minidsp-shd volumio[711]: info: Stopping UDEV Watcher for CD Jul 17 14:39:16 minidsp-shd volumio[711]: info: Disabling plugin cd_controller Jul 17 14:39:16 minidsp-shd volumio[711]: info: Done. Jul 17 14:39:18 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:22 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:24 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 14:39:24 minidsp-shd volumio[711]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 17 14:39:24 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 17 14:39:24 minidsp-shd volumio[711]: info: Received Get System Version Jul 17 14:39:24 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 14:39:24 minidsp-shd volumio[711]: info: Received Get System Info Jul 17 14:39:24 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 14:39:24 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 14:39:24 minidsp-shd volumio[711]: info: Discovery: Getting this device information Jul 17 14:39:24 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioGetState Jul 17 14:39:24 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 14:39:26 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 17 14:39:36 minidsp-shd systemd[1]: systemd-hostnamed.service: Succeeded. Jul 17 14:39:39 minidsp-shd volumio[711]: info: Airplay started streaming, receiving metadatas Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioStop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::stop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::stPlaybackTimer Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::updateTrackBlock Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrackBlock Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::serviceStop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::serviceStop Jul 17 14:39:39 minidsp-shd volumio[711]: info: [1721219979247] ControllerWebradio::stop Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 14:39:39 minidsp-shd volumio[711]: info: Airplay started streaming, receiving metadatas Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioStop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::stop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:39:39 minidsp-shd volumio[711]: info: sendMpdCommand stop took 22 milliseconds Jul 17 14:39:39 minidsp-shd volumio[711]: info: Jul 17 14:39:39 minidsp-shd volumio[711]: ---------------------------- MPD announces state update: player Jul 17 14:39:39 minidsp-shd volumio[711]: info: ControllerMpd::getState Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand status Jul 17 14:39:39 minidsp-shd volumio[711]: info: Jul 17 14:39:39 minidsp-shd volumio[711]: ---------------------------- MPD announces state update: player Jul 17 14:39:39 minidsp-shd volumio[711]: info: ControllerMpd::getState Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand status Jul 17 14:39:39 minidsp-shd volumio[711]: info: Jul 17 14:39:39 minidsp-shd volumio[711]: ---------------------------- MPD announces state update: player Jul 17 14:39:39 minidsp-shd volumio[711]: info: ControllerMpd::getState Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand status Jul 17 14:39:39 minidsp-shd volumio[711]: info: sendMpdCommand status took 7 milliseconds Jul 17 14:39:39 minidsp-shd volumio[711]: info: sendMpdCommand status took 4 milliseconds Jul 17 14:39:39 minidsp-shd volumio[711]: info: sendMpdCommand status took 3 milliseconds Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::parseState Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::parseState Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::parseState Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 14:39:39 minidsp-shd volumio[711]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 14:39:39 minidsp-shd volumio[711]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 14:39:39 minidsp-shd volumio[711]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::parseTrackInfo Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::parseTrackInfo Jul 17 14:39:39 minidsp-shd volumio[711]: verbose: ControllerMpd::parseTrackInfo Jul 17 14:39:39 minidsp-shd volumio[711]: info: ControllerMpd::pushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 14:39:39 minidsp-shd volumio[711]: info: ControllerMpd::pushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 14:39:39 minidsp-shd volumio[711]: info: ControllerMpd::pushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 14:39:39 minidsp-shd volumio[711]: info: ------------------------------ 39ms Jul 17 14:39:39 minidsp-shd volumio[711]: info: ------------------------------ 37ms Jul 17 14:39:39 minidsp-shd volumio[711]: info: ------------------------------ 36ms Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:39:39 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:39:39 minidsp-shd shairport-sync[12580]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 17 14:39:39 minidsp-shd shairport-sync[12580]: Dload Upload Total Spent Left Speed Jul 17 14:39:39 minidsp-shd volumio[711]: info: Jul 17 14:39:39 minidsp-shd volumio[711]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jul 17 14:39:39 minidsp-shd volumio[711]: info: Airplay playback start Jul 17 14:39:39 minidsp-shd volumio[711]: info: CorePlayQueue::getTrack 69 Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioStop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::stop Jul 17 14:39:39 minidsp-shd volumio[711]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 14:39:39 minidsp-shd shairport-sync[12580]: [158B blob data] Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreCommandRouter::servicePushState Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreStateMachine::pushState Jul 17 14:39:40 minidsp-shd volumio[711]: info: CoreCommandRouter::volumioPushState Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: SPOTIFY VOLUME 69 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: VOLUMIO VOLUME 68 Jul 17 14:39:40 minidsp-shd volumio[711]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 14:39:40 minidsp-shd volumio[711]: info: [1721219980792] [80s80s] Pushing the next song state Alison Moyet - All Cried Out and getting next track. Jul 17 14:39:40 minidsp-shd volumio[711]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 14:39:40 minidsp-shd volumio[711]: TypeError: Cannot set property 'name' of undefined Jul 17 14:39:40 minidsp-shd volumio[711]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Jul 17 14:39:40 minidsp-shd volumio[711]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Jul 17 14:39:40 minidsp-shd volumio[711]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Jul 17 14:39:40 minidsp-shd volumio[711]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Jul 17 14:39:40 minidsp-shd volumio[711]: at processImmediate (internal/timers.js:464:21) Jul 17 14:39:40 minidsp-shd volumio[711]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 14:39:41 minidsp-shd sudo[12702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-17 14:38 Jul 17 14:39:41 minidsp-shd sudo[12702]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:00:28 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="29ccfe8a9cff19911db4b736879ac117"