-- Logs begin at Sun 2025-05-18 14:34:48 CST, end at Sun 2025-05-18 14:37:05 CST. --
May 18 14:36:00 volumio volumio[1072]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
May 18 14:36:00 volumio volumio[1072]: info: Updating MyVolumio device info
May 18 14:36:00 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 14:36:01 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 18 14:36:01 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 14:36:01 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 18 14:36:01 volumio volumio-remote-updater[675]: No test mode
May 18 14:36:01 volumio volumio-remote-updater[675]: No alpha test mode
May 18 14:36:01 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 18 14:36:01 volumio volumio[1072]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
May 18 14:36:02 volumio volumio[1072]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
May 18 14:36:02 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 18 14:36:04 volumio volumio[1072]: info: MYVOLUMIO: Adding device
May 18 14:36:04 volumio volumio[1072]: info: MYVOLUMIO: Evaluating Server
May 18 14:36:05 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:05 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
May 18 14:36:06 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 18 14:36:06 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 18 14:36:06 volumio volumio[1072]: info: Discovery: Getting this device information
May 18 14:36:06 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:06 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
May 18 14:36:06 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 18 14:36:06 volumio volumio[1072]: info: Setting Geolocation for MyVolumio to us2
May 18 14:36:06 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 14:36:06 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 14:36:07 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 18 14:36:07 volumio volumio[1072]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
May 18 14:36:07 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:07 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
May 18 14:36:07 volumio volumio[1072]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
May 18 14:36:07 volumio volumio[1072]: info: Updating MyVolumio device info
May 18 14:36:07 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 14:36:08 volumio volumio[1072]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
May 18 14:36:12 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 18 14:36:12 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 18 14:36:12 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 18 14:36:12 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 18 14:36:12 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 18 14:36:12 volumio volumio[1072]: info: CoreCommandRouter::volumioGetBrowseSources
May 18 14:36:12 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 18 14:36:14 volumio volumio[1072]: info: Clearing queue after UPNP request
May 18 14:36:14 volumio volumio[1072]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 18 14:36:14 volumio volumio[1072]: info: Completed starting MyVolumio Plugin
May 18 14:36:14 volumio volumio[1072]: [Metrics] CommandRouter: 59s 59.20ms
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::volumiosetStartupVolume
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 18 14:36:14 volumio volumio[1072]: info: VolumeController:: Setting startup Volume 80
May 18 14:36:14 volumio volumio[1072]: info: VolumeController::SetAlsaVolume80
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::Close All Modals sent
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::Close All Modals sent
May 18 14:36:14 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:14 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:14 volumio volumio[1072]: info: CoreStateMachine::ClearQueue
May 18 14:36:14 volumio volumio[1072]: info: CoreStateMachine::stop
May 18 14:36:14 volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined
May 18 14:36:14 volumio volumio[1072]: info: CorePlayQueue::clearPlayQueue
May 18 14:36:14 volumio volumio[1072]: info: CorePlayQueue::saveQueue
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::volumioPushQueue
May 18 14:36:14 volumio volumio[1072]: info:
May 18 14:36:14 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:14 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:14 volumio volumio[1072]: info:
May 18 14:36:14 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:14 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:14 volumio volumio[1072]: error: updateQueue error: null
May 18 14:36:14 volumio volumio[1072]: error: updateQueue error: null
May 18 14:36:14 volumio volumio[1072]: info: ------------------------------ 9ms
May 18 14:36:14 volumio volumio[1072]: info: ------------------------------ 7ms
May 18 14:36:14 volumio volumio[1072]: info: Starting UPNP Playback
May 18 14:36:14 volumio volumio[1072]: info: Preparing playback through UPNP
May 18 14:36:14 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:14 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
May 18 14:36:14 volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService mpd
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 6ms
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 6ms
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 8ms
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 4ms
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 7ms
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 4ms
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 8ms
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 5ms
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 8ms
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 4ms
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces system playlist update
May 18 14:36:15 volumio volumio[1072]: info: Ignoring MPD Status Update
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 7ms
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 4ms
May 18 14:36:15 volumio volumio[1639]: 79
May 18 14:36:15 volumio volumio[1639]: % Total % Received % Xferd Average Speed Time Time Time Current
May 18 14:36:15 volumio volumio[1639]: Dload Upload Total Spent Left Speed
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- Client requests Volume 79
May 18 14:36:15 volumio volumio[1072]: info: VolumeController::SetAlsaVolume79
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:15 volumio volumio[1639]: [158B blob data]
May 18 14:36:15 volumio volumio[1639]: {"time":1747550175295,"response":"volume Success"}79
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces state update: player
May 18 14:36:15 volumio volumio[1072]: info: ControllerMpd::getState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces state update: player
May 18 14:36:15 volumio volumio[1072]: info: ControllerMpd::getState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces state update: player
May 18 14:36:15 volumio volumio[1072]: info: sendMpdCommand status took 230 milliseconds
May 18 14:36:15 volumio volumio[1072]: info: ControllerMpd::getState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status
May 18 14:36:15 volumio volumio[1072]: info: sendMpdCommand status took 222 milliseconds
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::parseState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::parseState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 14:36:15 volumio volumio[1072]: info:
May 18 14:36:15 volumio volumio[1072]: ---------------------------- MPD announces state update: player
May 18 14:36:15 volumio volumio[1072]: info: ControllerMpd::getState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand status
May 18 14:36:15 volumio volumio[1072]: info: sendMpdCommand status took 28 milliseconds
May 18 14:36:15 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 22 milliseconds
May 18 14:36:15 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 24 milliseconds
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::parseState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo
May 18 14:36:15 volumio volumio[1072]: info: ControllerMpd::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::servicePushState
May 18 14:36:15 volumio volumio[1072]: verbose: In UPNP mode
May 18 14:36:15 volumio volumio[1072]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"金风玉露","artist":"梅小琴","album":"潇洒","uri":"http://192.168.31.126:50739/bridge-1.flac","trackType":"flac"}
May 18 14:36:15 volumio volumio[1072]: verbose: CURRENT POSITION 0
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::syncState stateService play
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus stop
May 18 14:36:15 volumio volumio[1072]: info: ControllerMpd::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::servicePushState
May 18 14:36:15 volumio volumio[1072]: verbose: In UPNP mode
May 18 14:36:15 volumio volumio[1072]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"660 Kbps","isStreaming":false,"title":"金风玉露","artist":"梅小琴","album":"潇洒","uri":"http://192.168.31.126:50739/bridge-1.flac","trackType":"flac"}
May 18 14:36:15 volumio volumio[1072]: verbose: CURRENT POSITION 0
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::syncState stateService play
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus play
May 18 14:36:15 volumio volumio[1072]: info: Received an update from plugin. extracting info from payload
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 374ms
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 406ms
May 18 14:36:15 volumio volumio[1072]: info: sendMpdCommand status took 161 milliseconds
May 18 14:36:15 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 146 milliseconds
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::parseState
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 14:36:15 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo
May 18 14:36:15 volumio volumio[1072]: info: ControllerMpd::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::servicePushState
May 18 14:36:15 volumio volumio[1072]: verbose: In UPNP mode
May 18 14:36:15 volumio volumio[1072]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"753 Kbps","isStreaming":false,"title":"金风玉露","artist":"梅小琴","album":"潇洒","uri":"http://192.168.31.126:50739/bridge-1.flac","trackType":"flac"}
May 18 14:36:15 volumio volumio[1072]: verbose: CURRENT POSITION 0
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::syncState stateService play
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus play
May 18 14:36:15 volumio volumio[1072]: info: Received an update from plugin. extracting info from payload
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:15 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:15 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:15 volumio volumio[1072]: info: ------------------------------ 299ms
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CorePlayQueue::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CorePlayQueue::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CorePlayQueue::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CorePlayQueue::getQueue
May 18 14:36:16 volumio volumio[1072]: info: sendMpdCommand playlistinfo took 159 milliseconds
May 18 14:36:16 volumio volumio[1072]: verbose: ControllerMpd::parseTrackInfo
May 18 14:36:16 volumio volumio[1072]: info: ControllerMpd::pushState
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::servicePushState
May 18 14:36:16 volumio volumio[1072]: verbose: In UPNP mode
May 18 14:36:16 volumio volumio[1072]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"753 Kbps","isStreaming":false,"title":"金风玉露","artist":"梅小琴","album":"潇洒","uri":"http://192.168.31.126:50739/bridge-1.flac","trackType":"flac"}
May 18 14:36:16 volumio volumio[1072]: verbose: CURRENT POSITION 0
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::syncState stateService play
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::syncState currentStatus play
May 18 14:36:16 volumio volumio[1072]: info: Received an update from plugin. extracting info from payload
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:36:16 volumio volumio[1072]: info: ------------------------------ 435ms
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CorePlayQueue::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreStateMachine::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CorePlayQueue::getQueue
May 18 14:36:16 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:17 volumio sudo[2074]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
May 18 14:36:17 volumio sudo[2074]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 18 14:36:18 volumio ntpd[1061]: Soliciting pool server 193.182.111.143
May 18 14:36:19 volumio ntpd[1061]: Soliciting pool server 220.135.175.159
May 18 14:36:19 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 18 14:36:19 volumio volumio[1072]: info: Received Get System Info
May 18 14:36:19 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 18 14:36:19 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 18 14:36:19 volumio volumio[1072]: info: Discovery: Getting this device information
May 18 14:36:19 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:19 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 18 14:36:20 volumio ntpd[1061]: Soliciting pool server 117.80.231.60
May 18 14:36:21 volumio volumio[1072]: info: BOOT COMPLETED
May 18 14:36:21 volumio ntpd[1061]: Soliciting pool server 193.182.111.142
May 18 14:36:21 volumio ntpd[1061]: Soliciting pool server 193.182.111.143
May 18 14:36:21 volumio volumio[1072]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9
May 18 14:36:21 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:24 volumio volumio[1072]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10
May 18 14:36:24 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:36 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 18 14:36:36 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 18 14:36:36 volumio volumio[1072]: info: Discovery: Getting this device information
May 18 14:36:36 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState
May 18 14:36:36 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 18 14:37:04 volumio volumio[1072]: info: Preload queue cleared
May 18 14:37:04 volumio volumio[1072]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::ClearQueue
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::stop
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::setConsumeUpdateService undefined
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::stPlaybackTimer
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::updateTrackBlock
May 18 14:37:04 volumio volumio[1072]: info: CorePlayQueue::getTrackBlock
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::pushState
May 18 14:37:04 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
May 18 14:37:04 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 14:37:04 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::serviceStop
May 18 14:37:04 volumio volumio[1072]: info: CorePlayQueue::getTrack 0
May 18 14:37:04 volumio volumio[1072]: info: ControllerMpd::stop
May 18 14:37:04 volumio volumio[1072]: verbose: ControllerMpd::sendMpdCommand stop
May 18 14:37:04 volumio volumio[1072]: info: CorePlayQueue::clearPlayQueue
May 18 14:37:04 volumio volumio[1072]: info: CorePlayQueue::saveQueue
May 18 14:37:04 volumio volumio[1072]: info: CoreCommandRouter::volumioPushQueue
May 18 14:37:04 volumio volumio[1072]: info: CoreStateMachine::addQueueItems
May 18 14:37:04 volumio volumio[1072]: info: CorePlayQueue::addQueueItems
May 18 14:37:04 volumio volumio[1072]: info: Preload queue cleared
May 18 14:37:04 volumio volumio[1072]: info: Adding Item to queue: music-library/NAS/音乐/WAV/2024发烧合集/03. 梅小琴2024《共鸣Ⅲ·潇洒》24K金碟/01.梅小琴 - 金风玉露.wav
May 18 14:37:04 volumio volumio[1072]: info: Exploding uri music-library/NAS/音乐/WAV/2024发烧合集/03. 梅小琴2024《共鸣Ⅲ·潇洒》24K金碟/01.梅小琴 - 金风玉露.wav in service mpd
May 18 14:37:04 volumio volumio[1072]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 18 14:37:04 volumio volumio[1072]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
May 18 14:37:04 volumio volumio[1072]: at Object.readdirSync (fs.js:1048:3)
May 18 14:37:04 volumio volumio[1072]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
May 18 14:37:04 volumio volumio[1072]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
May 18 14:37:04 volumio volumio[1072]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
May 18 14:37:04 volumio volumio[1072]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
May 18 14:37:04 volumio volumio[1072]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
May 18 14:37:04 volumio volumio[1072]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
May 18 14:37:04 volumio volumio[1072]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
May 18 14:37:04 volumio volumio[1072]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
May 18 14:37:04 volumio volumio[1072]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) {
May 18 14:37:04 volumio volumio[1072]: errno: -20,
May 18 14:37:04 volumio volumio[1072]: syscall: 'scandir',
May 18 14:37:04 volumio volumio[1072]: code: 'ENOTDIR',
May 18 14:37:04 volumio volumio[1072]: path: '/tmp/peppyrunning'
May 18 14:37:04 volumio volumio[1072]: }
May 18 14:37:04 volumio volumio[1072]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 18 14:37:05 volumio sudo[2493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-18 14:36
May 18 14:37:05 volumio sudo[2493]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"