-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2024-09-02 18:48:57 CEST. -- Sep 02 18:47:01 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:02 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:02 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:02 torn-rr volumio[9166]: info: Currently active: mpd Sep 02 18:47:02 torn-rr volumio[9166]: info: Stopping currently active service Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioStop Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::stop Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 18:47:02 torn-rr volumio[9166]: info: TidalConnect Active Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:02 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:02 torn-rr volumio[9166]: info: Currently active: mpd Sep 02 18:47:02 torn-rr volumio[9166]: info: Setting Volatile state to tidalconnect Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:02 torn-rr vtcs[10949]: [2024-09-02 18:47:02.636] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:1 Sep 02 18:47:02 torn-rr vtcs[10949]: [2024-09-02 18:47:02.636] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:02 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:02 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:03 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:03 torn-rr vtcs[10949]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:1537:(_snd_pcm_volumioswitch_open) Invalid type for rate_min Sep 02 18:47:03 torn-rr vtcs[10949]: [2024-09-02 18:47:03.605] [tisoc] [error] [pcm_sink_alsa.cpp:114] Failed to open device volumio, error: Invalid argument Sep 02 18:47:03 torn-rr vtcs[10949]: [2024-09-02 18:47:03.606] [tisoc] [error] [media_player_tidal.cpp:178] Could not open pcm sink: 1 Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:03 torn-rr volumio[9166]: info: Unknown command: notifyPlaybackError Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:03 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:04 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:04 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:06 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:07 torn-rr vtcs[10949]: [2024-09-02 18:47:07.899] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=5, playstate_=1, player_state_=0 Sep 02 18:47:07 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:07 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:07 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:07 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:07 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:07 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:11 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioNext Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::next Sep 02 18:47:13 torn-rr volumio[9166]: info: Received next Sep 02 18:47:13 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:13 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:13 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:14 torn-rr vtcs[10949]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:1537:(_snd_pcm_volumioswitch_open) Invalid type for rate_min Sep 02 18:47:14 torn-rr vtcs[10949]: [2024-09-02 18:47:14.004] [tisoc] [error] [pcm_sink_alsa.cpp:114] Failed to open device volumio, error: Invalid argument Sep 02 18:47:14 torn-rr vtcs[10949]: [2024-09-02 18:47:14.004] [tisoc] [error] [media_player_tidal.cpp:178] Could not open pcm sink: 1 Sep 02 18:47:14 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:14 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:14 torn-rr volumio[9166]: info: Unknown command: notifyPlaybackError Sep 02 18:47:14 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:14 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:14 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:14 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:14 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:14 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:14 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:14 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:14 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:14 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:14 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:14 torn-rr volumiologrotate[634]: ls: cannot access '/var/log/samba/log.wb-TORN': No such file or directory Sep 02 18:47:14 torn-rr volumiologrotate[634]: ls: cannot access 'RR': No such file or directory Sep 02 18:47:16 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:16 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:16 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:17 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:17 torn-rr volumio[9166]: info: CoreCommandRouter::volumioVolatilePlay Sep 02 18:47:17 torn-rr volumio[9166]: info: CoreStateMachine::volatilePlay Sep 02 18:47:17 torn-rr volumio[9166]: info: Received play: Sep 02 18:47:17 torn-rr vtcs[10949]: [2024-09-02 18:47:17.844] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=5, playstate_=1, player_state_=0 Sep 02 18:47:17 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:17 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:17 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:17 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:17 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:17 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioNext Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::next Sep 02 18:47:20 torn-rr volumio[9166]: info: Received next Sep 02 18:47:20 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr vtcs[10949]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:1537:(_snd_pcm_volumioswitch_open) Invalid type for rate_min Sep 02 18:47:20 torn-rr vtcs[10949]: [2024-09-02 18:47:20.841] [tisoc] [error] [pcm_sink_alsa.cpp:114] Failed to open device volumio, error: Invalid argument Sep 02 18:47:20 torn-rr vtcs[10949]: [2024-09-02 18:47:20.841] [tisoc] [error] [media_player_tidal.cpp:178] Could not open pcm sink: 1 Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:20 torn-rr volumio[9166]: info: Unknown command: notifyPlaybackError Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:20 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:21 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:22 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:22 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:25 torn-rr sudo[11229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 02 18:47:25 torn-rr sudo[11229]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 02 18:47:25 torn-rr sudo[11229]: pam_unix(sudo:session): session closed for user root Sep 02 18:47:25 torn-rr sudo[11232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 02 18:47:25 torn-rr sudo[11232]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 02 18:47:25 torn-rr sudo[11232]: pam_unix(sudo:session): session closed for user root Sep 02 18:47:25 torn-rr volumio[9166]: verbose: New Socket.io Connection to 192.168.100.107 from 192.168.100.124 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetVisibleSources Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 02 18:47:25 torn-rr volumio[9166]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Sep 02 18:47:25 torn-rr volumio[9166]: info: Received Get System Info Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 18:47:25 torn-rr volumio[9166]: info: Discovery: Getting this device information Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:25 torn-rr volumio[9166]: info: Listing playlists Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 02 18:47:25 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 02 18:47:26 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:26 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 02 18:47:26 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:26 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:26 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:27 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:27 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 02 18:47:27 torn-rr volumio[9166]: info: Received Get System Info Sep 02 18:47:27 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 18:47:27 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 18:47:27 torn-rr volumio[9166]: info: Discovery: Getting this device information Sep 02 18:47:27 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:27 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 18:47:27 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 02 18:47:28 torn-rr volumio[9166]: info: Received Get System Info Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 18:47:28 torn-rr volumio[9166]: info: Discovery: Getting this device information Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 18:47:28 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:28 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:28 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:28 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:29 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:29 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:30 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:30 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:31 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:31 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:31 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:32 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:32 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:33 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:33 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:34 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:34 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:35 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:35 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 02 18:47:35 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:36 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:36 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:36 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:37 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:37 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:38 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:38 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr volumio[9166]: error: error Sep 02 18:47:39 torn-rr vtcs[10949]: [2024-09-02 18:47:39.535] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=5, playstate_=1, player_state_=0 Sep 02 18:47:39 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:39 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:39 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:39 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:39 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:39 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:39 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:40 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:40 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:40 torn-rr vtcs[10949]: [2024-09-02 18:47:40.758] [tisoc] [warning] [PlaybackControllerImpl.cpp:221] Ignore play request because player state is already PLAYING. state_=5, playstate_=1, player_state_=0 Sep 02 18:47:40 torn-rr vtcs[10949]: [2024-09-02 18:47:40.970] [tisoc] [warning] [PlaybackControllerImpl.cpp:221] Ignore play request because player state is already PLAYING. state_=5, playstate_=1, player_state_=0 Sep 02 18:47:41 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:41 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:41 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:42 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:42 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:43 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:43 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 02 18:47:44 torn-rr volumio[9166]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 02 18:47:44 torn-rr volumio[9166]: info: Received Get System Version Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 02 18:47:44 torn-rr volumio[9166]: info: Received Get System Info Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 18:47:44 torn-rr volumio[9166]: info: Discovery: Getting this device information Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 18:47:44 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:45 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:45 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:45 torn-rr vtcs[10949]: [2024-09-02 18:47:45] [error] handle_read_frame error: asio.ssl.stream:1 (stream truncated) Sep 02 18:47:45 torn-rr vtcs[10949]: [2024-09-02 18:47:45] [info] asio async_shutdown error: asio.ssl.stream:1 (stream truncated) Sep 02 18:47:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:46 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:47 torn-rr vtcs[10949]: [2024-09-02 18:47:47.560] [tisoc] [warning] [PlaybackControllerImpl.cpp:913] Not send NotifyMediaChanged(media_info is null) Sep 02 18:47:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:48 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:48 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:49 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:49 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:50 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:50 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:51 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:51 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:51 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:52 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:52 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:53 torn-rr vtcs[10949]: [2024-09-02 18:47:53.275] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr vtcs[10949]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:1537:(_snd_pcm_volumioswitch_open) Invalid type for rate_min Sep 02 18:47:53 torn-rr vtcs[10949]: [2024-09-02 18:47:53.559] [tisoc] [error] [pcm_sink_alsa.cpp:114] Failed to open device volumio, error: Invalid argument Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr vtcs[10949]: [2024-09-02 18:47:53.559] [tisoc] [error] [media_player_tidal.cpp:178] Could not open pcm sink: 1 Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: Unknown command: notifyPlaybackError Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:47:53 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:47:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:54 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:54 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:55 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:55 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:56 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:47:56 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:56 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:47:57 torn-rr volumio[9166]: info: PlaybackInactive Sep 02 18:47:57 torn-rr volumio[9166]: info: Device Session is_active: true Sep 02 18:47:57 torn-rr volumio[9166]: info: DeviceInactive Sep 02 18:47:57 torn-rr volumio[9166]: info: Relinquishing Volumio State Sep 02 18:47:57 torn-rr volumio[9166]: verbose: UNSET VOLATILE: Service: tidalconnect Sep 02 18:47:57 torn-rr volumio[9166]: info: unSetVolatile called Sep 02 18:47:57 torn-rr volumio[9166]: info: Relinquishing Volumio State to another service Sep 02 18:47:57 torn-rr vtcs[10949]: [2024-09-02 18:47:57.079] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Sep 02 18:47:57 torn-rr vtcs[10949]: [2024-09-02 18:47:57] [info] asio async_shutdown error: asio.misc:2 (End of file) Sep 02 18:47:57 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:57 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:57 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:57 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:58 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:58 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:58 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:58 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:59 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:59 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:47:59 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:47:59 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:00 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:00 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:00 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:00 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:01 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:01 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:01 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:01 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:01 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:02 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:02 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:02 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:03 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:03 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:03 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:04 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:04 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:04 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:04 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:05 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:05 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:05 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:05 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:06 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:06 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:06 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:06 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:06 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:07 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:07 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:07 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:07 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:08 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:08 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:08 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:08 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:09 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:09 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:09 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:09 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:10 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:10 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:10 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:10 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:11 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:11 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:11 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:11 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:11 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:12 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:12 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:12 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:12 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:13 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:13 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:13 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:14 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:14 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:14 torn-rr volumiologrotate[634]: ls: cannot access '/var/log/samba/log.wb-TORN': No such file or directory Sep 02 18:48:14 torn-rr volumiologrotate[634]: ls: cannot access 'RR': No such file or directory Sep 02 18:48:14 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:14 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:15 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:15 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:15 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:15 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:16 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:16 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:16 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:16 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:16 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:17 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:17 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:17 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:17 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:18 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:18 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:18 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:18 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:19 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:19 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:19 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:19 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:20 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:20 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:20 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:21 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:21 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:21 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:21 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:21 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:22 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:22 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:22 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:22 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:23 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:23 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:23 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:23 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:24 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:24 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:24 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:24 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:25 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:25 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:25 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:25 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:26 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:26 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:26 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:26 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:26 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:27 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:27 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:27 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:27 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:27 torn-rr volumio[9166]: error: error Sep 02 18:48:27 torn-rr volumio[9166]: error: error Sep 02 18:48:27 torn-rr volumio[9166]: error: error Sep 02 18:48:27 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:28 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:28 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:28 torn-rr volumio[9166]: error: error Sep 02 18:48:29 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:29 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:29 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:29 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:30 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:30 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:30 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:30 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:31 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:31 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:31 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:31 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:31 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:32 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:32 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:32 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:32 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:33 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:33 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:33 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:33 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:34 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:34 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:34 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:34 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:35 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:35 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:35 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:35 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:36 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:36 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:36 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:36 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:36 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:37 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:37 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:37 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:37 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:38 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:38 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:38 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:38 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:39 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:39 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:39 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:39 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:40 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:40 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:40 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:40 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:41 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:41 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:41 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:41 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:41 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:42 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:42 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:42 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:42 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:43 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:43 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:43 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:43 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:44 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:44 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:44 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:44 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:45 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:45 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:45 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:45 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:46 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:46 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:46 torn-rr volumio[9166]: info: Currently active: mpd Sep 02 18:48:46 torn-rr volumio[9166]: info: Stopping currently active service Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioStop Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::stop Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::updateTrackBlock Sep 02 18:48:46 torn-rr volumio[9166]: info: CorePlayQueue::getTrackBlock Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::stPlaybackTimer Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::serviceStop Sep 02 18:48:46 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:46 torn-rr volumio[9166]: info: ControllerMpd::stop Sep 02 18:48:46 torn-rr volumio[9166]: verbose: ControllerMpd::sendMpdCommand stop Sep 02 18:48:46 torn-rr volumio[9166]: info: sendMpdCommand stop took 19 milliseconds Sep 02 18:48:46 torn-rr volumio[9166]: info: TidalConnect Active Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:46 torn-rr volumio[9166]: info: CorePlayQueue::getTrack 0 Sep 02 18:48:46 torn-rr volumio[9166]: info: Currently active: mpd Sep 02 18:48:46 torn-rr volumio[9166]: info: Setting Volatile state to tidalconnect Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:46 torn-rr vtcs[10949]: [2024-09-02 18:48:46.634] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:1 Sep 02 18:48:46 torn-rr vtcs[10949]: [2024-09-02 18:48:46.634] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Sep 02 18:48:46 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:46 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:46 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:46 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:47 torn-rr volumio[9166]: info: Pushing metadata Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:47 torn-rr vtcs[10949]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:1537:(_snd_pcm_volumioswitch_open) Invalid type for rate_min Sep 02 18:48:47 torn-rr vtcs[10949]: [2024-09-02 18:48:47.272] [tisoc] [error] [pcm_sink_alsa.cpp:114] Failed to open device volumio, error: Invalid argument Sep 02 18:48:47 torn-rr vtcs[10949]: [2024-09-02 18:48:47.272] [tisoc] [error] [media_player_tidal.cpp:178] Could not open pcm sink: 1 Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:47 torn-rr volumio[9166]: info: Unknown command: notifyPlaybackError Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:47 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:47 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:48 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:48 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:49 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: Executing endpoint metavolumio Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 02 18:48:49 torn-rr vtcs[10949]: [2024-09-02 18:48:49.660] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=5, playstate_=1, player_state_=0 Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::servicePushState Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreStateMachine::pushState Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::volumioPushState Sep 02 18:48:49 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output update for this device Sep 02 18:48:49 torn-rr volumio[9166]: info: MRS: Pushing multiroomSync output Sep 02 18:48:49 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:50 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:50 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:51 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:51 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:51 torn-rr volumio[9166]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 14 Sep 02 18:48:52 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:52 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:53 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:54 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:54 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 02 18:48:54 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 02 18:48:55 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:55 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 02 18:48:55 torn-rr volumio[9166]: info: Received Get System Info Sep 02 18:48:55 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 18:48:55 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 18:48:55 torn-rr volumio[9166]: info: Discovery: Getting this device information Sep 02 18:48:55 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:55 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 02 18:48:56 torn-rr volumio[9166]: info: Received Get System Info Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 02 18:48:56 torn-rr volumio[9166]: info: Discovery: Getting this device information Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreCommandRouter::volumioGetState Sep 02 18:48:56 torn-rr volumio[9166]: info: Stopping Brutefir service Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreStateMachine::stop Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreStateMachine::serviceStop Sep 02 18:48:56 torn-rr volumio[9166]: info: CoreCommandRouter::serviceStop Sep 02 18:48:56 torn-rr volumio[9166]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 02 18:48:56 torn-rr volumio[9166]: TypeError: Cannot read property 'then' of undefined Sep 02 18:48:56 torn-rr volumio[9166]: at ControllerBrutefir.onStop (/data/plugins/audio_interface/brutefir/index.js:88:41) Sep 02 18:48:56 torn-rr volumio[9166]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Sep 02 18:48:56 torn-rr volumio[9166]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Sep 02 18:48:56 torn-rr volumio[9166]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1537:29) Sep 02 18:48:56 torn-rr volumio[9166]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1387:47) Sep 02 18:48:56 torn-rr volumio[9166]: at Socket.emit (events.js:315:20) Sep 02 18:48:56 torn-rr volumio[9166]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Sep 02 18:48:56 torn-rr volumio[9166]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Sep 02 18:48:56 torn-rr volumio[9166]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 02 18:48:56 torn-rr vtcs[10949]: [2024-09-02 18:48:56] [info] asio async_shutdown error: asio.misc:2 (End of file) Sep 02 18:48:57 torn-rr sudo[11322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-02 18:47 Sep 02 18:48:57 torn-rr sudo[11322]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"