-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-08-31 09:53:09 CEST. -- Aug 31 09:52:00 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:00 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:00 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:00 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:01 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:01 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:01 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:01 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:02 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:02 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:02 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:02 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:03 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:03 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:03 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:03 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:04 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:04 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:04 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:04 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:05 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:05 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:05 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:05 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:06 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:06 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:06 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:06 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:07 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:07 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:07 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:07 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: SleepWakePlugin - Volume increase complete. Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: SleepWakePlugin - onStart Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: SleepWakePlugin - Sleep scheduled in 47271168 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: SleepWakePlugin - Wake scheduled in -2602628834 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: SleepWakePlugin - Wake timer triggered Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: SleepWakePlugin - Starting playlist Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=40 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 40 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume40 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 40 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626728840,"response":"volume Success"} Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Initial volume set to 40 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=playplaylist&name=Radio%20NPO Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volumio Play Playlist Radio NPO Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Play playlist Radio NPO Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioClearQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::ClearQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::stop Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::stPlaybackTimer Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::updateTrackBlock Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrackBlock Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::serviceStop Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::serviceStop Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: [1756626728877] ControllerWebradio::stop Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::clearPlayQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::saveQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioAddQueueItems Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::addQueueItems Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::addQueueItems Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Preload queue cleared Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Adding Item to queue: http://icecast.omroep.nl/radio4-bb-mp3 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::saveQueue Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::updateTrackBlock Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrackBlock Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPlay Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::play index 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::stop Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::play index undefined Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::startPlaybackTimer Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: [1756626728887] ControllerWebradio::clearAddPlayTrack Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: sendMpdCommand stop took 14 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: sendMpdCommand stop took 4 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626728872,"response":"playplaylist Success"} Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Playlist "Radio NPO" started. Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 5 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: sendMpdCommand clear took 4 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 4 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 3 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.omroep.nl/radio4-bb-mp3" Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ------------------------------ 9ms Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ------------------------------ 10ms Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:08 volumio-bedroom volumio[1100]: error: updateQueue error: null Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ------------------------------ 9ms Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 31 09:52:08 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:08 volumio-bedroom volumio[1100]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: ------------------------------ 14ms Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Current volume is 40 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 41 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=41 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Aug 31 09:52:08 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 41 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume41 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 41 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626728912,"response":"volume Success"} Aug 31 09:52:08 volumio-bedroom volumio[1100]: info: Volume set to 41 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.omroep.nl/radio4-bb-mp3" Aug 31 09:52:09 volumio-bedroom volumio[1100]: error: updateQueue error: null Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 686ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand add "http://icecast.omroep.nl/radio4-bb-mp3" took 1 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 3ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand play took 2 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 2ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 1ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 3 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio4-bb-mp3","artist":null,"album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus stop Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 6ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 3 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio4-bb-mp3","artist":null,"album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio4-bb-mp3","artist":null,"album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 16ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 16ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 12 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio4-bb-mp3","artist":null,"album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio4-bb-mp3","artist":null,"album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 25ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 22ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Aug 31 09:52:09 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 15ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 14 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 15 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 3ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 3 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 2ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jan Pieterszoon Sweelinck - Variaties voor toetsinstrument (6), SwWV.324 S.60, \"Mein junges Leben hat ein End\"","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 35ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":988,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Jan Pieterszoon Sweelinck - Variaties voor toetsinstrument (6), SwWV.324 S.60, \"Mein junges Leben hat ein End\"","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":988,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Jan Pieterszoon Sweelinck - Variaties voor toetsinstrument (6), SwWV.324 S.60, \"Mein junges Leben hat ein End\"","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":988,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Jan Pieterszoon Sweelinck - Variaties voor toetsinstrument (6), SwWV.324 S.60, \"Mein junges Leben hat ein End\"","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:09 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 39ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 26ms Aug 31 09:52:09 volumio-bedroom volumio[1100]: info: ------------------------------ 26ms Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: Current volume is 41 Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 42 Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=42 Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: Aug 31 09:52:10 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 42 Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume42 Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 42 Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626730821,"response":"volume Success"} Aug 31 09:52:10 volumio-bedroom volumio[1100]: info: Volume set to 42 Aug 31 09:52:11 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:11 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:11 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:11 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:11 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:12 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:12 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:12 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:12 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:13 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:13 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:13 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:13 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:14 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:14 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:14 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:14 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:15 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:15 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:15 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:15 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:16 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:16 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:16 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:16 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:17 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:17 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:17 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:17 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:18 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:18 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:18 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:18 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Aug 31 09:52:19 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Aug 31 09:52:19 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Aug 31 09:52:19 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Aug 31 09:52:19 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Aug 31 09:52:19 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Aug 31 09:52:19 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ------------------------------ 6ms Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 5 milliseconds Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ------------------------------ 2ms Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ------------------------------ 3ms Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11110,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"NPO Klassiek - Tussen Hemel en Aarde - KRO-NCRV","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ------------------------------ 11ms Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11110,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"NPO Klassiek - Tussen Hemel en Aarde - KRO-NCRV","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11110,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"NPO Klassiek - Tussen Hemel en Aarde - KRO-NCRV","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:19 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ------------------------------ 16ms Aug 31 09:52:19 volumio-bedroom volumio[1100]: info: ------------------------------ 16ms Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: Current volume is 42 Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 43 Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=43 Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: Aug 31 09:52:20 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 43 Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume43 Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 43 Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626740952,"response":"volume Success"} Aug 31 09:52:20 volumio-bedroom volumio[1100]: info: Volume set to 43 Aug 31 09:52:21 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:21 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:21 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:21 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:21 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: Current volume is 43 Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 44 Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=44 Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: Aug 31 09:52:22 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 44 Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume44 Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 44 Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626742857,"response":"volume Success"} Aug 31 09:52:22 volumio-bedroom volumio[1100]: info: Volume set to 44 Aug 31 09:52:23 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:23 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:23 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:23 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:23 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:24 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:24 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:24 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:24 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:25 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:25 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:25 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:25 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:26 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:26 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:26 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:26 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:27 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:27 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:27 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:27 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:28 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:28 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:28 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:28 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:29 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:29 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:29 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:29 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:30 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:30 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:30 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:30 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:31 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:31 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:31 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:31 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: Current volume is 44 Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 45 Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=45 Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: Aug 31 09:52:32 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 45 Aug 31 09:52:32 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume45 Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 45 Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626752988,"response":"volume Success"} Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: Volume set to 45 Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:33 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: Current volume is 45 Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 46 Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=46 Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: Aug 31 09:52:34 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 46 Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume46 Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 46 Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626754892,"response":"volume Success"} Aug 31 09:52:34 volumio-bedroom volumio[1100]: info: Volume set to 46 Aug 31 09:52:35 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:35 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:35 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:35 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:35 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Aug 31 09:52:36 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Aug 31 09:52:36 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Aug 31 09:52:36 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Aug 31 09:52:36 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Aug 31 09:52:36 volumio-bedroom volumio[1100]: ---------------------------- MPD announces system playlist update Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Ignoring MPD Status Update Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Aug 31 09:52:36 volumio-bedroom volumio[1100]: ---------------------------- MPD announces state update: player Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ControllerMpd::getState Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand status Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ------------------------------ 3ms Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ------------------------------ 2ms Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ------------------------------ 2ms Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: sendMpdCommand status took 2 milliseconds Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseState Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: ControllerMpd::parseTrackInfo Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28113,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Peranda, Giuseppe - O Jesu mi dulcissime","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28113,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Peranda, Giuseppe - O Jesu mi dulcissime","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ControllerMpd::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::servicePushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CorePlayQueue::getTrack 0 Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28113,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Peranda, Giuseppe - O Jesu mi dulcissime","artist":"NPO Klassiek","album":null,"uri":"http://icecast.omroep.nl/radio4-bb-mp3","trackType":""} Aug 31 09:52:36 volumio-bedroom volumio[1100]: verbose: CURRENT POSITION 0 Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState stateService play Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::syncState currentStatus play Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: Received an update from plugin. extracting info from payload Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ------------------------------ 20ms Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ------------------------------ 19ms Aug 31 09:52:36 volumio-bedroom volumio[1100]: info: ------------------------------ 19ms Aug 31 09:52:37 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:37 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:37 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:37 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:38 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:38 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:38 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:38 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:39 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:39 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:39 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:39 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:40 volumio-bedroom volumiologrotate[665]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Aug 31 09:52:40 volumio-bedroom volumiologrotate[665]: ls: cannot access 'BEDROOM': No such file or directory Aug 31 09:52:40 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:40 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:40 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:40 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:41 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:41 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:41 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:41 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:42 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:42 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:42 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:42 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:43 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:43 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:43 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:43 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:44 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:44 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:44 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:44 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: Current volume is 46 Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 47 Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=47 Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: Aug 31 09:52:45 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 47 Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume47 Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 47 Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626765026,"response":"volume Success"} Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: Volume set to 47 Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:45 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: Current volume is 47 Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 48 Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=48 Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: Aug 31 09:52:46 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 48 Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume48 Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 48 Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626766937,"response":"volume Success"} Aug 31 09:52:46 volumio-bedroom volumio[1100]: info: Volume set to 48 Aug 31 09:52:47 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:47 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:47 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:47 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:47 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:48 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:48 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:48 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:48 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:49 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:49 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:49 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:49 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:50 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:50 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:50 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:50 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:51 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:51 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:51 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:51 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:52 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:52 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:52 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:52 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:53 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:53 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:53 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:53 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:54 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:54 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:54 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:54 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:55 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:55 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:55 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:55 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:56 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:56 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:56 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:56 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: Current volume is 48 Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 49 Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=49 Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: Aug 31 09:52:57 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 49 Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume49 Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 49 Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626777062,"response":"volume Success"} Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: Volume set to 49 Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:57 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: Current volume is 49 Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: Increasing volume by 1: setting volume to 50 Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=50 Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: Aug 31 09:52:58 volumio-bedroom volumio[1100]: ---------------------------- Client requests Volume 50 Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: VolumeController::SetAlsaVolume50 Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: [squeezelite_mc] Setting Squeezelite volume to 50 Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CoreStateMachine::pushState Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 09:52:58 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioPushState Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Received response: {"time":1756626778973,"response":"volume Success"} Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Volume set to 50 Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Starting Uninstall of plugin system_controller - SleepWakePlugin Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Uninstalling plugin SleepWakePlugin Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: SleepWakePlugin - onStop Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Disabling plugin SleepWakePlugin Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Checking if uninstall.sh is present Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Executing uninstall.sh Aug 31 09:52:59 volumio-bedroom sudo[10059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_controller/SleepWakePlugin/uninstall.sh Aug 31 09:52:59 volumio-bedroom sudo[10059]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 09:52:59 volumio-bedroom sudo[10059]: pam_unix(sudo:session): session closed for user root Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Uninstall script completed Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Removing plugin SleepWakePlugin from configuration Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Successfully removed SleepWakePlugin configuration files Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Plugin folders cleanup Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning into folder /volumio/app/plugins/ Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category audio_interface Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category miscellanea Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category music_service Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category plugins.json Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category system_controller Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category user_interface Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning into folder /data/plugins/ Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category music_service Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category system_controller Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Cleaning folder for SleepWakePlugin Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category system_hardware Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Scanning category user_interface Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: Plugin folders cleanup completed Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: [{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Squeezelite MC","name":"squeezelite_mc","category":"music_service","version":"1.0.4","icon":"fa-play-circle-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Audiophonics Evo Sabre","name":"audiophonics_evo_sabre","category":"system_hardware","version":"1.0.0","icon":"fa-hdd-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"MPD OLED","name":"mpd_oled","category":"system_hardware","version":"1.1.3","icon":"fa-television","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":false,"active":false}] Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:52:59 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:00 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:00 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:00 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:00 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:01 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:01 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:01 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:01 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:02 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:02 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:02 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:02 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:03 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:03 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:03 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:03 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:04 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:04 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:04 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:04 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:05 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:05 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:05 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:05 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:06 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:06 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:06 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:06 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:07 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:07 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:07 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:07 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetState Aug 31 09:53:08 volumio-bedroom volumio[1100]: info: CoreCommandRouter::volumioGetQueue Aug 31 09:53:08 volumio-bedroom volumio[1100]: info: CoreStateMachine::getQueue Aug 31 09:53:08 volumio-bedroom volumio[1100]: info: CorePlayQueue::getQueue Aug 31 09:53:09 volumio-bedroom volumio[1100]: info: Getting current volume Aug 31 09:53:09 volumio-bedroom volumio[1100]: error: SleepWakePlugin - Error in increaseVolume: Error: ENOENT: no such file or directory, open '/data/plugins/system_controller/SleepWakePlugin/sleep-wake-plugin.log' Aug 31 09:53:09 volumio-bedroom volumio[1100]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 09:53:09 volumio-bedroom volumio[1100]: Error: ENOENT: no such file or directory, open '/data/plugins/system_controller/SleepWakePlugin/sleep-wake-plugin.log' Aug 31 09:53:09 volumio-bedroom volumio[1100]: at Object.openSync (fs.js:476:3) Aug 31 09:53:09 volumio-bedroom volumio[1100]: at Object.writeFileSync (fs.js:1467:35) Aug 31 09:53:09 volumio-bedroom volumio[1100]: at Object.appendFileSync (fs.js:1506:6) Aug 31 09:53:09 volumio-bedroom volumio[1100]: at SleepWakePlugin.writeLog (/data/plugins/system_controller/SleepWakePlugin/index.js:827:6) Aug 31 09:53:09 volumio-bedroom volumio[1100]: at Timeout.increaseVolume [as _onTimeout] (/data/plugins/system_controller/SleepWakePlugin/index.js:802:12) Aug 31 09:53:09 volumio-bedroom volumio[1100]: at listOnTimeout (internal/timers.js:554:17) Aug 31 09:53:09 volumio-bedroom volumio[1100]: at processTimers (internal/timers.js:497:7) { Aug 31 09:53:09 volumio-bedroom volumio[1100]: errno: -2, Aug 31 09:53:09 volumio-bedroom volumio[1100]: syscall: 'open', Aug 31 09:53:09 volumio-bedroom volumio[1100]: code: 'ENOENT', Aug 31 09:53:09 volumio-bedroom volumio[1100]: path: '/data/plugins/system_controller/SleepWakePlugin/sleep-wake-plugin.log' Aug 31 09:53:09 volumio-bedroom volumio[1100]: } Aug 31 09:53:09 volumio-bedroom volumio[1100]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 09:53:09 volumio-bedroom sudo[10111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-31 09:52 Aug 31 09:53:09 volumio-bedroom sudo[10111]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"