-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Tue 2025-12-30 16:10:13 GMT. -- Dec 30 16:09:00 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 16:09:00 volumio volumio[1042]: info: Received Get System Info Dec 30 16:09:00 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 16:09:00 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 16:09:00 volumio volumio[1042]: info: Discovery: Getting this device information Dec 30 16:09:00 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:00 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 16:09:04 volumio volumio[1042]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 16:09:04 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 16:09:04 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Dec 30 16:09:04 volumio volumio[1042]: info: CoreStateMachine::getQueue Dec 30 16:09:04 volumio volumio[1042]: info: CorePlayQueue::getQueue Dec 30 16:09:04 volumio volumio[1042]: info: Listing playlists Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 16:09:05 volumio volumio[1042]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 30 16:09:05 volumio volumio[1042]: info: Received Get System Version Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 16:09:05 volumio volumio[1042]: info: Received Get System Info Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 16:09:05 volumio volumio[1042]: info: Discovery: Getting this device information Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 16:09:05 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 30 16:09:05 volumio volumio[1042]: info: browseTIDALUri took 148 milliseconds Dec 30 16:09:05 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:05 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:07 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 30 16:09:07 volumio volumio[1042]: info: browseTIDALUri took 380 milliseconds Dec 30 16:09:07 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:07 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:09 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 30 16:09:09 volumio volumio[1042]: info: browseTIDALUri took 249 milliseconds Dec 30 16:09:09 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:09 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:12 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 30 16:09:13 volumio volumio[1042]: info: browseTIDALUri took 256 milliseconds Dec 30 16:09:13 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:13 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:16 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 30 16:09:16 volumio volumio[1042]: info: browseTIDALUri took 234 milliseconds Dec 30 16:09:16 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:16 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:19 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 30 16:09:19 volumio volumio[1042]: info: browseTIDALUri took 478 milliseconds Dec 30 16:09:19 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/49653851 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/49653852 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/233178933 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/209382 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/1576967 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/77820636 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/140195550 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/1768693 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/216914 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/63889125 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/632127 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/2771548 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/2771546 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/2771550 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/284825 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/13097280 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/524062 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/2995144 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/93438199 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/570096 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/92240901 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/36182466 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/36182471 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/49650988 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/1322035 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/1312383 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/1456115 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/68465624 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/29507182 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/282407 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/41608 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/1554383 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/46996168 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/45161089 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/421139972 Dec 30 16:09:19 volumio volumio[1042]: info: Preloading song: tidal://song/45540328 Dec 30 16:09:19 volumio volumio[1042]: info: Exploding uri tidal://song/49653851 in service tidal Dec 30 16:09:19 volumio volumio[1042]: info: Exploding uri tidal://song/49653852 in service tidal Dec 30 16:09:19 volumio volumio[1042]: info: Exploding uri tidal://song/233178933 in service tidal Dec 30 16:09:19 volumio volumio[1042]: info: Exploding uri tidal://song/209382 in service tidal Dec 30 16:09:19 volumio volumio[1042]: info: Exploding uri tidal://song/1576967 in service tidal Dec 30 16:09:19 volumio volumio[1042]: info: explodeTIDALUri took 224 milliseconds Dec 30 16:09:19 volumio volumio[1042]: info: Exploding uri tidal://song/77820636 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/140195550 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/1768693 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/216914 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 266 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 370 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 321 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 246 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/63889125 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/632127 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 297 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/2771548 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 263 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 228 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/2771546 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 243 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/2771550 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 239 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/284825 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 232 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/13097280 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 240 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/524062 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 224 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/2995144 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 234 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/93438199 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 238 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/570096 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 232 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/92240901 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 232 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/36182466 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 236 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/36182471 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/49650988 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 248 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: explodeTIDALUri took 300 milliseconds Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/1322035 in service tidal Dec 30 16:09:20 volumio volumio[1042]: info: Exploding uri tidal://song/1312383 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://song/1456115 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 308 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://song/68465624 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 238 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 293 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 346 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://song/29507182 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 250 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://song/282407 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 244 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://song/41608 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 247 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://song/1554383 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 236 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://song/46996168 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:21 volumio volumio[1042]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::stop Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::serviceStop Dec 30 16:09:21 volumio volumio[1042]: info: Received STOP, but no service to execute it Dec 30 16:09:21 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Dec 30 16:09:21 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 30 16:09:21 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::addQueueItems Dec 30 16:09:21 volumio volumio[1042]: info: CorePlayQueue::addQueueItems Dec 30 16:09:21 volumio volumio[1042]: info: Preload queue cleared Dec 30 16:09:21 volumio volumio[1042]: info: Adding Item to queue: tidal://playlist/3bdefda2-d50f-4685-919a-a47dbca6e0c8 Dec 30 16:09:21 volumio volumio[1042]: info: Exploding uri tidal://playlist/3bdefda2-d50f-4685-919a-a47dbca6e0c8 in service tidal Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 249 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 239 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 231 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 226 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 232 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: explodeTIDALUri took 493 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Dec 30 16:09:21 volumio volumio[1042]: info: CorePlayQueue::saveQueue Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Dec 30 16:09:21 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Dec 30 16:09:21 volumio volumio[1042]: info: CoreCommandRouter::volumioPlay Dec 30 16:09:21 volumio volumio[1042]: verbose: UNSET VOLATILE: Service: undefined Dec 30 16:09:21 volumio volumio[1042]: info: Stopping Airplay Playback and sending pause command to client via USR2 Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::play index 0 Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::stop Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::play index undefined Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 16:09:21 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::startPlaybackTimer Dec 30 16:09:21 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 30 16:09:21 volumio volumio[1042]: info: [1767110961866] ControllerTidal::clearAddPlayTrack Dec 30 16:09:21 volumio volumio[1042]: info: Getting stream with soundQuality LOSSLESS Dec 30 16:09:21 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 16:09:21 volumio volumio[1042]: info: sendMpdCommand stop took 8 milliseconds Dec 30 16:09:21 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 16:09:21 volumio volumio[1042]: info: Dec 30 16:09:21 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 30 16:09:21 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 30 16:09:21 volumio volumio[1042]: info: sendMpdCommand clear took 1 milliseconds Dec 30 16:09:21 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/49653851&soundQuality=LOSSLESS" Dec 30 16:09:21 volumio volumio[1042]: info: Dec 30 16:09:21 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 30 16:09:21 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 30 16:09:21 volumio volumio[1042]: error: updateQueue error: null Dec 30 16:09:21 volumio volumio[1042]: info: Dec 30 16:09:21 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 30 16:09:21 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 30 16:09:21 volumio volumio[1042]: info: ------------------------------ 3ms Dec 30 16:09:21 volumio volumio[1042]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/49653851&soundQuality=LOSSLESS" took 2 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: ------------------------------ 3ms Dec 30 16:09:21 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 30 16:09:21 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand play Dec 30 16:09:21 volumio volumio[1042]: info: Dec 30 16:09:21 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Dec 30 16:09:21 volumio volumio[1042]: info: Ignoring MPD Status Update Dec 30 16:09:21 volumio volumio[1042]: info: ------------------------------ 4ms Dec 30 16:09:21 volumio volumio[1042]: info: sendMpdCommand play took 3 milliseconds Dec 30 16:09:21 volumio volumio[1042]: info: ------------------------------ 2ms Dec 30 16:09:21 volumio sudo[9392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 9162 Dec 30 16:09:21 volumio sudo[9392]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 16:09:21 volumio volumio[1042]: STREAMING PROXY: Handling url /?data=tidal://song/49653851&soundQuality=LOSSLESS Dec 30 16:09:21 volumio sudo[9392]: pam_unix(sudo:session): session closed for user root Dec 30 16:09:21 volumio volumio[1042]: info: Shairport-Sync paused with USR2 Dec 30 16:09:21 volumio volumio[1042]: info: Executing endpoint getStreamUrltidal Dec 30 16:09:21 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Dec 30 16:09:22 volumio volumio[1042]: info: getStreamUrl took 285 milliseconds Dec 30 16:09:22 volumio volumio[1042]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidiMDZmMmNkMjc4ZmRlMWI4MTRmMzBiYjI4ZTMyYzhhNV82MS5tcDQ/0.flac?token=1767114562~ZmVkNTU3MGZhNTVhMzhjYmQyNmQ5NzNiYjZlNThiODA1ZmVjYmY2Zg== Dec 30 16:09:22 volumio volumio[1042]: STREAMING PROXY: Response: 200, length: 23866100 Dec 30 16:09:22 volumio volumio[1042]: info: Dec 30 16:09:22 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::getState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 30 16:09:22 volumio volumio[1042]: info: Dec 30 16:09:22 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::getState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 30 16:09:22 volumio volumio[1042]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 30 16:09:22 volumio volumio[1042]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 30 16:09:22 volumio volumio[1042]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 30 16:09:22 volumio volumio[1042]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 30 16:09:22 volumio volumio[1042]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 30 16:09:22 volumio volumio[1042]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 30 16:09:22 volumio volumio[1042]: info: Dec 30 16:09:22 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand status took 27 milliseconds Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::getState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand status took 20 milliseconds Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 16:09:22 volumio volumio[1042]: info: Dec 30 16:09:22 volumio volumio[1042]: ---------------------------- MPD announces state update: player Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::getState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand status took 4 milliseconds Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand status took 3 milliseconds Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseState Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 30 16:09:22 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 30 16:09:22 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"49653851&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/49653851&soundQuality=LOSSLESS","trackType":"tidal"} Dec 30 16:09:22 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 30 16:09:22 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 30 16:09:22 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"49653851&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/49653851&soundQuality=LOSSLESS","trackType":"tidal"} Dec 30 16:09:22 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 30 16:09:22 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: ------------------------------ 49ms Dec 30 16:09:22 volumio volumio[1042]: info: ------------------------------ 58ms Dec 30 16:09:22 volumio volumio[1042]: error: FusionDsp - WebSocket error: [object Object] Dec 30 16:09:22 volumio volumio[1042]: error: FusionDsp - WebSocket error: [object Object] Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 27 milliseconds Dec 30 16:09:22 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 30 16:09:22 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 30 16:09:22 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 30 16:09:22 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"49653851&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/49653851&soundQuality=LOSSLESS","trackType":"tidal"} Dec 30 16:09:22 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 30 16:09:22 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: ControllerMpd::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Dec 30 16:09:22 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Dec 30 16:09:22 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"49653851&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/49653851&soundQuality=LOSSLESS","trackType":"tidal"} Dec 30 16:09:22 volumio volumio[1042]: verbose: CURRENT POSITION 0 Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Dec 30 16:09:22 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreStateMachine::pushState Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:09:22 volumio volumio[1042]: info: MRS: Pushing multiroomSync output Dec 30 16:09:22 volumio volumio[1042]: info: ------------------------------ 56ms Dec 30 16:09:22 volumio volumio[1042]: info: ------------------------------ 54ms Dec 30 16:09:22 volumio volumio[1042]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 30 16:09:22 volumio volumio[1042]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 30 16:09:22 volumio volumio[1042]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 30 16:09:22 volumio volumio[1042]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 30 16:09:22 volumio volumio[1042]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 30 16:09:22 volumio volumio[1042]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 30 16:09:22 volumio volumio[1042]: info: Restarting Shairport-Sync after stop Dec 30 16:09:22 volumio sudo[9404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 30 16:09:22 volumio sudo[9404]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 16:09:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 30 16:09:22 volumio volumio[1042]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 30 16:09:22 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 30 16:09:22 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 30 16:09:22 volumio volumio[1042]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 30 16:09:23 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 30 16:09:23 volumio sudo[9404]: pam_unix(sudo:session): session closed for user root Dec 30 16:09:23 volumio volumio[1042]: info: Shairport-Sync retarted Dec 30 16:10:04 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Dec 30 16:10:04 volumio volumio[1042]: error: MRS: impossible to set Google-Cast-Group-45bf2aa84053463e92d3f680d8ab2493 volume: device not found Dec 30 16:10:10 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Dec 30 16:10:10 volumio volumio[1042]: error: MRS: impossible to set Chromecast-Audio-3061fda6d3099b54ae97689eedb4e4c1 volume: device not found Dec 30 16:10:13 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Dec 30 16:10:13 volumio volumio[1042]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Dec 30 16:10:13 volumio volumio[1042]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 16:10:13 volumio volumio[1042]: TypeError: Cannot read property 'then' of undefined Dec 30 16:10:13 volumio volumio[1042]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Dec 30 16:10:13 volumio volumio[1042]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Dec 30 16:10:13 volumio volumio[1042]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1467:26) Dec 30 16:10:13 volumio volumio[1042]: at Socket.emit (events.js:315:20) Dec 30 16:10:13 volumio volumio[1042]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 30 16:10:13 volumio volumio[1042]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 30 16:10:13 volumio volumio[1042]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 16:10:13 volumio sudo[9540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 16:09 Dec 30 16:10:13 volumio sudo[9540]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"