-- Logs begin at Fri 2021-07-02 10:45:33 UTC, end at Tue 2025-04-29 00:46:09 UTC. -- Apr 29 00:45:18 volumio sudo[15203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 00:45:18 volumio sudo[15203]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 00:45:18 volumio sudo[15203]: pam_unix(sudo:session): session closed for user root Apr 29 00:45:18 volumio sudo[15206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 00:45:18 volumio sudo[15206]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 00:45:18 volumio sudo[15206]: pam_unix(sudo:session): session closed for user root Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::volumioGetState Apr 29 00:45:18 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 00:45:18 volumio volumio[1248]: info: Listing playlists Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 29 00:45:18 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 29 00:45:20 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 29 00:45:20 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 29 00:45:22 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 29 00:45:22 volumio volumio[1248]: info: CURURI: albums:// Apr 29 00:45:22 volumio volumio[1248]: listAlbums - loading Albums from cache Apr 29 00:45:22 volumio volumio[1248]: info: CoreCommandRouter::volumioGetQueue Apr 29 00:45:22 volumio volumio[1248]: info: CoreStateMachine::getQueue Apr 29 00:45:22 volumio volumio[1248]: info: CorePlayQueue::getQueue Apr 29 00:45:24 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 29 00:45:33 volumio volumio[1248]: Searching plugin music_service/mpd Apr 29 00:45:33 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 29 00:45:33 volumio volumio[1248]: info: All search sources collected, pushing search results Apr 29 00:45:34 volumio volumio[1248]: Searching plugin music_service/mpd Apr 29 00:45:34 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 29 00:45:34 volumio volumio[1248]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Apr 29 00:45:34 volumio volumio[1248]: info: All search sources collected, pushing search results Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::ClearQueue Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 00:45:35 volumio volumio[1248]: UNSET VOLATILE Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::updateTrackBlock Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrackBlock Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::stPlaybackTimer Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::serviceStop Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::serviceStop Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::stop Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand stop Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::clearPlayQueue Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::saveQueue Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushQueue Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::addQueueItems Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::addQueueItems Apr 29 00:45:35 volumio volumio[1248]: info: Adding Item to queue: albums://Diverse%20System/FIREWORKS. Apr 29 00:45:35 volumio volumio[1248]: info: Exploding uri albums://Diverse%20System/FIREWORKS. in service mpd Apr 29 00:45:35 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:35 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 176 | title: BOW AND ARROW | previous title: BOW AND ARROW Apr 29 00:45:35 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:35 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:35 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:35 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 0 | title: | previous title: BOW AND ARROW Apr 29 00:45:35 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:35 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand stop took 26 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::saveQueue Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushQueue Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::updateTrackBlock Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrackBlock Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPlay Apr 29 00:45:35 volumio volumio[1248]: UNSET VOLATILE Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::play index 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 00:45:35 volumio volumio[1248]: UNSET VOLATILE Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::play index undefined Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::startPlaybackTimer Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::clearAddPlayTracks NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3 Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand stop Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 18 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand stop took 3 milliseconds Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand clear Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:35 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand clear took 19 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 15 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 13 milliseconds Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand add "NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3" Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BOW AND ARROW","artist":"米津玄師","album":"BOW AND ARROW","uri":"NAS/yggdrasill/eonkyo/BOW AND ARROW/01_01_BOW AND ARROW.flac","trackType":"flac"} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: 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} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: 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} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ------------------------------ 83ms Apr 29 00:45:35 volumio volumio[1248]: info: ------------------------------ 58ms Apr 29 00:45:35 volumio volumio[1248]: info: ------------------------------ 55ms Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:35 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:35 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:35 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:35 volumio volumio[1248]: error: updateQueue error: null Apr 29 00:45:35 volumio volumio[1248]: info: Apr 29 00:45:35 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:35 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 57 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 56 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 55 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 56 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 55 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 54 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 54 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 53 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand status took 53 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: ------------------------------ 49ms Apr 29 00:45:35 volumio volumio[1248]: info: sendMpdCommand add "NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3" took 47 milliseconds Apr 29 00:45:35 volumio volumio[1248]: info: ------------------------------ 7ms Apr 29 00:45:35 volumio volumio[1248]: info: ------------------------------ 6ms Apr 29 00:45:35 volumio volumio[1248]: info: ------------------------------ 6ms Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:35 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand play Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: 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} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: 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} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: 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} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: 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} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: 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} Apr 29 00:45:35 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: No code Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:35 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:35 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:35 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: 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} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: No code Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: 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} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: No code Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: 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} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: No code Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: 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} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: No code Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 151ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 150ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 151ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 151ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 150ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 151ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 150ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 150ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 150ms Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 135ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand play took 131 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 34ms Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 33ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 34ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 13ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 12ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 11ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 10ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 9ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 8ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 7ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 6ms Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces system playlist update Apr 29 00:45:36 volumio volumio[1248]: info: Ignoring MPD Status Update Apr 29 00:45:36 volumio volumio[1248]: info: Apr 29 00:45:36 volumio volumio[1248]: ---------------------------- MPD announces state update: player Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::getState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand status Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 27 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 28 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 25 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 24 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 23 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 23ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 22 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 21ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 20 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 19ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 20 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 19ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 18 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 17ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 18 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 13ms Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 72 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 71ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 72 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 71ms Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand status took 71 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 61 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 60 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 61 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 61 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 61 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 61 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 60 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 60 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 61 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 60 milliseconds Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseState Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus stop Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 166ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 165ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 162ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 162ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 160ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 159ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 158ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 157ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 156ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 155ms Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: stop | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] stopping timer, song has ended. Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 325 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 325 milliseconds Apr 29 00:45:36 volumio volumio[1248]: info: sendMpdCommand playlistinfo took 325 milliseconds Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: verbose: ControllerMpd::parseTrackInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ControllerMpd::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::servicePushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"労働ROAD","artist":"Sakuzyo","album":"FIREWORKS.","uri":"NAS/yggdrasill/Music/Diverse System/FIREWORKS_/01 労働ROAD.mp3","trackType":"mp3"} Apr 29 00:45:36 volumio volumio[1248]: verbose: CURRENT POSITION 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState stateService play Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::syncState currentStatus play Apr 29 00:45:36 volumio volumio[1248]: info: Received an update from plugin. extracting info from payload Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: CoreStateMachine::pushState Apr 29 00:45:36 volumio volumio[1248]: info: CorePlayQueue::getTrack 0 Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::volumioPushState Apr 29 00:45:36 volumio volumio[1248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 427ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 426ms Apr 29 00:45:36 volumio volumio[1248]: info: ------------------------------ 425ms Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] using existing timer Apr 29 00:45:36 volumio volumio[1248]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: mpd | duration: 250 | title: 労働ROAD | previous title: 労働ROAD Apr 29 00:45:36 volumio volumio[1248]: info: =================> [timer] is active: false | can continue: false | timer started at: 1745885826716 Apr 29 00:45:36 volumio volumio[1248]: info: Playback detected, evaluating parameters for scrobbling... Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] Updating now playing Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] trying to authenticate... Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] Continuing playback or different song. Apr 29 00:45:36 volumio volumio[1248]: info: [LastFM] timeToPlay for current track: 0 Apr 29 00:45:55 volumio systemd-journal[185]: Suppressed 231 messages from /system.slice/volumio.service Apr 29 00:45:55 volumio volumio[1248]: info: [LastFM] authenticated successfully! Apr 29 00:45:55 volumio volumio[1248]: info: [LastFM] updated "now playing" | artist: Sakuzyo | title: 労働ROAD Apr 29 00:46:08 volumio volumio[1248]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 00:46:08 volumio volumio[1248]: { Error: connect ETIMEDOUT 130.211.19.189:80 Apr 29 00:46:08 volumio volumio[1248]: at Object._errnoException (util.js:1022:11) Apr 29 00:46:08 volumio volumio[1248]: at _exceptionWithHostPort (util.js:1044:20) Apr 29 00:46:08 volumio volumio[1248]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 29 00:46:08 volumio volumio[1248]: code: 'ETIMEDOUT', Apr 29 00:46:08 volumio volumio[1248]: errno: 'ETIMEDOUT', Apr 29 00:46:08 volumio volumio[1248]: syscall: 'connect', Apr 29 00:46:08 volumio volumio[1248]: address: '130.211.19.189', Apr 29 00:46:08 volumio volumio[1248]: port: 80 } Apr 29 00:46:08 volumio volumio[1248]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 00:46:09 volumio sudo[15357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 00:45 Apr 29 00:46:09 volumio sudo[15357]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"