-- 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"