-- Logs begin at Fri 2024-03-22 22:13:25 +08, end at Tue 2025-06-03 19:13:21 +08. -- Jun 03 19:12:06 minidsp-shd volumio[691]: Searching plugin music_service/tidal Jun 03 19:12:06 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jun 03 19:12:06 minidsp-shd volumio[691]: info: searchTIDALUri took 677 milliseconds Jun 03 19:12:06 minidsp-shd volumio[691]: info: search took 679 milliseconds Jun 03 19:12:06 minidsp-shd volumio[691]: info: All search sources collected, pushing search results Jun 03 19:12:07 minidsp-shd volumio[691]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 03 19:12:07 minidsp-shd volumio[691]: info: Retrying Login Due to Network Error Jun 03 19:12:12 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 19:12:12 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 19:12:12 minidsp-shd volumio[691]: info: Discovery: Getting this device information Jun 03 19:12:12 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioGetState Jun 03 19:12:12 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 0 Jun 03 19:12:12 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 19:12:17 minidsp-shd volumio[691]: info: MyVolumio login type: Token Jun 03 19:12:42 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 19:12:42 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 19:12:42 minidsp-shd volumio[691]: info: Discovery: Getting this device information Jun 03 19:12:42 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioGetState Jun 03 19:12:42 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 0 Jun 03 19:12:42 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 19:12:47 minidsp-shd volumio[691]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 03 19:12:47 minidsp-shd volumio[691]: info: Retrying Login Due to Network Error Jun 03 19:12:53 minidsp-shd volumio[691]: Searching plugin music_service/tidal Jun 03 19:12:53 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jun 03 19:12:54 minidsp-shd volumio[691]: info: searchTIDALUri took 396 milliseconds Jun 03 19:12:54 minidsp-shd volumio[691]: info: search took 399 milliseconds Jun 03 19:12:54 minidsp-shd volumio[691]: info: All search sources collected, pushing search results Jun 03 19:12:56 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Jun 03 19:12:56 minidsp-shd volumio[691]: info: browseTIDALUri took 647 milliseconds Jun 03 19:12:57 minidsp-shd volumio[691]: info: Preload queue cleared Jun 03 19:12:57 minidsp-shd volumio[691]: info: Preload queue cleared Jun 03 19:12:57 minidsp-shd volumio[691]: info: Preload queue cleared Jun 03 19:12:57 minidsp-shd volumio[691]: info: Executing endpoint getSimilarArtists Jun 03 19:12:57 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 03 19:12:57 minidsp-shd volumio[691]: error: Failed request for metavolumio API Jun 03 19:12:57 minidsp-shd volumio[691]: info: Executing endpoint metavolumio Jun 03 19:12:57 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 19:12:57 minidsp-shd volumio[691]: error: Failed request for metavolumio API Jun 03 19:12:57 minidsp-shd volumio[691]: info: MyVolumio login type: Token Jun 03 19:13:00 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Jun 03 19:13:01 minidsp-shd volumio[691]: info: browseTIDALUri took 346 milliseconds Jun 03 19:13:01 minidsp-shd volumio[691]: info: Preload queue cleared Jun 03 19:13:02 minidsp-shd volumio[691]: info: Executing endpoint getSimilarAlbums Jun 03 19:13:02 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jun 03 19:13:02 minidsp-shd volumio[691]: error: Failed request for metavolumio API Jun 03 19:13:02 minidsp-shd volumio[691]: info: Executing endpoint metavolumio Jun 03 19:13:02 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 19:13:02 minidsp-shd volumio[691]: error: Failed request for metavolumio API Jun 03 19:13:02 minidsp-shd volumio[691]: info: Executing endpoint metavolumio Jun 03 19:13:02 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 03 19:13:02 minidsp-shd volumio[691]: error: Failed request for metavolumio API Jun 03 19:13:05 minidsp-shd volumio[691]: info: Preload queue cleared Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioAddQueueItems Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::addQueueItems Jun 03 19:13:05 minidsp-shd volumio[691]: info: CorePlayQueue::addQueueItems Jun 03 19:13:05 minidsp-shd volumio[691]: info: Preload queue cleared Jun 03 19:13:05 minidsp-shd volumio[691]: info: Adding Item to queue: tidal://album/393569150 Jun 03 19:13:05 minidsp-shd volumio[691]: info: Exploding uri tidal://album/393569150 in service tidal Jun 03 19:13:05 minidsp-shd volumio[691]: info: explodeTIDALUri took 285 milliseconds Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushQueue Jun 03 19:13:05 minidsp-shd volumio[691]: info: CorePlayQueue::saveQueue Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::updateTrackBlock Jun 03 19:13:05 minidsp-shd volumio[691]: info: CorePlayQueue::getTrackBlock Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPlay Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::play index 392 Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::stop Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::play index undefined Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 19:13:05 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:05 minidsp-shd volumio[691]: info: CoreStateMachine::startPlaybackTimer Jun 03 19:13:05 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:05 minidsp-shd volumio[691]: info: [1748949185965] ControllerTidal::clearAddPlayTrack Jun 03 19:13:05 minidsp-shd volumio[691]: info: Getting stream with soundQuality LOSSLESS Jun 03 19:13:05 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 19:13:06 minidsp-shd volumio[691]: info: sendMpdCommand stop took 58 milliseconds Jun 03 19:13:06 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand clear Jun 03 19:13:06 minidsp-shd volumio[691]: info: Jun 03 19:13:06 minidsp-shd volumio[691]: ---------------------------- MPD announces system playlist update Jun 03 19:13:06 minidsp-shd volumio[691]: info: Ignoring MPD Status Update Jun 03 19:13:06 minidsp-shd volumio[691]: info: sendMpdCommand clear took 37 milliseconds Jun 03 19:13:06 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS" Jun 03 19:13:06 minidsp-shd volumio[691]: error: updateQueue error: null Jun 03 19:13:06 minidsp-shd volumio[691]: info: Jun 03 19:13:06 minidsp-shd volumio[691]: ---------------------------- MPD announces system playlist update Jun 03 19:13:06 minidsp-shd volumio[691]: info: Ignoring MPD Status Update Jun 03 19:13:06 minidsp-shd volumio[691]: info: ------------------------------ 79ms Jun 03 19:13:06 minidsp-shd volumio[691]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS" took 58 milliseconds Jun 03 19:13:06 minidsp-shd volumio[691]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 03 19:13:06 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand play Jun 03 19:13:06 minidsp-shd volumio[691]: info: Jun 03 19:13:06 minidsp-shd volumio[691]: ---------------------------- MPD announces system playlist update Jun 03 19:13:06 minidsp-shd volumio[691]: info: Ignoring MPD Status Update Jun 03 19:13:06 minidsp-shd volumio[691]: info: Jun 03 19:13:06 minidsp-shd volumio[691]: ---------------------------- MPD announces system playlist update Jun 03 19:13:06 minidsp-shd volumio[691]: info: Ignoring MPD Status Update Jun 03 19:13:06 minidsp-shd volumio[691]: info: ------------------------------ 64ms Jun 03 19:13:06 minidsp-shd volumio[691]: info: sendMpdCommand play took 43 milliseconds Jun 03 19:13:06 minidsp-shd volumio[691]: info: ------------------------------ 25ms Jun 03 19:13:06 minidsp-shd volumio[691]: info: ------------------------------ 20ms Jun 03 19:13:06 minidsp-shd volumio[691]: info: Jun 03 19:13:06 minidsp-shd volumio[691]: ---------------------------- MPD announces system playlist update Jun 03 19:13:06 minidsp-shd volumio[691]: STREAMING PROXY: Handling url /?data=tidal://song/393569151&soundQuality=LOSSLESS Jun 03 19:13:06 minidsp-shd volumio[691]: info: Ignoring MPD Status Update Jun 03 19:13:06 minidsp-shd volumio[691]: info: Jun 03 19:13:06 minidsp-shd volumio[691]: ---------------------------- MPD announces system playlist update Jun 03 19:13:06 minidsp-shd volumio[691]: info: Ignoring MPD Status Update Jun 03 19:13:06 minidsp-shd volumio[691]: error: Upnp client error: Error: This socket has been ended by the other party Jun 03 19:13:06 minidsp-shd volumio[691]: info: ------------------------------ 127ms Jun 03 19:13:06 minidsp-shd volumio[691]: info: ------------------------------ 53ms Jun 03 19:13:06 minidsp-shd volumio[691]: info: Executing endpoint getStreamUrltidal Jun 03 19:13:06 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Jun 03 19:13:07 minidsp-shd volumio[691]: info: getStreamUrl took 699 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKAgDEiQzNmRkYjUxMjgwMzk0ZmYxZDcyNzRkZGQzZThlZmFmNC5tcDQ/0.flac?Expires=1748952786&Signature=cM7HK~MTR0~ZYLvEKY7Ax0NJFs6q7IQScWkQO~yeIfFbevrN9O9mN2bM7vSn528aawDMYpT4sg9ibwn0C5OJ-yENQNVJ97n-80KXaZ2lvwaTiA5VcZm94aySkKz7KWyANBTfLFkL5w6cFEulIhCEkVfsPwakyVA1Mh9-4rPWhAZXuWxSoPVzGXqJOCh~hT8MRQullRpo-URwqAjctM3lnAvaZ8~6H09-VyhN2rBJQBd6igBIpYwomHwtvLhnWaNrL2KYQFqZyuxIx-D3DnJGdf0kHYu~oyBv1BykDIuyRu7bVl6fJeKJ3Cr5pMekaksU1FwDWNWKKbdZfDIKY0Hj9Q__&Key-Pair-Id=K14LZCZ9QUI4JL Jun 03 19:13:07 minidsp-shd volumio[691]: STREAMING PROXY: Response: 200, length: 23270648 Jun 03 19:13:07 minidsp-shd volumio[691]: info: Jun 03 19:13:07 minidsp-shd volumio[691]: ---------------------------- MPD announces state update: player Jun 03 19:13:07 minidsp-shd volumio[691]: info: ControllerMpd::getState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:13:07 minidsp-shd volumio[691]: info: Jun 03 19:13:07 minidsp-shd volumio[691]: ---------------------------- MPD announces state update: player Jun 03 19:13:07 minidsp-shd volumio[691]: info: ControllerMpd::getState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:13:07 minidsp-shd volumio[691]: info: Jun 03 19:13:07 minidsp-shd volumio[691]: ---------------------------- MPD announces state update: player Jun 03 19:13:07 minidsp-shd volumio[691]: info: ControllerMpd::getState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:13:07 minidsp-shd volumio[691]: info: Jun 03 19:13:07 minidsp-shd volumio[691]: ---------------------------- MPD announces state update: player Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand status took 20 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: info: ControllerMpd::getState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand status took 16 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand status took 10 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:13:07 minidsp-shd volumio[691]: info: Jun 03 19:13:07 minidsp-shd volumio[691]: ---------------------------- MPD announces state update: player Jun 03 19:13:07 minidsp-shd volumio[691]: info: ControllerMpd::getState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:13:07 minidsp-shd volumio[691]: info: Jun 03 19:13:07 minidsp-shd volumio[691]: ---------------------------- MPD announces state update: player Jun 03 19:13:07 minidsp-shd volumio[691]: info: ControllerMpd::getState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand status Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand status took 29 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand playlistinfo took 23 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand playlistinfo took 21 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand status took 13 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: info: sendMpdCommand status took 9 milliseconds Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::parseState Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 19:13:07 minidsp-shd volumio[691]: info: ControllerMpd::pushState Jun 03 19:13:07 minidsp-shd volumio[691]: info: CoreCommandRouter::servicePushState Jun 03 19:13:07 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"393569151&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS","trackType":"tidal"} Jun 03 19:13:07 minidsp-shd volumio[691]: verbose: CURRENT POSITION 392 Jun 03 19:13:07 minidsp-shd volumio[691]: info: CoreStateMachine::syncState stateService play Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState currentStatus stop Jun 03 19:13:08 minidsp-shd volumio[691]: info: ControllerMpd::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::servicePushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"393569151&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS","trackType":"tidal"} Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: CURRENT POSITION 392 Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState stateService play Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:13:08 minidsp-shd volumio[691]: info: Received an update from plugin. extracting info from payload Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: ControllerMpd::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::servicePushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"393569151&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS","trackType":"tidal"} Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: CURRENT POSITION 392 Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState stateService play Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:13:08 minidsp-shd volumio[691]: info: Received an update from plugin. extracting info from payload Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: ------------------------------ 179ms Jun 03 19:13:08 minidsp-shd volumio[691]: info: ------------------------------ 196ms Jun 03 19:13:08 minidsp-shd volumio[691]: info: ------------------------------ 192ms Jun 03 19:13:08 minidsp-shd volumio[691]: info: sendMpdCommand playlistinfo took 147 milliseconds Jun 03 19:13:08 minidsp-shd volumio[691]: info: sendMpdCommand playlistinfo took 141 milliseconds Jun 03 19:13:08 minidsp-shd volumio[691]: info: sendMpdCommand playlistinfo took 141 milliseconds Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: ControllerMpd::parseTrackInfo Jun 03 19:13:08 minidsp-shd volumio[691]: info: ControllerMpd::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::servicePushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"393569151&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS","trackType":"tidal"} Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: CURRENT POSITION 392 Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState stateService play Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:13:08 minidsp-shd volumio[691]: info: Received an update from plugin. extracting info from payload Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: ControllerMpd::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::servicePushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"393569151&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS","trackType":"tidal"} Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: CURRENT POSITION 392 Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState stateService play Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:13:08 minidsp-shd volumio[691]: info: Received an update from plugin. extracting info from payload Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: ControllerMpd::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::servicePushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CorePlayQueue::getTrack 392 Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":236,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"393569151&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/393569151&soundQuality=LOSSLESS","trackType":"tidal"} Jun 03 19:13:08 minidsp-shd volumio[691]: verbose: CURRENT POSITION 392 Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState stateService play Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::syncState currentStatus play Jun 03 19:13:08 minidsp-shd volumio[691]: info: Received an update from plugin. extracting info from payload Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreStateMachine::pushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioPushState Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output update for this device Jun 03 19:13:08 minidsp-shd volumio[691]: info: MRS: Pushing multiroomSync output Jun 03 19:13:08 minidsp-shd volumio[691]: info: ------------------------------ 316ms Jun 03 19:13:08 minidsp-shd volumio[691]: info: ------------------------------ 295ms Jun 03 19:13:08 minidsp-shd volumio[691]: info: ------------------------------ 292ms Jun 03 19:13:10 minidsp-shd volumio[691]: STREAMING PROXY: Client dropped request, destroying Jun 03 19:13:12 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 19:13:12 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 19:13:12 minidsp-shd volumio[691]: info: Discovery: Getting this device information Jun 03 19:13:12 minidsp-shd volumio[691]: info: CoreCommandRouter::volumioGetState Jun 03 19:13:12 minidsp-shd volumio[691]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 19:13:20 minidsp-shd volumio[691]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 19:13:20 minidsp-shd volumio[691]: Error: connect ETIMEDOUT 31.13.95.33:443 Jun 03 19:13:20 minidsp-shd volumio[691]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 03 19:13:20 minidsp-shd volumio[691]: errno: -110, Jun 03 19:13:20 minidsp-shd volumio[691]: code: 'ETIMEDOUT', Jun 03 19:13:20 minidsp-shd volumio[691]: syscall: 'connect', Jun 03 19:13:20 minidsp-shd volumio[691]: address: '31.13.95.33', Jun 03 19:13:20 minidsp-shd volumio[691]: port: 443 Jun 03 19:13:20 minidsp-shd volumio[691]: } Jun 03 19:13:20 minidsp-shd volumio[691]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 19:13:21 minidsp-shd sudo[1567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-03 19:12 Jun 03 19:13:21 minidsp-shd sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:13:25 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="18533ba33f8f92d7e7e459bb30f70beb"