-- Logs begin at Thu 2025-05-29 13:12:30 WEST, end at Mon 2025-06-02 10:26:09 WEST. -- Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 02 10:25:07 cinnamon-galle volumio[877]: info: Received Get System Version Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 10:25:07 cinnamon-galle volumio[877]: info: Received Get System Info Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 10:25:07 cinnamon-galle volumio[877]: info: Discovery: Getting this device information Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetState Jun 02 10:25:07 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 10:25:09 cinnamon-galle volumio[877]: info: Discovery: Getting this device information Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetState Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 10:25:09 cinnamon-galle volumio[877]: Searching all installed plugins Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: , search Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 02 10:25:09 cinnamon-galle volumio[877]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 02 10:25:09 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 02 10:25:10 cinnamon-galle volumio[877]: info: All search sources collected, pushing search results Jun 02 10:25:11 cinnamon-galle volumio[877]: info: Preload queue cleared Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::ClearQueue Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::stop Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CorePlayQueue::clearPlayQueue Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CorePlayQueue::saveQueue Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::addQueueItems Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CorePlayQueue::addQueueItems Jun 02 10:25:11 cinnamon-galle volumio[877]: info: Preload queue cleared Jun 02 10:25:11 cinnamon-galle volumio[877]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s35273 Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CorePlayQueue::saveQueue Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::updateTrackBlock Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrackBlock Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPlay Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::play index 0 Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::stop Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::play index undefined Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:25:11 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:11 cinnamon-galle volumio[877]: info: [1748856311977] ControllerWebradio::clearAddPlayTrack Jun 02 10:25:11 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:25:11 cinnamon-galle volumio[877]: info: sendMpdCommand stop took 2 milliseconds Jun 02 10:25:11 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:25:11 cinnamon-galle volumio[877]: info: Jun 02 10:25:11 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:11 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:11 cinnamon-galle volumio[877]: info: sendMpdCommand clear took 1 milliseconds Jun 02 10:25:11 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand load "http://ksds-ice.streamguys.com/ksds.mp3" Jun 02 10:25:11 cinnamon-galle volumio[877]: error: updateQueue error: null Jun 02 10:25:11 cinnamon-galle volumio[877]: info: ------------------------------ 2ms Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand add "http://ksds-ice.streamguys.com/ksds.mp3" Jun 02 10:25:13 cinnamon-galle volumio[877]: info: Jun 02 10:25:13 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:13 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:13 cinnamon-galle volumio[877]: info: sendMpdCommand add "http://ksds-ice.streamguys.com/ksds.mp3" took 1 milliseconds Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:25:13 cinnamon-galle volumio[877]: info: ------------------------------ 1ms Jun 02 10:25:13 cinnamon-galle volumio[877]: info: sendMpdCommand play took 1 milliseconds Jun 02 10:25:13 cinnamon-galle volumio[877]: info: Jun 02 10:25:13 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:13 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:13 cinnamon-galle kernel: usb 1-1.2: uac_clock_source_is_valid(): cannot get clock validity for id 41 Jun 02 10:25:13 cinnamon-galle kernel: usb 1-1.2: clock source 41 is not valid, cannot use Jun 02 10:25:13 cinnamon-galle kernel: usb 1-1.2: 1:1: cannot get freq (v2/v3): err -71 Jun 02 10:25:13 cinnamon-galle kernel: usb 1-1.2: 1:1: cannot set freq 44100 (v2/v3): err -71 Jun 02 10:25:13 cinnamon-galle volumio[877]: info: Jun 02 10:25:13 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 02 10:25:13 cinnamon-galle volumio[877]: info: sendMpdCommand status took 3 milliseconds Jun 02 10:25:13 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:13 cinnamon-galle volumio[877]: info: sendMpdCommand clearerror took 2 milliseconds Jun 02 10:25:13 cinnamon-galle volumio[877]: info: sendMpdCommand status took 1 milliseconds Jun 02 10:25:13 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:13 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: STATE SERVICE {"status":"pause","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":"ksds.mp3","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService pause Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: ------------------------------ 11ms Jun 02 10:25:13 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:13 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: STATE SERVICE {"status":"pause","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":"ksds.mp3","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:13 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService pause Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:13 cinnamon-galle volumio[877]: info: ------------------------------ 12ms Jun 02 10:25:22 cinnamon-galle kernel: usb 1-1.2: USB disconnect, device number 5 Jun 02 10:25:22 cinnamon-galle volumio[877]: info: Jun 02 10:25:22 cinnamon-galle volumio[877]: ---------------------------- USB Audio Device Detached Jun 02 10:25:22 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jun 02 10:25:22 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 02 10:25:22 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jun 02 10:25:25 cinnamon-galle kernel: usb 1-1.2: new high-speed USB device number 6 using xhci_hcd Jun 02 10:25:25 cinnamon-galle kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3073, bcdDevice= 6.c5 Jun 02 10:25:25 cinnamon-galle kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jun 02 10:25:25 cinnamon-galle kernel: usb 1-1.2: Product: Cinnamon Galle DAC Jun 02 10:25:25 cinnamon-galle kernel: usb 1-1.2: Manufacturer: XMOS Jun 02 10:25:25 cinnamon-galle kernel: usb 1-1.2: 1:3 : unsupported format bits 0x100000000 Jun 02 10:25:25 cinnamon-galle volumio[877]: info: Jun 02 10:25:25 cinnamon-galle volumio[877]: ---------------------------- USB Audio Device Attached Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::Close All Modals sent Jun 02 10:25:25 cinnamon-galle volumio[877]: info: Preparing to save Alsa Options, stopping services first Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetState Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPause Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreStateMachine::pause Jun 02 10:25:25 cinnamon-galle volumio[877]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Cinnamon Galle DAC","alsacard":"DAC"},"i2s":false} Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 02 10:25:25 cinnamon-galle volumio[877]: info: Device 5 does not have any Mixer Control Available Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 02 10:25:25 cinnamon-galle volumio[877]: info: Updating Volume Controller Parameters: Device: 5 Name: Cinnamon Galle DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 02 10:25:25 cinnamon-galle volumio[877]: info: Disabling external Volume Control Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:25 cinnamon-galle volumio[877]: info: Preparing to generate the ALSA configuration file Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 10:25:25 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 02 10:25:26 cinnamon-galle volumio[877]: info: Asound.conf file unchanged, so no further update is needed Jun 02 10:25:26 cinnamon-galle volumio[877]: info: Output device has changed, restarting MPD Jun 02 10:25:26 cinnamon-galle sudo[22115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 10:25:26 cinnamon-galle sudo[22115]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:25:26 cinnamon-galle sudo[22115]: pam_unix(sudo:session): session closed for user root Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:25:26 cinnamon-galle sudo[22117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 10:25:26 cinnamon-galle sudo[22117]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 10:25:26 cinnamon-galle systemd[1]: Stopping Music Player Daemon... Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:25:26 cinnamon-galle volumio[877]: info: MPD Permissions set Jun 02 10:25:26 cinnamon-galle systemd[1]: mpd.service: Succeeded. Jun 02 10:25:26 cinnamon-galle systemd[1]: Stopped Music Player Daemon. Jun 02 10:25:26 cinnamon-galle systemd[1]: Starting Music Player Daemon... Jun 02 10:25:26 cinnamon-galle sudo[22124]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 02 10:25:26 cinnamon-galle sudo[22124]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:25:26 cinnamon-galle sudo[22124]: pam_unix(sudo:session): session closed for user root Jun 02 10:25:26 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jun 02 10:25:26 cinnamon-galle mpd[22127]: Jun 02 10:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 02 10:25:26 cinnamon-galle systemd[1]: Started Music Player Daemon. Jun 02 10:25:26 cinnamon-galle sudo[22117]: pam_unix(sudo:session): session closed for user root Jun 02 10:25:26 cinnamon-galle volumio[877]: error: updateQueue error: null Jun 02 10:25:28 cinnamon-galle volumio[877]: info: Preload queue cleared Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::ClearQueue Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::stop Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CorePlayQueue::clearPlayQueue Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CorePlayQueue::saveQueue Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::addQueueItems Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CorePlayQueue::addQueueItems Jun 02 10:25:28 cinnamon-galle volumio[877]: info: Preload queue cleared Jun 02 10:25:28 cinnamon-galle volumio[877]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s35273 Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CorePlayQueue::saveQueue Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::updateTrackBlock Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrackBlock Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPlay Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::play index 0 Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::stop Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::play index undefined Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:25:28 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:28 cinnamon-galle volumio[877]: info: [1748856328501] ControllerWebradio::clearAddPlayTrack Jun 02 10:25:28 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:25:28 cinnamon-galle volumio[877]: info: sendMpdCommand stop took 0 milliseconds Jun 02 10:25:28 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:25:28 cinnamon-galle volumio[877]: info: Jun 02 10:25:28 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:28 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:28 cinnamon-galle volumio[877]: info: sendMpdCommand clear took 0 milliseconds Jun 02 10:25:28 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand load "http://ksds-ice.streamguys.com/ksds.mp3" Jun 02 10:25:28 cinnamon-galle volumio[877]: error: updateQueue error: null Jun 02 10:25:28 cinnamon-galle volumio[877]: info: ------------------------------ 1ms Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand add "http://ksds-ice.streamguys.com/ksds.mp3" Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Jun 02 10:25:29 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand add "http://ksds-ice.streamguys.com/ksds.mp3" took 1 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ------------------------------ 1ms Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand play took 1 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Jun 02 10:25:29 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Jun 02 10:25:29 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand status took 41 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand status took 1 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:29 cinnamon-galle volumio[877]: 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":"ksds.mp3","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService play Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ------------------------------ 43ms Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:29 cinnamon-galle volumio[877]: 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":"ksds.mp3","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService play Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Received an update from plugin. extracting info from payload Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ------------------------------ 8ms Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Jun 02 10:25:29 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Jun 02 10:25:29 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ------------------------------ 1ms Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand status took 1 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:29 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":" - ID- Ken Peplowski","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:29 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService play Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:25:29 cinnamon-galle volumio[877]: info: Received an update from plugin. extracting info from payload Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: ------------------------------ 7ms Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::getcurrentVolume Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:29 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:38 cinnamon-galle volumio[877]: info: Preload queue cleared Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::ClearQueue Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::stop Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::updateTrackBlock Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrackBlock Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::serviceStop Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::serviceStop Jun 02 10:25:38 cinnamon-galle volumio[877]: info: [1748856338859] ControllerWebradio::stop Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::clearPlayQueue Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::saveQueue Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::addQueueItems Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::addQueueItems Jun 02 10:25:38 cinnamon-galle volumio[877]: info: Preload queue cleared Jun 02 10:25:38 cinnamon-galle volumio[877]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s35273 Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::saveQueue Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::updateTrackBlock Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrackBlock Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPlay Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::play index 0 Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::stop Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::play index undefined Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:25:38 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:38 cinnamon-galle volumio[877]: info: [1748856338866] ControllerWebradio::clearAddPlayTrack Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:25:38 cinnamon-galle volumio[877]: info: Jun 02 10:25:38 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:38 cinnamon-galle volumio[877]: info: sendMpdCommand stop took 34 milliseconds Jun 02 10:25:38 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:38 cinnamon-galle volumio[877]: info: sendMpdCommand stop took 27 milliseconds Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:25:38 cinnamon-galle volumio[877]: info: Jun 02 10:25:38 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:38 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:38 cinnamon-galle volumio[877]: info: sendMpdCommand status took 1 milliseconds Jun 02 10:25:38 cinnamon-galle volumio[877]: info: sendMpdCommand clear took 0 milliseconds Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand load "http://ksds-ice.streamguys.com/ksds.mp3" Jun 02 10:25:38 cinnamon-galle volumio[877]: error: updateQueue error: null Jun 02 10:25:38 cinnamon-galle volumio[877]: info: ------------------------------ 1ms Jun 02 10:25:38 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 02 10:25:38 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:38 cinnamon-galle volumio[877]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:25:38 cinnamon-galle volumio[877]: info: ------------------------------ 4ms Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand add "http://ksds-ice.streamguys.com/ksds.mp3" Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Jun 02 10:25:39 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand add "http://ksds-ice.streamguys.com/ksds.mp3" took 1 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ------------------------------ 1ms Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand play took 1 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Discovery: Getting this device information Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Jun 02 10:25:39 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Jun 02 10:25:39 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand status took 2 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand status took 1 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:39 cinnamon-galle volumio[877]: 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":"ksds.mp3","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService play Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ------------------------------ 5ms Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:39 cinnamon-galle volumio[877]: 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":"ksds.mp3","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService play Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Received an update from plugin. extracting info from payload Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ------------------------------ 7ms Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Jun 02 10:25:39 cinnamon-galle volumio[877]: ---------------------------- MPD announces system playlist update Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Ignoring MPD Status Update Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Jun 02 10:25:39 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ------------------------------ 2ms Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand status took 1 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":" - ID- Ken Peplowski","artist":null,"album":null,"uri":"http://ksds-ice.streamguys.com/ksds.mp3","trackType":"mp3"} Jun 02 10:25:39 cinnamon-galle volumio[877]: verbose: CURRENT POSITION 0 Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState stateService play Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:25:39 cinnamon-galle volumio[877]: info: Received an update from plugin. extracting info from payload Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:39 cinnamon-galle volumio[877]: info: ------------------------------ 7ms Jun 02 10:25:45 cinnamon-galle volumiologrotate[597]: ls: cannot access '/var/log/samba/log.wb-CINNAMON': No such file or directory Jun 02 10:25:45 cinnamon-galle volumiologrotate[597]: ls: cannot access 'GALLE': No such file or directory Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioStop Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreStateMachine::stop Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreStateMachine::updateTrackBlock Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrackBlock Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreStateMachine::serviceStop Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreCommandRouter::serviceStop Jun 02 10:25:59 cinnamon-galle volumio[877]: info: [1748856359051] ControllerWebradio::stop Jun 02 10:25:59 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:25:59 cinnamon-galle volumio[877]: info: Jun 02 10:25:59 cinnamon-galle volumio[877]: ---------------------------- MPD announces state update: player Jun 02 10:25:59 cinnamon-galle volumio[877]: info: sendMpdCommand stop took 22 milliseconds Jun 02 10:25:59 cinnamon-galle volumio[877]: info: ControllerMpd::getState Jun 02 10:25:59 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:25:59 cinnamon-galle volumio[877]: info: sendMpdCommand status took 1 milliseconds Jun 02 10:25:59 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseState Jun 02 10:25:59 cinnamon-galle volumio[877]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:25:59 cinnamon-galle volumio[877]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 02 10:25:59 cinnamon-galle volumio[877]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:25:59 cinnamon-galle volumio[877]: info: ControllerMpd::pushState Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreCommandRouter::servicePushState Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreStateMachine::pushState Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioPushState Jun 02 10:25:59 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:25:59 cinnamon-galle volumio[877]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jun 02 10:25:59 cinnamon-galle volumio[877]: info: ------------------------------ 4ms Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Received Get System Info Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Discovery: Getting this device information Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetState Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CorePlayQueue::getTrack 0 Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Retrieving Cloud Streaming UI Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Getting Tidal Cloud Configuration Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Getting Qobuz Cloud Configuration Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Asking plugin for UI Config Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Getting Spotify Cloud Configuration Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Asking plugin for UI Config Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Saving Spotify Acccount Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Got Tidal Cloud Configuration Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Got it Jun 02 10:26:04 cinnamon-galle volumio[877]: info: Got it Jun 02 10:26:04 cinnamon-galle volumio[877]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 10:26:04 cinnamon-galle volumio[877]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetBrowseSources Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetBrowseSources Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::volumioGetBrowseSources Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 02 10:26:04 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 02 10:26:06 cinnamon-galle volumio[877]: info: Disabling MyMusic plugin upnp Jun 02 10:26:06 cinnamon-galle sudo[22241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jun 02 10:26:06 cinnamon-galle sudo[22241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:26:06 cinnamon-galle systemd[1]: Stopping UPnP Renderer front-end to MPD... Jun 02 10:26:06 cinnamon-galle volumio[877]: error: Upnp client error: Error: This socket has been ended by the other party Jun 02 10:26:08 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 02 10:26:08 cinnamon-galle volumio[877]: info: Enabling MyMusic plugin upnp Jun 02 10:26:08 cinnamon-galle volumio[877]: info: Enabling plugin upnp Jun 02 10:26:08 cinnamon-galle volumio[877]: info: Loading plugin "upnp"... Jun 02 10:26:08 cinnamon-galle volumio[877]: info: [1748856368944] Starting Upmpd Daemon Jun 02 10:26:08 cinnamon-galle volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 10:26:08 cinnamon-galle volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:26:08 cinnamon-galle volumio[877]: Error: listen EADDRINUSE: address already in use :::6599 Jun 02 10:26:08 cinnamon-galle volumio[877]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Jun 02 10:26:08 cinnamon-galle volumio[877]: at listenInCluster (net.js:1366:12) Jun 02 10:26:08 cinnamon-galle volumio[877]: at Server.listen (net.js:1452:7) Jun 02 10:26:08 cinnamon-galle volumio[877]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jun 02 10:26:08 cinnamon-galle volumio[877]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jun 02 10:26:08 cinnamon-galle volumio[877]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 02 10:26:08 cinnamon-galle volumio[877]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 02 10:26:08 cinnamon-galle volumio[877]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jun 02 10:26:08 cinnamon-galle volumio[877]: code: 'EADDRINUSE', Jun 02 10:26:08 cinnamon-galle volumio[877]: errno: -98, Jun 02 10:26:08 cinnamon-galle volumio[877]: syscall: 'listen', Jun 02 10:26:08 cinnamon-galle volumio[877]: address: '::', Jun 02 10:26:08 cinnamon-galle volumio[877]: port: 6599 Jun 02 10:26:08 cinnamon-galle volumio[877]: } Jun 02 10:26:08 cinnamon-galle volumio[877]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:26:09 cinnamon-galle sudo[22253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-02 10:25 Jun 02 10:26:09 cinnamon-galle sudo[22253]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"