-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Thu 2026-03-26 11:07:44 EDT. --
Mar 26 11:06:20 volumio-zero2 sudo[18842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 26 11:06:20 volumio-zero2 sudo[18840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 26 11:06:20 volumio-zero2 sudo[18840]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 26 11:06:20 volumio-zero2 sudo[18842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 26 11:06:20 volumio-zero2 sudo[18842]: pam_unix(sudo:session): session closed for user root
Mar 26 11:06:20 volumio-zero2 sudo[18840]: pam_unix(sudo:session): session closed for user root
Mar 26 11:06:21 volumio-zero2 volumio[907]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.2 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetQueue
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreStateMachine::getQueue
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CorePlayQueue::getQueue
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: Listing playlists
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: Received Get System Info
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: Discovery: Getting this device information
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 26 11:06:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: Received Get System Info
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: Discovery: Getting this device information
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 11:06:22 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: Received Get System Info
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: Discovery: Getting this device information
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:23 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 11:06:31 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 26 11:06:34 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:06:34 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Retrieving Cloud Streaming UI
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Getting Tidal Cloud Configuration
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Getting Qobuz Cloud Configuration
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Asking plugin for UI Config
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Getting Spotify Cloud Configuration
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Asking plugin for UI Config
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Saving Spotify Acccount
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Got Tidal Cloud Configuration
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Got it
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: Got it
Mar 26 11:06:35 volumio-zero2 volumio[907]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 11:06:35 volumio-zero2 volumio[907]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 26 11:06:35 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 26 11:06:36 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:06:36 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand rescan
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand rescan took 45 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:37 volumio-zero2 volumio[907]: info:
Mar 26 11:06:37 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:37 volumio-zero2 volumio[907]: info:
Mar 26 11:06:37 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:37 volumio-zero2 volumio[907]: info:
Mar 26 11:06:37 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand status took 8 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand status took 7 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand status took 6 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand status took 6 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand status took 5 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand status took 5 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatetrue
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatetrue
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatetrue
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 65 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 39 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:37 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 26 11:06:37 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ------------------------------ 264ms
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ------------------------------ 262ms
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ------------------------------ 261ms
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: MPD Database updated - AlbumList cache refreshed
Mar 26 11:06:38 volumio-zero2 volumio[907]: info:
Mar 26 11:06:38 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: database
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info:
Mar 26 11:06:38 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: MPD Database updated - AlbumList cache refreshed
Mar 26 11:06:38 volumio-zero2 volumio[907]: info:
Mar 26 11:06:38 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: database
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info:
Mar 26 11:06:38 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: MPD Database updated - AlbumList cache refreshed
Mar 26 11:06:38 volumio-zero2 volumio[907]: info:
Mar 26 11:06:38 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: database
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info:
Mar 26 11:06:38 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 77 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 76 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 76 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 74 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 73 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 71 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 70 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand status took 276 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 78 milliseconds
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:38 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:38 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ------------------------------ 319ms
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 90 milliseconds
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 58 milliseconds
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 44 milliseconds
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:39 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ------------------------------ 388ms
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ------------------------------ 389ms
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ------------------------------ 409ms
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: ------------------------------ 412ms
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: Received Get System Version
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: Received Get System Info
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: Discovery: Getting this device information
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:39 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 11:06:40 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand update
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info:
Mar 26 11:06:42 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand update took 4 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 3 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 2 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatetrue
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info:
Mar 26 11:06:42 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info:
Mar 26 11:06:42 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info:
Mar 26 11:06:42 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 15 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 9 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 9 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 8 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 8 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ------------------------------ 150ms
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info:
Mar 26 11:06:42 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info:
Mar 26 11:06:42 volumio-zero2 volumio[907]: ---------------------------- MPD announces state update: update
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::getState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand status
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 93 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 92 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 56 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 32 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 18 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 14 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 14 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand status took 12 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: Command Router : Notfying DB Updatefalse
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::Close All Modals sent
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseState
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ------------------------------ 213ms
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ------------------------------ 210ms
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 81 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 55 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: sendMpdCommand playlistinfo took 30 milliseconds
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: ControllerMpd::parseTrackInfo
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ControllerMpd::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::servicePushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29606,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"996 Kbps","isStreaming":false,"title":"零时十分","artist":"童丽","album":"零时十分","uri":"INTERNAL/零时十分.flac","trackType":"flac"}
Mar 26 11:06:42 volumio-zero2 volumio[907]: verbose: CURRENT POSITION 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState stateService pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::syncState currentStatus pause
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::pushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioPushState
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: CoreStateMachine::stPlaybackTimer
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ------------------------------ 241ms
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ------------------------------ 164ms
Mar 26 11:06:42 volumio-zero2 volumio[907]: info: ------------------------------ 159ms
Mar 26 11:06:44 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:06:48 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:06:52 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:06:56 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:07:00 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:07:04 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:07:08 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:07:12 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:07:16 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 11:07:18 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:07:18 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:07:21 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 26 11:07:21 volumio-zero2 volumio[907]: info: CURURI: albums://
Mar 26 11:07:21 volumio-zero2 volumio[907]: info: listAlbums - loading Albums from cache
Mar 26 11:07:21 volumio-zero2 volumio[907]: info: Preload queue cleared
Mar 26 11:07:37 volumio-zero2 volumio[907]: info: CoreCommandRouter::volumioGetState
Mar 26 11:07:37 volumio-zero2 volumio[907]: info: CorePlayQueue::getTrack 1
Mar 26 11:07:40 volumio-zero2 volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 26 11:07:40 volumio-zero2 volumio[907]: info: CURURI: artists://
Mar 26 11:07:41 volumio-zero2 volumio[907]: info: Preload queue cleared
Mar 26 11:07:42 volumio-zero2 volumio[907]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 26 11:07:42 volumio-zero2 volumio[907]: TypeError: Cannot read property 'slice' of null
Mar 26 11:07:42 volumio-zero2 volumio[907]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at Object.onceWrapper (events.js:422:26)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at ClientRequest.emit (events.js:315:20)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at TLSSocket.socketOnData (_http_client.js:509:22)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at TLSSocket.emit (events.js:315:20)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at addChunk (internal/streams/readable.js:309:12)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at readableAddChunk (internal/streams/readable.js:284:9)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10)
Mar 26 11:07:42 volumio-zero2 volumio[907]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23)
Mar 26 11:07:42 volumio-zero2 volumio[907]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 26 11:07:44 volumio-zero2 sudo[19055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-26 11:06
Mar 26 11:07:44 volumio-zero2 sudo[19055]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"