-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Tue 2025-02-18 18:14:06 CET. -- Feb 18 18:13:00 volumio-vangelek sudo[7963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 18 18:13:00 volumio-vangelek sudo[7963]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:00 volumio-vangelek autossh[7055]: received signal to exit (15) Feb 18 18:13:00 volumio-vangelek systemd[1]: Stopping MyVolumio SSH Tunnel... Feb 18 18:13:00 volumio-vangelek systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Feb 18 18:13:00 volumio-vangelek systemd[1]: sshtunnel.service: Succeeded. Feb 18 18:13:00 volumio-vangelek systemd[1]: Stopped MyVolumio SSH Tunnel. Feb 18 18:13:00 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 18 18:13:00 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 18 18:13:00 volumio-vangelek systemd[1]: Started MyVolumio SSH Tunnel. Feb 18 18:13:00 volumio-vangelek sudo[7963]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:00 volumio-vangelek volumio[7486]: info: Remote SSH Started Feb 18 18:13:00 volumio-vangelek autossh[7966]: port set to 0, monitoring disabled Feb 18 18:13:00 volumio-vangelek autossh[7966]: starting ssh (count 1) Feb 18 18:13:00 volumio-vangelek autossh[7966]: ssh child pid is 7969 Feb 18 18:13:00 volumio-vangelek volumio[7486]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 18 18:13:00 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:00 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:00 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.track' Feb 18 18:13:00 volumio-vangelek volumiossh-tunnel[7965]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts. Feb 18 18:13:01 volumio-vangelek volumio[7486]: info: MRS: Getting audio outputs on start Feb 18 18:13:01 volumio-vangelek volumio[7486]: info: MRS: Requesting all other devices output Feb 18 18:13:02 volumio-vangelek volumio[7486]: info: TidalConnect service started! Feb 18 18:13:02 volumio-vangelek volumio[7486]: [Metrics] CommandRouter: 18s 764.68ms Feb 18 18:13:02 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumiosetStartupVolume Feb 18 18:13:02 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:02 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 18:13:02 volumio-vangelek volumio[7486]: info: CoreCommandRouter::Close All Modals sent Feb 18 18:13:02 volumio-vangelek volumio[7486]: info: CoreCommandRouter::Close All Modals sent Feb 18 18:13:03 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 18 18:13:03 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 18 18:13:03 volumio-vangelek volumio[7486]: xcb_connection_has_error() returned true Feb 18 18:13:03 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPlay Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index undefined Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreStateMachine::startPlaybackTimer Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetVisibleSources Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: [1739898787984] ControllerTidal::clearAddPlayTrack Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: Getting stream with soundQuality HI_RES Feb 18 18:13:07 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: sendMpdCommand stop took 1 milliseconds Feb 18 18:13:07 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand clear Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: Feb 18 18:13:07 volumio-vangelek volumio[7486]: ---------------------------- MPD announces system playlist update Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: Ignoring MPD Status Update Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: sendMpdCommand clear took 1 milliseconds Feb 18 18:13:07 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES" Feb 18 18:13:07 volumio-vangelek volumio[7486]: error: updateQueue error: null Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: Feb 18 18:13:07 volumio-vangelek volumio[7486]: ---------------------------- MPD announces system playlist update Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: Ignoring MPD Status Update Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: ------------------------------ 2ms Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES" took 1 milliseconds Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 18 18:13:07 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand play Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: ------------------------------ 2ms Feb 18 18:13:07 volumio-vangelek volumio[7486]: info: sendMpdCommand play took 3 milliseconds Feb 18 18:13:07 volumio-vangelek volumio[7486]: STREAMING PROXY: Handling url /?data=tidal://album/404512440&soundQuality=HI_RES Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: Executing endpoint getStreamUrltidal Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: getStreamUrl took 63 milliseconds Feb 18 18:13:08 volumio-vangelek volumio[7486]: error: Failed to retrieve real stream URL Could not get TIDAL Stream URL: failed to get stream from provider tidal: rpc error: code = InvalidArgument desc = invalid resource type: TYPE_ALBUM Feb 18 18:13:08 volumio-vangelek volumio[7486]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get TIDAL Stream URL: failed to get stream from provider tidal: rpc error: code = InvalidArgument desc = invalid resource type: TYPE_ALBUM"} Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: Feb 18 18:13:08 volumio-vangelek volumio[7486]: ---------------------------- MPD announces state update: player Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: ControllerMpd::getState Feb 18 18:13:08 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand status Feb 18 18:13:08 volumio-vangelek volumio[7486]: error: MPD Playback Error: Failed to decode stream, moving to next track Feb 18 18:13:08 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: sendMpdCommand status took 3 milliseconds Feb 18 18:13:08 volumio-vangelek volumio[7486]: verbose: ControllerMpd::parseState Feb 18 18:13:08 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: sendMpdCommand clearerror took 1 milliseconds Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 18 18:13:08 volumio-vangelek volumio[7486]: verbose: ControllerMpd::parseTrackInfo Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: ControllerMpd::pushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::servicePushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:08 volumio-vangelek volumio[7486]: 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":"404512440&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES","trackType":"tidal"} Feb 18 18:13:08 volumio-vangelek volumio[7486]: verbose: CURRENT POSITION 0 Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreStateMachine::syncState stateService stop Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreStateMachine::syncState currentStatus stop Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: No code Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: ------------------------------ 21ms Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: PrevState: stop Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: [ASDebug] Togle GPIO: ON Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: undefined PrevState: Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: [ASDebug] Togle GPIO: ON Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: undefined PrevState: undefined Feb 18 18:13:08 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.status' Feb 18 18:13:08 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.status' Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 18 18:13:08 volumio-vangelek volumio[7486]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 18 18:13:08 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: Moving to next track after playback error Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPlay Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index 1 Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CoreStateMachine::stop Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index undefined Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 1 Feb 18 18:13:09 volumio-vangelek volumio[7486]: info: BOOT COMPLETED Feb 18 18:13:10 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:10 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:10 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:10 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:10 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:10 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:13 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:13 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:13 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 18 18:13:13 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 18 18:13:13 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 18 18:13:13 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetBrowseSources Feb 18 18:13:13 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 18:13:14 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 18:13:14 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 18:13:14 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 18 18:13:14 volumio-vangelek volumio-remote-updater[1947]: No test mode Feb 18 18:13:14 volumio-vangelek volumio-remote-updater[1947]: No alpha test mode Feb 18 18:13:14 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 18 18:13:14 volumio-vangelek volumio[7486]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 18 18:13:14 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 18 18:13:16 volumio-vangelek sudo[8012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 18 18:13:16 volumio-vangelek sudo[8012]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:16 volumio-vangelek sudo[8012]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:16 volumio-vangelek sudo[8015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 18 18:13:16 volumio-vangelek sudo[8015]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:16 volumio-vangelek sudo[8015]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:16 volumio-vangelek volumio[7486]: verbose: New Socket.io Connection to 192.168.0.221 from 192.168.0.107 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 18 18:13:16 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 18 18:13:17 volumio-vangelek sudo[8018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 18 18:13:17 volumio-vangelek sudo[8018]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:17 volumio-vangelek sudo[8018]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:17 volumio-vangelek sudo[8021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 18 18:13:17 volumio-vangelek sudo[8021]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:17 volumio-vangelek sudo[8021]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:17 volumio-vangelek volumio[7486]: verbose: New Socket.io Connection to 192.168.0.221 from 192.168.0.107 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetVisibleSources Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: Listing playlists Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 18 18:13:17 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:19 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:20 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPlay Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index undefined Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::startPlaybackTimer Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetVisibleSources Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: [1739898803088] ControllerTidal::clearAddPlayTrack Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: Getting stream with soundQuality HI_RES Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: sendMpdCommand stop took 0 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand clear Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: Feb 18 18:13:23 volumio-vangelek volumio[7486]: ---------------------------- MPD announces system playlist update Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: Ignoring MPD Status Update Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: sendMpdCommand clear took 0 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES" Feb 18 18:13:23 volumio-vangelek volumio[7486]: error: updateQueue error: null Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: ------------------------------ 1ms Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: Feb 18 18:13:23 volumio-vangelek volumio[7486]: ---------------------------- MPD announces system playlist update Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: Ignoring MPD Status Update Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES" took 1 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand play Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: ------------------------------ 1ms Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: sendMpdCommand play took 0 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: STREAMING PROXY: Handling url /?data=tidal://album/404512440&soundQuality=HI_RES Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: Executing endpoint getStreamUrltidal Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: getStreamUrl took 87 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: error: Failed to retrieve real stream URL Could not get TIDAL Stream URL: failed to get stream from provider tidal: rpc error: code = InvalidArgument desc = invalid resource type: TYPE_ALBUM Feb 18 18:13:23 volumio-vangelek volumio[7486]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get TIDAL Stream URL: failed to get stream from provider tidal: rpc error: code = InvalidArgument desc = invalid resource type: TYPE_ALBUM"} Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: Feb 18 18:13:23 volumio-vangelek volumio[7486]: ---------------------------- MPD announces state update: player Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: ControllerMpd::getState Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand status Feb 18 18:13:23 volumio-vangelek volumio[7486]: error: MPD Playback Error: Failed to decode stream, moving to next track Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: sendMpdCommand status took 3 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::parseState Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: sendMpdCommand clearerror took 1 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: ControllerMpd::parseTrackInfo Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: ControllerMpd::pushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::servicePushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:23 volumio-vangelek volumio[7486]: 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":"404512440&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES","trackType":"tidal"} Feb 18 18:13:23 volumio-vangelek volumio[7486]: verbose: CURRENT POSITION 0 Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::syncState stateService stop Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::syncState currentStatus stop Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: No code Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: ------------------------------ 28ms Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: PrevState: undefined Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: [ASDebug] Togle GPIO: ON Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: undefined PrevState: Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: [ASDebug] Togle GPIO: ON Feb 18 18:13:23 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: undefined PrevState: undefined Feb 18 18:13:23 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.status' Feb 18 18:13:23 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.status' Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: Moving to next track after playback error Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPlay Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index 1 Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CoreStateMachine::stop Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index undefined Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:24 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 1 Feb 18 18:13:27 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPlay Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index undefined Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::startPlaybackTimer Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetVisibleSources Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: [1739898809712] ControllerTidal::clearAddPlayTrack Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: Getting stream with soundQuality HI_RES Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand stop Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: sendMpdCommand stop took 1 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand clear Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: Feb 18 18:13:29 volumio-vangelek volumio[7486]: ---------------------------- MPD announces system playlist update Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: Ignoring MPD Status Update Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: sendMpdCommand clear took 1 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES" Feb 18 18:13:29 volumio-vangelek volumio[7486]: error: updateQueue error: null Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: ------------------------------ 1ms Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: Feb 18 18:13:29 volumio-vangelek volumio[7486]: ---------------------------- MPD announces system playlist update Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: Ignoring MPD Status Update Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES" took 1 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand play Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: ------------------------------ 1ms Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: sendMpdCommand play took 1 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: STREAMING PROXY: Handling url /?data=tidal://album/404512440&soundQuality=HI_RES Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: Executing endpoint getStreamUrltidal Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: getStreamUrl took 67 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: error: Failed to retrieve real stream URL Could not get TIDAL Stream URL: failed to get stream from provider tidal: rpc error: code = InvalidArgument desc = invalid resource type: TYPE_ALBUM Feb 18 18:13:29 volumio-vangelek volumio[7486]: STREAMING PROXY: Error: Failed to retrieve proper real streamUrl: {"success":false,"error":"Could not get TIDAL Stream URL: failed to get stream from provider tidal: rpc error: code = InvalidArgument desc = invalid resource type: TYPE_ALBUM"} Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: Feb 18 18:13:29 volumio-vangelek volumio[7486]: ---------------------------- MPD announces state update: player Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: ControllerMpd::getState Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand status Feb 18 18:13:29 volumio-vangelek volumio[7486]: error: MPD Playback Error: Failed to decode stream, moving to next track Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: sendMpdCommand status took 3 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::parseState Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: sendMpdCommand clearerror took 1 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: ControllerMpd::parseTrackInfo Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: ControllerMpd::pushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::servicePushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:29 volumio-vangelek volumio[7486]: 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":"404512440&soundQuality=HI_RES","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://album/404512440&soundQuality=HI_RES","trackType":"tidal"} Feb 18 18:13:29 volumio-vangelek volumio[7486]: verbose: CURRENT POSITION 0 Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::syncState stateService stop Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::syncState currentStatus stop Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: No code Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: ------------------------------ 30ms Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: PrevState: undefined Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: [ASDebug] Togle GPIO: ON Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: undefined PrevState: Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: [ASDebug] Togle GPIO: ON Feb 18 18:13:29 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: undefined PrevState: undefined Feb 18 18:13:29 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.status' Feb 18 18:13:29 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.status' Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: Moving to next track after playback error Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPlay Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index 1 Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CoreStateMachine::stop Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CoreStateMachine::play index undefined Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 18:13:30 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 1 Feb 18 18:13:32 volumio-vangelek sudo[8045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 18 18:13:32 volumio-vangelek sudo[8045]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:32 volumio-vangelek sudo[8045]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:32 volumio-vangelek sudo[8048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 18 18:13:32 volumio-vangelek sudo[8048]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:32 volumio-vangelek sudo[8048]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:32 volumio-vangelek volumio[7486]: verbose: New Socket.io Connection to 192.168.0.221 from 192.168.0.107 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 18 18:13:32 volumio-vangelek sudo[8051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 18 18:13:32 volumio-vangelek sudo[8051]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:32 volumio-vangelek sudo[8051]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:32 volumio-vangelek sudo[8054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 18 18:13:32 volumio-vangelek sudo[8054]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:32 volumio-vangelek sudo[8054]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:33 volumio-vangelek volumio[7486]: verbose: New Socket.io Connection to 192.168.0.221 from 192.168.0.107 UA: Mozilla/5.0 (Linux; Android 13; 2201116SG Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.163 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetVisibleSources Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: Listing playlists Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 18 18:13:33 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:34 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: Received Get System Version Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:35 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:38 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 18:13:38 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 18:13:40 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:40 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:40 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:40 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:40 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:40 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:13:42 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Starting Uninstall of plugin audio_interface - fusiondsp Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Uninstalling plugin fusiondsp Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Disabling plugin fusiondsp Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Preparing to generate the ALSA configuration file Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Reading ALSA contributions from plugins. Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Asound.conf file unchanged, so no further update is needed Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Output device has changed, restarting MPD Feb 18 18:13:43 volumio-vangelek sudo[8074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 18 18:13:43 volumio-vangelek sudo[8074]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek sudo[8074]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Output device has changed, restarting Shairport Sync Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 18:13:43 volumio-vangelek sudo[8077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 18 18:13:43 volumio-vangelek sudo[8077]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek systemd[1]: Stopping Music Player Daemon... Feb 18 18:13:43 volumio-vangelek volumio[7486]: xcb_connection_has_error() returned true Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 18 18:13:43 volumio-vangelek volumio[7486]: xcb_connection_has_error() returned true Feb 18 18:13:43 volumio-vangelek systemd[1]: mpd.service: Succeeded. Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 18 18:13:43 volumio-vangelek systemd[1]: Stopped Music Player Daemon. Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek vtcs[7939]: [2025-02-18 18:13:43.752] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Feb 18 18:13:43 volumio-vangelek vtcs[7939]: [2025-02-18 18:13:43.752] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Feb 18 18:13:43 volumio-vangelek systemd[1]: Starting Music Player Daemon... Feb 18 18:13:43 volumio-vangelek sudo[8086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Checking if uninstall.sh is present Feb 18 18:13:43 volumio-vangelek sudo[8086]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek systemd[1]: Stopping Volumio Tidal Connect Service... Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Executing uninstall.sh Feb 18 18:13:43 volumio-vangelek systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 18 18:13:43 volumio-vangelek systemd[1]: vtcs.service: Succeeded. Feb 18 18:13:43 volumio-vangelek sudo[8089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 18 18:13:43 volumio-vangelek systemd[1]: Stopped Volumio Tidal Connect Service. Feb 18 18:13:43 volumio-vangelek sudo[8089]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 18 18:13:43 volumio-vangelek sudo[8086]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:43 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 18 18:13:43 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 18 18:13:43 volumio-vangelek sudo[8089]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:43 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 18 18:13:43 volumio-vangelek sudo[8082]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 18 18:13:43 volumio-vangelek sudo[8082]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek sudo[8082]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: MPD Permissions set Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek sudo[8093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Feb 18 18:13:43 volumio-vangelek sudo[8093]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Starting Shairport Sync Feb 18 18:13:43 volumio-vangelek sudo[8105]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/systemd/system/multi-user.target.wants/fusiondsp.service Feb 18 18:13:43 volumio-vangelek sudo[8105]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek sudo[8105]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:43 volumio-vangelek sudo[8093]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:43 volumio-vangelek sudo[8108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 18 18:13:43 volumio-vangelek sudo[8108]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Uninstall script completed Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Removing plugin fusiondsp from configuration Feb 18 18:13:43 volumio-vangelek systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 18 18:13:43 volumio-vangelek systemd[1]: shairport-sync.service: Succeeded. Feb 18 18:13:43 volumio-vangelek systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 18 18:13:43 volumio-vangelek systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 18 18:13:43 volumio-vangelek sudo[8108]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Successfully removed fusiondsp configuration files Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Plugin folders cleanup Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning into folder /volumio/app/plugins/ Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category audio_interface Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category miscellanea Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category music_service Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category plugins.json Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category system_controller Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category user_interface Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning into folder /data/plugins/ Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category audio_interface Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Cleaning folder for fusiondsp Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Scanning category system_controller Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: Plugin folders cleanup completed Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: [{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":true}] Feb 18 18:13:43 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 18:13:44 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 18 18:13:44 volumio-vangelek volumio[7486]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 18 18:13:44 volumio-vangelek volumio[7486]: info: Shairport-Sync Started Feb 18 18:13:44 volumio-vangelek mpd[8097]: Feb 18 18:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 18 18:13:44 volumio-vangelek systemd[1]: Started Music Player Daemon. Feb 18 18:13:44 volumio-vangelek sudo[8077]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:44 volumio-vangelek volumio[7486]: error: updateQueue error: null Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: TidalConnect service stoped! Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: TidalConnect service stoped! Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 18 18:13:46 volumio-vangelek sudo[8142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 18 18:13:46 volumio-vangelek sudo[8142]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 18:13:46 volumio-vangelek systemd[1]: Started Volumio Tidal Connect Service. Feb 18 18:13:46 volumio-vangelek sudo[8142]: pam_unix(sudo:session): session closed for user root Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: Executing endpoint tc_getconfig Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 18 18:13:46 volumio-vangelek vtcs[8144]: STARTING TidalConnect services, version: 1.4.0.34 Feb 18 18:13:46 volumio-vangelek vtcs[8144]: STARTED TidalConnect services. Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: Executing endpoint tc_connect Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: Connecting to TidalConnect Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreCommandRouter::servicePushState Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreCommandRouter::servicePushState Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreStateMachine::pushState Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioPushState Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output update for this device Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: MRS: Pushing multiroomSync output Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: stop PrevState: undefined Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: [ASDebug] CurState: stop PrevState: undefined Feb 18 18:13:46 volumio-vangelek volumio[7486]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Feb 18 18:13:46 volumio-vangelek volumio[7486]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.zvcufWPiwMO8mJKSNbMdc4KnxqA2.1ccee2e236889e6f3ccf445527b3adc7.state.track' Feb 18 18:13:47 volumio-vangelek volumio[7486]: info: [ASDebug] Togle GPIO: OFF Feb 18 18:13:49 volumio-vangelek volumio[7486]: info: TidalConnect service started! Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: Received Get System Version Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: Received Get System Info Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: Discovery: Getting this device information Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CoreCommandRouter::volumioGetState Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CorePlayQueue::getTrack 0 Feb 18 18:13:50 volumio-vangelek volumio[7486]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 18 18:14:01 volumio-vangelek volumio[7486]: info: Starting Uninstall of plugin system_controller - ampswitch Feb 18 18:14:01 volumio-vangelek volumio[7486]: info: Uninstalling plugin ampswitch Feb 18 18:14:01 volumio-vangelek volumio[7486]: info: [ASDebug] Port: 24 Feb 18 18:14:01 volumio-vangelek volumio[7486]: info: [ASDebug] Inverted: false Feb 18 18:14:01 volumio-vangelek volumio[7486]: info: [ASDebug] Delay: 720 Feb 18 18:14:06 volumio-vangelek volumio[7486]: info: Starting Uninstall of plugin system_controller - ampswitch Feb 18 18:14:06 volumio-vangelek volumio[7486]: info: Uninstalling plugin ampswitch Feb 18 18:14:06 volumio-vangelek volumio[7486]: info: [ASDebug] Port: 24 Feb 18 18:14:06 volumio-vangelek volumio[7486]: info: [ASDebug] Inverted: false Feb 18 18:14:06 volumio-vangelek volumio[7486]: info: [ASDebug] Delay: 720 Feb 18 18:14:06 volumio-vangelek volumio[7486]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 18:14:06 volumio-vangelek volumio[7486]: Error: EBADF: bad file descriptor, close Feb 18 18:14:06 volumio-vangelek volumio[7486]: at Object.closeSync (fs.js:439:3) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1478:22) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1254:45) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at Socket.emit (events.js:315:20) Feb 18 18:14:06 volumio-vangelek volumio[7486]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 18 18:14:06 volumio-vangelek volumio[7486]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Feb 18 18:14:06 volumio-vangelek volumio[7486]: errno: -9, Feb 18 18:14:06 volumio-vangelek volumio[7486]: syscall: 'close', Feb 18 18:14:06 volumio-vangelek volumio[7486]: code: 'EBADF' Feb 18 18:14:06 volumio-vangelek volumio[7486]: } Feb 18 18:14:06 volumio-vangelek volumio[7486]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 18:14:06 volumio-vangelek sudo[8261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-18 18:13 Feb 18 18:14:06 volumio-vangelek sudo[8261]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"