Oct 15 20:10:00 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:00 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:02 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:02 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:03 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:03 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:04 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:04 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:05 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:05 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:06 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:06 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:06 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:06 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:06 volumio volumio[1166]: info: Listing playlists Oct 15 20:10:06 volumio volumio[1166]: info: Listing playlists Oct 15 20:10:07 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:07 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:08 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:08 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:09 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:09 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:10 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:10 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:11 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:11 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:12 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:12 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:13 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:13 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:14 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:14 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:15 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:15 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:16 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:16 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:16 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:16 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:17 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:17 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:18 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:18 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:19 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:19 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:20 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:20 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:21 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:21 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:22 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:22 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:23 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:23 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:24 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:24 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:25 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:25 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:26 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:26 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:26 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:26 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:26 volumio volumio[1166]: info: Listing playlists Oct 15 20:10:26 volumio volumio[1166]: info: Listing playlists Oct 15 20:10:27 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:27 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:28 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:28 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:29 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:29 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:30 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:30 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:31 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:31 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:32 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:32 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:33 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:33 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:33 volumio sudo[19380]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 20:10:33 volumio sudo[19380]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 20:10:33 volumio sudo[19382]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 20:10:33 volumio sudo[19380]: pam_unix(sudo:session): session closed for user root Oct 15 20:10:33 volumio sudo[19382]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 20:10:33 volumio sudo[19382]: pam_unix(sudo:session): session closed for user root Oct 15 20:10:33 volumio volumio[1166]: verbose: New Socket.io Connection to 10.18.23.177 from 10.18.23.1 UA: Mozilla/5.0 (Linux; Android 16; 23127PN0CC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.36 Mobile Safari/537.36 Home Assistant/2026.5.3-22116 (Android 16; 23127PN0CC) Engine version: 3 Transport: polling Total Clients: 5 Oct 15 20:10:33 volumio sudo[19386]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 20:10:33 volumio sudo[19386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 20:10:33 volumio sudo[19388]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 20:10:33 volumio sudo[19386]: pam_unix(sudo:session): session closed for user root Oct 15 20:10:33 volumio sudo[19388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 20:10:33 volumio sudo[19388]: pam_unix(sudo:session): session closed for user root Oct 15 20:10:33 volumio volumio[1166]: verbose: New Socket.io Connection to 10.18.23.177 from 10.18.23.1 UA: Mozilla/5.0 (Linux; Android 16; 23127PN0CC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.36 Mobile Safari/537.36 Home Assistant/2026.5.3-22116 (Android 16; 23127PN0CC) Engine version: 3 Transport: polling Total Clients: 5 Oct 15 20:10:34 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:34 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:34 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 20:10:34 volumio volumio[1166]: info: Listing playlists Oct 15 20:10:34 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 20:10:34 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 15 20:10:34 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 15 20:10:34 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 20:10:34 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:34 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioPlay Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::play index undefined Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::startPlaybackTimer Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: ControllerMpd::resume Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand play Oct 15 20:10:35 volumio volumio[1166]: info: Oct 15 20:10:35 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:35 volumio volumio[1166]: info: sendMpdCommand play took 18 milliseconds Oct 15 20:10:35 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:35 volumio volumio[1166]: info: Oct 15 20:10:35 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:35 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:35 volumio volumio[1166]: info: Oct 15 20:10:35 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:35 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:35 volumio volumio[1166]: info: sendMpdCommand status took 7 milliseconds Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:35 volumio volumio[1166]: info: sendMpdCommand status took 14 milliseconds Oct 15 20:10:35 volumio volumio[1166]: info: sendMpdCommand status took 12 milliseconds Oct 15 20:10:35 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:35 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":30582,"duration":594,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"2010.mp3","artist":null,"album":null,"uri":"INTERNAL/2010.mp3","trackType":"mp3"} Oct 15 20:10:35 volumio volumio[1166]: verbose: CURRENT POSITION 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus pause Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:35 volumio volumio[1166]: info: ------------------------------ 60ms Oct 15 20:10:35 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 30 milliseconds Oct 15 20:10:35 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 31 milliseconds Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:35 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:35 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":30582,"duration":594,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"2010.mp3","artist":null,"album":null,"uri":"INTERNAL/2010.mp3","trackType":"mp3"} Oct 15 20:10:35 volumio volumio[1166]: verbose: CURRENT POSITION 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:35 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:35 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":30582,"duration":594,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"2010.mp3","artist":null,"album":null,"uri":"INTERNAL/2010.mp3","trackType":"mp3"} Oct 15 20:10:35 volumio volumio[1166]: verbose: CURRENT POSITION 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:35 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:35 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:35 volumio volumio[1166]: info: ------------------------------ 84ms Oct 15 20:10:35 volumio volumio[1166]: info: ------------------------------ 84ms Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 20:10:35 volumio volumio[1166]: info: Received Get System Info Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 20:10:35 volumio volumio[1166]: info: Discovery: Getting this device information Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:35 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 20:10:35 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 15 20:10:36 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:36 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:36 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:36 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:36 volumio volumio[1166]: info: CoreCommandRouter::volumioGetQueue Oct 15 20:10:36 volumio volumio[1166]: info: CoreStateMachine::getQueue Oct 15 20:10:36 volumio volumio[1166]: info: CorePlayQueue::getQueue Oct 15 20:10:37 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:37 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:37 volumio volumio[1166]: (node:1166) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit Oct 15 20:10:38 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:38 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:39 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:39 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:40 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:40 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:41 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:41 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPlay Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::play index 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::stop Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::stPlaybackTimer Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::updateTrackBlock Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrackBlock Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::serviceStop Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 0 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::serviceStop Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::stop Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand stop took 12 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::play index undefined Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::startPlaybackTimer Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/任贤齐-心太软-哭个痛快-320.mp3 Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 11 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand stop took 8 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 5 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 3 milliseconds Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"2010.mp3","artist":null,"album":null,"uri":"INTERNAL/2010.mp3","trackType":"mp3"} Oct 15 20:10:42 volumio volumio[1166]: verbose: CURRENT POSITION 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState stateService stop Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: No code Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 43ms Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:42 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand clear took 34 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 35 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 34 milliseconds Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/任贤齐-心太软-哭个痛快-320.mp3" Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 15 20:10:42 volumio volumio[1166]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 55ms Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 52ms Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:42 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:42 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:42 volumio volumio[1166]: error: updateQueue error: null Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:42 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 40ms Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand add "INTERNAL/任贤齐-心太软-哭个痛快-320.mp3" took 35 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 27ms Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 24ms Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand play Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:42 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:42 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 14ms Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand play took 7 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 6ms Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 4ms Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 12 milliseconds Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 18 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 16 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 6 milliseconds Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"哭个痛快","artist":"任贤齐","album":"心太软","uri":"INTERNAL/任贤齐-心太软-哭个痛快-320.mp3","trackType":"mp3"} Oct 15 20:10:42 volumio volumio[1166]: verbose: CURRENT POSITION 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 30ms Oct 15 20:10:42 volumio volumio[1166]: info: Oct 15 20:10:42 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 15 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand status took 5 milliseconds Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"哭个痛快","artist":"任贤齐","album":"心太软","uri":"INTERNAL/任贤齐-心太软-哭个痛快-320.mp3","trackType":"mp3"} Oct 15 20:10:42 volumio volumio[1166]: verbose: CURRENT POSITION 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:42 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"哭个痛快","artist":"任贤齐","album":"心太软","uri":"INTERNAL/任贤齐-心太软-哭个痛快-320.mp3","trackType":"mp3"} Oct 15 20:10:42 volumio volumio[1166]: verbose: CURRENT POSITION 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:42 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"哭个痛快","artist":"任贤齐","album":"心太软","uri":"INTERNAL/任贤齐-心太软-哭个痛快-320.mp3","trackType":"mp3"} Oct 15 20:10:42 volumio volumio[1166]: verbose: CURRENT POSITION 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:42 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 91ms Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 91ms Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 80ms Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 61 milliseconds Oct 15 20:10:42 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 59 milliseconds Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"哭个痛快","artist":"任贤齐","album":"心太软","uri":"INTERNAL/任贤齐-心太软-哭个痛快-320.mp3","trackType":"mp3"} Oct 15 20:10:42 volumio volumio[1166]: verbose: CURRENT POSITION 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:42 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"哭个痛快","artist":"任贤齐","album":"心太软","uri":"INTERNAL/任贤齐-心太软-哭个痛快-320.mp3","trackType":"mp3"} Oct 15 20:10:42 volumio volumio[1166]: verbose: CURRENT POSITION 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:42 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:42 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:42 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 111ms Oct 15 20:10:42 volumio volumio[1166]: info: ------------------------------ 100ms Oct 15 20:10:43 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:43 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314450 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314460 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314470 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314480 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314490 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314500 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314510 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314520 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314530 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314540 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314550 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314560 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314570 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314580 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314590 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314600 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314610 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314620 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314630 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314640 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314650 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314660 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314670 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314680 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314690 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314700 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314710 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314720 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314730 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314740 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314750 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314760 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314770 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314780 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314790 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314800 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314810 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314820 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314830 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314840 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314850 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314860 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314870 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314880 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314890 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314900 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314910 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314920 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314930 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314940 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314950 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314960 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314970 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314980 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 314990 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 315000 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 315010 帧 (音量=32, 进度=5.0%, 状态=pause) Oct 15 20:10:43 volumio volumio_display[871]: Display: 渲染第 315020 帧 (音量=32, 进度=5.6%, 状态=play) Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPlay Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::play index 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::stop Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::stPlaybackTimer Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::updateTrackBlock Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrackBlock Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::serviceStop Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 20 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::serviceStop Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::stop Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand stop took 12 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::play index undefined Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::startPlaybackTimer Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/清空.mp3 Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand stop Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand stop took 2 milliseconds Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand clear Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:46 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 8 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand clear took 8 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 7 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 6 milliseconds Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/清空.mp3" Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService stop Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: No code Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService stop Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: No code Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 50ms Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 49ms Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:46 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:46 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:46 volumio volumio[1166]: error: updateQueue error: null Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:46 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 54ms Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 50 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand add "INTERNAL/清空.mp3" took 50 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 8ms Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 6ms Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand play Oct 15 20:10:46 volumio volumio[1166]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 71ms Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:46 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces system playlist update Oct 15 20:10:46 volumio volumio[1166]: info: Ignoring MPD Status Update Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 34ms Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand play took 25 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 21ms Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 20ms Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 15 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 14 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 12 milliseconds Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: Oct 15 20:10:46 volumio volumio[1166]: ---------------------------- MPD announces state update: player Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::getState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand status Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 14 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 8 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand status took 6 milliseconds Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseState Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"清空","artist":"王忻辰/苏星婕","album":"清空","uri":"INTERNAL/清空.mp3","trackType":"mp3"} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus stop Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"清空","artist":"王忻辰/苏星婕","album":"清空","uri":"INTERNAL/清空.mp3","trackType":"mp3"} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:46 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"清空","artist":"王忻辰/苏星婕","album":"清空","uri":"INTERNAL/清空.mp3","trackType":"mp3"} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:46 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 63ms Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 83ms Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 81ms Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 55 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 53 milliseconds Oct 15 20:10:46 volumio volumio[1166]: info: sendMpdCommand playlistinfo took 53 milliseconds Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:46 volumio volumio[1166]: verbose: ControllerMpd::parseTrackInfo Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"清空","artist":"王忻辰/苏星婕","album":"清空","uri":"INTERNAL/清空.mp3","trackType":"mp3"} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:46 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":298,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"清空","artist":"王忻辰/苏星婕","album":"清空","uri":"INTERNAL/清空.mp3","trackType":"mp3"} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:46 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: ControllerMpd::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::servicePushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: verbose: STATE SERVICE {"status":"play","position":0,"seek":710,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"清空","artist":"王忻辰/苏星婕","album":"清空","uri":"INTERNAL/清空.mp3","trackType":"mp3"} Oct 15 20:10:46 volumio volumio[1166]: verbose: CURRENT POSITION 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState stateService play Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::syncState currentStatus play Oct 15 20:10:46 volumio volumio[1166]: info: Received an update from plugin. extracting info from payload Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:46 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:46 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 123ms Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 115ms Oct 15 20:10:46 volumio volumio[1166]: info: ------------------------------ 114ms Oct 15 20:10:46 volumio volumio[1166]: info: Listing playlists Oct 15 20:10:46 volumio volumio[1166]: info: Listing playlists Oct 15 20:10:47 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:47 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:48 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:48 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:49 volumio volumio[1166]: info: VolumeController::SetAlsaVolume40 Oct 15 20:10:49 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:49 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:49 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:49 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:49 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:49 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:50 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:50 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:51 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:51 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:52 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:52 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:53 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:53 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:54 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:54 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:54 volumio volumio[1166]: info: VolumeController::SetAlsaVolume50 Oct 15 20:10:54 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:54 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:54 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:54 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:55 volumio volumio[1166]: info: VolumeController::SetAlsaVolume75 Oct 15 20:10:55 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:55 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:55 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:55 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:55 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:55 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:56 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:56 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:56 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:56 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:57 volumio volumio[1166]: info: VolumeController::SetAlsaVolume65 Oct 15 20:10:57 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:57 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:57 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:57 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:57 volumio volumio[1166]: info: VolumeController::SetAlsaVolume55 Oct 15 20:10:57 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:57 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:57 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:57 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:57 volumio volumio[1166]: info: VolumeController::SetAlsaVolume50 Oct 15 20:10:57 volumio volumio[1166]: info: CoreStateMachine::pushState Oct 15 20:10:57 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:57 volumio volumio[1166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 20:10:57 volumio volumio[1166]: info: CoreCommandRouter::volumioPushState Oct 15 20:10:57 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:57 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:58 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:58 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:10:59 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:10:59 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:11:00 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:11:00 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:11:01 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:11:01 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:11:02 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:11:02 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:11:03 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:11:03 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:11:04 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:11:04 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:11:05 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Oct 15 20:11:05 volumio volumio[1166]: info: CorePlayQueue::getTrack 25 Oct 15 20:11:05 volumio volumio[1166]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 20:11:05 volumio volumio[1166]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Oct 15 20:11:05 volumio volumio[1166]: code: 'auth/network-request-failed', Oct 15 20:11:05 volumio volumio[1166]: a: null Oct 15 20:11:05 volumio volumio[1166]: } Oct 15 20:11:05 volumio volumio[1166]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 20:11:07 volumio sudo[19526]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 20:10' Oct 15 20:11:07 volumio sudo[19526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"