-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2024-08-30 11:24:57 UTC. -- Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 11:24:03 living volumio[733]: info: Discovery: Getting this device information Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 11:24:03 living volumio[733]: info: Discovery: Getting this device information Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:03 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 11:24:03 living volumio[733]: verbose: New Socket.io Connection to 192.168.1.10:3000 from 192.168.1.62 UA: Dart/3.4 (dart:io) Total Clients: 6 Aug 30 11:24:04 living volumio[733]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.62 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:04 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:04 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:04 living volumio[733]: info: Listing playlists Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 11:24:04 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 30 11:24:04 living volumio[733]: info: Received Get System Info Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 11:24:04 living volumio[733]: info: Discovery: Getting this device information Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 11:24:04 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:05 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 11:24:06 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 11:24:06 living volumio[733]: info: Received Get System Info Aug 30 11:24:06 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 11:24:06 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 11:24:06 living volumio[733]: info: Discovery: Getting this device information Aug 30 11:24:06 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:06 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 11:24:07 living volumio[733]: info: CoreCommandRouter::volumioNext Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::next Aug 30 11:24:07 living volumio[733]: info: [1725017047829] ControllerQobuz::next Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::next Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::stop Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::play index undefined Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:07 living volumio[733]: info: CorePlayQueue::getTrack 41 Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::startPlaybackTimer Aug 30 11:24:07 living volumio[733]: info: CorePlayQueue::getTrack 41 Aug 30 11:24:07 living volumio[733]: info: [1725017047836] ControllerQobuz::clearAddPlayTrack Aug 30 11:24:07 living volumio[733]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 11:24:07 living volumio[733]: info: CoreStateMachine::updateTrackBlock Aug 30 11:24:07 living volumio[733]: info: CorePlayQueue::getTrackBlock Aug 30 11:24:07 living volumio[733]: info: sendMpdCommand stop took 1 milliseconds Aug 30 11:24:07 living volumio[733]: verbose: ControllerMpd::sendMpdCommand clear Aug 30 11:24:07 living volumio[733]: info: Aug 30 11:24:07 living volumio[733]: ---------------------------- MPD announces system playlist update Aug 30 11:24:07 living volumio[733]: info: Ignoring MPD Status Update Aug 30 11:24:07 living volumio[733]: info: sendMpdCommand clear took 2 milliseconds Aug 30 11:24:07 living volumio[733]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/179965624" Aug 30 11:24:07 living volumio[733]: error: updateQueue error: null Aug 30 11:24:07 living volumio[733]: info: ------------------------------ 4ms Aug 30 11:24:07 living volumio[733]: STREAMING PROXY: Handling url /?data=qobuz://song/179965624 Aug 30 11:24:07 living volumio[733]: info: Executing endpoint getStreamUrlqobuz Aug 30 11:24:07 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Aug 30 11:24:08 living volumio[733]: info: getStreamUrl took 202 milliseconds Aug 30 11:24:08 living volumio[733]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1152944&eid=179965624&fmt=7&profile=raw&app_id=539451548&cid=2293328&etsp=1725020648&hmac=LwY1mjixgupB6mxAde7LTuC8ef0 Aug 30 11:24:08 living volumio[733]: STREAMING PROXY: Response: 200, length: 53396173 Aug 30 11:24:08 living volumio[733]: STREAMING PROXY: Client dropped request, destroying Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/179965624" Aug 30 11:24:08 living volumio[733]: info: Aug 30 11:24:08 living volumio[733]: ---------------------------- MPD announces system playlist update Aug 30 11:24:08 living volumio[733]: info: Ignoring MPD Status Update Aug 30 11:24:08 living volumio[733]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/179965624" took 2 milliseconds Aug 30 11:24:08 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::sendMpdCommand play Aug 30 11:24:08 living volumio[733]: info: ------------------------------ 3ms Aug 30 11:24:08 living volumio[733]: info: sendMpdCommand play took 2 milliseconds Aug 30 11:24:08 living volumio[733]: STREAMING PROXY: Handling url /?data=qobuz://song/179965624 Aug 30 11:24:08 living volumio[733]: info: Executing endpoint getStreamUrlqobuz Aug 30 11:24:08 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Aug 30 11:24:08 living volumio[733]: info: getStreamUrl took 217 milliseconds Aug 30 11:24:08 living volumio[733]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1152944&eid=179965624&fmt=7&profile=raw&app_id=539451548&cid=2293328&etsp=1725020648&hmac=LwY1mjixgupB6mxAde7LTuC8ef0 Aug 30 11:24:08 living volumio[733]: STREAMING PROXY: Response: 200, length: 53396173 Aug 30 11:24:08 living volumio[733]: info: Aug 30 11:24:08 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:08 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:08 living volumio[733]: info: Aug 30 11:24:08 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:08 living volumio[733]: info: sendMpdCommand status took 26 milliseconds Aug 30 11:24:08 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:08 living volumio[733]: info: sendMpdCommand status took 3 milliseconds Aug 30 11:24:08 living volumio[733]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:08 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:08 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:08 living volumio[733]: info: CorePlayQueue::getTrack 41 Aug 30 11:24:08 living volumio[733]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"179965624","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/179965624","trackType":"qobuz"} Aug 30 11:24:08 living volumio[733]: verbose: CURRENT POSITION 41 Aug 30 11:24:08 living volumio[733]: info: CoreStateMachine::syncState stateService play Aug 30 11:24:08 living volumio[733]: info: CoreStateMachine::syncState currentStatus stop Aug 30 11:24:08 living volumio[733]: info: ------------------------------ 37ms Aug 30 11:24:08 living volumio[733]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 30 11:24:08 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:08 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:08 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:08 living volumio[733]: info: CorePlayQueue::getTrack 41 Aug 30 11:24:08 living volumio[733]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1028,"duration":251,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1626 Kbps","isStreaming":false,"title":"179965624","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/179965624","trackType":"qobuz"} Aug 30 11:24:08 living volumio[733]: verbose: CURRENT POSITION 41 Aug 30 11:24:08 living volumio[733]: info: CoreStateMachine::syncState stateService play Aug 30 11:24:08 living volumio[733]: info: CoreStateMachine::syncState currentStatus play Aug 30 11:24:08 living volumio[733]: info: Received an update from plugin. extracting info from payload Aug 30 11:24:08 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:08 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:24:08 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:08 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:08 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:08 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:08 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:08 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:08 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:08 living volumio[733]: info: ------------------------------ 33ms Aug 30 11:24:10 living volumio[733]: STREAMING PROXY: Client dropped request, destroying Aug 30 11:24:14 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 11:24:14 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 11:24:14 living volumio[733]: info: Discovery: Getting this device information Aug 30 11:24:14 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:14 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::volumioNext Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::next Aug 30 11:24:33 living volumio[733]: info: [1725017073159] ControllerQobuz::next Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::next Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::stop Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::stPlaybackTimer Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::updateTrackBlock Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrackBlock Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 41 Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::serviceStop Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 41 Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::serviceStop Aug 30 11:24:33 living volumio[733]: info: [1725017073165] ControllerQobuz::stop Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 11:24:33 living volumio[733]: info: ControllerMpd::stop Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 11:24:33 living volumio[733]: info: Aug 30 11:24:33 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand stop took 91 milliseconds Aug 30 11:24:33 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::play index undefined Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::startPlaybackTimer Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:33 living volumio[733]: info: [1725017073259] ControllerQobuz::clearAddPlayTrack Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::updateTrackBlock Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrackBlock Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand status took 3 milliseconds Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand stop took 2 milliseconds Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand clear Aug 30 11:24:33 living volumio[733]: info: Aug 30 11:24:33 living volumio[733]: ---------------------------- MPD announces system playlist update Aug 30 11:24:33 living volumio[733]: info: Ignoring MPD Status Update Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand clear took 2 milliseconds Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/307648" Aug 30 11:24:33 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:33 living volumio[733]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Aug 30 11:24:33 living volumio[733]: STREAMING PROXY: Handling url /?data=qobuz://song/307648 Aug 30 11:24:33 living volumio[733]: info: ------------------------------ 19ms Aug 30 11:24:33 living volumio[733]: error: updateQueue error: null Aug 30 11:24:33 living volumio[733]: info: ------------------------------ 16ms Aug 30 11:24:33 living volumio[733]: info: Executing endpoint getStreamUrlqobuz Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Aug 30 11:24:33 living volumio[733]: info: getStreamUrl took 213 milliseconds Aug 30 11:24:33 living volumio[733]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1152944&eid=307648&fmt=6&profile=raw&app_id=539451548&cid=2293328&etsp=1725020673&hmac=dWeok4FnRcYxfQ7i-i796ZKeCkc Aug 30 11:24:33 living volumio[733]: STREAMING PROXY: Response: 200, length: 29242872 Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/307648" Aug 30 11:24:33 living volumio[733]: STREAMING PROXY: Client dropped request, destroying Aug 30 11:24:33 living volumio[733]: info: Aug 30 11:24:33 living volumio[733]: ---------------------------- MPD announces system playlist update Aug 30 11:24:33 living volumio[733]: info: Ignoring MPD Status Update Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/307648" took 2 milliseconds Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand play Aug 30 11:24:33 living volumio[733]: info: ------------------------------ 4ms Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand play took 2 milliseconds Aug 30 11:24:33 living volumio[733]: STREAMING PROXY: Handling url /?data=qobuz://song/307648 Aug 30 11:24:33 living volumio[733]: info: Executing endpoint getStreamUrlqobuz Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Aug 30 11:24:33 living volumio[733]: info: getStreamUrl took 180 milliseconds Aug 30 11:24:33 living volumio[733]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1152944&eid=307648&fmt=6&profile=raw&app_id=539451548&cid=2293328&etsp=1725020673&hmac=dWeok4FnRcYxfQ7i-i796ZKeCkc Aug 30 11:24:33 living volumio[733]: STREAMING PROXY: Response: 200, length: 29242872 Aug 30 11:24:33 living volumio[733]: info: Aug 30 11:24:33 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:33 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:33 living volumio[733]: info: Aug 30 11:24:33 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand status took 26 milliseconds Aug 30 11:24:33 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand status took 2 milliseconds Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:33 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:33 living volumio[733]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"307648","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/307648","trackType":"qobuz"} Aug 30 11:24:33 living volumio[733]: verbose: CURRENT POSITION 3 Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::syncState stateService play Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::syncState currentStatus stop Aug 30 11:24:33 living volumio[733]: info: ------------------------------ 33ms Aug 30 11:24:33 living volumio[733]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 30 11:24:33 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:33 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:33 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:33 living volumio[733]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1097,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"982 Kbps","isStreaming":false,"title":"307648","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/307648","trackType":"qobuz"} Aug 30 11:24:33 living volumio[733]: verbose: CURRENT POSITION 3 Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::syncState stateService play Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::syncState currentStatus play Aug 30 11:24:33 living volumio[733]: info: Received an update from plugin. extracting info from payload Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:33 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:33 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:33 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:33 living volumio[733]: info: ------------------------------ 35ms Aug 30 11:24:34 living volumio[733]: STREAMING PROXY: Client dropped request, destroying Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::volumioNext Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::next Aug 30 11:24:35 living volumio[733]: info: [1725017075101] ControllerQobuz::next Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::next Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::stop Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::stPlaybackTimer Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::updateTrackBlock Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrackBlock Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:35 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:35 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::serviceStop Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrack 3 Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::serviceStop Aug 30 11:24:35 living volumio[733]: info: [1725017075107] ControllerQobuz::stop Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 11:24:35 living volumio[733]: info: ControllerMpd::stop Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 11:24:35 living volumio[733]: info: Aug 30 11:24:35 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:35 living volumio[733]: info: sendMpdCommand stop took 101 milliseconds Aug 30 11:24:35 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::play index undefined Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrack 49 Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::startPlaybackTimer Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrack 49 Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 30 11:24:35 living volumio[733]: info: METAVOLUMIO: Retrieving similar tracks from metavolumio Aug 30 11:24:35 living volumio[733]: info: [1725017075215] ControllerQobuz::clearAddPlayTrack Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand stop Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::updateTrackBlock Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrackBlock Aug 30 11:24:35 living volumio[733]: info: sendMpdCommand status took 16 milliseconds Aug 30 11:24:35 living volumio[733]: info: sendMpdCommand stop took 9 milliseconds Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand clear Aug 30 11:24:35 living volumio[733]: info: Aug 30 11:24:35 living volumio[733]: ---------------------------- MPD announces system playlist update Aug 30 11:24:35 living volumio[733]: info: Ignoring MPD Status Update Aug 30 11:24:35 living volumio[733]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 30 11:24:35 living volumio[733]: info: sendMpdCommand clear took 2 milliseconds Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/40985581" Aug 30 11:24:35 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrack 49 Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:35 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:35 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:35 living volumio[733]: info: CorePlayQueue::getTrack 49 Aug 30 11:24:35 living volumio[733]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Aug 30 11:24:35 living volumio[733]: STREAMING PROXY: Handling url /?data=qobuz://song/40985581 Aug 30 11:24:35 living volumio[733]: info: ------------------------------ 34ms Aug 30 11:24:35 living volumio[733]: error: updateQueue error: null Aug 30 11:24:35 living volumio[733]: info: ------------------------------ 15ms Aug 30 11:24:35 living volumio[733]: info: Executing endpoint getStreamUrlqobuz Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Aug 30 11:24:35 living volumio[733]: info: getStreamUrl took 194 milliseconds Aug 30 11:24:35 living volumio[733]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1152944&eid=40985581&fmt=6&profile=raw&app_id=539451548&cid=2293328&etsp=1725020675&hmac=F4EIpK5hVy_L_Ac9VwATAX9ZMUs Aug 30 11:24:35 living volumio[733]: STREAMING PROXY: Response: 200, length: 27367946 Aug 30 11:24:35 living volumio[733]: STREAMING PROXY: Client dropped request, destroying Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/40985581" Aug 30 11:24:35 living volumio[733]: info: Aug 30 11:24:35 living volumio[733]: ---------------------------- MPD announces system playlist update Aug 30 11:24:35 living volumio[733]: info: Ignoring MPD Status Update Aug 30 11:24:35 living volumio[733]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/40985581" took 1 milliseconds Aug 30 11:24:35 living volumio[733]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 30 11:24:35 living volumio[733]: verbose: ControllerMpd::sendMpdCommand play Aug 30 11:24:35 living volumio[733]: info: ------------------------------ 2ms Aug 30 11:24:35 living volumio[733]: info: sendMpdCommand play took 2 milliseconds Aug 30 11:24:35 living volumio[733]: STREAMING PROXY: Handling url /?data=qobuz://song/40985581 Aug 30 11:24:35 living volumio[733]: info: Executing endpoint getStreamUrlqobuz Aug 30 11:24:35 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Aug 30 11:24:36 living volumio[733]: info: getStreamUrl took 196 milliseconds Aug 30 11:24:36 living volumio[733]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=1152944&eid=40985581&fmt=6&profile=raw&app_id=539451548&cid=2293328&etsp=1725020675&hmac=F4EIpK5hVy_L_Ac9VwATAX9ZMUs Aug 30 11:24:36 living volumio[733]: STREAMING PROXY: Response: 200, length: 27367946 Aug 30 11:24:36 living volumio[733]: info: Aug 30 11:24:36 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:36 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:36 living volumio[733]: info: Aug 30 11:24:36 living volumio[733]: ---------------------------- MPD announces state update: player Aug 30 11:24:36 living volumio[733]: info: sendMpdCommand status took 40 milliseconds Aug 30 11:24:36 living volumio[733]: info: ControllerMpd::getState Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::sendMpdCommand status Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:36 living volumio[733]: info: sendMpdCommand status took 2 milliseconds Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::parseState Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 30 11:24:36 living volumio[733]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 30 11:24:36 living volumio[733]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:36 living volumio[733]: verbose: ControllerMpd::parseTrackInfo Aug 30 11:24:36 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:36 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:36 living volumio[733]: info: CorePlayQueue::getTrack 49 Aug 30 11:24:36 living volumio[733]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"40985581","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/40985581","trackType":"qobuz"} Aug 30 11:24:36 living volumio[733]: verbose: CURRENT POSITION 49 Aug 30 11:24:36 living volumio[733]: info: CoreStateMachine::syncState stateService play Aug 30 11:24:36 living volumio[733]: info: CoreStateMachine::syncState currentStatus stop Aug 30 11:24:36 living volumio[733]: info: ControllerMpd::pushState Aug 30 11:24:36 living volumio[733]: info: CoreCommandRouter::servicePushState Aug 30 11:24:36 living volumio[733]: info: CorePlayQueue::getTrack 49 Aug 30 11:24:36 living volumio[733]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1097,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"40985581","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/40985581","trackType":"qobuz"} Aug 30 11:24:36 living volumio[733]: verbose: CURRENT POSITION 49 Aug 30 11:24:36 living volumio[733]: info: CoreStateMachine::syncState stateService play Aug 30 11:24:36 living volumio[733]: info: CoreStateMachine::syncState currentStatus play Aug 30 11:24:36 living volumio[733]: info: Received an update from plugin. extracting info from payload Aug 30 11:24:36 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:36 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 11:24:36 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:36 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:36 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:36 living volumio[733]: info: CoreStateMachine::pushState Aug 30 11:24:36 living volumio[733]: info: CoreCommandRouter::volumioPushState Aug 30 11:24:36 living volumio[733]: info: MRS: Pushing multiroomSync output update for this device Aug 30 11:24:36 living volumio[733]: info: MRS: Pushing multiroomSync output Aug 30 11:24:36 living volumio[733]: info: ------------------------------ 59ms Aug 30 11:24:36 living volumio[733]: info: ------------------------------ 25ms Aug 30 11:24:36 living volumio[733]: STREAMING PROXY: Client dropped request, destroying Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: All cached search sources collected Aug 30 11:24:41 living volumio[733]: info: All cached search sources collected Aug 30 11:24:41 living volumio[733]: info: All cached search sources collected Aug 30 11:24:41 living volumio[733]: info: All cached search sources collected Aug 30 11:24:41 living volumio[733]: info: All cached search sources collected Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: [youtube2] InnertubeLoader: creating Innertube instance... Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Aug 30 11:24:41 living volumio[733]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Aug 30 11:24:41 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 11:24:44 living volumio[733]: info: searchQOBUZUri took 3704 milliseconds Aug 30 11:24:45 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 11:24:45 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 11:24:45 living volumio[733]: info: Discovery: Getting this device information Aug 30 11:24:45 living volumio[733]: info: CoreCommandRouter::volumioGetState Aug 30 11:24:45 living volumio[733]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 11:24:45 living volumio[733]: info: searchQOBUZUri took 4210 milliseconds Aug 30 11:24:45 living volumio[733]: info: searchQOBUZUri took 4259 milliseconds Aug 30 11:24:46 living volumio[733]: info: searchQOBUZUri took 5028 milliseconds Aug 30 11:24:46 living volumio[733]: info: searchQOBUZUri took 5067 milliseconds Aug 30 11:24:48 living volumio[733]: info: searchQOBUZUri took 7034 milliseconds Aug 30 11:24:48 living volumio[733]: info: searchQOBUZUri took 6989 milliseconds Aug 30 11:24:48 living volumio[733]: info: searchQOBUZUri took 7074 milliseconds Aug 30 11:24:48 living volumio[733]: info: searchQOBUZUri took 7003 milliseconds Aug 30 11:24:49 living volumio[733]: info: searchQOBUZUri took 8638 milliseconds Aug 30 11:24:49 living volumio[733]: info: searchQOBUZUri took 8580 milliseconds Aug 30 11:24:49 living volumio[733]: info: searchQOBUZUri took 8596 milliseconds Aug 30 11:24:49 living volumio[733]: info: searchQOBUZUri took 8624 milliseconds Aug 30 11:24:49 living volumio[733]: info: searchQOBUZUri took 8613 milliseconds Aug 30 11:24:49 living volumio[733]: info: searchQOBUZUri took 8673 milliseconds Aug 30 11:24:49 living volumio[733]: info: searchQOBUZUri took 8730 milliseconds Aug 30 11:24:50 living volumio[733]: info: searchQOBUZUri took 8690 milliseconds Aug 30 11:24:50 living volumio[733]: info: searchQOBUZUri took 8703 milliseconds Aug 30 11:24:50 living volumio[733]: info: searchQOBUZUri took 8754 milliseconds Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/23011514 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/23011514 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/219784 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/219784 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/98301000 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/98301000 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/27891005 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/27891005 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/2781545 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/2781545 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/269687 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/269687 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/44536220 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/44536220 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/2797359 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/2797359 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/2719878 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/2719878 in service qobuz Aug 30 11:24:53 living volumio[733]: error: Search in plugin mpd timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin soundcloud timed out Aug 30 11:24:53 living volumio[733]: error: Search in plugin youtube2 timed out Aug 30 11:24:53 living volumio[733]: info: All search sources collected, pushing search results Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioGetQueue Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::getQueue Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::getQueue Aug 30 11:24:53 living volumio[733]: info: CoreCommandRouter::volumioAddQueueItems Aug 30 11:24:53 living volumio[733]: info: CoreStateMachine::addQueueItems Aug 30 11:24:53 living volumio[733]: info: CorePlayQueue::addQueueItems Aug 30 11:24:53 living volumio[733]: info: Preload queue cleared Aug 30 11:24:53 living volumio[733]: info: Adding Item to queue: qobuz://song/2571758 Aug 30 11:24:53 living volumio[733]: info: Exploding uri qobuz://song/2571758 in service qobuz Aug 30 11:24:53 living volumio[733]: info: METAVOLUMIO: Infinity Playback added 10 Tracks to queue Aug 30 11:24:56 living volumio[733]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 11:24:56 living volumio[733]: Error: connect ECONNREFUSED 127.0.0.1:443 Aug 30 11:24:56 living volumio[733]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Aug 30 11:24:56 living volumio[733]: errno: -111, Aug 30 11:24:56 living volumio[733]: code: 'ECONNREFUSED', Aug 30 11:24:56 living volumio[733]: syscall: 'connect', Aug 30 11:24:56 living volumio[733]: address: '127.0.0.1', Aug 30 11:24:56 living volumio[733]: port: 443 Aug 30 11:24:56 living volumio[733]: } Aug 30 11:24:56 living volumio[733]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 11:24:57 living sudo[2920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 11:23 Aug 30 11:24:57 living sudo[2920]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"