-- Logs begin at Thu 2019-02-14 18:12:02 CST, end at Thu 2024-11-28 16:22:34 CST. --
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Nov 28 16:21:00 smsl-d400n volumio[922]: xcb_connection_has_error() returned true
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Nov 28 16:21:00 smsl-d400n sudo[2390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Nov 28 16:21:00 smsl-d400n sudo[2390]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n sudo[2390]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n sudo[2394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Nov 28 16:21:00 smsl-d400n sudo[2394]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n volumio[922]: xcb_connection_has_error() returned true
Nov 28 16:21:00 smsl-d400n systemd[1]: Stopping RAAT DAEMON...
Nov 28 16:21:00 smsl-d400n systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Nov 28 16:21:00 smsl-d400n systemd[1]: raat-daemon.service: Succeeded.
Nov 28 16:21:00 smsl-d400n systemd[1]: Stopped RAAT DAEMON.
Nov 28 16:21:00 smsl-d400n volumio[922]: info: Asound.conf file unchanged, so no further update is needed
Nov 28 16:21:00 smsl-d400n volumio[922]: info: Output device has changed, restarting MPD
Nov 28 16:21:00 smsl-d400n sudo[2397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Nov 28 16:21:00 smsl-d400n sudo[2397]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n systemd[1]: Started RAAT DAEMON.
Nov 28 16:21:00 smsl-d400n sudo[2394]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n sudo[2403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 28 16:21:00 smsl-d400n sudo[2403]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n sudo[2397]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n sudo[2403]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n volumio[922]: info: Output device has changed, restarting Shairport Sync
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 28 16:21:00 smsl-d400n sudo[2410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 28 16:21:00 smsl-d400n sudo[2410]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n systemd[1]: Stopping Music Player Daemon...
Nov 28 16:21:00 smsl-d400n sudo[2415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Nov 28 16:21:00 smsl-d400n sudo[2415]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n systemd[1]: Stopping RAAT DAEMON...
Nov 28 16:21:00 smsl-d400n systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Nov 28 16:21:00 smsl-d400n systemd[1]: raat-daemon.service: Succeeded.
Nov 28 16:21:00 smsl-d400n systemd[1]: Stopped RAAT DAEMON.
Nov 28 16:21:00 smsl-d400n volumio[922]: xcb_connection_has_error() returned true
Nov 28 16:21:00 smsl-d400n volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 28 16:21:00 smsl-d400n volumio[922]: xcb_connection_has_error() returned true
Nov 28 16:21:00 smsl-d400n volumio[922]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n systemd[1]: Started RAAT DAEMON.
Nov 28 16:21:00 smsl-d400n systemd[1]: mpd.service: Succeeded.
Nov 28 16:21:00 smsl-d400n systemd[1]: Stopped Music Player Daemon.
Nov 28 16:21:00 smsl-d400n sudo[2415]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n volumio[922]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:00 smsl-d400n systemd[1]: Starting Music Player Daemon...
Nov 28 16:21:00 smsl-d400n sudo[2443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Nov 28 16:21:00 smsl-d400n sudo[2443]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n volumio[922]: info: Got it
Nov 28 16:21:00 smsl-d400n volumio[922]: info: Got Tidal Cloud Configuration
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:00 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:00 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 28 16:21:00 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:00 smsl-d400n sudo[2443]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n sudo[2453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Nov 28 16:21:00 smsl-d400n sudo[2453]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:00 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 28 16:21:00 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 28 16:21:00 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:00 smsl-d400n sudo[2433]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Nov 28 16:21:00 smsl-d400n sudo[2433]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:00 smsl-d400n sudo[2433]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Nov 28 16:21:00 smsl-d400n sudo[2453]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:00 smsl-d400n volumio[922]: xcb_connection_has_error() returned true
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage
Nov 28 16:21:00 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Nov 28 16:21:00 smsl-d400n volumio[922]: xcb_connection_has_error() returned true
Nov 28 16:21:00 smsl-d400n volumio[922]: info: MPD Permissions set
Nov 28 16:21:00 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Raat Daemon started successfully
Nov 28 16:21:01 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Raat Daemon started successfully
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:01 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:01 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Executing endpoint restartRAATSocket
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Executing endpoint restartRAATSocket
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Retrieving Cloud Streaming UI
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:01 smsl-d400n volumio[922]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Nov 28 16:21:01 smsl-d400n volumio[922]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Nov 28 16:21:01 smsl-d400n sudo[2486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Nov 28 16:21:01 smsl-d400n sudo[2486]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Starting Shairport Sync
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Getting Tidal Cloud Configuration
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Getting Qobuz Cloud Configuration
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Asking plugin for UI Config
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:01 smsl-d400n sudo[2489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 28 16:21:01 smsl-d400n sudo[2489]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:01 smsl-d400n systemd[1]: Started Volumio Tidal Connect Service.
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Getting Spotify Cloud Configuration
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Asking plugin for UI Config
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Saving Spotify Acccount
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Got it
Nov 28 16:21:01 smsl-d400n volumio[922]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Nov 28 16:21:01 smsl-d400n sudo[2486]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:01 smsl-d400n systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 28 16:21:01 smsl-d400n systemd[1]: shairport-sync.service: Succeeded.
Nov 28 16:21:01 smsl-d400n systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 28 16:21:01 smsl-d400n systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 28 16:21:01 smsl-d400n sudo[2489]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:01 smsl-d400n volumio[922]: xcb_connection_has_error() returned true
Nov 28 16:21:01 smsl-d400n sudo[2499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Nov 28 16:21:01 smsl-d400n sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:01 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:01 smsl-d400n sudo[2499]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:01 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Shairport-Sync Started
Nov 28 16:21:01 smsl-d400n sudo[2502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Nov 28 16:21:01 smsl-d400n sudo[2502]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Got Tidal Cloud Configuration
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Got it
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:01 smsl-d400n systemd[1]: Stopping RAAT DAEMON...
Nov 28 16:21:01 smsl-d400n systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Nov 28 16:21:01 smsl-d400n systemd[1]: raat-daemon.service: Succeeded.
Nov 28 16:21:01 smsl-d400n systemd[1]: Stopped RAAT DAEMON.
Nov 28 16:21:01 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:01 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 28 16:21:01 smsl-d400n systemd[1]: Started RAAT DAEMON.
Nov 28 16:21:01 smsl-d400n sudo[2502]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Raat Daemon started successfully
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Executing endpoint tc_getconfig
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Nov 28 16:21:01 smsl-d400n vtcs[2490]: STARTING TidalConnect services, version: 1.4.0.34
Nov 28 16:21:01 smsl-d400n volumio[922]: info: Executing endpoint restartRAATSocket
Nov 28 16:21:01 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Nov 28 16:21:02 smsl-d400n vtcs[2490]: STARTED TidalConnect services.
Nov 28 16:21:02 smsl-d400n volumio[922]: info: Executing endpoint tc_connect
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Nov 28 16:21:02 smsl-d400n volumio[922]: info: Connecting to TidalConnect
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: 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}
Nov 28 16:21:02 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService stop
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus stop
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:02 smsl-d400n volumio[922]: info: No code
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: 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}
Nov 28 16:21:02 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService stop
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus stop
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:02 smsl-d400n volumio[922]: info: No code
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:02 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:02 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:02 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:02 smsl-d400n volumio[922]: info: Discovery: Started advertising with name: SMSL D400N
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object]
Nov 28 16:21:02 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings
Nov 28 16:21:02 smsl-d400n volumio[922]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined
Nov 28 16:21:02 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:02 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:02 smsl-d400n volumio[922]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:02 smsl-d400n volumio[922]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:02 smsl-d400n volumio[922]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:02 smsl-d400n volumio[922]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:02 smsl-d400n sudo[2549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Nov 28 16:21:02 smsl-d400n sudo[2549]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:02 smsl-d400n sudo[2552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Nov 28 16:21:02 smsl-d400n sudo[2552]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:02 smsl-d400n sudo[2549]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:02 smsl-d400n sudo[2552]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:03 smsl-d400n volumio[922]: info: RAAT: Requesting Headphone Status
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Nov 28 16:21:03 smsl-d400n mpd[2458]: Nov 28 16:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Nov 28 16:21:03 smsl-d400n systemd[1]: Started Music Player Daemon.
Nov 28 16:21:03 smsl-d400n sudo[2410]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:03 smsl-d400n volumio[922]: error: updateQueue error: null
Nov 28 16:21:03 smsl-d400n volumio[922]: info: RAAT: Requesting Headphone Status
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreStateMachine::getcurrentVolume
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioRetrievevolume
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:03 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:03 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:03 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:03 smsl-d400n volumio[922]: info: Discovery: adding 52a3211c-232e-4bb6-848a-8f68165efd64
Nov 28 16:21:03 smsl-d400n volumio[922]: info: Discovery: Found device SMSL D400N
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:03 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:03 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:03 smsl-d400n volumio[922]: info: TidalConnect service stoped!
Nov 28 16:21:03 smsl-d400n volumio[922]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:03 smsl-d400n volumio[922]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Nov 28 16:21:03 smsl-d400n sudo[2568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Nov 28 16:21:03 smsl-d400n sudo[2568]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:04 smsl-d400n sudo[2568]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Retrieving Cloud Streaming UI
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Getting Tidal Cloud Configuration
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Getting Qobuz Cloud Configuration
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Asking plugin for UI Config
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Getting Spotify Cloud Configuration
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Asking plugin for UI Config
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Saving Spotify Acccount
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Got it
Nov 28 16:21:04 smsl-d400n volumio[922]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Got Tidal Cloud Configuration
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Got it
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::Reload Ui
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard
Nov 28 16:21:04 smsl-d400n volumio[922]: info: Wizard terminated Successfully
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::volumiosetStartupVolume
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 28 16:21:04 smsl-d400n volumio[922]: info: TidalConnect service started!
Nov 28 16:21:04 smsl-d400n volumio[922]: info: RAAT: Requesting Headphone Status
Nov 28 16:21:04 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Nov 28 16:21:05 smsl-d400n sudo[2575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 28 16:21:05 smsl-d400n sudo[2575]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:05 smsl-d400n sudo[2575]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:05 smsl-d400n sudo[2578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 28 16:21:05 smsl-d400n sudo[2578]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:05 smsl-d400n sudo[2578]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:05 smsl-d400n volumio[922]: info: TidalConnect service started!
Nov 28 16:21:05 smsl-d400n volumio[922]: verbose: New Socket.io Connection to 192.168.2.10 from 192.168.2.179 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 10
Nov 28 16:21:05 smsl-d400n volumio[922]: info: TidalConnect service started!
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Received Get System Info
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Discovery: Getting this device information
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Listing playlists
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Nov 28 16:21:06 smsl-d400n sudo[2583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 28 16:21:06 smsl-d400n sudo[2583]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:06 smsl-d400n sudo[2583]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:06 smsl-d400n sudo[2586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 28 16:21:06 smsl-d400n sudo[2586]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:06 smsl-d400n sudo[2586]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:06 smsl-d400n volumio[922]: verbose: New Socket.io Connection to 192.168.2.10 from 192.168.2.179 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 10
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Received Get System Info
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Discovery: Getting this device information
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:06 smsl-d400n volumio[922]: info: Listing playlists
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Nov 28 16:21:06 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Nov 28 16:21:07 smsl-d400n volumio[922]: info: TidalConnect service started!
Nov 28 16:21:07 smsl-d400n sudo[2591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf
Nov 28 16:21:07 smsl-d400n sudo[2591]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:07 smsl-d400n sudo[2591]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:07 smsl-d400n volumio[922]: info: smb.conf Permissions set
Nov 28 16:21:07 smsl-d400n sudo[2594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL
Nov 28 16:21:07 smsl-d400n sudo[2594]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:07 smsl-d400n sudo[2594]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:07 smsl-d400n volumio[922]: info: Internal perms successfully set
Nov 28 16:21:07 smsl-d400n sudo[2597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service
Nov 28 16:21:07 smsl-d400n sudo[2597]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:07 smsl-d400n nmbd[872]: [2024/11/28 16:21:07.626474, 0] ../source3/nmbd/nmbd.c:58(terminate)
Nov 28 16:21:07 smsl-d400n nmbd[872]: Got SIGTERM: going down...
Nov 28 16:21:07 smsl-d400n systemd[1]: Stopping Samba NMB Daemon...
Nov 28 16:21:07 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:07 smsl-d400n systemd[1]: nmbd.service: Succeeded.
Nov 28 16:21:07 smsl-d400n systemd[1]: Stopped Samba NMB Daemon.
Nov 28 16:21:07 smsl-d400n sudo[2600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 28 16:21:07 smsl-d400n sudo[2600]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:07 smsl-d400n systemd[1]: Starting Samba NMB Daemon...
Nov 28 16:21:07 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Nov 28 16:21:07 smsl-d400n sudo[2600]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:07 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Nov 28 16:21:07 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 28 16:21:07 smsl-d400n sudo[2604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 28 16:21:07 smsl-d400n sudo[2604]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:07 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:07 smsl-d400n sudo[2604]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:07 smsl-d400n sudo[2610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Nov 28 16:21:07 smsl-d400n sudo[2610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:07 smsl-d400n sudo[2610]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:07 smsl-d400n volumio[922]: info: Upmpdcli Daemon Started
Nov 28 16:21:07 smsl-d400n nmbd[2605]: [2024/11/28 16:21:07.986960, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Nov 28 16:21:07 smsl-d400n nmbd[2605]: started asyncdns process 2612
Nov 28 16:21:07 smsl-d400n nmbd[2605]: [2024/11/28 16:21:07.993291, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 28 16:21:07 smsl-d400n nmbd[2605]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Nov 28 16:21:07 smsl-d400n systemd[1]: Started Samba NMB Daemon.
Nov 28 16:21:07 smsl-d400n sudo[2597]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:08 smsl-d400n nmbd[2605]: [2024/11/28 16:21:08.007760, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 28 16:21:08 smsl-d400n nmbd[2605]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.10 for name WORKGROUP<1d>.
Nov 28 16:21:08 smsl-d400n nmbd[2605]: This response was from IP 192.168.2.95, reporting an IP address of 192.168.2.95.
Nov 28 16:21:08 smsl-d400n sudo[2614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service
Nov 28 16:21:08 smsl-d400n sudo[2614]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:08 smsl-d400n systemd[1]: Stopping Samba SMB Daemon...
Nov 28 16:21:08 smsl-d400n systemd[1]: smbd.service: Main process exited, code=killed, status=15/TERM
Nov 28 16:21:08 smsl-d400n systemd[1]: smbd.service: Succeeded.
Nov 28 16:21:08 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:08 smsl-d400n systemd[1]: Stopped Samba SMB Daemon.
Nov 28 16:21:08 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Nov 28 16:21:08 smsl-d400n systemd[1]: Starting Samba SMB Daemon...
Nov 28 16:21:08 smsl-d400n volumio[922]: ------------------------------------ BT MESSAGE: BT STATUS: running
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Nov 28 16:21:08 smsl-d400n volumio[922]: info: Received Get System Info
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 28 16:21:08 smsl-d400n volumio[922]: info: Discovery: Getting this device information
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetState
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 28 16:21:08 smsl-d400n volumio-remote-updater[731]: No test mode
Nov 28 16:21:08 smsl-d400n volumio-remote-updater[731]: No alpha test mode
Nov 28 16:21:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Nov 28 16:21:08 smsl-d400n winbindd[1405]: [2024/11/28 16:21:08.932950, 0] ../source3/winbindd/winbindd_samr.c:672(sam_sid_to_name)
Nov 28 16:21:08 smsl-d400n winbindd[1405]: sam_sid_to_name: possible deadlock - trying to lookup SID S-1-5-21-1855304790-311451866-3447901999-501
Nov 28 16:21:08 smsl-d400n winbindd[1405]: [2024/11/28 16:21:08.933949, 0] ../source3/winbindd/winbindd_samr.c:672(sam_sid_to_name)
Nov 28 16:21:08 smsl-d400n winbindd[1405]: sam_sid_to_name: possible deadlock - trying to lookup SID S-1-5-21-1855304790-311451866-3447901999-514
Nov 28 16:21:08 smsl-d400n smbd[2626]: [2024/11/28 16:21:08.956192, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 28 16:21:08 smsl-d400n smbd[2626]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Nov 28 16:21:08 smsl-d400n systemd[1]: Started Samba SMB Daemon.
Nov 28 16:21:08 smsl-d400n sudo[2614]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:08 smsl-d400n volumio[922]: info: SAMBA Restarted
Nov 28 16:21:09 smsl-d400n volumio[922]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 28 16:21:09 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 28 16:21:09 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse
Nov 28 16:21:09 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetQueue
Nov 28 16:21:09 smsl-d400n volumio[922]: info: CoreStateMachine::getQueue
Nov 28 16:21:09 smsl-d400n volumio[922]: info: CorePlayQueue::getQueue
Nov 28 16:21:12 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Nov 28 16:21:12 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 28 16:21:12 smsl-d400n volumio-remote-updater[731]: No test mode
Nov 28 16:21:12 smsl-d400n volumio-remote-updater[731]: No alpha test mode
Nov 28 16:21:12 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Nov 28 16:21:12 smsl-d400n volumio[922]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 28 16:21:12 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 28 16:21:14 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Nov 28 16:21:14 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 28 16:21:14 smsl-d400n systemd[1]: systemd-timedated.service: Succeeded.
Nov 28 16:21:14 smsl-d400n volumio-remote-updater[731]: No test mode
Nov 28 16:21:14 smsl-d400n volumio-remote-updater[731]: No alpha test mode
Nov 28 16:21:14 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Nov 28 16:21:14 smsl-d400n volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin
Nov 28 16:21:14 smsl-d400n volumio[922]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory
Nov 28 16:21:14 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Nov 28 16:21:14 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Nov 28 16:21:15 smsl-d400n sudo[2657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Nov 28 16:21:15 smsl-d400n sudo[2657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n sudo[2657]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n sudo[2663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Nov 28 16:21:15 smsl-d400n sudo[2663]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n sudo[2673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Nov 28 16:21:15 smsl-d400n sudo[2673]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n sudo[2663]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n sudo[2683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Nov 28 16:21:15 smsl-d400n sudo[2683]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n sudo[2673]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n sudo[2693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 28 16:21:15 smsl-d400n sudo[2693]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Nov 28 16:21:15 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Nov 28 16:21:15 smsl-d400n sudo[2693]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n sudo[2683]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n sudo[2700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 28 16:21:15 smsl-d400n sudo[2700]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n volumio[922]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 28 16:21:15 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 28 16:21:15 smsl-d400n sudo[2700]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n sudo[2705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Nov 28 16:21:15 smsl-d400n sudo[2705]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n sudo[2705]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n volumio[922]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Nov 28 16:21:15 smsl-d400n volumio[922]: wlan0 Interface doesn't support scanning.
Nov 28 16:21:15 smsl-d400n volumio[922]: info: Cannot use regular scanning, forcing with ap-force
Nov 28 16:21:15 smsl-d400n sudo[2715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Nov 28 16:21:15 smsl-d400n sudo[2715]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 28 16:21:15 smsl-d400n sudo[2715]: pam_unix(sudo:session): session closed for user root
Nov 28 16:21:15 smsl-d400n volumio[922]: command failed: No such device (-19)
Nov 28 16:21:15 smsl-d400n volumio[922]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Nov 28 16:21:15 smsl-d400n volumio[922]: command failed: No such device (-19)
Nov 28 16:21:16 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Nov 28 16:21:23 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPlay
Nov 28 16:21:23 smsl-d400n volumio[922]: info: CoreStateMachine::play index undefined
Nov 28 16:21:23 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:23 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:34 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Nov 28 16:21:34 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 28 16:21:35 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:21:39 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Nov 28 16:21:42 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:21:43 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioReplaceandPlayItems
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::ClearQueue
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CorePlayQueue::clearPlayQueue
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::addQueueItems
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CorePlayQueue::addQueueItems
Nov 28 16:21:43 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:21:43 smsl-d400n volumio[922]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPlay
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::play index 0
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::play index undefined
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreStateMachine::startPlaybackTimer
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 28 16:21:43 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Nov 28 16:21:43 smsl-d400n volumio[922]: info: [1732782103482] ControllerWebradio::clearAddPlayTrack
Nov 28 16:21:43 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand stop
Nov 28 16:21:43 smsl-d400n volumio[922]: info: sendMpdCommand stop took 8 milliseconds
Nov 28 16:21:43 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand clear
Nov 28 16:21:43 smsl-d400n volumio[922]: info:
Nov 28 16:21:43 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:43 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:43 smsl-d400n volumio[922]: info: sendMpdCommand clear took 5 milliseconds
Nov 28 16:21:43 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996"
Nov 28 16:21:43 smsl-d400n volumio[922]: error: updateQueue error: null
Nov 28 16:21:43 smsl-d400n volumio[922]: info: ------------------------------ 9ms
Nov 28 16:21:44 smsl-d400n volumio[922]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 880 milliseconds
Nov 28 16:21:44 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService mpd
Nov 28 16:21:44 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand play
Nov 28 16:21:44 smsl-d400n volumio[922]: info:
Nov 28 16:21:44 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:44 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:44 smsl-d400n volumio[922]: info: sendMpdCommand play took 7 milliseconds
Nov 28 16:21:44 smsl-d400n volumio[922]: info: ------------------------------ 6ms
Nov 28 16:21:46 smsl-d400n volumio[922]: info:
Nov 28 16:21:46 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:46 smsl-d400n volumio[922]: info:
Nov 28 16:21:46 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:46 smsl-d400n volumio[922]: info: sendMpdCommand status took 8 milliseconds
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:46 smsl-d400n volumio[922]: info: sendMpdCommand status took 5 milliseconds
Nov 28 16:21:46 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 3 milliseconds
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5740/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus stop
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ------------------------------ 30ms
Nov 28 16:21:46 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 10 milliseconds
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"(#1 - 5740/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:21:46 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ------------------------------ 71ms
Nov 28 16:21:46 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:46 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:46 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:21:46 smsl-d400n volumio[922]: info:
Nov 28 16:21:46 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:46 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:46 smsl-d400n volumio[922]: info:
Nov 28 16:21:46 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ------------------------------ 10ms
Nov 28 16:21:46 smsl-d400n volumio[922]: info: sendMpdCommand status took 3 milliseconds
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:46 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 2 milliseconds
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1103,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bryan Adams - Run to you","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Nov 28 16:21:46 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:21:46 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:46 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:46 smsl-d400n volumio[922]: info: ------------------------------ 62ms
Nov 28 16:21:46 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:46 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:46 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:21:47 smsl-d400n volumio[922]: info:
Nov 28 16:21:47 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:47 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:47 smsl-d400n volumio[922]: info:
Nov 28 16:21:47 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:47 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:47 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:47 smsl-d400n volumio[922]: info: ------------------------------ 6ms
Nov 28 16:21:47 smsl-d400n volumio[922]: info: sendMpdCommand status took 3 milliseconds
Nov 28 16:21:47 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:47 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:47 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 1 milliseconds
Nov 28 16:21:47 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:47 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:47 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bryan Adams - Run to you","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Nov 28 16:21:47 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:21:47 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:47 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:47 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:47 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:47 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:47 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:47 smsl-d400n volumio[922]: info: ------------------------------ 52ms
Nov 28 16:21:47 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:47 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:47 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:21:56 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioReplaceandPlayItems
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::ClearQueue
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::stPlaybackTimer
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:56 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:56 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::serviceStop
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::serviceStop
Nov 28 16:21:56 smsl-d400n volumio[922]: info: [1732782116483] ControllerWebradio::stop
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand stop
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::clearPlayQueue
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::addQueueItems
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::addQueueItems
Nov 28 16:21:56 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:21:56 smsl-d400n volumio[922]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1454276
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPlay
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::play index 0
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::play index undefined
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreStateMachine::startPlaybackTimer
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 28 16:21:56 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Nov 28 16:21:56 smsl-d400n volumio[922]: info: [1732782116527] ControllerWebradio::clearAddPlayTrack
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand stop
Nov 28 16:21:56 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:56 smsl-d400n volumio[922]: info:
Nov 28 16:21:56 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:56 smsl-d400n volumio[922]: info: sendMpdCommand stop took 71 milliseconds
Nov 28 16:21:56 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:56 smsl-d400n volumio[922]: info: sendMpdCommand stop took 27 milliseconds
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand clear
Nov 28 16:21:56 smsl-d400n volumio[922]: info:
Nov 28 16:21:56 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:56 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:56 smsl-d400n volumio[922]: info: sendMpdCommand status took 6 milliseconds
Nov 28 16:21:56 smsl-d400n volumio[922]: info: sendMpdCommand clear took 4 milliseconds
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1454276"
Nov 28 16:21:56 smsl-d400n volumio[922]: error: updateQueue error: null
Nov 28 16:21:56 smsl-d400n volumio[922]: info: ------------------------------ 10ms
Nov 28 16:21:56 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 5 milliseconds
Nov 28 16:21:56 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:56 smsl-d400n volumio[922]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Nov 28 16:21:56 smsl-d400n volumio[922]: info: ------------------------------ 21ms
Nov 28 16:21:56 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:21:57 smsl-d400n volumio[922]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1454276" took 916 milliseconds
Nov 28 16:21:57 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService mpd
Nov 28 16:21:57 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand play
Nov 28 16:21:57 smsl-d400n volumio[922]: info:
Nov 28 16:21:57 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:57 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:57 smsl-d400n volumio[922]: info: sendMpdCommand play took 3 milliseconds
Nov 28 16:21:57 smsl-d400n volumio[922]: info: ------------------------------ 4ms
Nov 28 16:21:58 smsl-d400n volumio[922]: info:
Nov 28 16:21:58 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:58 smsl-d400n volumio[922]: info:
Nov 28 16:21:58 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand status took 4 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand status took 5 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 4 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 529/2500) Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://141.94.96.97:8123/stream","trackType":""}
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus stop
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ------------------------------ 23ms
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 8 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 529/2500) Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://141.94.96.97:8123/stream","trackType":""}
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ------------------------------ 75ms
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:58 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:21:58 smsl-d400n volumio[922]: info:
Nov 28 16:21:58 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:58 smsl-d400n volumio[922]: info:
Nov 28 16:21:58 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ------------------------------ 10ms
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand status took 4 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 2 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://141.94.96.97:8123/stream","trackType":""}
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ------------------------------ 55ms
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:58 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:21:58 smsl-d400n volumio[922]: info:
Nov 28 16:21:58 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:21:58 smsl-d400n volumio[922]: info:
Nov 28 16:21:58 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ------------------------------ 6ms
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand status took 4 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 2 milliseconds
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1611,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Denisa Botiș - DENISA BOTIȘ - Am o viață, numai una | Colaj de petrecere | NOU ✨ COVER","artist":"Radio Manele Romania wWw.FMRadioManele.Ro","album":null,"uri":"http://141.94.96.97:8123/stream","trackType":""}
Nov 28 16:21:58 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:21:58 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:21:58 smsl-d400n volumio[922]: info: ------------------------------ 61ms
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:58 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:21:58 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:22:08 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioReplaceandPlayItems
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::ClearQueue
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::stPlaybackTimer
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:08 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:08 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::serviceStop
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::serviceStop
Nov 28 16:22:08 smsl-d400n volumio[922]: info: [1732782128749] ControllerWebradio::stop
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand stop
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::clearPlayQueue
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::addQueueItems
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::addQueueItems
Nov 28 16:22:08 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:08 smsl-d400n volumio[922]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497960
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPlay
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::play index 0
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::play index undefined
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreStateMachine::startPlaybackTimer
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 28 16:22:08 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Nov 28 16:22:08 smsl-d400n volumio[922]: info: [1732782128787] ControllerWebradio::clearAddPlayTrack
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand stop
Nov 28 16:22:08 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:08 smsl-d400n volumio[922]: info:
Nov 28 16:22:08 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:08 smsl-d400n volumio[922]: info: sendMpdCommand stop took 53 milliseconds
Nov 28 16:22:08 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:08 smsl-d400n volumio[922]: info: sendMpdCommand stop took 23 milliseconds
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand clear
Nov 28 16:22:08 smsl-d400n volumio[922]: info:
Nov 28 16:22:08 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:08 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:08 smsl-d400n volumio[922]: info: sendMpdCommand status took 6 milliseconds
Nov 28 16:22:08 smsl-d400n volumio[922]: info: sendMpdCommand clear took 4 milliseconds
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497960"
Nov 28 16:22:08 smsl-d400n volumio[922]: error: updateQueue error: null
Nov 28 16:22:08 smsl-d400n volumio[922]: info: ------------------------------ 8ms
Nov 28 16:22:08 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 4 milliseconds
Nov 28 16:22:08 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:08 smsl-d400n volumio[922]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Nov 28 16:22:08 smsl-d400n volumio[922]: info: ------------------------------ 24ms
Nov 28 16:22:08 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:22:09 smsl-d400n volumio[922]: info:
Nov 28 16:22:09 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:09 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:09 smsl-d400n volumio[922]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497960" took 343 milliseconds
Nov 28 16:22:09 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService mpd
Nov 28 16:22:09 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand play
Nov 28 16:22:09 smsl-d400n volumio[922]: info: ------------------------------ 4ms
Nov 28 16:22:09 smsl-d400n volumio[922]: info: sendMpdCommand play took 3 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand status took 4 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand status took 14 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 13 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chillout","artist":"(#1 - 961/500000) ANTENNE BAYERN Chillout (Germany)","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""}
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus stop
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 29ms
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 7 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chillout","artist":"(#1 - 961/500000) ANTENNE BAYERN Chillout (Germany)","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""}
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:10 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:10 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 71ms
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:10 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioReplaceandPlayItems
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::ClearQueue
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::stPlaybackTimer
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:10 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:10 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::serviceStop
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::serviceStop
Nov 28 16:22:10 smsl-d400n volumio[922]: info: [1732782130607] ControllerWebradio::stop
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand stop
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::clearPlayQueue
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::addQueueItems
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::addQueueItems
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushQueue
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::saveQueue
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::updateTrackBlock
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrackBlock
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPlay
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::play index 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::stop
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::play index undefined
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::startPlaybackTimer
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioGetVisibleSources
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Nov 28 16:22:10 smsl-d400n volumio[922]: info: [1732782130643] ControllerWebradio::clearAddPlayTrack
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand stop
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand stop took 41 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand stop took 7 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand clear
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 22ms
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand status took 18 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 21ms
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand status took 18 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand clear took 16 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958"
Nov 28 16:22:10 smsl-d400n volumio[922]: error: updateQueue error: null
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 16ms
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 13 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 12 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:10 smsl-d400n volumio[922]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Nov 28 16:22:10 smsl-d400n volumio[922]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 40ms
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 40ms
Nov 28 16:22:10 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" took 230 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: CoreStateMachine::setConsumeUpdateService mpd
Nov 28 16:22:10 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand play
Nov 28 16:22:10 smsl-d400n volumio[922]: info:
Nov 28 16:22:10 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:10 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:10 smsl-d400n volumio[922]: info: sendMpdCommand play took 3 milliseconds
Nov 28 16:22:10 smsl-d400n volumio[922]: info: ------------------------------ 3ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand status took 3 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 3 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldies-but-goldies","artist":"(#1 - 20/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""}
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus stop
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 16ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand status took 7 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 1 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"oldies-but-goldies","artist":"(#1 - 20/500000) ANTENNE BAYERN Oldies but Goldies (Germany)","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""}
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 57ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:11 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:11 smsl-d400n volumio[922]: info:
Nov 28 16:22:11 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 11ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand status took 8 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 13ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand status took 9 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 11ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand status took 8 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 5 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Soulsister - Ain't that simple (1993)","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""}
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 64ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 45 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 44 milliseconds
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Soulsister - Ain't that simple (1993)","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""}
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Soulsister - Ain't that simple (1993)","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""}
Nov 28 16:22:11 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:11 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 124ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: ------------------------------ 123ms
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:11 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:12 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:22:12 smsl-d400n volumio[922]: info:
Nov 28 16:22:12 smsl-d400n volumio[922]: ---------------------------- MPD announces system playlist update
Nov 28 16:22:12 smsl-d400n volumio[922]: info: Ignoring MPD Status Update
Nov 28 16:22:12 smsl-d400n volumio[922]: info:
Nov 28 16:22:12 smsl-d400n volumio[922]: ---------------------------- MPD announces state update: player
Nov 28 16:22:12 smsl-d400n volumio[922]: info: ControllerMpd::getState
Nov 28 16:22:12 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand status
Nov 28 16:22:12 smsl-d400n volumio[922]: info: ------------------------------ 5ms
Nov 28 16:22:12 smsl-d400n volumio[922]: info: sendMpdCommand status took 3 milliseconds
Nov 28 16:22:12 smsl-d400n volumio[922]: verbose: ControllerMpd::parseState
Nov 28 16:22:12 smsl-d400n volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Nov 28 16:22:12 smsl-d400n volumio[922]: info: sendMpdCommand playlistinfo took 2 milliseconds
Nov 28 16:22:12 smsl-d400n volumio[922]: verbose: ControllerMpd::parseTrackInfo
Nov 28 16:22:12 smsl-d400n volumio[922]: info: ControllerMpd::pushState
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreCommandRouter::servicePushState
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CorePlayQueue::getTrack 0
Nov 28 16:22:12 smsl-d400n volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2608,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Soulsister - Ain't that simple (1993)","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""}
Nov 28 16:22:12 smsl-d400n volumio[922]: verbose: CURRENT POSITION 0
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreStateMachine::syncState stateService play
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreStateMachine::syncState currentStatus play
Nov 28 16:22:12 smsl-d400n volumio[922]: info: Received an update from plugin. extracting info from payload
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:12 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:12 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreStateMachine::pushState
Nov 28 16:22:12 smsl-d400n volumio[922]: info: CoreCommandRouter::volumioPushState
Nov 28 16:22:12 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output update for this device
Nov 28 16:22:12 smsl-d400n volumio[922]: info: MRS: Pushing multiroomSync output
Nov 28 16:22:13 smsl-d400n volumio[922]: info: ------------------------------ 45ms
Nov 28 16:22:13 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:13 smsl-d400n volumio[922]: info: Updating RAAT Signal Path
Nov 28 16:22:13 smsl-d400n volumio[922]: error: Serial API: Failed to decode command: GET, message: STATE
Nov 28 16:22:19 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Nov 28 16:22:19 smsl-d400n volumio[922]: info: CURURI: music-library
Nov 28 16:22:19 smsl-d400n volumio[922]: error: Failed LSINFO: null
Nov 28 16:22:19 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:27 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Nov 28 16:22:27 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:29 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Nov 28 16:22:29 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:30 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Nov 28 16:22:31 smsl-d400n volumio[922]: info: Preload queue cleared
Nov 28 16:22:33 smsl-d400n volumio[922]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Nov 28 16:22:33 smsl-d400n volumio[922]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 28 16:22:33 smsl-d400n volumio[922]: TypeError: Cannot read property 'length' of undefined
Nov 28 16:22:33 smsl-d400n volumio[922]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Nov 28 16:22:33 smsl-d400n volumio[922]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Nov 28 16:22:33 smsl-d400n volumio[922]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Nov 28 16:22:33 smsl-d400n volumio[922]: at Parser.emit (events.js:400:28)
Nov 28 16:22:33 smsl-d400n volumio[922]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Nov 28 16:22:33 smsl-d400n volumio[922]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Nov 28 16:22:33 smsl-d400n volumio[922]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Nov 28 16:22:33 smsl-d400n volumio[922]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Nov 28 16:22:33 smsl-d400n volumio[922]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Nov 28 16:22:33 smsl-d400n volumio[922]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Nov 28 16:22:33 smsl-d400n volumio[922]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Nov 28 16:22:33 smsl-d400n volumio[922]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Nov 28 16:22:33 smsl-d400n volumio[922]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Nov 28 16:22:33 smsl-d400n volumio[922]: at IncomingMessage.emit (events.js:412:35)
Nov 28 16:22:33 smsl-d400n volumio[922]: at endReadableNT (internal/streams/readable.js:1333:12)
Nov 28 16:22:33 smsl-d400n volumio[922]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
Nov 28 16:22:33 smsl-d400n volumio[922]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 28 16:22:34 smsl-d400n sudo[3081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 16:21
Nov 28 16:22:34 smsl-d400n sudo[3081]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="smsl"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 14 Nov 2024 10:37:31 AM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="nanopineo3-armbian"
VOLUMIO_DEVICENAME="NanoPi Neo3"
VOLUMIO_VENDOR_MODEL="SMSL S100"
VOLUMIO_VENDOR="SMSL"
VOLUMIO_MODEL="S100"
VOLUMIO_HASH="693350a73c5f32caa813f2d9ff9306ea"