-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sat 2025-07-19 23:05:00 CST. -- Jul 19 23:04:03 volumio sudo[2974]: pam_unix(sudo:session): session closed for user root Jul 19 23:04:05 volumio volumio[870]: info: CoreCommandRouter::volumioPause Jul 19 23:04:05 volumio volumio[870]: info: CoreStateMachine::pause Jul 19 23:04:05 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:05 volumio volumio[870]: info: CoreStateMachine::servicePause Jul 19 23:04:05 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:05 volumio volumio[870]: info: Error: no service or no trackblock to pause Jul 19 23:04:06 volumio volumio[870]: info: CoreCommandRouter::volumioPause Jul 19 23:04:06 volumio volumio[870]: info: CoreStateMachine::pause Jul 19 23:04:07 volumio volumio[870]: info: CoreCommandRouter::volumioPause Jul 19 23:04:07 volumio volumio[870]: info: CoreStateMachine::pause Jul 19 23:04:14 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:14 volumio sudo[3059]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Jul 19 23:04:14 volumio sudo[3059]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 23:04:16 volumio volumio[870]: info: Jul 19 23:04:16 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:16 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:16 volumio volumio[870]: info: Jul 19 23:04:16 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:16 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:16 volumio volumio[870]: info: Jul 19 23:04:16 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:16 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:16 volumio volumio[870]: info: Jul 19 23:04:16 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:16 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:16 volumio volumio[870]: info: sendMpdCommand status took 4 milliseconds Jul 19 23:04:16 volumio volumio[870]: info: sendMpdCommand status took 3 milliseconds Jul 19 23:04:16 volumio volumio[870]: info: sendMpdCommand status took 2 milliseconds Jul 19 23:04:16 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:16 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:16 volumio volumio[870]: 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} Jul 19 23:04:16 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:16 volumio volumio[870]: 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} Jul 19 23:04:16 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:16 volumio volumio[870]: 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} Jul 19 23:04:16 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: ------------------------------ 72ms Jul 19 23:04:16 volumio volumio[870]: info: ------------------------------ 71ms Jul 19 23:04:16 volumio volumio[870]: info: ------------------------------ 70ms Jul 19 23:04:16 volumio volumio[870]: info: sendMpdCommand status took 71 milliseconds Jul 19 23:04:16 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:16 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:16 volumio volumio[870]: 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} Jul 19 23:04:16 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:16 volumio volumio[870]: info: ------------------------------ 103ms Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:16 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:16 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:17 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 7 Jul 19 23:04:17 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:20 volumio volumio[870]: info: Clearing queue after UPNP request Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::ClearQueue Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::stop Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::updateTrackBlock Jul 19 23:04:20 volumio volumio[870]: info: CorePlayQueue::getTrackBlock Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:20 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:20 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 23:04:20 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::serviceStop Jul 19 23:04:20 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:20 volumio volumio[870]: info: ControllerMpd::stop Jul 19 23:04:20 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 23:04:20 volumio volumio[870]: info: CorePlayQueue::clearPlayQueue Jul 19 23:04:20 volumio volumio[870]: info: CorePlayQueue::saveQueue Jul 19 23:04:20 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:20 volumio volumio[870]: info: CoreCommandRouter::volumioPushQueue Jul 19 23:04:20 volumio volumio[870]: info: Jul 19 23:04:20 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:20 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:20 volumio volumio[870]: info: sendMpdCommand stop took 38 milliseconds Jul 19 23:04:20 volumio volumio[870]: info: Jul 19 23:04:20 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:20 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:20 volumio volumio[870]: info: Jul 19 23:04:20 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:20 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:20 volumio volumio[870]: info: Jul 19 23:04:20 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:20 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:20 volumio volumio[870]: error: updateQueue error: null Jul 19 23:04:20 volumio volumio[870]: error: updateQueue error: null Jul 19 23:04:20 volumio volumio[870]: error: updateQueue error: null Jul 19 23:04:20 volumio volumio[870]: error: updateQueue error: null Jul 19 23:04:20 volumio volumio[870]: info: ------------------------------ 11ms Jul 19 23:04:20 volumio volumio[870]: info: ------------------------------ 9ms Jul 19 23:04:20 volumio volumio[870]: info: ------------------------------ 8ms Jul 19 23:04:20 volumio volumio[870]: info: ------------------------------ 7ms Jul 19 23:04:20 volumio volumio[870]: info: Starting UPNP Playback Jul 19 23:04:20 volumio volumio[870]: info: Preparing playback through UPNP Jul 19 23:04:20 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:20 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:20 volumio volumio[870]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 19 23:04:20 volumio sudo[3059]: pam_unix(sudo:session): session closed for user root Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 5ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 5ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 5ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 7ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 9ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 7ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 2ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:21 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 5ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 2ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 27 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 29 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 27 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 27 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 4 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 35ms Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: info: Jul 19 23:04:21 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 9 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 4 milliseconds Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:21 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:21 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:21 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:21 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 141ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 141ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 118ms Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand status took 109 milliseconds Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand playlistinfo took 105 milliseconds Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:21 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:21 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 174ms Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 169ms Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: sendMpdCommand playlistinfo took 112 milliseconds Jul 19 23:04:21 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:21 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:21 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:21 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:21 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:21 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:21 volumio volumio[870]: info: ------------------------------ 243ms Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:21 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:21 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:31 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:31 volumio sudo[3191]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Jul 19 23:04:31 volumio sudo[3191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 23:04:35 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 7 Jul 19 23:04:35 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:35 volumio volumio[870]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E9%9B%A8%E7%94%9F/%E5%A4%A7%E6%B5%B7/38e9da6e-0a1d-4485-a87d-9c48435b0d3b.png' Jul 19 23:04:35 volumio sudo[3191]: pam_unix(sudo:session): session closed for user root Jul 19 23:04:42 volumio volumio[870]: info: Adding http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE= to favourites using generic method Jul 19 23:04:42 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , lsInfo Jul 19 23:04:42 volumio volumio[870]: error: Failed LSINFO: Error: [52@0] {lsinfo} Failed to access /m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=: No such file or directory Jul 19 23:04:42 volumio volumio[870]: info: Saving local item favourites Jul 19 23:04:42 volumio volumio[870]: info: Pushing Favourites {"uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","favourite":false} Jul 19 23:04:46 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:46 volumio sudo[3275]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Jul 19 23:04:46 volumio sudo[3275]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 23:04:47 volumio volumio[870]: info: CoreCommandRouter::volumioPause Jul 19 23:04:47 volumio volumio[870]: info: CoreStateMachine::pause Jul 19 23:04:47 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:47 volumio volumio[870]: info: CoreStateMachine::servicePause Jul 19 23:04:47 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:47 volumio volumio[870]: info: Error: no service or no trackblock to pause Jul 19 23:04:49 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 7 Jul 19 23:04:49 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:49 volumio volumio[870]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E9%9B%A8%E7%94%9F/%E5%A4%A7%E6%B5%B7/38e9da6e-0a1d-4485-a87d-9c48435b0d3b.png' Jul 19 23:04:50 volumio volumio[870]: info: Jul 19 23:04:50 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:50 volumio volumio[870]: info: Jul 19 23:04:50 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:50 volumio volumio[870]: info: Jul 19 23:04:50 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:50 volumio volumio[870]: info: Jul 19 23:04:50 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:50 volumio volumio[870]: info: sendMpdCommand status took 4 milliseconds Jul 19 23:04:50 volumio volumio[870]: info: sendMpdCommand status took 4 milliseconds Jul 19 23:04:50 volumio volumio[870]: info: sendMpdCommand status took 3 milliseconds Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:50 volumio volumio[870]: info: sendMpdCommand status took 5 milliseconds Jul 19 23:04:50 volumio volumio[870]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 19 23:04:50 volumio volumio[870]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:50 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:50 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29698,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:50 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:50 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:50 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29698,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:50 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:50 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:50 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29698,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:50 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:50 volumio volumio[870]: info: ------------------------------ 46ms Jul 19 23:04:50 volumio volumio[870]: info: ------------------------------ 44ms Jul 19 23:04:50 volumio volumio[870]: info: ------------------------------ 44ms Jul 19 23:04:50 volumio volumio[870]: info: sendMpdCommand playlistinfo took 37 milliseconds Jul 19 23:04:50 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:50 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:50 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:50 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":29698,"duration":30,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"大海","artist":"张雨生","album":"大海","uri":"http://m702.music.126.net/20250719232920/e6a036f90fc9fb71b262f1d4067410a8/jd-musicrep-ts/5c51/2a9e/a06f/20c0c4b40a080934f1afd3a1fa36e643.mp3?vuutv=1rwo8e5vlooHrPJIwXYGzIltONrHY4SA6OAyaokrdXfN89YMhvpTrHhNr53L6HUDwoqqKzXk0KK8Hl65wdgFSbhH7/hjpQfa/LI6vdhAwHE=","trackType":""} Jul 19 23:04:50 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus pause Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:50 volumio volumio[870]: info: ------------------------------ 61ms Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:50 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:50 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:50 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:50 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:50 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:50 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:50 volumio screensaver.sh[604]: pygame 1.9.4.post1 Jul 19 23:04:50 volumio screensaver.sh[604]: Hello from the pygame community. https://www.pygame.org/contribute.html Jul 19 23:04:50 volumio sudo[3275]: pam_unix(sudo:session): session closed for user root Jul 19 23:04:52 volumio volumio[870]: info: Clearing queue after UPNP request Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::ClearQueue Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::updateTrackBlock Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrackBlock Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::serviceStop Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::stop Jul 19 23:04:53 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::clearPlayQueue Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::saveQueue Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushQueue Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:53 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:53 volumio volumio[870]: info: sendMpdCommand stop took 62 milliseconds Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:53 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:53 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:53 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:53 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:53 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:53 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:53 volumio volumio[870]: info: Jul 19 23:04:53 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:53 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:53 volumio volumio[870]: error: updateQueue error: null Jul 19 23:04:53 volumio volumio[870]: error: updateQueue error: null Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 12ms Jul 19 23:04:53 volumio volumio[870]: info: sendMpdCommand status took 10 milliseconds Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 10ms Jul 19 23:04:53 volumio volumio[870]: info: sendMpdCommand status took 8 milliseconds Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 7ms Jul 19 23:04:53 volumio volumio[870]: info: sendMpdCommand status took 6 milliseconds Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:53 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: 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} Jul 19 23:04:53 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: No code Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: 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} Jul 19 23:04:53 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: No code Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: 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} Jul 19 23:04:53 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: No code Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 95ms Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 92ms Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 91ms Jul 19 23:04:53 volumio volumio[870]: info: sendMpdCommand status took 91 milliseconds Jul 19 23:04:53 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:53 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: 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} Jul 19 23:04:53 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState stateService stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: No code Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:53 volumio volumio[870]: info: ------------------------------ 120ms Jul 19 23:04:53 volumio volumio[870]: info: Starting UPNP Playback Jul 19 23:04:53 volumio volumio[870]: info: Preparing playback through UPNP Jul 19 23:04:53 volumio volumio[870]: info: CoreCommandRouter::volumioGetState Jul 19 23:04:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:53 volumio volumio[870]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 5ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 2ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 7ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 5ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 10ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 8ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 7ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces system playlist update Jul 19 23:04:54 volumio volumio[870]: info: Ignoring MPD Status Update Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 6ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 5ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 4ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 3ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 33 milliseconds Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 36 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 34 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 32 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 51ms Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: Jul 19 23:04:54 volumio volumio[870]: ---------------------------- MPD announces state update: player Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::getState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 14 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 4 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 3 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand status took 2 milliseconds Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseState Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:54 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:54 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:54 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 122ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 120ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 117ms Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 72 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 71 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 70 milliseconds Jul 19 23:04:54 volumio volumio[870]: info: sendMpdCommand playlistinfo took 71 milliseconds Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:54 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:54 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:54 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:54 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: ControllerMpd::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::servicePushState Jul 19 23:04:54 volumio volumio[870]: verbose: In UPNP mode Jul 19 23:04:54 volumio volumio[870]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"你走以后1.0","artist":"王恩信Est/二胖u（王訫）","album":"你走以后1.0","uri":"http://m701.music.126.net/20250719232952/36de785347af6f4365cf81ae0b748d31/jdymusic/obj/wo3DlMOGwrbDjj7DisKw/14096440897/5f97/baad/b1ca/ee663d597519bc9bc418e152c4041d9e.mp3?vuutv=YrbrXMip+EqtfXvxnb0JAkKwu/OLVgZCw6pT5tcHgNX1EbWBQdrCp+AAbxaX8uAcr40NkcBtratyyVm8efNvxNcMurwg5j75e+fd4cUFapM=","trackType":""} Jul 19 23:04:54 volumio volumio[870]: verbose: CURRENT POSITION 0 Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState stateService play Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus play Jul 19 23:04:54 volumio volumio[870]: info: Received an update from plugin. extracting info from payload Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::pushState Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioPushState Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 173ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 160ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 160ms Jul 19 23:04:54 volumio volumio[870]: info: ------------------------------ 160ms Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue Jul 19 23:04:54 volumio volumio[870]: info: CoreStateMachine::getQueue Jul 19 23:04:54 volumio volumio[870]: info: CorePlayQueue::getQueue Jul 19 23:04:57 volumio volumio[870]: info: CoreCommandRouter::volumioPause Jul 19 23:04:57 volumio volumio[870]: info: CoreStateMachine::pause Jul 19 23:04:57 volumio volumio[870]: info: CoreStateMachine::stPlaybackTimer Jul 19 23:04:57 volumio volumio[870]: info: CoreStateMachine::servicePause Jul 19 23:04:57 volumio volumio[870]: info: CorePlayQueue::getTrack 0 Jul 19 23:04:57 volumio volumio[870]: info: Error: no service or no trackblock to pause Jul 19 23:04:58 volumio volumio[870]: info: CoreCommandRouter::volumioPause Jul 19 23:04:58 volumio volumio[870]: info: CoreStateMachine::pause Jul 19 23:04:58 volumio volumio[870]: info: CoreCommandRouter::volumioPause Jul 19 23:04:58 volumio volumio[870]: info: CoreStateMachine::pause Jul 19 23:05:00 volumio volumio[870]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 23:05:00 volumio volumio[870]: Error: connect ETIMEDOUT 31.13.95.34:443 Jul 19 23:05:00 volumio volumio[870]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 19 23:05:00 volumio volumio[870]: errno: -110, Jul 19 23:05:00 volumio volumio[870]: code: 'ETIMEDOUT', Jul 19 23:05:00 volumio volumio[870]: syscall: 'connect', Jul 19 23:05:00 volumio volumio[870]: address: '31.13.95.34', Jul 19 23:05:00 volumio volumio[870]: port: 443 Jul 19 23:05:00 volumio volumio[870]: } Jul 19 23:05:00 volumio volumio[870]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 23:05:00 volumio sudo[3372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-19 23:04 Jul 19 23:05:00 volumio sudo[3372]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"