-- Logs begin at Thu 2024-05-09 13:26:17 UTC, end at Sat 2024-05-11 10:59:09 UTC. --
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPause
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreStateMachine::pause
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreStateMachine::stPlaybackTimer
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreStateMachine::servicePause
May 11 10:58:01 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 5
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePause
May 11 10:58:01 alexandria-audio volumio[13682]: info: ControllerMpd::pause
May 11 10:58:01 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand pause
May 11 10:58:01 alexandria-audio volumio[13682]: info:
May 11 10:58:01 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:58:01 alexandria-audio volumio[13682]: info: sendMpdCommand pause took 99 milliseconds
May 11 10:58:01 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:58:01 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:58:01 alexandria-audio volumio[13682]: info: sendMpdCommand status took 1 milliseconds
May 11 10:58:01 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:58:01 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:58:01 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 11 10:58:01 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:58:01 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:58:01 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 5
May 11 10:58:01 alexandria-audio volumio[13682]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":163352,"duration":259,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Photograph","artist":"Ed Sheeran","album":"x","uri":"INTERNAL/Albums/Ed Sheeran - x/06 Photograph.aif","trackType":"aif"}
May 11 10:58:01 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 5
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService pause
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus pause
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:01 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 5
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:01 alexandria-audio volumio[13682]: info: CoreStateMachine::stPlaybackTimer
May 11 10:58:01 alexandria-audio volumio[13682]: info: ------------------------------ 95ms
May 11 10:58:34 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 11 10:58:34 alexandria-audio volumio[13682]: info: CURURI: music-library/INTERNAL/Albums
May 11 10:58:36 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 11 10:58:36 alexandria-audio volumio[13682]: info: CURURI: music-library/INTERNAL/AA Setup Tracks
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::ClearQueue
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::stop
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:58:37 alexandria-audio volumio[13682]: verbose: UNSET VOLATILE
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::updateTrackBlock
May 11 10:58:37 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrackBlock
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::stPlaybackTimer
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:37 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 5
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::serviceStop
May 11 10:58:37 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 5
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreCommandRouter::serviceStop
May 11 10:58:37 alexandria-audio volumio[13682]: info: ControllerMpd::stop
May 11 10:58:37 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand stop
May 11 10:58:37 alexandria-audio volumio[13682]: info: CorePlayQueue::clearPlayQueue
May 11 10:58:37 alexandria-audio volumio[13682]: info: CorePlayQueue::saveQueue
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushQueue
May 11 10:58:37 alexandria-audio volumio[13682]: info: CoreStateMachine::addQueueItems
May 11 10:58:37 alexandria-audio volumio[13682]: info: CorePlayQueue::addQueueItems
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/02 - Phase Test.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/02 - Phase Test.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/03 - L to R Instrument.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/03 - L to R Instrument.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/04 - Male Voice.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/04 - Male Voice.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/05 - Female Voice.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/05 - Female Voice.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/06 - Symphony no. 8 - Dynamic Contrast.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/06 - Symphony no. 8 - Dynamic Contrast.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/07 - Symphony no. 4 - Harmonics Flow.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/07 - Symphony no. 4 - Harmonics Flow.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/08 - Omnimic Mono Short Sine Sweep.m4a
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/08 - Omnimic Mono Short Sine Sweep.m4a in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/09 - Omnimic Left.m4a
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/09 - Omnimic Left.m4a in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/10 - Omnimic Right.m4a
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/10 - Omnimic Right.m4a in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/11 - Deep Bass Test.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/11 - Deep Bass Test.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/12 - Violin Test.wav
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/12 - Violin Test.wav in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac in service mpd
May 11 10:58:37 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/13 - System Burn In.flac
May 11 10:58:37 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/13 - System Burn In.flac in service mpd
May 11 10:58:38 alexandria-audio volumio[13682]: info:
May 11 10:58:38 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F02%20-%20Phase%20Test.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/02 - Phase Test.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F03%20-%20L%20to%20R%20Instrument.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/03 - L to R Instrument.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F04%20%20-%20%20Male%20Voice.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/04 - Male Voice.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F05%20-%20Female%20Voice.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/05 - Female Voice.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F06%20-%20Symphony%20no.%208%20-%20Dynamic%20Contrast.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/06 - Symphony no. 8 - Dynamic Contrast.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F07%20-%20Symphony%20no.%204%20-%20Harmonics%20Flow.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/07 - Symphony no. 4 - Harmonics Flow.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F08%20-%20Omnimic%20Mono%20Short%20Sine%20Sweep.m4a&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/08 - Omnimic Mono Short Sine Sweep.m4a
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F09%20-%20Omnimic%20Left.m4a&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/09 - Omnimic Left.m4a
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F10%20-%20Omnimic%20Right.m4a&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/10 - Omnimic Right.m4a
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F11%20-%20Deep%20Bass%20Test.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/11 - Deep Bass Test.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F12%20-%20Violin%20Test.wav&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/12 - Violin Test.wav
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=Various%20Artist/XLO%20%26%20Reference%20Recordings%20Test%20And%20Burn-In%20CD/medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F01%20-%20L%20R%20Channel%20Test.flac&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac
May 11 10:58:38 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=Various%20Artist/XLO%20%26%20Reference%20Recordings%20Test%20And%20Burn-In%20CD/medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F13%20-%20System%20Burn%20In.flac&metadata=false
May 11 10:58:38 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/13 - System Burn In.flac
May 11 10:58:38 alexandria-audio volumio[13682]: info: sendMpdCommand stop took 1082 milliseconds
May 11 10:58:38 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:58:38 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:58:38 alexandria-audio volumio[13682]: info: CorePlayQueue::saveQueue
May 11 10:58:38 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushQueue
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::updateTrackBlock
May 11 10:58:39 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrackBlock
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPlay
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: UNSET VOLATILE
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::play index 0
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::stop
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: UNSET VOLATILE
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::play index undefined
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:58:39 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::startPlaybackTimer
May 11 10:58:39 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/AA Setup Tracks/02 - Phase Test.wav
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand stop
May 11 10:58:39 alexandria-audio volumio[13682]: info: sendMpdCommand status took 316 milliseconds
May 11 10:58:39 alexandria-audio volumio[13682]: info: sendMpdCommand stop took 269 milliseconds
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand clear
May 11 10:58:39 alexandria-audio volumio[13682]: info:
May 11 10:58:39 alexandria-audio volumio[13682]: ---------------------------- MPD announces system playlist update
May 11 10:58:39 alexandria-audio volumio[13682]: info: Ignoring MPD Status Update
May 11 10:58:39 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 69 milliseconds
May 11 10:58:39 alexandria-audio volumio[13682]: info: sendMpdCommand clear took 69 milliseconds
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/AA Setup Tracks/02 - Phase Test.wav"
May 11 10:58:39 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:39 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:39 alexandria-audio volumio[13682]: 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":"Photograph","artist":"Ed Sheeran","album":"x","uri":"INTERNAL/Albums/Ed Sheeran - x/06 Photograph.aif","trackType":"aif"}
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 0
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService stop
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus stop
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:39 alexandria-audio volumio[13682]: info: No code
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:39 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:39 alexandria-audio volumio[13682]: info: ------------------------------ 556ms
May 11 10:58:39 alexandria-audio volumio[13682]: error: updateQueue error: null
May 11 10:58:39 alexandria-audio volumio[13682]: info:
May 11 10:58:39 alexandria-audio volumio[13682]: ---------------------------- MPD announces system playlist update
May 11 10:58:39 alexandria-audio volumio[13682]: info: Ignoring MPD Status Update
May 11 10:58:39 alexandria-audio volumio[13682]: info: ------------------------------ 230ms
May 11 10:58:39 alexandria-audio volumio[13682]: info: sendMpdCommand add "INTERNAL/AA Setup Tracks/02 - Phase Test.wav" took 229 milliseconds
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand play
May 11 10:58:39 alexandria-audio volumio[13682]: info:
May 11 10:58:39 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:58:39 alexandria-audio volumio[13682]: info: ------------------------------ 121ms
May 11 10:58:39 alexandria-audio volumio[13682]: info: sendMpdCommand play took 120 milliseconds
May 11 10:58:39 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:58:39 alexandria-audio volumio[13682]: info:
May 11 10:58:39 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:58:39 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:58:39 alexandria-audio volumio[13682]: info: sendMpdCommand status took 54 milliseconds
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:58:39 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioGetState
May 11 10:58:40 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:40 alexandria-audio volumio[13682]: info: VolumeController::SetAlsaVolume90
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:40 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:40 alexandria-audio volumio[13682]: info: sendMpdCommand status took 900 milliseconds
May 11 10:58:40 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 900 milliseconds
May 11 10:58:40 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:58:40 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:58:40 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:58:40 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:58:40 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:40 alexandria-audio volumio[13682]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Phase Test.wav","artist":null,"album":null,"uri":"INTERNAL/AA Setup Tracks/02 - Phase Test.wav","trackType":"wav"}
May 11 10:58:40 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 0
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService play
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus stop
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:40 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:40 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:40 alexandria-audio volumio[13682]: info: ------------------------------ 1015ms
May 11 10:58:41 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 436 milliseconds
May 11 10:58:41 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:58:41 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:58:41 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:41 alexandria-audio volumio[13682]: verbose: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Phase Test.wav","artist":null,"album":null,"uri":"INTERNAL/AA Setup Tracks/02 - Phase Test.wav","trackType":"wav"}
May 11 10:58:41 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 0
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService play
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus play
May 11 10:58:41 alexandria-audio volumio[13682]: info: Received an update from plugin. extracting info from payload
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:41 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:58:41 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:58:41 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:58:41 alexandria-audio volumio[13682]: info: ------------------------------ 1437ms
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::ClearQueue
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::stop
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:59:02 alexandria-audio volumio[13682]: verbose: UNSET VOLATILE
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::stPlaybackTimer
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::updateTrackBlock
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrackBlock
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::serviceStop
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 0
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::serviceStop
May 11 10:59:02 alexandria-audio volumio[13682]: info: ControllerMpd::stop
May 11 10:59:02 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand stop
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::clearPlayQueue
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::saveQueue
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushQueue
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::addQueueItems
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::addQueueItems
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/02 - Phase Test.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/02 - Phase Test.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/03 - L to R Instrument.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/03 - L to R Instrument.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/04 - Male Voice.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/04 - Male Voice.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/05 - Female Voice.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/05 - Female Voice.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/06 - Symphony no. 8 - Dynamic Contrast.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/06 - Symphony no. 8 - Dynamic Contrast.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/07 - Symphony no. 4 - Harmonics Flow.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/07 - Symphony no. 4 - Harmonics Flow.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/08 - Omnimic Mono Short Sine Sweep.m4a
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/08 - Omnimic Mono Short Sine Sweep.m4a in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/09 - Omnimic Left.m4a
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/09 - Omnimic Left.m4a in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/10 - Omnimic Right.m4a
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/10 - Omnimic Right.m4a in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/11 - Deep Bass Test.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/11 - Deep Bass Test.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/12 - Violin Test.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/12 - Violin Test.wav in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info: Adding Item to queue: music-library/INTERNAL/AA Setup Tracks/13 - System Burn In.flac
May 11 10:59:02 alexandria-audio volumio[13682]: info: Exploding uri music-library/INTERNAL/AA Setup Tracks/13 - System Burn In.flac in service mpd
May 11 10:59:02 alexandria-audio volumio[13682]: info:
May 11 10:59:02 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F02%20-%20Phase%20Test.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/02 - Phase Test.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F03%20-%20L%20to%20R%20Instrument.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/03 - L to R Instrument.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F04%20%20-%20%20Male%20Voice.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/04 - Male Voice.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F05%20-%20Female%20Voice.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/05 - Female Voice.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F06%20-%20Symphony%20no.%208%20-%20Dynamic%20Contrast.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/06 - Symphony no. 8 - Dynamic Contrast.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F07%20-%20Symphony%20no.%204%20-%20Harmonics%20Flow.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/07 - Symphony no. 4 - Harmonics Flow.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F08%20-%20Omnimic%20Mono%20Short%20Sine%20Sweep.m4a&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/08 - Omnimic Mono Short Sine Sweep.m4a
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F09%20-%20Omnimic%20Left.m4a&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/09 - Omnimic Left.m4a
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F10%20-%20Omnimic%20Right.m4a&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/10 - Omnimic Right.m4a
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F11%20-%20Deep%20Bass%20Test.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/11 - Deep Bass Test.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=//medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F12%20-%20Violin%20Test.wav&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/12 - Violin Test.wav
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=Various%20Artist/XLO%20%26%20Reference%20Recordings%20Test%20And%20Burn-In%20CD/medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F01%20-%20L%20R%20Channel%20Test.flac&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac
May 11 10:59:02 alexandria-audio volumio[13682]: info: ALBUMART /albumart?cacheid=983&web=Various%20Artist/XLO%20%26%20Reference%20Recordings%20Test%20And%20Burn-In%20CD/medium&path=%2Fmnt%2FINTERNAL%2FAA%20Setup%20Tracks%2F13%20-%20System%20Burn%20In.flac&metadata=false
May 11 10:59:02 alexandria-audio volumio[13682]: info: URI /mnt/INTERNAL/AA Setup Tracks/13 - System Burn In.flac
May 11 10:59:02 alexandria-audio volumio[13682]: info: sendMpdCommand stop took 815 milliseconds
May 11 10:59:02 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:59:02 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::saveQueue
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushQueue
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::updateTrackBlock
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrackBlock
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPlay
May 11 10:59:02 alexandria-audio volumio[13682]: verbose: UNSET VOLATILE
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::play index 11
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::stop
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:59:02 alexandria-audio volumio[13682]: verbose: UNSET VOLATILE
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::play index undefined
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::setConsumeUpdateService undefined
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:02 alexandria-audio volumio[13682]: info: CoreStateMachine::startPlaybackTimer
May 11 10:59:02 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:02 alexandria-audio volumio[13682]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac
May 11 10:59:02 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand stop
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand status took 76 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand stop took 29 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand clear
May 11 10:59:03 alexandria-audio volumio[13682]: info:
May 11 10:59:03 alexandria-audio volumio[13682]: ---------------------------- MPD announces system playlist update
May 11 10:59:03 alexandria-audio volumio[13682]: info: Ignoring MPD Status Update
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 68 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand clear took 68 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac"
May 11 10:59:03 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: 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":"02 - Phase Test.wav","artist":null,"album":null,"uri":"INTERNAL/AA Setup Tracks/02 - Phase Test.wav","trackType":"wav"}
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService stop
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus stop
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: No code
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: ------------------------------ 183ms
May 11 10:59:03 alexandria-audio volumio[13682]: error: updateQueue error: null
May 11 10:59:03 alexandria-audio volumio[13682]: info:
May 11 10:59:03 alexandria-audio volumio[13682]: ---------------------------- MPD announces system playlist update
May 11 10:59:03 alexandria-audio volumio[13682]: info: Ignoring MPD Status Update
May 11 10:59:03 alexandria-audio volumio[13682]: info: ------------------------------ 53ms
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand add "INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac" took 52 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand play
May 11 10:59:03 alexandria-audio volumio[13682]: info:
May 11 10:59:03 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:59:03 alexandria-audio volumio[13682]: info: ------------------------------ 107ms
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand play took 107 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:59:03 alexandria-audio volumio[13682]: info:
May 11 10:59:03 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:59:03 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand status took 45 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand status took 185 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 184 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":32,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"170 Kbps","isStreaming":false,"title":"01 - L R Channel Test.flac","artist":"Various Artist","album":"XLO & Reference Recordings Test And Burn-In CD","uri":"INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac","trackType":"flac"}
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService play
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus stop
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: ------------------------------ 246ms
May 11 10:59:03 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 128 milliseconds
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":32,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"166 Kbps","isStreaming":false,"title":"01 - L R Channel Test.flac","artist":"Various Artist","album":"XLO & Reference Recordings Test And Burn-In CD","uri":"INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac","trackType":"flac"}
May 11 10:59:03 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService play
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus play
May 11 10:59:03 alexandria-audio volumio[13682]: info: Received an update from plugin. extracting info from payload
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:03 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:03 alexandria-audio volumio[13682]: info: ------------------------------ 322ms
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioSeek
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreStateMachine::seek
May 11 10:59:06 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:06 alexandria-audio volumio[13682]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac","service":"mpd","name":"01 - L R Channel Test.flac","artist":"Various Artist","album":"XLO & Reference Recordings Test And Burn-In CD","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=983&web=Various%20Artist/XLO%20%26%20Reference%20Recordings%20Test%20And%20Burn-In%20CD/medium&path=%2FINTERNAL%2FAA%20Setup%20Tracks&metadata=false","duration":32,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2}
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreStateMachine::startPlaybackTimer
May 11 10:59:06 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:06 alexandria-audio volumio[13682]: info: ControllerMpd::seek
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:06 alexandria-audio volumio[13682]: error: null
May 11 10:59:06 alexandria-audio volumio[13682]: info:
May 11 10:59:06 alexandria-audio volumio[13682]: ---------------------------- MPD announces state update: player
May 11 10:59:06 alexandria-audio volumio[13682]: info: ControllerMpd::getState
May 11 10:59:06 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand status
May 11 10:59:06 alexandria-audio volumio[13682]: info: sendMpdCommand status took 228 milliseconds
May 11 10:59:06 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseState
May 11 10:59:06 alexandria-audio volumio[13682]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 11 10:59:06 alexandria-audio volumio[13682]: info: sendMpdCommand playlistinfo took 57 milliseconds
May 11 10:59:06 alexandria-audio volumio[13682]: verbose: ControllerMpd::parseTrackInfo
May 11 10:59:06 alexandria-audio volumio[13682]: info: ControllerMpd::pushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::servicePushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:06 alexandria-audio volumio[13682]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17000,"duration":32,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"203 Kbps","isStreaming":false,"title":"01 - L R Channel Test.flac","artist":"Various Artist","album":"XLO & Reference Recordings Test And Burn-In CD","uri":"INTERNAL/AA Setup Tracks/01 - L R Channel Test.flac","trackType":"flac"}
May 11 10:59:06 alexandria-audio volumio[13682]: verbose: CURRENT POSITION 11
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState stateService play
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreStateMachine::syncState currentStatus play
May 11 10:59:06 alexandria-audio volumio[13682]: info: Received an update from plugin. extracting info from payload
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreStateMachine::pushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioPushState
May 11 10:59:06 alexandria-audio volumio[13682]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 11 10:59:06 alexandria-audio volumio[13682]: info: ------------------------------ 308ms
May 11 10:59:09 alexandria-audio volumio[13682]: info: CoreCommandRouter::volumioGetState
May 11 10:59:09 alexandria-audio volumio[13682]: info: CorePlayQueue::getTrack 11
May 11 10:59:09 alexandria-audio volumio[13682]: info: VolumeController::SetAlsaVolume95
May 11 10:59:09 alexandria-audio volumio[13682]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 10:59:09 alexandria-audio volumio[13682]: { Error: spawn ENOMEM
May 11 10:59:09 alexandria-audio volumio[13682]: at _errnoException (util.js:1022:11)
May 11 10:59:09 alexandria-audio volumio[13682]: at ChildProcess.spawn (internal/child_process.js:323:11)
May 11 10:59:09 alexandria-audio volumio[13682]: at exports.spawn (child_process.js:502:9)
May 11 10:59:09 alexandria-audio volumio[13682]: at amixer (/volumio/app/volumecontrol.js:65:13)
May 11 10:59:09 alexandria-audio volumio[13682]: at CoreVolumeController.self.setVolume (/volumio/app/volumecontrol.js:209:9)
May 11 10:59:09 alexandria-audio volumio[13682]: at CoreVolumeController.alsavolume (/volumio/app/volumecontrol.js:457:16)
May 11 10:59:09 alexandria-audio volumio[13682]: at CoreCommandRouter.volumiosetvolume (/volumio/app/index.js:125:35)
May 11 10:59:09 alexandria-audio volumio[13682]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:267:33)
May 11 10:59:09 alexandria-audio volumio[13682]: at emitTwo (events.js:126:13)
May 11 10:59:09 alexandria-audio volumio[13682]: at Socket.emit (events.js:214:7)
May 11 10:59:09 alexandria-audio volumio[13682]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 11 10:59:09 alexandria-audio volumio[13682]: at _combinedTickCallback (internal/process/next_tick.js:131:7)
May 11 10:59:09 alexandria-audio volumio[13682]: at process._tickCallback (internal/process/next_tick.js:180:9) code: 'ENOMEM', errno: 'ENOMEM', syscall: 'spawn' }
May 11 10:59:09 alexandria-audio volumio[13682]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 11 10:59:09 alexandria-audio sudo[16135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-11 10:58
May 11 10:59:09 alexandria-audio sudo[16135]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d"
VOLUMIO_ARCH="x86"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021"
VOLUMIO_VERSION="2.916"
VOLUMIO_HARDWARE="x86"
VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"