-- Logs begin at Thu 2019-02-14 18:11:59 +08, end at Sun 2025-06-08 11:40:51 +08. -- Jun 08 11:39:00 minidsp-shd volumio[5426]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 08 11:39:00 minidsp-shd volumio[5426]: info: Retrying Login Due to Network Error Jun 08 11:39:01 minidsp-shd sudo[5824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //169.254.198.219/Internal Storage /mnt/NAS/Internal_Storage Jun 08 11:39:01 minidsp-shd sudo[5824]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 11:39:01 minidsp-shd kernel: CIFS: Attempting to mount //169.254.198.219/Internal Storage Jun 08 11:39:01 minidsp-shd kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jun 08 11:39:10 minidsp-shd volumio[5426]: info: MyVolumio login type: Token Jun 08 11:39:11 minidsp-shd kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jun 08 11:39:11 minidsp-shd kernel: CIFS VFS: cifs_mount failed w/return code = -115 Jun 08 11:39:11 minidsp-shd sudo[5824]: pam_unix(sudo:session): session closed for user root Jun 08 11:39:11 minidsp-shd volumio[5426]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jun 08 11:39:37 minidsp-shd volumio[5426]: Searching all installed plugins Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: , search Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jun 08 11:39:37 minidsp-shd volumio[5426]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: inputs , search Jun 08 11:39:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jun 08 11:39:38 minidsp-shd volumio[5426]: (node:5426) UnhandledPromiseRejectionWarning: Error: Start tag expected, '<' not found Jun 08 11:39:38 minidsp-shd volumio[5426]: at Object.module.exports.fromXml (/volumio/node_modules/libxmljs/lib/document.js:168:21) Jun 08 11:39:38 minidsp-shd volumio[5426]: at /volumio/app/plugins/music_service/webradio/index.js:971:31 Jun 08 11:39:38 minidsp-shd volumio[5426]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jun 08 11:39:38 minidsp-shd volumio[5426]: (node:5426) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Jun 08 11:39:38 minidsp-shd volumio[5426]: (node:5426) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jun 08 11:39:38 minidsp-shd volumio[5426]: info: searchTIDALUri took 736 milliseconds Jun 08 11:39:38 minidsp-shd volumio[5426]: info: search took 739 milliseconds Jun 08 11:39:40 minidsp-shd volumio[5426]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 08 11:39:40 minidsp-shd volumio[5426]: info: Retrying Login Due to Network Error Jun 08 11:39:42 minidsp-shd volumio[5426]: error: Search in plugin webradio timed out Jun 08 11:39:42 minidsp-shd volumio[5426]: error: Search in plugin inputs timed out Jun 08 11:39:42 minidsp-shd volumio[5426]: info: All search sources collected, pushing search results Jun 08 11:39:45 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Jun 08 11:39:46 minidsp-shd volumio[5426]: Searching plugin music_service/tidal Jun 08 11:39:46 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jun 08 11:39:46 minidsp-shd volumio[5426]: info: searchTIDALUri took 650 milliseconds Jun 08 11:39:46 minidsp-shd volumio[5426]: info: search took 653 milliseconds Jun 08 11:39:46 minidsp-shd volumio[5426]: info: All search sources collected, pushing search results Jun 08 11:39:47 minidsp-shd volumio[5426]: info: browseTIDALUri took 1587 milliseconds Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preload queue cleared Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preload queue cleared Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preload queue cleared Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/407570109 Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/407570110 Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/234938079 Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/302295675 Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/327159909 Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/407570109 in service tidal Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/407570110 in service tidal Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Executing endpoint getSimilarArtists Jun 08 11:39:47 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Executing endpoint getSimilarArtists Jun 08 11:39:47 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/234938079 in service tidal Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/302295675 in service tidal Jun 08 11:39:47 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/327159909 in service tidal Jun 08 11:39:48 minidsp-shd volumio[5426]: info: explodeTIDALUri took 601 milliseconds Jun 08 11:39:48 minidsp-shd volumio[5426]: info: explodeTIDALUri took 592 milliseconds Jun 08 11:39:48 minidsp-shd volumio[5426]: info: explodeTIDALUri took 541 milliseconds Jun 08 11:39:48 minidsp-shd volumio[5426]: info: explodeTIDALUri took 553 milliseconds Jun 08 11:39:48 minidsp-shd volumio[5426]: info: explodeTIDALUri took 625 milliseconds Jun 08 11:39:49 minidsp-shd volumio[5426]: info: Executing endpoint getSimilarArtists Jun 08 11:39:49 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 08 11:39:49 minidsp-shd volumio[5426]: info: Executing endpoint getSimilarArtists Jun 08 11:39:49 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 08 11:39:49 minidsp-shd volumio[5426]: info: Executing endpoint getSimilarArtists Jun 08 11:39:49 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 08 11:39:49 minidsp-shd volumio[5426]: info: Executing endpoint metavolumio Jun 08 11:39:49 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 11:39:49 minidsp-shd volumio[5426]: info: Executing endpoint metavolumio Jun 08 11:39:49 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 11:39:50 minidsp-shd volumio[5426]: info: MyVolumio login type: Token Jun 08 11:39:52 minidsp-shd volumio[5426]: info: Executing endpoint metavolumio Jun 08 11:39:52 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 11:39:53 minidsp-shd volumio[5426]: info: Executing endpoint metavolumio Jun 08 11:39:53 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 11:39:54 minidsp-shd volumio[5426]: info: Executing endpoint metavolumio Jun 08 11:39:54 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 11:39:56 minidsp-shd volumio[5426]: Searching plugin music_service/tidal Jun 08 11:39:56 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jun 08 11:39:56 minidsp-shd volumio[5426]: info: searchTIDALUri took 397 milliseconds Jun 08 11:39:56 minidsp-shd volumio[5426]: info: search took 399 milliseconds Jun 08 11:39:56 minidsp-shd volumio[5426]: info: All search sources collected, pushing search results Jun 08 11:40:17 minidsp-shd volumio[5426]: Searching plugin music_service/tidal Jun 08 11:40:17 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jun 08 11:40:18 minidsp-shd volumio[5426]: info: searchTIDALUri took 621 milliseconds Jun 08 11:40:18 minidsp-shd volumio[5426]: info: search took 623 milliseconds Jun 08 11:40:18 minidsp-shd volumio[5426]: info: All search sources collected, pushing search results Jun 08 11:40:20 minidsp-shd volumio[5426]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 08 11:40:20 minidsp-shd volumio[5426]: info: Retrying Login Due to Network Error Jun 08 11:40:30 minidsp-shd volumio[5426]: info: MyVolumio login type: Token Jun 08 11:40:30 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Jun 08 11:40:31 minidsp-shd volumio-remote-updater[466]: No test mode Jun 08 11:40:31 minidsp-shd volumio-remote-updater[466]: No alpha test mode Jun 08 11:40:31 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 08 11:40:31 minidsp-shd volumio[5426]: info: browseTIDALUri took 1005 milliseconds Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preload queue cleared Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459705 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459706 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459707 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459708 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459709 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459710 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459711 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459712 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459713 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459714 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459715 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459716 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459717 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459718 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459719 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459720 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459721 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459722 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459723 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459724 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459725 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459726 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459727 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459728 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459729 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459730 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459731 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459732 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459733 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459734 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459735 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459736 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459737 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459738 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459739 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459740 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459741 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459742 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459743 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Preloading song: tidal://song/254459744 Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459705 in service tidal Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459706 in service tidal Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459707 in service tidal Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459708 in service tidal Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459709 in service tidal Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459710 in service tidal Jun 08 11:40:31 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459711 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459712 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459713 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459714 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459715 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 543 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459716 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459717 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 08 11:40:32 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 561 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459718 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 620 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459719 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 569 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459720 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 612 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459721 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459722 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 558 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 653 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459723 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 566 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459724 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 569 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 543 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459725 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459726 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 600 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459727 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459728 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 547 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 666 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459729 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 646 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459730 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 611 milliseconds Jun 08 11:40:32 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459731 in service tidal Jun 08 11:40:32 minidsp-shd volumio[5426]: info: explodeTIDALUri took 573 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459732 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 571 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459733 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 595 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 553 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459734 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459735 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 590 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 585 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459736 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 545 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459737 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 538 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459738 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 552 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459739 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 553 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459740 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 535 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459741 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 557 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459742 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459743 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 576 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 554 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: Exploding uri tidal://song/254459744 in service tidal Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 565 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 599 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 576 milliseconds Jun 08 11:40:33 minidsp-shd volumio[5426]: info: explodeTIDALUri took 558 milliseconds Jun 08 11:40:34 minidsp-shd volumio[5426]: info: explodeTIDALUri took 568 milliseconds Jun 08 11:40:34 minidsp-shd volumio[5426]: info: explodeTIDALUri took 540 milliseconds Jun 08 11:40:34 minidsp-shd volumio[5426]: info: explodeTIDALUri took 538 milliseconds Jun 08 11:40:34 minidsp-shd volumio[5426]: info: explodeTIDALUri took 1014 milliseconds Jun 08 11:40:34 minidsp-shd volumio[5426]: info: explodeTIDALUri took 546 milliseconds Jun 08 11:40:34 minidsp-shd volumio[5426]: info: explodeTIDALUri took 974 milliseconds Jun 08 11:40:34 minidsp-shd volumio[5426]: info: explodeTIDALUri took 986 milliseconds Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Preload queue cleared Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CoreStateMachine::ClearQueue Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CoreStateMachine::stop Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CorePlayQueue::clearPlayQueue Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CorePlayQueue::saveQueue Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushQueue Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CoreStateMachine::addQueueItems Jun 08 11:40:35 minidsp-shd volumio[5426]: info: CorePlayQueue::addQueueItems Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Preload queue cleared Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459705 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459705 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459706 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459706 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459707 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459707 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459708 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459708 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459709 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459709 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459710 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459710 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459711 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459711 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459712 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459712 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459713 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459713 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459714 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459714 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459715 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459715 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459716 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459716 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459717 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459717 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459718 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459718 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459719 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459719 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459720 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459720 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459721 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459721 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459722 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459722 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459723 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459723 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459724 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459724 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459725 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459725 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459726 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459726 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459727 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459727 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459728 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459728 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459729 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459729 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459730 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459730 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459731 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459731 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459732 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459732 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459733 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459733 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459734 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459734 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459735 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459735 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459736 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459736 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459737 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459737 Jun 08 11:40:35 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459738 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459738 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459739 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459739 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459740 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459740 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459741 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459741 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459742 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459742 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459743 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459743 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Adding Item to queue: tidal://song/254459744 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Using cached record of: tidal://song/254459744 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushQueue Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CorePlayQueue::saveQueue Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::updateTrackBlock Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrackBlock Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPlay Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::play index 3 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::stop Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::play index undefined Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::startPlaybackTimer Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:36 minidsp-shd volumio[5426]: info: [1749354036052] ControllerTidal::clearAddPlayTrack Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Getting stream with soundQuality LOSSLESS Jun 08 11:40:36 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand stop Jun 08 11:40:36 minidsp-shd volumio[5426]: info: sendMpdCommand stop took 30 milliseconds Jun 08 11:40:36 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand clear Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Jun 08 11:40:36 minidsp-shd volumio[5426]: ---------------------------- MPD announces system playlist update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Ignoring MPD Status Update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: sendMpdCommand clear took 17 milliseconds Jun 08 11:40:36 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS" Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Jun 08 11:40:36 minidsp-shd volumio[5426]: ---------------------------- MPD announces system playlist update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Ignoring MPD Status Update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Jun 08 11:40:36 minidsp-shd volumio[5426]: ---------------------------- MPD announces system playlist update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Ignoring MPD Status Update Jun 08 11:40:36 minidsp-shd volumio[5426]: error: updateQueue error: null Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Jun 08 11:40:36 minidsp-shd volumio[5426]: ---------------------------- MPD announces system playlist update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Ignoring MPD Status Update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: ------------------------------ 27ms Jun 08 11:40:36 minidsp-shd volumio[5426]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS" took 21 milliseconds Jun 08 11:40:36 minidsp-shd volumio[5426]: info: ------------------------------ 19ms Jun 08 11:40:36 minidsp-shd volumio[5426]: info: ------------------------------ 15ms Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 08 11:40:36 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand play Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Jun 08 11:40:36 minidsp-shd volumio[5426]: ---------------------------- MPD announces system playlist update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Ignoring MPD Status Update Jun 08 11:40:36 minidsp-shd volumio[5426]: STREAMING PROXY: Handling url /?data=tidal://song/254459708&soundQuality=LOSSLESS Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Jun 08 11:40:36 minidsp-shd volumio[5426]: ---------------------------- MPD announces system playlist update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Ignoring MPD Status Update Jun 08 11:40:36 minidsp-shd volumio[5426]: info: ------------------------------ 34ms Jun 08 11:40:36 minidsp-shd volumio[5426]: info: sendMpdCommand play took 25 milliseconds Jun 08 11:40:36 minidsp-shd volumio[5426]: info: ------------------------------ 23ms Jun 08 11:40:36 minidsp-shd volumio[5426]: info: ------------------------------ 19ms Jun 08 11:40:36 minidsp-shd volumio[5426]: info: Executing endpoint getStreamUrltidal Jun 08 11:40:36 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Jun 08 11:40:36 minidsp-shd volumio[5426]: info: getStreamUrl took 632 milliseconds Jun 08 11:40:36 minidsp-shd volumio[5426]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEic2MDgxM2QyODNlNmE3NGY0YTliNWI4YWVlZjYzOTNjYl82MS5tcDQ/0.flac?token=1749357636~NDNiNjY3OTcwNTg3ZTk3M2RhNzU0NDUwNTEyNmNjOTQ1NjgxYWRkMw== Jun 08 11:40:37 minidsp-shd volumio[5426]: STREAMING PROXY: Response: 200, length: 27780733 Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Jun 08 11:40:37 minidsp-shd volumio[5426]: ---------------------------- MPD announces state update: player Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::getState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand status Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Jun 08 11:40:37 minidsp-shd volumio[5426]: ---------------------------- MPD announces state update: player Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::getState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand status Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand status took 10 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Jun 08 11:40:37 minidsp-shd volumio[5426]: ---------------------------- MPD announces state update: player Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::getState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand status Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Jun 08 11:40:37 minidsp-shd volumio[5426]: ---------------------------- MPD announces state update: player Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::getState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand status Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand status took 19 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand status took 11 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand status took 7 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseTrackInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::servicePushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"254459708&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS","trackType":"tidal"} Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: CURRENT POSITION 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState stateService play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState currentStatus stop Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ------------------------------ 56ms Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Jun 08 11:40:37 minidsp-shd volumio[5426]: ---------------------------- MPD announces state update: player Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::getState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand status Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Jun 08 11:40:37 minidsp-shd volumio[5426]: ---------------------------- MPD announces state update: player Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::getState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand status Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand playlistinfo took 31 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand playlistinfo took 29 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand playlistinfo took 28 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand status took 15 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseTrackInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseTrackInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseTrackInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::servicePushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"254459708&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS","trackType":"tidal"} Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: CURRENT POSITION 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState stateService play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState currentStatus play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Received an update from plugin. extracting info from payload Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::servicePushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"254459708&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS","trackType":"tidal"} Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: CURRENT POSITION 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState stateService play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState currentStatus play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Received an update from plugin. extracting info from payload Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::servicePushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"254459708&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS","trackType":"tidal"} Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: CURRENT POSITION 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState stateService play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState currentStatus play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Received an update from plugin. extracting info from payload Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ------------------------------ 250ms Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ------------------------------ 240ms Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ------------------------------ 238ms Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand status took 202 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand playlistinfo took 185 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseState Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseTrackInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::servicePushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"254459708&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS","trackType":"tidal"} Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: CURRENT POSITION 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState stateService play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState currentStatus play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Received an update from plugin. extracting info from payload Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ------------------------------ 290ms Jun 08 11:40:37 minidsp-shd volumio[5426]: info: sendMpdCommand playlistinfo took 129 milliseconds Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: ControllerMpd::parseTrackInfo Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ControllerMpd::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::servicePushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CorePlayQueue::getTrack 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"254459708&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/254459708&soundQuality=LOSSLESS","trackType":"tidal"} Jun 08 11:40:37 minidsp-shd volumio[5426]: verbose: CURRENT POSITION 3 Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState stateService play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::syncState currentStatus play Jun 08 11:40:37 minidsp-shd volumio[5426]: info: Received an update from plugin. extracting info from payload Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreStateMachine::pushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: CoreCommandRouter::volumioPushState Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output update for this device Jun 08 11:40:37 minidsp-shd volumio[5426]: info: MRS: Pushing multiroomSync output Jun 08 11:40:37 minidsp-shd volumio[5426]: info: ------------------------------ 410ms Jun 08 11:40:39 minidsp-shd volumio[5426]: STREAMING PROXY: Client dropped request, destroying Jun 08 11:40:50 minidsp-shd volumio[5426]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 11:40:50 minidsp-shd volumio[5426]: Error: connect ETIMEDOUT 59.188.250.54:443 Jun 08 11:40:50 minidsp-shd volumio[5426]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 08 11:40:50 minidsp-shd volumio[5426]: errno: -110, Jun 08 11:40:50 minidsp-shd volumio[5426]: code: 'ETIMEDOUT', Jun 08 11:40:50 minidsp-shd volumio[5426]: syscall: 'connect', Jun 08 11:40:50 minidsp-shd volumio[5426]: address: '59.188.250.54', Jun 08 11:40:50 minidsp-shd volumio[5426]: port: 443 Jun 08 11:40:50 minidsp-shd volumio[5426]: } Jun 08 11:40:50 minidsp-shd volumio[5426]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 11:40:51 minidsp-shd sudo[5922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-08 11:39 Jun 08 11:40:51 minidsp-shd sudo[5922]: 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"