-- Logs begin at Sat 2025-03-01 10:27:05 GMT, end at Sat 2025-03-01 21:45:53 GMT. -- Mar 01 21:44:00 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:02 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:03 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:04 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:05 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:06 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:09 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:10 bladelius-ask bladelius[605]: PIN: 6, time: 0.18999999999999997 Mar 01 21:44:10 bladelius-ask bladelius[605]: Standby Button short press event Mar 01 21:44:10 bladelius-ask bladelius[605]: Current Standby State is 1 Mar 01 21:44:10 bladelius-ask bladelius[605]: Changed to 0111_0000 Mar 01 21:44:10 bladelius-ask bladelius[605]: Changed to 0101_0000 Mar 01 21:44:10 bladelius-ask bladelius[605]: Changed to 1111_1110 Mar 01 21:44:10 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:11 bladelius-ask bladelius[605]: PIN: 6, time: 0.18999999999999997 Mar 01 21:44:11 bladelius-ask bladelius[605]: Standby Button short press event Mar 01 21:44:11 bladelius-ask bladelius[605]: Current Standby State is 0 Mar 01 21:44:11 bladelius-ask bladelius[605]: Changed to 0001_0000 Mar 01 21:44:11 bladelius-ask bladelius[605]: Changed to 0011_0000 Mar 01 21:44:11 bladelius-ask bladelius[605]: Changed to 1111_1111 Mar 01 21:44:11 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:12 bladelius-ask bladelius[605]: PIN: 17, time: 0.16999999999999998 Mar 01 21:44:12 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:44:12 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:44:12 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 0000_1111 Mar 01 21:44:12 bladelius-ask bladelius[605]: Current Input is 5 , Previous Input was 4 Mar 01 21:44:12 bladelius-ask bladelius[605]: Current Mode is SPDIF , Previous Mode was I2S Mar 01 21:44:12 bladelius-ask bladelius[605]: Write to 72 address, Register 6, with 0b11110001 Mar 01 21:44:12 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 0000_1111 Mar 01 21:44:12 bladelius-ask bladelius[605]: Current Input is: AES Mar 01 21:44:12 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:12 bladelius-ask bladelius[605]: PIN: 17, time: 0.13 Mar 01 21:44:12 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:44:12 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:44:12 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 0100_1111 Mar 01 21:44:12 bladelius-ask bladelius[605]: Current Input is 6 , Previous Input was 5 Mar 01 21:44:12 bladelius-ask bladelius[605]: Current Mode is SPDIF , Previous Mode was SPDIF Mar 01 21:44:12 bladelius-ask bladelius[605]: Current Input is: SPDIF 1 Mar 01 21:44:13 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:14 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:15 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:16 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:17 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:18 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:19 bladelius-ask volumiologrotate[572]: ls: cannot access '/var/log/samba/log.wb-BLADELIUS': No such file or directory Mar 01 21:44:19 bladelius-ask volumiologrotate[572]: ls: cannot access 'ASK': No such file or directory Mar 01 21:44:19 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:20 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:21 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:22 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:23 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:24 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:25 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:26 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:27 bladelius-ask sudo[4790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 21:44:27 bladelius-ask sudo[4790]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:44:27 bladelius-ask sudo[4790]: pam_unix(sudo:session): session closed for user root Mar 01 21:44:27 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:27 bladelius-ask sudo[4793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 21:44:27 bladelius-ask sudo[4793]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:44:27 bladelius-ask sudo[4793]: pam_unix(sudo:session): session closed for user root Mar 01 21:44:28 bladelius-ask volumio[781]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.243 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Total Clients: 6 Mar 01 21:44:28 bladelius-ask sudo[4797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 21:44:28 bladelius-ask sudo[4797]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:44:28 bladelius-ask sudo[4797]: pam_unix(sudo:session): session closed for user root Mar 01 21:44:28 bladelius-ask sudo[4800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 21:44:28 bladelius-ask sudo[4800]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:44:28 bladelius-ask sudo[4800]: pam_unix(sudo:session): session closed for user root Mar 01 21:44:28 bladelius-ask volumio[781]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.243 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Total Clients: 7 Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 01 21:44:28 bladelius-ask volumio[781]: info: Received Get System Info Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:44:28 bladelius-ask volumio[781]: info: Discovery: Getting this device information Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:28 bladelius-ask volumio[781]: info: Listing playlists Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 01 21:44:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 21:44:29 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 01 21:44:29 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:29 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:30 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 21:44:30 bladelius-ask volumio[781]: info: Received Get System Info Mar 01 21:44:30 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:44:30 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:44:30 bladelius-ask volumio[781]: info: Discovery: Getting this device information Mar 01 21:44:30 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:30 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:44:30 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 01 21:44:30 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:31 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetQueue Mar 01 21:44:31 bladelius-ask volumio[781]: info: CoreStateMachine::getQueue Mar 01 21:44:31 bladelius-ask volumio[781]: info: CorePlayQueue::getQueue Mar 01 21:44:31 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:32 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:33 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:34 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 21:44:34 bladelius-ask volumio[781]: info: Received Get System Info Mar 01 21:44:34 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:44:34 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:44:34 bladelius-ask volumio[781]: info: Discovery: Getting this device information Mar 01 21:44:34 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:34 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:44:34 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:35 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:36 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:37 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:38 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:39 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:40 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:41 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:44:41 bladelius-ask volumio[781]: info: browseTIDALUri took 305 milliseconds Mar 01 21:44:41 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:41 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:41 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:42 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:43 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:44 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:45 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:46 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 21:44:47 bladelius-ask volumio[781]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 01 21:44:47 bladelius-ask volumio[781]: info: Received Get System Version Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 21:44:47 bladelius-ask volumio[781]: info: Received Get System Info Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:44:47 bladelius-ask volumio[781]: info: Discovery: Getting this device information Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:44:47 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:48 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:49 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:44:49 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:50 bladelius-ask volumio[781]: info: browseTIDALUri took 328 milliseconds Mar 01 21:44:50 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:50 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:50 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:51 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:51 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:44:52 bladelius-ask volumio[781]: info: browseTIDALUri took 446 milliseconds Mar 01 21:44:52 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:52 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:52 bladelius-ask volumio[781]: info: Preloading song: tidal://mymusic/tracks/az/52577956 Mar 01 21:44:52 bladelius-ask volumio[781]: info: Preloading song: tidal://mymusic/tracks/az/265360613 Mar 01 21:44:52 bladelius-ask volumio[781]: info: Preloading song: tidal://mymusic/tracks/az/273244215 Mar 01 21:44:52 bladelius-ask volumio[781]: info: Preloading song: tidal://mymusic/tracks/az/30845560 Mar 01 21:44:52 bladelius-ask volumio[781]: info: Preloading song: tidal://mymusic/tracks/az/124727911 Mar 01 21:44:52 bladelius-ask volumio[781]: info: Exploding uri tidal://mymusic/tracks/az/52577956 in service tidal Mar 01 21:44:52 bladelius-ask volumio[781]: info: Exploding uri tidal://mymusic/tracks/az/265360613 in service tidal Mar 01 21:44:52 bladelius-ask volumio[781]: info: Exploding uri tidal://mymusic/tracks/az/273244215 in service tidal Mar 01 21:44:52 bladelius-ask volumio[781]: info: Exploding uri tidal://mymusic/tracks/az/30845560 in service tidal Mar 01 21:44:52 bladelius-ask volumio[781]: info: Exploding uri tidal://mymusic/tracks/az/124727911 in service tidal Mar 01 21:44:52 bladelius-ask volumio[781]: info: explodeTIDALUri took 365 milliseconds Mar 01 21:44:52 bladelius-ask volumio[781]: error: Commandrouter: Cannot explode uri tidal://mymusic/tracks/az/265360613 from service tidal: Mar 01 21:44:52 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:52 bladelius-ask volumio[781]: info: explodeTIDALUri took 293 milliseconds Mar 01 21:44:52 bladelius-ask volumio[781]: info: explodeTIDALUri took 397 milliseconds Mar 01 21:44:53 bladelius-ask volumio[781]: info: explodeTIDALUri took 415 milliseconds Mar 01 21:44:53 bladelius-ask volumio[781]: info: explodeTIDALUri took 1152 milliseconds Mar 01 21:44:53 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:54 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:55 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:44:55 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:56 bladelius-ask volumio[781]: info: browseTIDALUri took 366 milliseconds Mar 01 21:44:56 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:56 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:56 bladelius-ask volumio[781]: info: Preloading song: tidal://mymusic/tracks/az/265360613 Mar 01 21:44:56 bladelius-ask volumio[781]: info: Exploding uri tidal://mymusic/tracks/az/265360613 in service tidal Mar 01 21:44:56 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:57 bladelius-ask volumio[781]: info: explodeTIDALUri took 915 milliseconds Mar 01 21:44:57 bladelius-ask volumio[781]: error: Commandrouter: Cannot explode uri tidal://mymusic/tracks/az/265360613 from service tidal: Mar 01 21:44:57 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:44:58 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::ClearQueue Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::stPlaybackTimer Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::updateTrackBlock Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::getTrackBlock Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::serviceStop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::serviceStop Mar 01 21:44:58 bladelius-ask volumio[781]: info: [1740865498842] ControllerTidal::stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 01 21:44:58 bladelius-ask volumio[781]: info: ControllerMpd::stop Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::clearPlayQueue Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::saveQueue Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushQueue Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::addQueueItems Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::addQueueItems Mar 01 21:44:58 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:44:58 bladelius-ask volumio[781]: info: Adding Item to queue: tidal://mymusic/tracks/az/52577956 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Using cached record of: tidal://mymusic/tracks/az/52577956 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Adding Item to queue: tidal://mymusic/tracks/az/265360613 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Exploding uri tidal://mymusic/tracks/az/265360613 in service tidal Mar 01 21:44:58 bladelius-ask volumio[781]: info: Adding Item to queue: tidal://mymusic/tracks/az/273244215 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Using cached record of: tidal://mymusic/tracks/az/273244215 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Adding Item to queue: tidal://mymusic/tracks/az/30845560 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Using cached record of: tidal://mymusic/tracks/az/30845560 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Adding Item to queue: tidal://mymusic/tracks/az/124727911 Mar 01 21:44:58 bladelius-ask volumio[781]: info: Using cached record of: tidal://mymusic/tracks/az/124727911 Mar 01 21:44:58 bladelius-ask volumio[781]: info: sendMpdCommand stop took 51 milliseconds Mar 01 21:44:58 bladelius-ask volumio[781]: info: Mar 01 21:44:58 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:44:58 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:44:58 bladelius-ask volumio[781]: info: Mar 01 21:44:58 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:44:58 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:44:58 bladelius-ask volumio[781]: info: Mar 01 21:44:58 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:44:58 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:44:58 bladelius-ask volumio[781]: info: sendMpdCommand status took 6 milliseconds Mar 01 21:44:58 bladelius-ask volumio[781]: info: sendMpdCommand status took 5 milliseconds Mar 01 21:44:58 bladelius-ask volumio[781]: info: sendMpdCommand status took 4 milliseconds Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:44:58 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 01 21:44:58 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 01 21:44:58 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:44:58 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"398864319&soundQuality=LOW","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/398864319&soundQuality=LOW","trackType":"tidal"} Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: No code Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"398864319&soundQuality=LOW","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/398864319&soundQuality=LOW","trackType":"tidal"} Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: No code Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"398864319&soundQuality=LOW","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/398864319&soundQuality=LOW","trackType":"tidal"} Mar 01 21:44:58 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus stop Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: No code Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:44:58 bladelius-ask volumio[781]: info: ------------------------------ 66ms Mar 01 21:44:58 bladelius-ask volumio[781]: info: ------------------------------ 66ms Mar 01 21:44:58 bladelius-ask volumio[781]: info: ------------------------------ 66ms Mar 01 21:44:59 bladelius-ask volumio[781]: info: explodeTIDALUri took 396 milliseconds Mar 01 21:44:59 bladelius-ask volumio[781]: error: Commandrouter: Cannot explode uri tidal://mymusic/tracks/az/265360613 from service tidal: Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushQueue Mar 01 21:44:59 bladelius-ask volumio[781]: info: CorePlayQueue::saveQueue Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::updateTrackBlock Mar 01 21:44:59 bladelius-ask volumio[781]: info: CorePlayQueue::getTrackBlock Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPlay Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::play index 3 Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::stop Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::play index undefined Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:44:59 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::startPlaybackTimer Mar 01 21:44:59 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:44:59 bladelius-ask volumio[781]: info: [1740865499267] ControllerTidal::clearAddPlayTrack Mar 01 21:44:59 bladelius-ask volumio[781]: info: Getting stream with soundQuality LOSSLESS Mar 01 21:44:59 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand stop Mar 01 21:44:59 bladelius-ask volumio[781]: info: sendMpdCommand stop took 3 milliseconds Mar 01 21:44:59 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand clear Mar 01 21:44:59 bladelius-ask volumio[781]: info: Mar 01 21:44:59 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:44:59 bladelius-ask volumio[781]: info: sendMpdCommand clear took 3 milliseconds Mar 01 21:44:59 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS" Mar 01 21:44:59 bladelius-ask volumio[781]: error: updateQueue error: null Mar 01 21:44:59 bladelius-ask volumio[781]: info: Mar 01 21:44:59 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:44:59 bladelius-ask volumio[781]: info: ------------------------------ 3ms Mar 01 21:44:59 bladelius-ask volumio[781]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS" took 2 milliseconds Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 01 21:44:59 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand play Mar 01 21:44:59 bladelius-ask volumio[781]: STREAMING PROXY: Handling url /?data=tidal://song/124727911&soundQuality=LOSSLESS Mar 01 21:44:59 bladelius-ask volumio[781]: info: Mar 01 21:44:59 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Mar 01 21:44:59 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:44:59 bladelius-ask volumio[781]: info: ------------------------------ 12ms Mar 01 21:44:59 bladelius-ask volumio[781]: info: sendMpdCommand play took 12 milliseconds Mar 01 21:44:59 bladelius-ask volumio[781]: info: ------------------------------ 8ms Mar 01 21:44:59 bladelius-ask volumio[781]: info: ------------------------------ 7ms Mar 01 21:44:59 bladelius-ask volumio[781]: info: Mar 01 21:44:59 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Mar 01 21:44:59 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:44:59 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:44:59 bladelius-ask volumio[781]: info: ------------------------------ 7ms Mar 01 21:44:59 bladelius-ask volumio[781]: info: ------------------------------ 6ms Mar 01 21:44:59 bladelius-ask volumio[781]: info: Executing endpoint getStreamUrltidal Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Mar 01 21:44:59 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:00 bladelius-ask volumio[781]: info: getStreamUrl took 1396 milliseconds Mar 01 21:45:00 bladelius-ask volumio[781]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKAgDEiQxMTgzMjFiYTE4YjljZDc0YmNmMjkzNWJkYjBlYTA3Yi5tcDQ/0.flac?Expires=1740869100&Signature=gqY0ux65J-9C3NQ-HRmcMNjGocpsWBf6Li2jSJpUL0WyRmSDJGEEWkEyYz6AFcVOrceKe0firJ104pFckgyBvidAD7abk0MunuyEKTp8DSZ6~bBloXnIUwlL1wSNMZVDF0NWEHq5fzt37x3btVv5HPm7XWbMYFZx53lRdiP2tLCHtjnH7kzoQlKUSSxOjZu6EGFz5s3gP4MRUIO6PkUzVem5yOjWXvk72iTREPgeeHUiNuFj94pJV3CUbV2H1AUG36Vkt0jes24ViBr-PcMtBPPg8XKGlLBr8cQNsWKDFu6H9CexAPpi7dHAwi0iEslC2eA8PWXzpQm41dqhGT4SDg__&Key-Pair-Id=K14LZCZ9QUI4JL Mar 01 21:45:00 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:01 bladelius-ask volumio[781]: STREAMING PROXY: Response: 200, length: 12696301 Mar 01 21:45:01 bladelius-ask volumio[781]: info: Mar 01 21:45:01 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:01 bladelius-ask volumio[781]: info: Mar 01 21:45:01 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:01 bladelius-ask volumio[781]: info: Mar 01 21:45:01 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:01 bladelius-ask volumio[781]: info: Mar 01 21:45:01 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand status took 30 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand status took 32 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand status took 29 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand status took 4 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: CURRENT POSITION 3 Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus stop Mar 01 21:45:01 bladelius-ask volumio[781]: info: ------------------------------ 47ms Mar 01 21:45:01 bladelius-ask volumio[781]: info: Mar 01 21:45:01 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:01 bladelius-ask volumio[781]: info: Mar 01 21:45:01 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand status took 5 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand status took 4 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: CURRENT POSITION 3 Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:01 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: CURRENT POSITION 3 Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:01 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: CURRENT POSITION 3 Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:01 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: ------------------------------ 104ms Mar 01 21:45:01 bladelius-ask volumio[781]: info: ------------------------------ 101ms Mar 01 21:45:01 bladelius-ask volumio[781]: info: ------------------------------ 77ms Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 50 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 48 milliseconds Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: CURRENT POSITION 3 Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:01 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:01 bladelius-ask volumio[781]: verbose: CURRENT POSITION 3 Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:01 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:01 bladelius-ask volumio[781]: info: ------------------------------ 77ms Mar 01 21:45:01 bladelius-ask volumio[781]: info: ------------------------------ 75ms Mar 01 21:45:01 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:02 bladelius-ask volumio[781]: STREAMING PROXY: Client dropped request, destroying Mar 01 21:45:02 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:03 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:04 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:05 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:06 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:07 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::ClearQueue Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::stop Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::stPlaybackTimer Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::updateTrackBlock Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrackBlock Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::serviceStop Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 3 Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::serviceStop Mar 01 21:45:07 bladelius-ask volumio[781]: info: [1740865507797] ControllerTidal::stop Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 01 21:45:07 bladelius-ask volumio[781]: info: ControllerMpd::stop Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand stop Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::clearPlayQueue Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::saveQueue Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushQueue Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::addQueueItems Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::addQueueItems Mar 01 21:45:07 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:07 bladelius-ask volumio[781]: info: Adding Item to queue: tidal://mymusic/tracks/az/124727911 Mar 01 21:45:07 bladelius-ask volumio[781]: info: Using cached record of: tidal://mymusic/tracks/az/124727911 Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushQueue Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::saveQueue Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::updateTrackBlock Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrackBlock Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPlay Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::play index 0 Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::stop Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::play index undefined Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::startPlaybackTimer Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:07 bladelius-ask volumio[781]: info: [1740865507814] ControllerTidal::clearAddPlayTrack Mar 01 21:45:07 bladelius-ask volumio[781]: info: Getting stream with soundQuality LOSSLESS Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand stop Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand stop took 29 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:07 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand stop took 13 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand clear Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:07 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:07 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand status took 10 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand clear took 9 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand status took 9 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand status took 7 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS" Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:07 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:07 bladelius-ask volumio[781]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Mar 01 21:45:07 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:07 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:07 bladelius-ask volumio[781]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 20ms Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:45:07 bladelius-ask volumio[781]: error: updateQueue error: null Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 18ms Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS" took 15 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 5ms Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 4ms Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 01 21:45:07 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand play Mar 01 21:45:07 bladelius-ask volumio[781]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 31ms Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Mar 01 21:45:07 bladelius-ask volumio[781]: ---------------------------- MPD announces system playlist update Mar 01 21:45:07 bladelius-ask volumio[781]: info: Ignoring MPD Status Update Mar 01 21:45:07 bladelius-ask volumio[781]: STREAMING PROXY: Handling url /?data=tidal://song/124727911&soundQuality=LOSSLESS Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 15ms Mar 01 21:45:07 bladelius-ask volumio[781]: info: sendMpdCommand play took 12 milliseconds Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 11ms Mar 01 21:45:07 bladelius-ask volumio[781]: info: ------------------------------ 10ms Mar 01 21:45:07 bladelius-ask volumio[781]: info: Executing endpoint getStreamUrltidal Mar 01 21:45:07 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Mar 01 21:45:08 bladelius-ask volumio[781]: info: getStreamUrl took 923 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: STREAMING PROXY: Got real url: http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKAgDEiQxMTgzMjFiYTE4YjljZDc0YmNmMjkzNWJkYjBlYTA3Yi5tcDQ/0.flac?Expires=1740869100&Signature=gqY0ux65J-9C3NQ-HRmcMNjGocpsWBf6Li2jSJpUL0WyRmSDJGEEWkEyYz6AFcVOrceKe0firJ104pFckgyBvidAD7abk0MunuyEKTp8DSZ6~bBloXnIUwlL1wSNMZVDF0NWEHq5fzt37x3btVv5HPm7XWbMYFZx53lRdiP2tLCHtjnH7kzoQlKUSSxOjZu6EGFz5s3gP4MRUIO6PkUzVem5yOjWXvk72iTREPgeeHUiNuFj94pJV3CUbV2H1AUG36Vkt0jes24ViBr-PcMtBPPg8XKGlLBr8cQNsWKDFu6H9CexAPpi7dHAwi0iEslC2eA8PWXzpQm41dqhGT4SDg__&Key-Pair-Id=K14LZCZ9QUI4JL Mar 01 21:45:08 bladelius-ask volumio[781]: STREAMING PROXY: Response: 200, length: 12696301 Mar 01 21:45:08 bladelius-ask volumio[781]: info: Mar 01 21:45:08 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:08 bladelius-ask volumio[781]: info: Mar 01 21:45:08 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:08 bladelius-ask volumio[781]: info: Mar 01 21:45:08 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:08 bladelius-ask volumio[781]: info: Mar 01 21:45:08 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand status took 11 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand status took 11 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand status took 10 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand status took 3 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus stop Mar 01 21:45:08 bladelius-ask volumio[781]: info: ------------------------------ 18ms Mar 01 21:45:08 bladelius-ask volumio[781]: info: Mar 01 21:45:08 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:08 bladelius-ask volumio[781]: info: Mar 01 21:45:08 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand status took 3 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand status took 2 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:08 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:08 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:08 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: ------------------------------ 50ms Mar 01 21:45:08 bladelius-ask volumio[781]: info: ------------------------------ 49ms Mar 01 21:45:08 bladelius-ask volumio[781]: info: ------------------------------ 43ms Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 32 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:08 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:08 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService play Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:08 bladelius-ask volumio[781]: info: Received an update from plugin. extracting info from payload Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:08 bladelius-ask volumio[781]: info: ------------------------------ 63ms Mar 01 21:45:08 bladelius-ask volumio[781]: info: ------------------------------ 63ms Mar 01 21:45:09 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:09 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:10 bladelius-ask volumio[781]: STREAMING PROXY: Client dropped request, destroying Mar 01 21:45:10 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:11 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:12 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:13 bladelius-ask bladelius[605]: PIN: 17, time: 0.15 Mar 01 21:45:13 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:13 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:13 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 1000_1111 Mar 01 21:45:13 bladelius-ask bladelius[605]: Current Input is 7 , Previous Input was 6 Mar 01 21:45:13 bladelius-ask bladelius[605]: Current Mode is SPDIF , Previous Mode was SPDIF Mar 01 21:45:13 bladelius-ask bladelius[605]: Current Input is: SPDIF 2 Mar 01 21:45:13 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:14 bladelius-ask bladelius[605]: PIN: 17, time: 0.15 Mar 01 21:45:14 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:14 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:14 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 0010_1111 Mar 01 21:45:14 bladelius-ask bladelius[605]: Current Input is 8 , Previous Input was 7 Mar 01 21:45:14 bladelius-ask bladelius[605]: Current Mode is SPDIF , Previous Mode was SPDIF Mar 01 21:45:14 bladelius-ask bladelius[605]: Current Input is: OPT 1 Mar 01 21:45:14 bladelius-ask bladelius[605]: PIN: 17, time: 0.16999999999999998 Mar 01 21:45:14 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:14 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:14 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 1100_1111 Mar 01 21:45:14 bladelius-ask bladelius[605]: Current Input is 9 , Previous Input was 8 Mar 01 21:45:14 bladelius-ask bladelius[605]: Current Mode is SPDIF , Previous Mode was SPDIF Mar 01 21:45:14 bladelius-ask bladelius[605]: Current Input is: OPT 2 Mar 01 21:45:14 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:15 bladelius-ask bladelius[605]: PIN: 17, time: 0.18999999999999997 Mar 01 21:45:15 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:15 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:15 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 1101_1111 Mar 01 21:45:15 bladelius-ask bladelius[605]: Current Input is 10 , Previous Input was 9 Mar 01 21:45:15 bladelius-ask bladelius[605]: Current Mode is I2S , Previous Mode was SPDIF Mar 01 21:45:15 bladelius-ask bladelius[605]: Write to 72 address, Register 6, with 0b1110001 Mar 01 21:45:15 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 1101_1111 Mar 01 21:45:15 bladelius-ask bladelius[605]: Enable USB Input Mar 01 21:45:15 bladelius-ask bladelius[605]: Current Input is: USB Mar 01 21:45:15 bladelius-ask volumio[781]: info: Mar 01 21:45:15 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:15 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:15 bladelius-ask kernel: usb 1-1.3: USB disconnect, device number 3 Mar 01 21:45:15 bladelius-ask volumio[781]: info: Mar 01 21:45:15 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:15 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:15 bladelius-ask volumio[781]: info: Mar 01 21:45:15 bladelius-ask volumio[781]: ---------------------------- MPD announces state update: player Mar 01 21:45:15 bladelius-ask volumio[781]: info: ControllerMpd::getState Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand status Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand status took 9 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand status took 8 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand status took 17 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand clearerror took 11 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand clearerror took 10 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::parseState Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:15 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7893,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService pause Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::stPlaybackTimer Mar 01 21:45:15 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7893,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService pause Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::stPlaybackTimer Mar 01 21:45:15 bladelius-ask volumio[781]: info: ------------------------------ 37ms Mar 01 21:45:15 bladelius-ask volumio[781]: info: ------------------------------ 36ms Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand clearerror took 31 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: info: sendMpdCommand playlistinfo took 30 milliseconds Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: ControllerMpd::parseTrackInfo Mar 01 21:45:15 bladelius-ask volumio[781]: info: ControllerMpd::pushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::servicePushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7893,"duration":112,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"124727911&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/124727911&soundQuality=LOSSLESS","trackType":"tidal"} Mar 01 21:45:15 bladelius-ask volumio[781]: verbose: CURRENT POSITION 0 Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::syncState stateService pause Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::syncState currentStatus play Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreStateMachine::stPlaybackTimer Mar 01 21:45:15 bladelius-ask volumio[781]: info: ------------------------------ 56ms Mar 01 21:45:15 bladelius-ask volumio[781]: info: Mar 01 21:45:15 bladelius-ask volumio[781]: ---------------------------- USB Audio Device Detached Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Mar 01 21:45:15 bladelius-ask bladelius[605]: PIN: 17, time: 0.15 Mar 01 21:45:15 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:15 bladelius-ask bladelius[605]: Disable USB Input Mar 01 21:45:15 bladelius-ask bladelius[605]: PCF8574 with address of 0x38 was sent this: 0010_0001 Mar 01 21:45:15 bladelius-ask bladelius[605]: Current Input is 0 , Previous Input was 10 Mar 01 21:45:15 bladelius-ask bladelius[605]: Current Mode is I2S , Previous Mode was I2S Mar 01 21:45:15 bladelius-ask bladelius[605]: Current Input is: BAL Mar 01 21:45:15 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:16 bladelius-ask kernel: usb 1-1.3: new high-speed USB device number 4 using xhci-hcd Mar 01 21:45:16 bladelius-ask kernel: usb 1-1.3: New USB device found, idVendor=20b1, idProduct=3033, bcdDevice= 1.00 Mar 01 21:45:16 bladelius-ask kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Mar 01 21:45:16 bladelius-ask kernel: usb 1-1.3: Product: Bladelius DAC Mar 01 21:45:16 bladelius-ask kernel: usb 1-1.3: Manufacturer: BDG Mar 01 21:45:16 bladelius-ask bladelius[605]: PIN: 17, time: 0.16999999999999998 Mar 01 21:45:16 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:16 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:16 bladelius-ask bladelius[605]: PCF8574 with address of 0x38 was sent this: 0011_0011 Mar 01 21:45:16 bladelius-ask bladelius[605]: Current Input is 1 , Previous Input was 0 Mar 01 21:45:16 bladelius-ask bladelius[605]: Current Mode is I2S , Previous Mode was I2S Mar 01 21:45:16 bladelius-ask bladelius[605]: Current Input is: LINE 1 Mar 01 21:45:16 bladelius-ask kernel: usb 1-1.3: 1:3 : unsupported format bits 0x100000000 Mar 01 21:45:16 bladelius-ask kernel: hid-generic 0003:20B1:3033.0002: hiddev96,hidraw0: USB HID v1.10 Device [BDG Bladelius DAC] on usb-fe9c0000.xhci-1.3/input3 Mar 01 21:45:16 bladelius-ask volumio[781]: info: Mar 01 21:45:16 bladelius-ask volumio[781]: ---------------------------- USB Audio Device Attached Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::Close All Modals sent Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:45:16 bladelius-ask volumio[781]: info: Device 5 does not have any Mixer Control Available Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 01 21:45:16 bladelius-ask volumio[781]: info: Updating Volume Controller Parameters: Device: 5 Name: Bladelius DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 01 21:45:16 bladelius-ask volumio[781]: info: Disabling external Volume Control Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:45:16 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:16 bladelius-ask volumio[781]: info: Preparing to generate the ALSA configuration file Mar 01 21:45:16 bladelius-ask volumio[781]: info: Asound.conf file unchanged, so no further update is needed Mar 01 21:45:16 bladelius-ask volumio[781]: info: Output device has changed, restarting MPD Mar 01 21:45:16 bladelius-ask sudo[4832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 01 21:45:16 bladelius-ask sudo[4832]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:45:16 bladelius-ask sudo[4832]: pam_unix(sudo:session): session closed for user root Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:17 bladelius-ask sudo[4835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 01 21:45:17 bladelius-ask sudo[4835]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:45:17 bladelius-ask systemd[1]: Stopping Music Player Daemon... Mar 01 21:45:17 bladelius-ask bladelius[605]: PIN: 17, time: 0.15 Mar 01 21:45:17 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:17 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:17 bladelius-ask bladelius[605]: PCF8574 with address of 0x38 was sent this: 0011_0101 Mar 01 21:45:17 bladelius-ask bladelius[605]: Current Input is 2 , Previous Input was 1 Mar 01 21:45:17 bladelius-ask bladelius[605]: Current Mode is I2S , Previous Mode was I2S Mar 01 21:45:17 bladelius-ask bladelius[605]: Current Input is: LINE 2 Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:45:17 bladelius-ask systemd[1]: mpd.service: Succeeded. Mar 01 21:45:17 bladelius-ask systemd[1]: Stopped Music Player Daemon. Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 01 21:45:17 bladelius-ask volumio[781]: info: MPD Permissions set Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:45:17 bladelius-ask systemd[1]: Starting Music Player Daemon... Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Mar 01 21:45:17 bladelius-ask mpd[4841]: Mar 01 21:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 01 21:45:17 bladelius-ask systemd[1]: Started Music Player Daemon. Mar 01 21:45:17 bladelius-ask sudo[4835]: pam_unix(sudo:session): session closed for user root Mar 01 21:45:17 bladelius-ask volumio[781]: error: updateQueue error: null Mar 01 21:45:17 bladelius-ask bladelius[605]: PIN: 17, time: 0.18999999999999997 Mar 01 21:45:17 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:17 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:17 bladelius-ask bladelius[605]: PCF8574 with address of 0x38 was sent this: 0010_1001 Mar 01 21:45:17 bladelius-ask bladelius[605]: Current Input is 3 , Previous Input was 2 Mar 01 21:45:17 bladelius-ask bladelius[605]: Current Mode is I2S , Previous Mode was I2S Mar 01 21:45:17 bladelius-ask bladelius[605]: Current Input is: LINE 3 Mar 01 21:45:17 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:18 bladelius-ask bladelius[605]: PIN: 17, time: 0.18999999999999997 Mar 01 21:45:18 bladelius-ask bladelius[605]: Next Input Button short press event Mar 01 21:45:18 bladelius-ask bladelius[605]: SOURCE + was pressed False Mar 01 21:45:18 bladelius-ask bladelius[605]: PCF8574 with address of 0x39 was sent this: 1101_1111 Mar 01 21:45:18 bladelius-ask bladelius[605]: Current Input is 4 , Previous Input was 3 Mar 01 21:45:18 bladelius-ask bladelius[605]: Current Mode is I2S , Previous Mode was I2S Mar 01 21:45:18 bladelius-ask bladelius[605]: PCF8574 with address of 0x38 was sent this: 0011_0000 Mar 01 21:45:18 bladelius-ask bladelius[605]: Current Input is: STREAM Mar 01 21:45:18 bladelius-ask bladelius[605]: curInput is volumio 0 pause Mar 01 21:45:18 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:18 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:19 bladelius-ask volumiologrotate[572]: ls: cannot access '/var/log/samba/log.wb-BLADELIUS': No such file or directory Mar 01 21:45:19 bladelius-ask volumiologrotate[572]: ls: cannot access 'ASK': No such file or directory Mar 01 21:45:19 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:20 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 01 21:45:20 bladelius-ask volumio[781]: info: CoreStateMachine::getcurrentVolume Mar 01 21:45:20 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 21:45:20 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:20 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:20 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:21 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:21 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:45:22 bladelius-ask volumio[781]: info: browseTIDALUri took 327 milliseconds Mar 01 21:45:22 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:22 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:22 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:45:22 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:23 bladelius-ask volumio[781]: info: browseTIDALUri took 621 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439870 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439871 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439872 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439873 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439874 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439875 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439876 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439877 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439878 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439879 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Preloading song: tidal://song/439880 Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439870 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439871 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439872 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439873 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439874 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: No valid Plugin REST Endpoint: getSimilarAlbums Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439875 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439876 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439877 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 379 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 332 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439878 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439879 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 334 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 311 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: Exploding uri tidal://song/439880 in service tidal Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 349 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 365 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 386 milliseconds Mar 01 21:45:23 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:23 bladelius-ask volumio[781]: info: explodeTIDALUri took 333 milliseconds Mar 01 21:45:24 bladelius-ask volumio[781]: info: explodeTIDALUri took 348 milliseconds Mar 01 21:45:24 bladelius-ask volumio[781]: info: explodeTIDALUri took 300 milliseconds Mar 01 21:45:24 bladelius-ask volumio[781]: info: explodeTIDALUri took 316 milliseconds Mar 01 21:45:24 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:25 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:26 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:27 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:28 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:45:28 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:28 bladelius-ask volumio[781]: info: browseTIDALUri took 391 milliseconds Mar 01 21:45:29 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:29 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:29 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:30 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:31 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:32 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:45:32 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Mar 01 21:45:32 bladelius-ask volumio[781]: info: browseTIDALUri took 729 milliseconds Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/213389254 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/105047849 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/23235249 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/53696782 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/170962523 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/10939772 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96016008 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/5256198 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/67041717 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96901523 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87300011 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/122996660 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/79027898 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87680840 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/407779424 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/334864369 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/141334317 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/50891005 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/105236602 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/286327502 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/327430569 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/276778739 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/27064573 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/109485856 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/180073344 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/246489734 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/94370579 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/118664310 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/51123362 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/150502615 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/150502620 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/110311769 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/100325217 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/85318379 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/25056078 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/54512460 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87312322 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/296977251 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/105192951 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/93499459 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/121069665 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96229330 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/75396254 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/89050871 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/182794871 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/83996775 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/90405759 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/45391911 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/64541142 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/218627956 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/7599011 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/257665676 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/250761774 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/139681586 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96229326 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/117715505 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/125182564 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/107443678 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/141334318 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/118664322 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/333545438 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/65281308 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/272468072 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/65021721 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/90476037 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/59727857 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/59727868 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/161221395 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87389116 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/144856914 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/163799636 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/185780047 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/151253290 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/401262428 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/157751890 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/290200409 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/264854340 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/72155000 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/221434019 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/114492507 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/223436630 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/137003643 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/231056159 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Preloading song: tidal://song/180396753 Mar 01 21:45:32 bladelius-ask volumio[781]: info: Exploding uri tidal://song/213389254 in service tidal Mar 01 21:45:32 bladelius-ask volumio[781]: info: Exploding uri tidal://song/105047849 in service tidal Mar 01 21:45:32 bladelius-ask volumio[781]: info: browseTIDALUri took 680 milliseconds Mar 01 21:45:32 bladelius-ask volumio[781]: info: Exploding uri tidal://song/23235249 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/53696782 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preload queue cleared Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/170962523 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/10939772 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96016008 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/5256198 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/67041717 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96901523 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87300011 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/122996660 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/79027898 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87680840 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/407779424 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/334864369 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/141334317 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/50891005 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/105236602 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/286327502 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/327430569 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/276778739 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/27064573 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/109485856 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/180073344 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/246489734 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/94370579 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/118664310 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/51123362 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/150502615 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/150502620 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/110311769 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/100325217 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/85318379 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/25056078 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/54512460 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87312322 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/296977251 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/105192951 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/93499459 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/121069665 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96229330 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/75396254 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/89050871 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/182794871 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/83996775 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/90405759 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/45391911 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/64541142 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/218627956 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/7599011 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/257665676 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/250761774 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/139681586 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/96229326 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/117715505 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/125182564 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/107443678 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/141334318 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/118664322 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/333545438 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/65281308 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/272468072 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/65021721 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/90476037 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/59727857 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/59727868 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/161221395 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/87389116 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/144856914 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/163799636 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/185780047 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/151253290 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/401262428 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/157751890 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/290200409 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/264854340 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/72155000 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/221434019 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/114492507 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/223436630 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/137003643 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/231056159 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Preloading song: tidal://song/180396753 Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/170962523 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/10939772 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/96016008 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 325 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/5256198 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 340 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/67041717 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 319 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/96901523 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/87300011 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 335 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/122996660 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 347 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 290 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/79027898 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/87680840 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 307 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 292 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/407779424 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/334864369 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 345 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/141334317 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 308 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/50891005 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 288 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/105236602 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 375 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 284 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/286327502 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/327430569 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 284 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/276778739 in service tidal Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 939 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: explodeTIDALUri took 297 milliseconds Mar 01 21:45:33 bladelius-ask volumio[781]: info: Exploding uri tidal://song/27064573 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 281 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/109485856 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 287 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/180073344 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 288 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/246489734 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/94370579 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 327 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/118664310 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 280 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/51123362 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 291 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 396 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/150502615 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 293 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/150502620 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/110311769 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 283 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/100325217 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 909 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 293 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/85318379 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/25056078 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 303 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 288 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/54512460 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 282 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/87312322 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/296977251 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/105192951 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 360 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 290 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/93499459 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 283 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/121069665 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/96229330 in service tidal Mar 01 21:45:34 bladelius-ask volumio[781]: info: explodeTIDALUri took 280 milliseconds Mar 01 21:45:34 bladelius-ask volumio[781]: info: Exploding uri tidal://song/75396254 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/89050871 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 924 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/182794871 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 300 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 293 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/83996775 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 286 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/90405759 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 294 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/45391911 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/64541142 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/218627956 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/7599011 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 923 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 333 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 301 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/257665676 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 285 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 498 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/250761774 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/139681586 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 926 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/96229326 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 298 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 297 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/117715505 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 907 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 283 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/125182564 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 298 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/107443678 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/141334318 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/118664322 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 308 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 290 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/333545438 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/65281308 in service tidal Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 909 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: explodeTIDALUri took 307 milliseconds Mar 01 21:45:35 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:35 bladelius-ask volumio[781]: info: Exploding uri tidal://song/272468072 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/65021721 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/90476037 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 282 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/59727857 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 293 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 447 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/59727868 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 1005 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/161221395 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/87389116 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 281 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/144856914 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/163799636 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 316 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/185780047 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/151253290 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 348 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 314 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 281 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/401262428 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 1066 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/157751890 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 305 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/290200409 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 309 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 1005 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/264854340 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 311 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/72155000 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 279 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 993 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/221434019 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 286 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 894 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/114492507 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 296 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/223436630 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: Exploding uri tidal://song/137003643 in service tidal Mar 01 21:45:36 bladelius-ask volumio[781]: info: explodeTIDALUri took 304 milliseconds Mar 01 21:45:36 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:37 bladelius-ask volumio[781]: info: Exploding uri tidal://song/231056159 in service tidal Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 307 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 1016 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 278 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: Exploding uri tidal://song/180396753 in service tidal Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 275 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 281 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 1029 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 708 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: explodeTIDALUri took 899 milliseconds Mar 01 21:45:37 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:38 bladelius-ask volumio[781]: info: explodeTIDALUri took 1003 milliseconds Mar 01 21:45:38 bladelius-ask volumio[781]: info: explodeTIDALUri took 1297 milliseconds Mar 01 21:45:39 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:39 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:40 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:41 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:42 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:43 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:44 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:45 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:46 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:47 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:48 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioGetState Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioStop Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreStateMachine::stop Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreStateMachine::stPlaybackTimer Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreStateMachine::updateTrackBlock Mar 01 21:45:49 bladelius-ask volumio[781]: info: CorePlayQueue::getTrackBlock Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreStateMachine::pushState Mar 01 21:45:49 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreCommandRouter::volumioPushState Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreStateMachine::serviceStop Mar 01 21:45:49 bladelius-ask volumio[781]: info: CorePlayQueue::getTrack 0 Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreCommandRouter::serviceStop Mar 01 21:45:49 bladelius-ask volumio[781]: info: [1740865549548] ControllerTidal::stop Mar 01 21:45:49 bladelius-ask volumio[781]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 01 21:45:49 bladelius-ask volumio[781]: info: ControllerMpd::stop Mar 01 21:45:49 bladelius-ask volumio[781]: verbose: ControllerMpd::sendMpdCommand stop Mar 01 21:45:49 bladelius-ask volumio[781]: info: sendMpdCommand stop took 9 milliseconds Mar 01 21:45:52 bladelius-ask volumio[781]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Mar 01 21:45:52 bladelius-ask volumio[781]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 21:45:52 bladelius-ask volumio[781]: TypeError: Cannot read property 'then' of undefined Mar 01 21:45:52 bladelius-ask volumio[781]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:470:20) Mar 01 21:45:52 bladelius-ask volumio[781]: at Socket.emit (events.js:315:20) Mar 01 21:45:52 bladelius-ask volumio[781]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 01 21:45:52 bladelius-ask volumio[781]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 01 21:45:52 bladelius-ask volumio[781]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 21:45:53 bladelius-ask sudo[4902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 21:44 Mar 01 21:45:53 bladelius-ask sudo[4902]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="bladelius" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 22 Feb 2024 11:40:29 AM CET" VOLUMIO_VERSION="3.605" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d3bdd0b3fc9d786f35abf7517805f755"