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