-- Logs begin at Thu 2019-02-14 14:11:59 +04, end at Mon 2025-11-03 20:34:56 +04. -- Nov 03 20:33:00 volumio volumio[6273]: info: Setting Geolocation for MyVolumio to eu7 Nov 03 20:33:00 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:00 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:00 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:00 volumio volumio[6273]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 03 20:33:01 volumio volumio[6273]: info: Updating MyVolumio device info Nov 03 20:33:01 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:01 volumio volumio[6273]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 03 20:33:04 volumio volumio[6273]: info: MYVOLUMIO: Adding device Nov 03 20:33:04 volumio volumio[6273]: info: MYVOLUMIO: Evaluating Server Nov 03 20:33:05 volumio volumio[6273]: info: Setting Geolocation for MyVolumio to eu7 Nov 03 20:33:05 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:05 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:05 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:05 volumio volumio[6273]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 03 20:33:06 volumio volumio[6273]: info: Updating MyVolumio device info Nov 03 20:33:06 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:06 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:06 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 20:33:06 volumio volumio[6273]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 03 20:33:08 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:33:08 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:33:08 volumio volumio[6273]: info: Discovery: Getting this device information Nov 03 20:33:08 volumio volumio[6273]: info: CoreCommandRouter::volumioGetState Nov 03 20:33:08 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:33:39 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:33:39 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:33:39 volumio volumio[6273]: info: Discovery: Getting this device information Nov 03 20:33:39 volumio volumio[6273]: info: CoreCommandRouter::volumioGetState Nov 03 20:33:39 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:34:08 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:34:08 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:34:08 volumio volumio[6273]: info: Discovery: Getting this device information Nov 03 20:34:08 volumio volumio[6273]: info: CoreCommandRouter::volumioGetState Nov 03 20:34:08 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getTrack 20 Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:31 volumio volumio[6273]: info: Prefetching next song Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3" Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:31 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3" took 5 milliseconds Nov 03 20:34:31 volumio volumio[6273]: verbose: MPD COMMAND [object Object] Nov 03 20:34:31 volumio volumio[6273]: verbose: MPD COMMAND [object Object] Nov 03 20:34:31 volumio volumio[6273]: verbose: MPD COMMAND [object Object] Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:31 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:31 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:31 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 9ms Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 6ms Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 5ms Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand consume 1 Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:31 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:31 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces state update: options Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 11ms Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand consume 1 took 6 milliseconds Nov 03 20:34:31 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 6ms Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 6ms Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces state update: options Nov 03 20:34:31 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:31 volumio volumio[6273]: info: Nov 03 20:34:31 volumio volumio[6273]: ---------------------------- MPD announces state update: options Nov 03 20:34:31 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand status took 7 milliseconds Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand status took 3 milliseconds Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand status took 3 milliseconds Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 03 20:34:31 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:31 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:31 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getTrack 20 Nov 03 20:34:31 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":404973,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1016 Kbps","isStreaming":false,"title":"Я так соскучился","artist":"Порнофильмы","album":"В диапазоне между отчаянием и надеждой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-rutjm01rtk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da84b4110591bb71d4ead80ae5816a7a13a5e71a42786a7657830133403aab501%2Clid%3D1625%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916bb38%2F0%2F23044%2F92b3c3e6.98111135.28.37258117%2Fflac-mp4&ext=.flac","trackType":"flac"} Nov 03 20:34:31 volumio volumio[6273]: verbose: CURRENT POSITION 20 Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:31 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:31 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getTrack 20 Nov 03 20:34:31 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":404973,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1016 Kbps","isStreaming":false,"title":"Я так соскучился","artist":"Порнофильмы","album":"В диапазоне между отчаянием и надеждой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-rutjm01rtk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da84b4110591bb71d4ead80ae5816a7a13a5e71a42786a7657830133403aab501%2Clid%3D1625%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916bb38%2F0%2F23044%2F92b3c3e6.98111135.28.37258117%2Fflac-mp4&ext=.flac","trackType":"flac"} Nov 03 20:34:31 volumio volumio[6273]: verbose: CURRENT POSITION 20 Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:31 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:31 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getTrack 20 Nov 03 20:34:31 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":404973,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1016 Kbps","isStreaming":false,"title":"Я так соскучился","artist":"Порнофильмы","album":"В диапазоне между отчаянием и надеждой","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-rutjm01rtk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Da84b4110591bb71d4ead80ae5816a7a13a5e71a42786a7657830133403aab501%2Clid%3D1625%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916bb38%2F0%2F23044%2F92b3c3e6.98111135.28.37258117%2Fflac-mp4&ext=.flac","trackType":"flac"} Nov 03 20:34:31 volumio volumio[6273]: verbose: CURRENT POSITION 20 Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:31 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 81ms Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 78ms Nov 03 20:34:31 volumio volumio[6273]: info: ------------------------------ 77ms Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:31 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:31 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:35 volumio volumio[6273]: info: Nov 03 20:34:35 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:35 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:35 volumio volumio[6273]: info: Nov 03 20:34:35 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:35 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:35 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:35 volumio volumio[6273]: info: Nov 03 20:34:35 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:35 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:35 volumio volumio[6273]: info: Nov 03 20:34:35 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:35 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:35 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:35 volumio volumio[6273]: info: ------------------------------ 6ms Nov 03 20:34:35 volumio volumio[6273]: info: Nov 03 20:34:35 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:35 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:35 volumio volumio[6273]: info: Nov 03 20:34:35 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:35 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:35 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:35 volumio volumio[6273]: info: CoreStateMachine::startPlaybackTimer Nov 03 20:34:35 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand status took 900 milliseconds Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:36 volumio volumio[6273]: info: Nov 03 20:34:36 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 904ms Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand status took 904 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 902ms Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand status took 901 milliseconds Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:36 volumio volumio[6273]: info: Nov 03 20:34:36 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:36 volumio volumio[6273]: info: Nov 03 20:34:36 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand status took 11 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand status took 6 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand status took 5 milliseconds Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"My Favourite Game","artist":"The Cardigans","album":"Best Of","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3","trackType":"mp3"} Nov 03 20:34:36 volumio volumio[6273]: verbose: CURRENT POSITION 21 Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:36 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"My Favourite Game","artist":"The Cardigans","album":"Best Of","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3","trackType":"mp3"} Nov 03 20:34:36 volumio volumio[6273]: verbose: CURRENT POSITION 21 Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:36 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"My Favourite Game","artist":"The Cardigans","album":"Best Of","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3","trackType":"mp3"} Nov 03 20:34:36 volumio volumio[6273]: verbose: CURRENT POSITION 21 Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:36 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 994ms Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 993ms Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 990ms Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 93 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 92 milliseconds Nov 03 20:34:36 volumio volumio[6273]: info: sendMpdCommand playlistinfo took 92 milliseconds Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:36 volumio volumio[6273]: verbose: ControllerMpd::parseTrackInfo Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"My Favourite Game","artist":"The Cardigans","album":"Best Of","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3","trackType":"mp3"} Nov 03 20:34:36 volumio volumio[6273]: verbose: CURRENT POSITION 21 Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:36 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"My Favourite Game","artist":"The Cardigans","album":"Best Of","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3","trackType":"mp3"} Nov 03 20:34:36 volumio volumio[6273]: verbose: CURRENT POSITION 21 Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:36 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:36 volumio volumio[6273]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"My Favourite Game","artist":"The Cardigans","album":"Best Of","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-41.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Df24a7112df56a9ae5e62d487459b5ec4f0423ed5522ae476e054d72379777ce5%2Clid%3D82%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6916f557%2F34035%2F15652%2Fe87a9149.107691114.9.7786%2F320.mp3&ext=.mp3","trackType":"mp3"} Nov 03 20:34:36 volumio volumio[6273]: verbose: CURRENT POSITION 21 Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState stateService play Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:36 volumio volumio[6273]: info: Received an update from plugin. extracting info from payload Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 171ms Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 165ms Nov 03 20:34:36 volumio volumio[6273]: info: ------------------------------ 164ms Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:36 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:36 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:38 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:34:38 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:34:38 volumio volumio[6273]: info: Discovery: Getting this device information Nov 03 20:34:38 volumio volumio[6273]: info: CoreCommandRouter::volumioGetState Nov 03 20:34:38 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:34:48 volumio volumio[6273]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.97 UA: Mozilla/5.0 (Linux; Android 13; 23028RNCAG Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 03 20:34:48 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::volumioGetState Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:49 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:49 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:49 volumio volumio[6273]: info: Listing playlists Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 20:34:49 volumio volumio[6273]: info: Received Get System Info Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 20:34:49 volumio volumio[6273]: info: Discovery: Getting this device information Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::volumioGetState Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::volumioGetState Nov 03 20:34:49 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::volumioNext Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::next Nov 03 20:34:55 volumio volumio[6273]: info: ControllerMpd::next Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand next Nov 03 20:34:55 volumio volumio[6273]: info: sendMpdCommand next took 5 milliseconds Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:55 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:55 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:55 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:55 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:55 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces state update: player Nov 03 20:34:55 volumio volumio[6273]: info: ControllerMpd::getState Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand status Nov 03 20:34:55 volumio volumio[6273]: error: updateQueue error: null Nov 03 20:34:55 volumio volumio[6273]: error: updateQueue error: null Nov 03 20:34:55 volumio volumio[6273]: error: updateQueue error: null Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 8ms Nov 03 20:34:55 volumio volumio[6273]: info: sendMpdCommand status took 8 milliseconds Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 7ms Nov 03 20:34:55 volumio volumio[6273]: info: sendMpdCommand status took 5 milliseconds Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 5ms Nov 03 20:34:55 volumio volumio[6273]: info: sendMpdCommand status took 4 milliseconds Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::parseState Nov 03 20:34:55 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 21 Nov 03 20:34:55 volumio volumio[6273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 03 20:34:55 volumio volumio[6273]: verbose: CURRENT POSITION 21 Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::syncState stateService stop Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::syncState currentStatus play Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::play index undefined Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:55 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Nov 03 20:34:55 volumio volumio[6273]: info: ControllerMpd::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::servicePushState Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::startPlaybackTimer Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand stop Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 63ms Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 61ms Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 60ms Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::pushState Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getTrack 22 Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::volumioPushState Nov 03 20:34:55 volumio volumio[6273]: info: sendMpdCommand stop took 17 milliseconds Nov 03 20:34:55 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand clear Nov 03 20:34:55 volumio volumio[6273]: info: CoreCommandRouter::volumioGetQueue Nov 03 20:34:55 volumio volumio[6273]: info: CoreStateMachine::getQueue Nov 03 20:34:55 volumio volumio[6273]: info: CorePlayQueue::getQueue Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:55 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:55 volumio volumio[6273]: info: sendMpdCommand clear took 13 milliseconds Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:55 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:55 volumio volumio[6273]: info: Nov 03 20:34:55 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:55 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:55 volumio volumio[6273]: error: updateQueue error: null Nov 03 20:34:55 volumio volumio[6273]: error: updateQueue error: null Nov 03 20:34:55 volumio volumio[6273]: error: updateQueue error: null Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 17ms Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 4ms Nov 03 20:34:55 volumio volumio[6273]: info: ------------------------------ 4ms Nov 03 20:34:56 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-mar-149.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D03cd7ca33c68775b4e9ebca46151224ad964aeaf80fef382c4027eb299bd496c%2Clid%3D83%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69162686%2F42043%2F20798%2F3243110d.109974750.7.34608%2F320.mp3&ext=.mp3" Nov 03 20:34:56 volumio volumio[6273]: info: Nov 03 20:34:56 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:56 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:56 volumio volumio[6273]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-mar-149.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D03cd7ca33c68775b4e9ebca46151224ad964aeaf80fef382c4027eb299bd496c%2Clid%3D83%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69162686%2F42043%2F20798%2F3243110d.109974750.7.34608%2F320.mp3&ext=.mp3" took 3 milliseconds Nov 03 20:34:56 volumio volumio[6273]: verbose: MPD COMMAND [object Object] Nov 03 20:34:56 volumio volumio[6273]: verbose: MPD COMMAND [object Object] Nov 03 20:34:56 volumio volumio[6273]: verbose: MPD COMMAND [object Object] Nov 03 20:34:56 volumio volumio[6273]: info: Nov 03 20:34:56 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:56 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:56 volumio volumio[6273]: info: Nov 03 20:34:56 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:56 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:56 volumio volumio[6273]: info: Nov 03 20:34:56 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:56 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:56 volumio volumio[6273]: info: ------------------------------ 7ms Nov 03 20:34:56 volumio volumio[6273]: info: ------------------------------ 4ms Nov 03 20:34:56 volumio volumio[6273]: info: ------------------------------ 4ms Nov 03 20:34:56 volumio volumio[6273]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 03 20:34:56 volumio volumio[6273]: verbose: ControllerMpd::sendMpdCommand play Nov 03 20:34:56 volumio volumio[6273]: info: Nov 03 20:34:56 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:56 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:56 volumio volumio[6273]: info: Nov 03 20:34:56 volumio volumio[6273]: ---------------------------- MPD announces system playlist update Nov 03 20:34:56 volumio volumio[6273]: info: Ignoring MPD Status Update Nov 03 20:34:56 volumio volumio[6273]: info: ------------------------------ 7ms Nov 03 20:34:56 volumio volumio[6273]: info: sendMpdCommand play took 5 milliseconds Nov 03 20:34:56 volumio volumio[6273]: info: ------------------------------ 4ms Nov 03 20:34:56 volumio volumio[6273]: info: ------------------------------ 3ms Nov 03 20:34:56 volumio volumio[6273]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 20:34:56 volumio volumio[6273]: Error: connect EHOSTUNREACH 37.9.101.207:443 Nov 03 20:34:56 volumio volumio[6273]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 03 20:34:56 volumio volumio[6273]: errno: -113, Nov 03 20:34:56 volumio volumio[6273]: code: 'EHOSTUNREACH', Nov 03 20:34:56 volumio volumio[6273]: syscall: 'connect', Nov 03 20:34:56 volumio volumio[6273]: address: '37.9.101.207', Nov 03 20:34:56 volumio volumio[6273]: port: 443 Nov 03 20:34:56 volumio volumio[6273]: } Nov 03 20:34:56 volumio volumio[6273]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 20:34:56 volumio sudo[7703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-03 20:33 Nov 03 20:34:56 volumio sudo[7703]: 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"