-- Logs begin at Tue 2025-06-03 19:20:15 HKT, end at Tue 2025-06-03 19:29:56 HKT. -- Jun 03 19:28:00 volumio volumio[3334]: info: VolumeController::SetAlsaVolume67 Jun 03 19:28:00 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:00 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:28:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:00 volumio volumio[3334]: info: VolumeController::SetAlsaVolume65 Jun 03 19:28:00 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:00 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:28:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:01 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 03 19:28:01 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 03 19:28:03 volumio volumio[3334]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%83%91%E6%B6%A6%E6%B3%BD/%E5%A6%82%E6%9E%9C%E5%91%A2/f248ac7f-0718-4fc4-9282-93e2653fa154.jpg' Jun 03 19:28:03 volumio sudo[4969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 19:28:03 volumio sudo[4969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 19:28:03 volumio sudo[4971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 19:28:03 volumio sudo[4971]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 03 19:28:03 volumio sudo[4969]: pam_unix(sudo:session): session closed for user root Jun 03 19:28:03 volumio sudo[4971]: pam_unix(sudo:session): session closed for user root Jun 03 19:28:03 volumio volumio[3334]: verbose: New Socket.io Connection to 192.168.1.185 from 192.168.1.81 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 10 Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::volumioGetVisibleSources Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 03 19:28:03 volumio volumio[3334]: info: Received Get System Info Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 19:28:03 volumio volumio[3334]: info: Discovery: Getting this device information Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:28:03 volumio volumio[3334]: info: Listing playlists Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 03 19:28:03 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 03 19:28:04 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 03 19:28:05 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 03 19:28:05 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 03 19:28:05 volumio volumio[3334]: info: Received Get System Info Jun 03 19:28:05 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 19:28:05 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 19:28:05 volumio volumio[3334]: info: Discovery: Getting this device information Jun 03 19:28:05 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:28:05 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 19:28:05 volumio volumio[3334]: info: CoreCommandRouter::volumioPlay Jun 03 19:28:05 volumio volumio[3334]: info: CoreStateMachine::play index undefined Jun 03 19:28:05 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:28:05 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:09 volumio volumio[3334]: info: CoreCommandRouter::volumioPlay Jun 03 19:28:09 volumio volumio[3334]: info: CoreStateMachine::play index undefined Jun 03 19:28:09 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:28:09 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:14 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 03 19:28:15 volumio volumio[3334]: info: Clearing queue after UPNP request Jun 03 19:28:15 volumio volumio[3334]: info: CoreStateMachine::ClearQueue Jun 03 19:28:15 volumio volumio[3334]: info: CoreStateMachine::stop Jun 03 19:28:15 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:28:15 volumio volumio[3334]: info: CorePlayQueue::clearPlayQueue Jun 03 19:28:15 volumio volumio[3334]: info: CorePlayQueue::saveQueue Jun 03 19:28:15 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:15 volumio volumio[3334]: info: CoreCommandRouter::volumioPushQueue Jun 03 19:28:15 volumio volumio[3334]: error: Upnp client error: Error: This socket has been ended by the other party Jun 03 19:28:16 volumio volumio[3334]: verbose: New Socket.io Connection to 192.168.1.185 from 192.168.1.81 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 10 Jun 03 19:28:17 volumio volumio[3334]: info: Starting UPNP Playback Jun 03 19:28:17 volumio volumio[3334]: info: Preparing playback through UPNP Jun 03 19:28:17 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:28:17 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:17 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 19:28:18 volumio volumio[3334]: info: Jun 03 19:28:18 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:18 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:18 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:18 volumio volumio[3334]: info: Jun 03 19:28:18 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:18 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:18 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:18 volumio volumio[3334]: info: Jun 03 19:28:18 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:18 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:18 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:18 volumio volumio[3334]: info: Jun 03 19:28:18 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:18 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:18 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:18 volumio volumio[3334]: info: Jun 03 19:28:18 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:18 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:18 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:18 volumio volumio[3334]: info: Jun 03 19:28:18 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:18 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:18 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:28:18 volumio volumio[3334]: info: Jun 03 19:28:18 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:28:18 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:28:18 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:28:18 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 03 19:28:18 volumio volumio[3334]: info: sendMpdCommand status took 10 milliseconds Jun 03 19:28:18 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:28:18 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:28:18 volumio volumio[3334]: info: sendMpdCommand clearerror took 2 milliseconds Jun 03 19:28:18 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 19:28:18 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:28:18 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:28:18 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:28:18 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:18 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:18 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:18 volumio volumio[3334]: 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":"I Love You So","artist":"The Walters","album":"I Love You So","uri":"https://music.163.com/package/aHR0cDovL2VyLnN5Y2RuLmt1d28uY24vMWU3YmUwZGFiZjVmZTZlOTU0NGE3NGEwNjQwMTUyN2UvNjgzZWRjNGYvcmVzb3VyY2UvMzAxMDYvdHJhY2ttZWRpYS9NODAwMDAzbGREbWIyVkRPZncubXAzP2JpdHJhdGU=/1294899297.mp3","trackType":"mp3"} Jun 03 19:28:18 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:28:18 volumio volumio[3334]: info: CoreStateMachine::syncState stateService stop Jun 03 19:28:18 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:28:18 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:18 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:18 volumio volumio[3334]: info: No code Jun 03 19:28:18 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:18 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:18 volumio volumio[3334]: info: ------------------------------ 40ms Jun 03 19:28:18 volumio volumio[3334]: info: Clearing queue after UPNP request Jun 03 19:28:19 volumio volumio[3334]: info: CoreStateMachine::ClearQueue Jun 03 19:28:19 volumio volumio[3334]: info: CoreStateMachine::stop Jun 03 19:28:19 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:28:19 volumio volumio[3334]: info: CorePlayQueue::clearPlayQueue Jun 03 19:28:19 volumio volumio[3334]: info: CorePlayQueue::saveQueue Jun 03 19:28:19 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:19 volumio volumio[3334]: info: CoreCommandRouter::volumioPushQueue Jun 03 19:28:19 volumio volumio[3334]: info: Jun 03 19:28:19 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:19 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:19 volumio volumio[3334]: error: updateQueue error: null Jun 03 19:28:19 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:28:19 volumio volumio[3334]: info: Starting UPNP Playback Jun 03 19:28:19 volumio volumio[3334]: info: Preparing playback through UPNP Jun 03 19:28:19 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:28:19 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:19 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 19:28:19 volumio volumio[3334]: info: Jun 03 19:28:19 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:19 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:19 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:19 volumio volumio[3334]: info: Jun 03 19:28:19 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:19 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:19 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:19 volumio volumio[3334]: info: Jun 03 19:28:19 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:19 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:19 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:19 volumio volumio[3334]: info: Jun 03 19:28:19 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:19 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:19 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:19 volumio volumio[3334]: info: Jun 03 19:28:19 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:19 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:19 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:19 volumio volumio[3334]: info: Jun 03 19:28:19 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:19 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:19 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:20 volumio volumio[3334]: info: Jun 03 19:28:20 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:28:20 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:28:20 volumio volumio[3334]: info: Jun 03 19:28:20 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:28:20 volumio volumio[3334]: info: sendMpdCommand status took 28 milliseconds Jun 03 19:28:20 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:28:20 volumio volumio[3334]: info: sendMpdCommand status took 2 milliseconds Jun 03 19:28:20 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:28:20 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:28:20 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:28:20 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"舍得","artist":"王唯旖","album":"哈NI,非WO陌属","uri":"http://m801.music.126.net/20250603195318/c37d5da574188a8df8d84c24a3a854a6/jdyyaac/545a/550b/025d/c06caedabcbab677d1e057849aadca1c.m4a?vuutv=2F09v5Ts2/nJhjM/Ku5sXXMLsBW1AiIdqD5D9eXyJIuoIzi0apYgwosciMUxixziHARhg+ypUAomduWKpJeNdC7EwHeQicKAyD4oMVW1cU0=","trackType":""} Jun 03 19:28:20 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:28:20 volumio volumio[3334]: info: ------------------------------ 35ms Jun 03 19:28:20 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 03 19:28:20 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:28:20 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:28:20 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:28:20 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"舍得","artist":"王唯旖","album":"哈NI,非WO陌属","uri":"http://m801.music.126.net/20250603195318/c37d5da574188a8df8d84c24a3a854a6/jdyyaac/545a/550b/025d/c06caedabcbab677d1e057849aadca1c.m4a?vuutv=2F09v5Ts2/nJhjM/Ku5sXXMLsBW1AiIdqD5D9eXyJIuoIzi0apYgwosciMUxixziHARhg+ypUAomduWKpJeNdC7EwHeQicKAyD4oMVW1cU0=","trackType":""} Jun 03 19:28:20 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:28:20 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:20 volumio volumio[3334]: info: ------------------------------ 29ms Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:28:20 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:28:20 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:28:20 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:28:20 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:28:27 volumio volumio[3334]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 03 19:28:27 volumio volumio[3334]: info: Retrying Login Due to Network Error Jun 03 19:28:34 volumio volumio[3334]: info: Clearing queue after UPNP request Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::ClearQueue Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::stop Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::updateTrackBlock Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrackBlock Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::serviceStop Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:34 volumio volumio[3334]: info: ControllerMpd::stop Jun 03 19:28:34 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::clearPlayQueue Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::saveQueue Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushQueue Jun 03 19:28:34 volumio volumio[3334]: info: Jun 03 19:28:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:34 volumio volumio[3334]: info: Jun 03 19:28:34 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:28:34 volumio volumio[3334]: info: sendMpdCommand stop took 48 milliseconds Jun 03 19:28:34 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:28:34 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:28:34 volumio volumio[3334]: error: updateQueue error: null Jun 03 19:28:34 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:28:34 volumio volumio[3334]: info: sendMpdCommand status took 1 milliseconds Jun 03 19:28:34 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:28:34 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:34 volumio volumio[3334]: 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} Jun 03 19:28:34 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::syncState stateService stop Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:34 volumio volumio[3334]: info: No code Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:34 volumio volumio[3334]: info: ------------------------------ 39ms Jun 03 19:28:34 volumio volumio[3334]: info: Starting UPNP Playback Jun 03 19:28:34 volumio volumio[3334]: info: Preparing playback through UPNP Jun 03 19:28:34 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:28:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:28:34 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:35 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:35 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:35 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:35 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:35 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 4ms Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:28:35 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:28:35 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:28:35 volumio volumio[3334]: info: Jun 03 19:28:35 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:28:35 volumio volumio[3334]: info: sendMpdCommand status took 9 milliseconds Jun 03 19:28:35 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:28:35 volumio volumio[3334]: info: sendMpdCommand status took 1 milliseconds Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:28:35 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:28:35 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:28:35 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:28:35 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":28226,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??? 1:1??????","artist":"??","album":"?? ??? 1:1??????","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:28:35 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 14ms Jun 03 19:28:35 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 03 19:28:35 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:28:35 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:28:35 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:28:35 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":28226,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??? 1:1??????","artist":"??","album":"?? ??? 1:1??????","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:28:35 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:28:35 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:35 volumio volumio[3334]: info: ------------------------------ 24ms Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:28:35 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:28:35 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:28:35 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:28:35 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:28:37 volumio volumio[3334]: info: MyVolumio login type: Token Jun 03 19:28:41 volumio volumio[3596]: 60 Jun 03 19:28:41 volumio volumio[3596]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 03 19:28:41 volumio volumio[3596]: Dload Upload Total Spent Left Speed Jun 03 19:28:41 volumio volumio[3334]: info: Jun 03 19:28:41 volumio volumio[3334]: ---------------------------- Client requests Volume 60 Jun 03 19:28:41 volumio volumio[3334]: info: VolumeController::SetAlsaVolume60 Jun 03 19:28:41 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:41 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:28:41 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:41 volumio volumio[3596]: [158B blob data] Jun 03 19:28:41 volumio volumio[3596]: {"time":1748950121880,"response":"volume Success"}60 Jun 03 19:28:41 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:28:41 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:28:41 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:28:44 volumio volumio[3334]: info: Jun 03 19:28:44 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:28:44 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:28:44 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:28:44 volumio volumio[3334]: info: sendMpdCommand status took 4 milliseconds Jun 03 19:28:44 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:28:44 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:28:44 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 03 19:28:44 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:28:44 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:28:44 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:28:44 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:28:44 volumio volumio[3334]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":8345,"duration":28226,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"5914 Kbps","isStreaming":false,"title":"??? 1:1??????","artist":"??","album":"?? ??? 1:1??????","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:28:44 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:28:44 volumio volumio[3334]: info: CoreStateMachine::syncState stateService pause Jun 03 19:28:44 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:28:44 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:28:44 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:28:44 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:28:44 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:28:44 volumio volumio[3334]: info: ------------------------------ 18ms Jun 03 19:28:44 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:28:44 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:28:44 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:00 volumio volumio[3334]: info: Clearing queue after UPNP request Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::ClearQueue Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::stop Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::updateTrackBlock Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrackBlock Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::serviceStop Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:00 volumio volumio[3334]: info: ControllerMpd::stop Jun 03 19:29:00 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::clearPlayQueue Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::saveQueue Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushQueue Jun 03 19:29:00 volumio volumio[3334]: info: Jun 03 19:29:00 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:00 volumio volumio[3334]: info: sendMpdCommand stop took 30 milliseconds Jun 03 19:29:00 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:00 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:00 volumio volumio[3334]: info: Jun 03 19:29:00 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:00 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:00 volumio volumio[3334]: info: sendMpdCommand status took 2 milliseconds Jun 03 19:29:00 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:00 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:00 volumio volumio[3334]: 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} Jun 03 19:29:00 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::syncState stateService stop Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:00 volumio volumio[3334]: info: No code Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:00 volumio volumio[3334]: info: ------------------------------ 40ms Jun 03 19:29:00 volumio volumio[3334]: error: updateQueue error: null Jun 03 19:29:00 volumio volumio[3334]: info: ------------------------------ 41ms Jun 03 19:29:00 volumio volumio[3334]: info: Starting UPNP Playback Jun 03 19:29:00 volumio volumio[3334]: info: Preparing playback through UPNP Jun 03 19:29:00 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:29:00 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:00 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 19:29:01 volumio volumio[3334]: info: Jun 03 19:29:01 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:01 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:01 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:01 volumio volumio[3334]: info: Jun 03 19:29:01 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:01 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:01 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:29:01 volumio volumio[3334]: info: Jun 03 19:29:01 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:01 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:01 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:29:01 volumio volumio[3334]: info: Jun 03 19:29:01 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:01 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:01 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:01 volumio volumio[3334]: info: Jun 03 19:29:01 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:01 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:01 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:01 volumio volumio[3334]: info: Jun 03 19:29:01 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:01 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:01 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:29:02 volumio volumio[3334]: info: Jun 03 19:29:02 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:02 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:02 volumio volumio[3334]: info: Jun 03 19:29:02 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:02 volumio volumio[3334]: info: sendMpdCommand status took 8 milliseconds Jun 03 19:29:02 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:02 volumio volumio[3334]: info: sendMpdCommand status took 2 milliseconds Jun 03 19:29:02 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:02 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:02 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:02 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":29700,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:02 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:29:02 volumio volumio[3334]: info: ------------------------------ 15ms Jun 03 19:29:02 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 03 19:29:02 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:02 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:02 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:02 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":29700,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:02 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:02 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:02 volumio volumio[3334]: info: ------------------------------ 30ms Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:02 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:02 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:02 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:02 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:04 volumio volumio[3596]: 55 Jun 03 19:29:04 volumio volumio[3596]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 03 19:29:04 volumio volumio[3596]: Dload Upload Total Spent Left Speed Jun 03 19:29:04 volumio volumio[3334]: info: Jun 03 19:29:04 volumio volumio[3334]: ---------------------------- Client requests Volume 55 Jun 03 19:29:04 volumio volumio[3334]: info: VolumeController::SetAlsaVolume55 Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:04 volumio volumio[3596]: [158B blob data] Jun 03 19:29:04 volumio volumio[3596]: {"time":1748950144115,"response":"volume Success"}55 Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:04 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:04 volumio volumio[3596]: 50 Jun 03 19:29:04 volumio volumio[3596]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 03 19:29:04 volumio volumio[3596]: Dload Upload Total Spent Left Speed Jun 03 19:29:04 volumio volumio[3334]: info: Jun 03 19:29:04 volumio volumio[3334]: ---------------------------- Client requests Volume 50 Jun 03 19:29:04 volumio volumio[3334]: info: VolumeController::SetAlsaVolume50 Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:04 volumio volumio[3596]: [158B blob data] Jun 03 19:29:04 volumio volumio[3596]: {"time":1748950144370,"response":"volume Success"}50 Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:04 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:04 volumio volumio[3334]: info: Jun 03 19:29:04 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:04 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:04 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:04 volumio volumio[3334]: info: sendMpdCommand status took 0 milliseconds Jun 03 19:29:04 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:04 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:04 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 03 19:29:04 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:04 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:04 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:04 volumio volumio[3334]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2868,"duration":29700,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"1407 Kbps","isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:04 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::syncState stateService pause Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:29:04 volumio volumio[3334]: info: ------------------------------ 16ms Jun 03 19:29:04 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:04 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:04 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:07 volumio volumio[3334]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 03 19:29:07 volumio volumio[3334]: info: Retrying Login Due to Network Error Jun 03 19:29:09 volumio volumio[3334]: info: Jun 03 19:29:09 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:09 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:09 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:09 volumio volumio[3334]: info: sendMpdCommand status took 2 milliseconds Jun 03 19:29:09 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:09 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:09 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 03 19:29:09 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:09 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:09 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:09 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:09 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3642,"duration":29700,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"3772 Kbps","isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:09 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:09 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:09 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:09 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:29:09 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:29:09 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:09 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:09 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:09 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:09 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:09 volumio volumio[3334]: info: ------------------------------ 26ms Jun 03 19:29:09 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:09 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:09 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:09 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:09 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:09 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:10 volumio volumio[3334]: info: Jun 03 19:29:10 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:10 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:10 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:10 volumio volumio[3334]: info: sendMpdCommand status took 1 milliseconds Jun 03 19:29:10 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:10 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:10 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 03 19:29:10 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:10 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:10 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:10 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:10 volumio volumio[3334]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4371,"duration":29700,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"2566 Kbps","isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:10 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:10 volumio volumio[3334]: info: CoreStateMachine::syncState stateService pause Jun 03 19:29:10 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:10 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:10 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:10 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:10 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:29:10 volumio volumio[3334]: info: ------------------------------ 14ms Jun 03 19:29:10 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:10 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:10 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:11 volumio volumio[3334]: info: Jun 03 19:29:11 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:11 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:11 volumio volumio[3334]: info: sendMpdCommand status took 4 milliseconds Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:11 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:11 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:11 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:11 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5145,"duration":29700,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"212 Kbps","isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:11 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:11 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:11 volumio volumio[3334]: info: ------------------------------ 25ms Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:11 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:11 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:11 volumio volumio[3334]: info: Jun 03 19:29:11 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:11 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:11 volumio volumio[3334]: info: sendMpdCommand status took 1 milliseconds Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:11 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 19:29:11 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:11 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:11 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:11 volumio volumio[3334]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5782,"duration":29700,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"212 Kbps","isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:11 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::syncState stateService pause Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:29:11 volumio volumio[3334]: info: ------------------------------ 15ms Jun 03 19:29:11 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:11 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:11 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:17 volumio volumio[3334]: info: MyVolumio login type: Token Jun 03 19:29:33 volumio volumio[3334]: info: Jun 03 19:29:33 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:33 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:33 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:33 volumio volumio[3334]: info: sendMpdCommand status took 1 milliseconds Jun 03 19:29:33 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:33 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:33 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 19:29:33 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:33 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:33 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:33 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:33 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:33 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:33 volumio volumio[3334]: 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":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:33 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:33 volumio volumio[3334]: info: CoreStateMachine::syncState stateService stop Jun 03 19:29:33 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:33 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:33 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:29:33 volumio volumio[3334]: info: ------------------------------ 20ms Jun 03 19:29:33 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:33 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:33 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:34 volumio volumio[3334]: info: Clearing queue after UPNP request Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::ClearQueue Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::stop Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:29:34 volumio volumio[3334]: info: CorePlayQueue::clearPlayQueue Jun 03 19:29:34 volumio volumio[3334]: info: CorePlayQueue::saveQueue Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushQueue Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:34 volumio volumio[3334]: error: updateQueue error: null Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 3ms Jun 03 19:29:34 volumio volumio[3334]: info: Starting UPNP Playback Jun 03 19:29:34 volumio volumio[3334]: info: Preparing playback through UPNP Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:29:34 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 3ms Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 2ms Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:34 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:34 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:34 volumio volumio[3334]: info: Jun 03 19:29:34 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:34 volumio volumio[3334]: info: sendMpdCommand status took 4 milliseconds Jun 03 19:29:34 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:34 volumio volumio[3334]: info: sendMpdCommand status took 1 milliseconds Jun 03 19:29:34 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:34 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:34 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:34 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4856,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:34 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 8ms Jun 03 19:29:34 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 03 19:29:34 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:34 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:34 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:34 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":4856,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:34 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:34 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:34 volumio volumio[3334]: info: ------------------------------ 22ms Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:34 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:34 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:34 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:34 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:39 volumio volumio[3334]: info: Jun 03 19:29:39 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:39 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:39 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:39 volumio volumio[3334]: info: sendMpdCommand status took 0 milliseconds Jun 03 19:29:39 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:39 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:39 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 03 19:29:39 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:39 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:39 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:39 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:39 volumio volumio[3334]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1331,"duration":4856,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"未知","artist":"未知","album":"未知专辑","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:39 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:39 volumio volumio[3334]: info: CoreStateMachine::syncState stateService pause Jun 03 19:29:39 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:39 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:39 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:39 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:39 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:29:39 volumio volumio[3334]: info: ------------------------------ 13ms Jun 03 19:29:39 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:39 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:39 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:47 volumio volumio[3334]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 03 19:29:47 volumio volumio[3334]: info: Retrying Login Due to Network Error Jun 03 19:29:50 volumio volumio[3334]: info: Clearing queue after UPNP request Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::ClearQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::stop Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::stPlaybackTimer Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::updateTrackBlock Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrackBlock Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::serviceStop Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::stop Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::clearPlayQueue Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::saveQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushQueue Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand stop took 20 milliseconds Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand status took 2 milliseconds Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:51 volumio volumio[3334]: 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} Jun 03 19:29:51 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState stateService stop Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: No code Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 40ms Jun 03 19:29:51 volumio volumio[3334]: error: updateQueue error: null Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 41ms Jun 03 19:29:51 volumio volumio[3334]: info: Starting UPNP Playback Jun 03 19:29:51 volumio volumio[3334]: info: Preparing playback through UPNP Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioGetState Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getTrack 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 1ms Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand status took 7 milliseconds Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand status took 1 milliseconds Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:51 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:51 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"二两仙","artist":"王若熙","album":"01.网络前沿流行热歌榜单","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:51 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:51 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:51 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"二两仙","artist":"王若熙","album":"01.网络前沿流行热歌榜单","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:51 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:51 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 47ms Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 49ms Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces system playlist update Jun 03 19:29:51 volumio volumio[3334]: info: Ignoring MPD Status Update Jun 03 19:29:51 volumio volumio[3334]: info: Jun 03 19:29:51 volumio volumio[3334]: ---------------------------- MPD announces state update: player Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::getState Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 6ms Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand status took 5 milliseconds Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::parseState Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:29:51 volumio volumio[3334]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 19:29:51 volumio volumio[3334]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:29:51 volumio volumio[3334]: info: ControllerMpd::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::servicePushState Jun 03 19:29:51 volumio volumio[3334]: verbose: In UPNP mode Jun 03 19:29:51 volumio volumio[3334]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":206,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"二两仙","artist":"王若熙","album":"01.网络前沿流行热歌榜单","uri":"http://192.168.1.81:61323/mp3?filepath=%2Fdata%2Fuser%2F0%2Fcom.netease.cloudmusic%2Ffiles%2F%E4%B8%B4%E6%97%B6%E6%96%87%E4%BB%B6&decode=false","trackType":""} Jun 03 19:29:51 volumio volumio[3334]: verbose: CURRENT POSITION 0 Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState stateService play Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:29:51 volumio volumio[3334]: info: Received an update from plugin. extracting info from payload Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::pushState Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioPushState Jun 03 19:29:51 volumio volumio[3334]: info: ------------------------------ 45ms Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreCommandRouter::volumioGetQueue Jun 03 19:29:51 volumio volumio[3334]: info: CoreStateMachine::getQueue Jun 03 19:29:51 volumio volumio[3334]: info: CorePlayQueue::getQueue Jun 03 19:29:55 volumio ntpd[1234]: 185.209.85.222 local addr 192.168.1.185 -> Jun 03 19:29:56 volumio volumio[3334]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 19:29:56 volumio volumio[3334]: Error: connect ETIMEDOUT 173.252.108.3:443 Jun 03 19:29:56 volumio volumio[3334]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 03 19:29:56 volumio volumio[3334]: errno: -110, Jun 03 19:29:56 volumio volumio[3334]: code: 'ETIMEDOUT', Jun 03 19:29:56 volumio volumio[3334]: syscall: 'connect', Jun 03 19:29:56 volumio volumio[3334]: address: '173.252.108.3', Jun 03 19:29:56 volumio volumio[3334]: port: 443 Jun 03 19:29:56 volumio volumio[3334]: } Jun 03 19:29:56 volumio volumio[3334]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 19:29:56 volumio sudo[5718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-03 19:28 Jun 03 19:29:56 volumio sudo[5718]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"