-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Mon 2025-12-29 21:11:44 CET. -- Dec 29 21:10:00 volumio mpd[1484]: Dec 29 21:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 29 21:10:00 volumio volumio[931]: info: Successfully retrieved User Session From TIDAL Dec 29 21:10:00 volumio volumio[931]: info: Successfully Added MyVolumio device Dec 29 21:10:00 volumio systemd[1]: Started Music Player Daemon. Dec 29 21:10:00 volumio sudo[1459]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:00 volumio volumio[931]: error: updateQueue error: null Dec 29 21:10:00 volumio volumio[931]: info: Successfully retrieved User Subscription From TIDAL Dec 29 21:10:00 volumio volumio[931]: info: Adding TIDAL to Browse Sources Dec 29 21:10:00 volumio volumio[931]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 29 21:10:00 volumio volumio[931]: info: [1767039000335] CoreMusicLibrary::Adding element TIDAL Dec 29 21:10:00 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 21:10:00 volumio volumio[931]: Cannot find translation for source TIDAL Dec 29 21:10:00 volumio volumio[931]: info: Adding TIDAL REST API Endpoints Dec 29 21:10:00 volumio volumio[931]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Dec 29 21:10:00 volumio volumio[931]: info: Updating MyVolumio device info Dec 29 21:10:00 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 21:10:00 volumio volumio[931]: info: Updating MyVolumio device info Dec 29 21:10:00 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 21:10:00 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 21:10:00 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 21:10:00 volumio volumio[1336]: .......................................................................................++++ Dec 29 21:10:00 volumio volumio[1336]: e is 65537 (0x010001) Dec 29 21:10:00 volumio volumio[1336]: writing RSA key Dec 29 21:10:01 volumio volumio[931]: info: Successfully Updated MyVolumio device Dec 29 21:10:01 volumio volumio[931]: info: Successfully Updated MyVolumio device Dec 29 21:10:01 volumio sudo[1530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 29 21:10:01 volumio sudo[1530]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:01 volumio systemd[1]: Started MyVolumio SSH Tunnel. Dec 29 21:10:01 volumio sudo[1530]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:01 volumio autossh[1533]: port set to 0, monitoring disabled Dec 29 21:10:01 volumio volumio[931]: info: Remote SSH Started Dec 29 21:10:01 volumio autossh[1533]: starting ssh (count 1) Dec 29 21:10:01 volumio autossh[1533]: ssh child pid is 1536 Dec 29 21:10:01 volumio volumio[931]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 29 21:10:01 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:01 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:01 volumio volumiossh-tunnel[1532]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts. Dec 29 21:10:02 volumio sudo[1538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Dec 29 21:10:02 volumio sudo[1538]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:02 volumio systemd[1]: Started Volumio Bluetooth Module. Dec 29 21:10:02 volumio sudo[1538]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:02 volumio volumio[931]: info: Volumio BT Module successfully started Dec 29 21:10:02 volumio sudo[1541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Dec 29 21:10:02 volumio sudo[1541]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:02 volumio volumiobt[1540]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Dec 29 21:10:02 volumio sudo[1541]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:02 volumio volumio[931]: info: TidalConnect service stoped! Dec 29 21:10:02 volumio volumio[931]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 29 21:10:02 volumio volumio[931]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 29 21:10:02 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 29 21:10:02 volumio sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:02 volumio systemd[1]: Started Volumio Tidal Connect Service. Dec 29 21:10:02 volumio sudo[1553]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:02 volumio volumio[931]: info: Executing endpoint tc_getconfig Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 29 21:10:02 volumio vtcs[1555]: STARTING TidalConnect services, version: 1.5.2.56 Dec 29 21:10:02 volumio vtcs[1555]: STARTED TidalConnect services. Dec 29 21:10:02 volumio volumio[931]: info: Executing endpoint tc_connect Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 29 21:10:02 volumio volumio[931]: info: Connecting to TidalConnect Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::servicePushState Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 29 21:10:02 volumio volumio[931]: verbose: CURRENT POSITION 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::syncState stateService stop Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: No code Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::servicePushState Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 29 21:10:02 volumio volumio[931]: verbose: CURRENT POSITION 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::syncState stateService stop Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: No code Dec 29 21:10:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:03 volumio sudo[1574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Dec 29 21:10:03 volumio sudo[1574]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:03 volumio volumiobt[1540]: pulseaudio: no process found Dec 29 21:10:03 volumio sudo[1574]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:03 volumio sudo[1578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 29 21:10:03 volumio sudo[1578]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:03 volumio dbus-daemon[638]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.24' (uid=1000 pid=1581 comm="/usr/bin/pulseaudio --high-priority=true ") Dec 29 21:10:03 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Dec 29 21:10:03 volumio systemd[1]: Stopping MPD Monitor Service... Dec 29 21:10:03 volumio systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 29 21:10:03 volumio systemd[1]: mpd_monitor.service: Succeeded. Dec 29 21:10:03 volumio systemd[1]: Stopped MPD Monitor Service. Dec 29 21:10:03 volumio volumio[931]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 29 21:10:03 volumio systemd[1]: Started MPD Monitor Service. Dec 29 21:10:03 volumio dbus-daemon[638]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Dec 29 21:10:03 volumio volumio[931]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 29 21:10:03 volumio volumio[931]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 29 21:10:03 volumio sudo[1578]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:03 volumio rtkit-daemon[1582]: Successfully called chroot. Dec 29 21:10:03 volumio rtkit-daemon[1582]: Successfully dropped privileges. Dec 29 21:10:03 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Dec 29 21:10:03 volumio rtkit-daemon[1582]: Successfully limited resources. Dec 29 21:10:03 volumio rtkit-daemon[1582]: Running. Dec 29 21:10:03 volumio rtkit-daemon[1582]: Watchdog thread running. Dec 29 21:10:03 volumio mpd_monitor.sh[1584]: MPD Monitor Service: Starting MPD Monitor Service Dec 29 21:10:03 volumio dbus-daemon[638]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.25' (uid=0 pid=1582 comm="/usr/lib/rtkit/rtkit-daemon ") Dec 29 21:10:03 volumio rtkit-daemon[1582]: Canary thread running. Dec 29 21:10:03 volumio systemd[1]: Starting Authorization Manager... Dec 29 21:10:03 volumio volumio[931]: info: Successfully started MPD Monitor Dec 29 21:10:03 volumio volumio[931]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 29 21:10:03 volumio polkitd[1589]: started daemon version 0.105 using authority implementation `local' version `0.105' Dec 29 21:10:03 volumio dbus-daemon[638]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Dec 29 21:10:03 volumio systemd[1]: Started Authorization Manager. Dec 29 21:10:03 volumio pulseaudio[1581]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Dec 29 21:10:03 volumio pulseaudio[1581]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Dec 29 21:10:03 volumio bluetoothd[781]: Endpoint registered: sender=:1.45 path=/MediaEndpoint/A2DPSource Dec 29 21:10:03 volumio bluetoothd[781]: Endpoint registered: sender=:1.45 path=/MediaEndpoint/A2DPSink Dec 29 21:10:03 volumio pulseaudio[1581]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Dec 29 21:10:03 volumio volumiobt[1540]: Applying permissions Dec 29 21:10:03 volumio volumiobt[1540]: Setting BT discoverable and pairable Dec 29 21:10:03 volumio kernel: Bluetooth: RFCOMM TTY layer initialized Dec 29 21:10:03 volumio kernel: Bluetooth: RFCOMM socket layer initialized Dec 29 21:10:03 volumio kernel: Bluetooth: RFCOMM ver 1.11 Dec 29 21:10:03 volumio volumiobt[1540]: [96B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [77B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [77B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [79B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [33B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [95B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [65B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [55B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [bluetoothctl]> -e power on Dec 29 21:10:03 volumio volumiobt[1540]: Invalid command in menu main: -e Dec 29 21:10:03 volumio volumiobt[1540]: Dec 29 21:10:03 volumio volumiobt[1540]: Use "help" for a list of available commands in a menu. Dec 29 21:10:03 volumio volumiobt[1540]: Use "menu " if you want to enter any submenu. Dec 29 21:10:03 volumio volumiobt[1540]: Use "back" if you want to return to menu main. Dec 29 21:10:03 volumio volumiobt[1540]: [78B blob data] Dec 29 21:10:03 volumio volumiobt[1540]: [bluetoothctl]> agent on Dec 29 21:10:03 volumio volumiobt[1540]: Agent is already registered Dec 29 21:10:03 volumio volumiobt[1540]: [bluetoothctl]> discoverable on Dec 29 21:10:03 volumio volumiobt[1540]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Dec 29 21:10:03 volumio volumiobt[1540]: [bluetoothctl]> pairable on Dec 29 21:10:03 volumio volumiobt[1540]: [bluetoothctl]> agent NoInputNoOutput Dec 29 21:10:03 volumio volumiobt[1540]: Agent is already registered Dec 29 21:10:03 volumio volumiobt[1540]: [bluetoothctl]> default-agent Dec 29 21:10:03 volumio volumiobt[1540]: [bluetoothctl]> quit Dec 29 21:10:03 volumio bluetoothd[781]: src/adapter.c:store_adapter_info() Unable set contents for /usr/var/lib/bluetooth/DC:A6:32:8B:82:48/settings: (Failed to create file “/usr/var/lib/bluetooth/DC:A6:32:8B:82:48/settings.X40LI3”: No such file or directory) Dec 29 21:10:03 volumio volumiobt[1540]: [65B blob data] Dec 29 21:10:04 volumio volumio[931]: info: MRS: Getting audio outputs on start Dec 29 21:10:04 volumio volumio[931]: info: MRS: Requesting all other devices output Dec 29 21:10:05 volumio volumio[931]: info: TidalConnect service started! Dec 29 21:10:05 volumio volumio[931]: [Metrics] CommandRouter: 30s 640.93ms Dec 29 21:10:05 volumio volumio[931]: info: CoreCommandRouter::volumiosetStartupVolume Dec 29 21:10:05 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 21:10:05 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 21:10:05 volumio volumio[931]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:10:05 volumio volumio[931]: info: CoreCommandRouter::Close All Modals sent Dec 29 21:10:06 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 29 21:10:06 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 29 21:10:06 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 29 21:10:07 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 29 21:10:07 volumio volumio[931]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 29 21:10:07 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:07 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:09 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 29 21:10:09 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 21:10:09 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 29 21:10:09 volumio volumio-remote-updater[644]: No test mode Dec 29 21:10:09 volumio volumio-remote-updater[644]: No alpha test mode Dec 29 21:10:09 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 29 21:10:09 volumio volumio[931]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 29 21:10:09 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 29 21:10:10 volumio systemd[1]: systemd-timedated.service: Succeeded. Dec 29 21:10:10 volumio volumio[931]: verbose: New Socket.io Connection to 192.168.178.60:3000 from 192.168.178.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:10 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:10 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:10 volumio volumio[931]: verbose: New Socket.io Connection to 192.168.178.60:3000 from 192.168.178.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:10 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:10 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:10 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:10 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 29 21:10:10 volumio sudo[1622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 29 21:10:10 volumio sudo[1622]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:10 volumio sudo[1622]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:10 volumio sudo[1628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 21:10:10 volumio sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:10 volumio sudo[1628]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:10 volumio sudo[1634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 21:10:10 volumio sudo[1634]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:10 volumio sudo[1634]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:10 volumio sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 29 21:10:10 volumio sudo[1642]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:10 volumio sudo[1642]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:10 volumio sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 21:10:10 volumio sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:10 volumio sudo[1648]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:10 volumio sudo[1651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 21:10:10 volumio sudo[1651]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:10 volumio sudo[1651]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:10 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:10 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 29 21:10:10 volumio volumio[931]: verbose: New Socket.io Connection to 192.168.178.60:3000 from 192.168.178.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:10 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:10 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:10 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:10 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:10 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:10 volumio volumio[931]: verbose: New Socket.io Connection to 192.168.178.60:3000 from 192.168.178.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 29 21:10:10 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 29 21:10:12 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 21:10:12 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 21:10:12 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 29 21:10:12 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 29 21:10:12 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 29 21:10:12 volumio volumio[931]: info: CoreCommandRouter::volumioGetBrowseSources Dec 29 21:10:12 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 29 21:10:12 volumio volumio[931]: info: BOOT COMPLETED Dec 29 21:10:18 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:18 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:18 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:18 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:18 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:18 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:18 volumio volumio[931]: verbose: New Socket.io Connection to 192.168.178.60:3000 from 192.168.178.112 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 29 21:10:18 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 29 21:10:18 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 29 21:10:20 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 29 21:10:20 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 29 21:10:22 volumio sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 21:10:22 volumio sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:22 volumio sudo[1668]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:22 volumio sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 21:10:22 volumio sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:22 volumio sudo[1671]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:22 volumio volumio[931]: verbose: New Socket.io Connection to 192.168.178.60 from 192.168.178.112 UA: Mozilla/5.0 (Linux; Android 16; Pixel 9 Build/BP4A.251205.006.E1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.146 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 29 21:10:22 volumio sudo[1674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 21:10:22 volumio sudo[1674]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:22 volumio sudo[1674]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:22 volumio sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 21:10:22 volumio sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 21:10:22 volumio sudo[1677]: pam_unix(sudo:session): session closed for user root Dec 29 21:10:22 volumio volumio[931]: verbose: New Socket.io Connection to 192.168.178.60 from 192.168.178.112 UA: Mozilla/5.0 (Linux; Android 16; Pixel 9 Build/BP4A.251205.006.E1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.146 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::volumioGetVisibleSources Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:22 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 29 21:10:22 volumio volumio[931]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 29 21:10:22 volumio volumio[931]: info: Received Get System Info Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:22 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:22 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:22 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:22 volumio volumio[931]: info: Listing playlists Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 29 21:10:22 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 29 21:10:24 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 29 21:10:24 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 29 21:10:24 volumio volumio[931]: info: Received Get System Info Dec 29 21:10:24 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:24 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:24 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:24 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:24 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:24 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:25 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 29 21:10:25 volumio volumio[931]: info: Received Get System Info Dec 29 21:10:25 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:25 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:25 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:25 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:25 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:25 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:25 volumio volumio[931]: info: CoreCommandRouter::volumioGetQueue Dec 29 21:10:25 volumio volumio[931]: info: CoreStateMachine::getQueue Dec 29 21:10:25 volumio volumio[931]: info: CorePlayQueue::getQueue Dec 29 21:10:26 volumio volumio[931]: info: Executing endpoint metavolumio Dec 29 21:10:26 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 29 21:10:26 volumio volumio[931]: info: Executing endpoint metavolumio Dec 29 21:10:26 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 29 21:10:29 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 29 21:10:29 volumio volumio[931]: info: CURURI: artists:// Dec 29 21:10:29 volumio volumio[931]: info: Preload queue cleared Dec 29 21:10:32 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 29 21:10:33 volumio ntpd[813]: Soliciting pool server 162.159.200.123 Dec 29 21:10:34 volumio ntpd[813]: Soliciting pool server 139.162.152.20 Dec 29 21:10:35 volumio ntpd[813]: Soliciting pool server 128.140.109.119 Dec 29 21:10:36 volumio ntpd[813]: Soliciting pool server 94.16.122.152 Dec 29 21:10:36 volumio ntpd[813]: Soliciting pool server 212.132.108.186 Dec 29 21:10:37 volumio ntpd[813]: Soliciting pool server 185.248.189.10 Dec 29 21:10:37 volumio ntpd[813]: Soliciting pool server 134.60.1.30 Dec 29 21:10:37 volumio ntpd[813]: Soliciting pool server 212.132.97.26 Dec 29 21:10:38 volumio ntpd[813]: Soliciting pool server 134.60.111.110 Dec 29 21:10:38 volumio ntpd[813]: Soliciting pool server 185.207.105.38 Dec 29 21:10:38 volumio ntpd[813]: Soliciting pool server 141.144.246.224 Dec 29 21:10:39 volumio ntpd[813]: Soliciting pool server 78.46.238.113 Dec 29 21:10:39 volumio ntpd[813]: Soliciting pool server 82.165.178.31 Dec 29 21:10:39 volumio ntpd[813]: Soliciting pool server 45.9.61.155 Dec 29 21:10:40 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 29 21:10:40 volumio volumio[931]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 29 21:10:40 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 29 21:10:40 volumio volumio[931]: info: Received Get System Version Dec 29 21:10:40 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 29 21:10:40 volumio volumio[931]: info: Received Get System Info Dec 29 21:10:40 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 29 21:10:40 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 29 21:10:40 volumio volumio[931]: info: Discovery: Getting this device information Dec 29 21:10:40 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:40 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:40 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 29 21:10:40 volumio ntpd[813]: Soliciting pool server 5.45.97.204 Dec 29 21:10:43 volumio ntpd[813]: receive: Unexpected origin timestamp 0xecfd5ec0.df77807a does not match aorg 0000000000.00000000 from server@128.140.109.119 xmt 0xecfd5ec3.c3c4b088 Dec 29 21:10:43 volumio ntpd[813]: receive: Unexpected origin timestamp 0xecfd5ec0.df71983f does not match aorg 0000000000.00000000 from server@78.46.238.113 xmt 0xecfd5ec3.c3cff4b0 Dec 29 21:10:43 volumio ntpd[813]: receive: Unexpected origin timestamp 0xecfd5ec0.df765799 does not match aorg 0000000000.00000000 from server@185.248.189.10 xmt 0xecfd5ec3.c3e9959d Dec 29 21:10:43 volumio ntpd[813]: receive: Unexpected origin timestamp 0xecfd5ec0.df755c10 does not match aorg 0000000000.00000000 from server@212.132.97.26 xmt 0xecfd5ec3.c440df80 Dec 29 21:10:44 volumio ntpd[813]: Soliciting pool server 2003:a:87f:c37c::1 Dec 29 21:10:45 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 29 21:10:45 volumio volumio[931]: info: CURURI: artists://Frijid%20Pink Dec 29 21:10:45 volumio volumio[931]: info: Preload queue cleared Dec 29 21:10:45 volumio volumio[931]: info: Preload queue cleared Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/02. Crying Shame.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/03. I'm On My Way.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/04. Drivin' Blues.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/05. Tell Me Why.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/06. End of the Line.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/07. House of the Rising Sun.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/08. I Want To Be Your Lover.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/09. Boozin' Blues.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/10. Heartbreak Hotel.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/11. Music for the People.flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/12. House of the Rising Sun (single edit).flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/13. Sing a Song For Freedom (mono single mix).flac Dec 29 21:10:45 volumio volumio[931]: info: Preloading song: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/14. End of the Line (mono single mix).flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F01.%20God%20Gave%20Me%20You.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/02. Crying Shame.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F02.%20Crying%20Shame.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/02. Crying Shame.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/03. I'm On My Way.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F03.%20I'm%20On%20My%20Way.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/03. I'm On My Way.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/04. Drivin' Blues.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F04.%20Drivin'%20Blues.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/04. Drivin' Blues.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/05. Tell Me Why.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F05.%20Tell%20Me%20Why.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/05. Tell Me Why.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/06. End of the Line.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F06.%20End%20of%20the%20Line.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/06. End of the Line.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/07. House of the Rising Sun.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F07.%20House%20of%20the%20Rising%20Sun.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/07. House of the Rising Sun.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/08. I Want To Be Your Lover.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F08.%20I%20Want%20To%20Be%20Your%20Lover.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/08. I Want To Be Your Lover.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/09. Boozin' Blues.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F09.%20Boozin'%20Blues.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/09. Boozin' Blues.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/10. Heartbreak Hotel.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F10.%20Heartbreak%20Hotel.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/10. Heartbreak Hotel.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/11. Music for the People.flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F11.%20Music%20for%20the%20People.flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/11. Music for the People.flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/12. House of the Rising Sun (single edit).flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F12.%20House%20of%20the%20Rising%20Sun%20(single%20edit).flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/12. House of the Rising Sun (single edit).flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/13. Sing a Song For Freedom (mono single mix).flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F13.%20Sing%20a%20Song%20For%20Freedom%20(mono%20single%20mix).flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/13. Sing a Song For Freedom (mono single mix).flac Dec 29 21:10:45 volumio volumio[931]: info: Exploding uri music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/14. End of the Line (mono single mix).flac in service mpd Dec 29 21:10:45 volumio volumio[931]: info: ALBUMART /albumart?cacheid=26&web=Frijid%20Pink/Frijid%20Pink/extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FFrijid%20Pink%2F%5B1970%5D%20Frijid%20Pink%2F14.%20End%20of%20the%20Line%20(mono%20single%20mix).flac&metadata=false Dec 29 21:10:45 volumio volumio[931]: info: URI /mnt/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/14. End of the Line (mono single mix).flac Dec 29 21:10:57 volumio volumio[931]: info: Preload queue cleared Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::ClearQueue Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::stop Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::clearPlayQueue Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::saveQueue Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioPushQueue Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::addQueueItems Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::addQueueItems Dec 29 21:10:57 volumio volumio[931]: info: Preload queue cleared Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioPushQueue Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::saveQueue Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::updateTrackBlock Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrackBlock Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioPlay Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::play index 0 Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::addQueueItems Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::addQueueItems Dec 29 21:10:57 volumio volumio[931]: info: Preload queue cleared Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/02. Crying Shame.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/02. Crying Shame.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/03. I'm On My Way.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/03. I'm On My Way.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/04. Drivin' Blues.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/04. Drivin' Blues.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/05. Tell Me Why.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/05. Tell Me Why.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/06. End of the Line.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/06. End of the Line.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/07. House of the Rising Sun.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/07. House of the Rising Sun.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/08. I Want To Be Your Lover.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/08. I Want To Be Your Lover.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/09. Boozin' Blues.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/09. Boozin' Blues.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/10. Heartbreak Hotel.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/10. Heartbreak Hotel.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/11. Music for the People.flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/11. Music for the People.flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/12. House of the Rising Sun (single edit).flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/12. House of the Rising Sun (single edit).flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/13. Sing a Song For Freedom (mono single mix).flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/13. Sing a Song For Freedom (mono single mix).flac Dec 29 21:10:57 volumio volumio[931]: info: Adding Item to queue: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/14. End of the Line (mono single mix).flac Dec 29 21:10:57 volumio volumio[931]: info: Using cached record of: music-library/USB/MUSIC/Frijid Pink/[1970] Frijid Pink/14. End of the Line (mono single mix).flac Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::stop Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioPushQueue Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::saveQueue Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::play index undefined Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::updateTrackBlock Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrackBlock Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::startPlaybackTimer Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand stop took 5 milliseconds Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 21:10:57 volumio volumio[931]: info: Dec 29 21:10:57 volumio volumio[931]: ---------------------------- MPD announces system playlist update Dec 29 21:10:57 volumio volumio[931]: info: Ignoring MPD Status Update Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand clear took 2 milliseconds Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac" Dec 29 21:10:57 volumio volumio[931]: error: updateQueue error: null Dec 29 21:10:57 volumio volumio[931]: info: Dec 29 21:10:57 volumio volumio[931]: ---------------------------- MPD announces system playlist update Dec 29 21:10:57 volumio volumio[931]: info: Ignoring MPD Status Update Dec 29 21:10:57 volumio volumio[931]: info: ------------------------------ 3ms Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand add "USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac" took 2 milliseconds Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand play Dec 29 21:10:57 volumio volumio[931]: info: ------------------------------ 2ms Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand play took 2 milliseconds Dec 29 21:10:57 volumio volumio[931]: info: Dec 29 21:10:57 volumio volumio[931]: ---------------------------- MPD announces state update: player Dec 29 21:10:57 volumio volumio[931]: info: ControllerMpd::getState Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:10:57 volumio volumio[931]: info: Dec 29 21:10:57 volumio volumio[931]: ---------------------------- MPD announces state update: player Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand status took 5 milliseconds Dec 29 21:10:57 volumio volumio[931]: info: ControllerMpd::getState Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand status Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::parseState Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand status took 3 milliseconds Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::parseState Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo Dec 29 21:10:57 volumio volumio[931]: info: ControllerMpd::pushState Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::servicePushState Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"God Gave Me You","artist":"Frijid Pink","album":"Frijid Pink","uri":"USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac","trackType":"flac"} Dec 29 21:10:57 volumio volumio[931]: verbose: CURRENT POSITION 0 Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::syncState stateService play Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus stop Dec 29 21:10:57 volumio volumio[931]: info: ------------------------------ 13ms Dec 29 21:10:57 volumio volumio[931]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 29 21:10:57 volumio volumio[931]: verbose: ControllerMpd::parseTrackInfo Dec 29 21:10:57 volumio volumio[931]: info: ControllerMpd::pushState Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::servicePushState Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"God Gave Me You","artist":"Frijid Pink","album":"Frijid Pink","uri":"USB/MUSIC/Frijid Pink/[1970] Frijid Pink/01. God Gave Me You.flac","trackType":"flac"} Dec 29 21:10:57 volumio volumio[931]: verbose: CURRENT POSITION 0 Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::syncState stateService play Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::syncState currentStatus play Dec 29 21:10:57 volumio volumio[931]: info: Received an update from plugin. extracting info from payload Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:57 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:57 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:10:57 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:10:57 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:10:57 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:10:57 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:10:57 volumio volumio[931]: info: ------------------------------ 34ms Dec 29 21:11:02 volumio volumio[931]: info: VolumeController::SetAlsaVolume47 Dec 29 21:11:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:02 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:02 volumio volumio[931]: info: VolumeController::SetAlsaVolume48 Dec 29 21:11:02 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:02 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:02 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:02 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:02 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:02 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:03 volumio volumio[931]: info: VolumeController::SetAlsaVolume49 Dec 29 21:11:03 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:03 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:03 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:03 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:03 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:03 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:03 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:03 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:03 volumio volumio[931]: info: VolumeController::SetAlsaVolume50 Dec 29 21:11:03 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:03 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:03 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:03 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:03 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:03 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:03 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:03 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:04 volumio volumio[931]: info: VolumeController::SetAlsaVolume51 Dec 29 21:11:04 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:04 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:04 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:04 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:04 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:04 volumio volumio[931]: info: VolumeController::SetAlsaVolume52 Dec 29 21:11:04 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:04 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:04 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:04 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:04 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:04 volumio volumio[931]: info: VolumeController::SetAlsaVolume53 Dec 29 21:11:04 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:04 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:04 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:04 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:04 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:04 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:05 volumio volumio[931]: info: VolumeController::SetAlsaVolume54 Dec 29 21:11:06 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:06 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:06 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:06 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:06 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:06 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:06 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:06 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:06 volumio volumio[931]: info: VolumeController::SetAlsaVolume55 Dec 29 21:11:06 volumio volumio[931]: info: CoreStateMachine::pushState Dec 29 21:11:06 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:06 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 21:11:06 volumio volumio[931]: info: CoreCommandRouter::volumioPushState Dec 29 21:11:06 volumio volumio[931]: info: MRS: Pushing multiroomSync output update for this device Dec 29 21:11:06 volumio volumio[931]: info: MRS: Pushing multiroomSync output Dec 29 21:11:06 volumio volumio[931]: info: CoreCommandRouter::volumioGetState Dec 29 21:11:06 volumio volumio[931]: info: CorePlayQueue::getTrack 0 Dec 29 21:11:27 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 29 21:11:27 volumio volumio[931]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 29 21:11:44 volumio volumio[931]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 21:11:44 volumio volumio[931]: TypeError: Cannot read property 'slice' of null Dec 29 21:11:44 volumio volumio[931]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 29 21:11:44 volumio volumio[931]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 29 21:11:44 volumio volumio[931]: at Object.onceWrapper (events.js:422:26) Dec 29 21:11:44 volumio volumio[931]: at ClientRequest.emit (events.js:315:20) Dec 29 21:11:44 volumio volumio[931]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 29 21:11:44 volumio volumio[931]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 29 21:11:44 volumio volumio[931]: at TLSSocket.socketOnData (_http_client.js:509:22) Dec 29 21:11:44 volumio volumio[931]: at TLSSocket.emit (events.js:315:20) Dec 29 21:11:44 volumio volumio[931]: at addChunk (internal/streams/readable.js:309:12) Dec 29 21:11:44 volumio volumio[931]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 29 21:11:44 volumio volumio[931]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Dec 29 21:11:44 volumio volumio[931]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Dec 29 21:11:44 volumio volumio[931]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 21:11:44 volumio sudo[1900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-29 21:10 Dec 29 21:11:44 volumio sudo[1900]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"